builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0025 starttime: 1456339930.1 results: success (0) buildid: 20160224084158 builduid: db298f2fec8c4f69a7194cafd5bfe7af revision: 37ab9a732b0635f2d7c5d85b20e14f870cbc4084 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 10:52:10.100017) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 10:52:10.100480) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 10:52:10.100788) ========= 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.WzulBUUkPQ/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.4At5YuyX8N/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.005257 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 10:52:10.123947) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 10:52:10.124263) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 10:52:10.139171) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:52:10.139708) ========= 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.WzulBUUkPQ/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.4At5YuyX8N/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.004713 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:52:10.207811) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 10:52:10.208153) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 10:52:10.208565) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:52:10.208859) ========= 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.WzulBUUkPQ/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.4At5YuyX8N/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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-24 10:52:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-02-24 10:52:10 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.201404 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:52:10.427795) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:52:10.428339) ========= 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.WzulBUUkPQ/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.4At5YuyX8N/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.025944 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:52:10.484656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-24 10:52:10.485265) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 37ab9a732b0635f2d7c5d85b20e14f870cbc4084 --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 37ab9a732b0635f2d7c5d85b20e14f870cbc4084 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WzulBUUkPQ/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.4At5YuyX8N/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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-24 10:52:10,561 truncating revision to first 12 chars 2016-02-24 10:52:10,561 Setting DEBUG logging. 2016-02-24 10:52:10,561 attempt 1/10 2016-02-24 10:52:10,561 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/37ab9a732b06?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-24 10:52:13,158 unpacking tar archive at: fx-team-37ab9a732b06/testing/mozharness/ program finished with exit code 0 elapsedTime=2.853521 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-24 10:52:13.357055) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 10:52:13.357421) ========= echo 37ab9a732b0635f2d7c5d85b20e14f870cbc4084 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'37ab9a732b0635f2d7c5d85b20e14f870cbc4084'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WzulBUUkPQ/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.4At5YuyX8N/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 37ab9a732b0635f2d7c5d85b20e14f870cbc4084 program finished with exit code 0 elapsedTime=0.005291 script_repo_revision: '37ab9a732b0635f2d7c5d85b20e14f870cbc4084' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 10:52:13.411185) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 10:52:13.411796) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 10:52:13.430242) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-24 10:52:13.430831) ========= /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.WzulBUUkPQ/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.4At5YuyX8N/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:52:13 INFO - MultiFileLogger online at 20160224 10:52:13 in /builds/slave/test 10:52:13 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 10:52:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:52:13 INFO - {'append_to_log': False, 10:52:13 INFO - 'base_work_dir': '/builds/slave/test', 10:52:13 INFO - 'blob_upload_branch': 'Fx-Team', 10:52:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:52:13 INFO - 'branch': 'Fx-Team', 10:52:13 INFO - 'buildbot_json_path': 'buildprops.json', 10:52:13 INFO - 'config_files': ('talos/mac_config.py',), 10:52:13 INFO - 'default_actions': ('clobber', 10:52:13 INFO - 'read-buildbot-config', 10:52:13 INFO - 'download-and-extract', 10:52:13 INFO - 'populate-webroot', 10:52:13 INFO - 'create-virtualenv', 10:52:13 INFO - 'install', 10:52:13 INFO - 'run-tests'), 10:52:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:52:13 INFO - 'download_minidump_stackwalk': True, 10:52:13 INFO - 'download_symbols': 'ondemand', 10:52:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:52:13 INFO - 'tooltool.py': '/tools/tooltool.py', 10:52:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:52:13 INFO - '/tools/misc-python/virtualenv.py')}, 10:52:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:52:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:52:13 INFO - 'installer_path': 'installer.exe', 10:52:13 INFO - 'log_level': 'info', 10:52:13 INFO - 'log_name': 'talos', 10:52:13 INFO - 'log_to_console': True, 10:52:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:52:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:52:13 INFO - 'opt_config_files': (), 10:52:13 INFO - 'pip_index': False, 10:52:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:52:13 INFO - 'cmd': ('bash', 10:52:13 INFO - '-c', 10:52:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:52:13 INFO - 'enabled': True, 10:52:13 INFO - 'halt_on_failure': False, 10:52:13 INFO - 'name': 'check_screen_resolution'},), 10:52:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:52:13 INFO - 'cmd': ('bash', 10:52:13 INFO - '-c', 10:52:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:52:13 INFO - 'enabled': True, 10:52:13 INFO - 'halt_on_failure': False, 10:52:13 INFO - 'name': 'check_screen_resolution'},), 10:52:13 INFO - 'run_cmd_checks_enabled': True, 10:52:13 INFO - 'sps_profile': False, 10:52:13 INFO - 'sps_profile_interval': 0, 10:52:13 INFO - 'suite': 'dromaeojs', 10:52:13 INFO - 'system_bits': '32', 10:52:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:52:13 INFO - 'title': 't-yosemite-r7-0025', 10:52:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:52:13 INFO - 'use_talos_json': True, 10:52:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:52:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:52:13 INFO - 'work_dir': 'build'} 10:52:13 INFO - ##### 10:52:13 INFO - ##### Running clobber step. 10:52:13 INFO - ##### 10:52:13 INFO - Running pre-action listener: _resource_record_pre_action 10:52:13 INFO - Running main action method: clobber 10:52:13 INFO - rmtree: /builds/slave/test/build 10:52:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:52:15 INFO - Running post-action listener: _resource_record_post_action 10:52:15 INFO - ##### 10:52:15 INFO - ##### Running read-buildbot-config step. 10:52:15 INFO - ##### 10:52:15 INFO - Running pre-action listener: _resource_record_pre_action 10:52:15 INFO - Running main action method: read_buildbot_config 10:52:15 INFO - Using buildbot properties: 10:52:15 INFO - { 10:52:15 INFO - "project": "", 10:52:15 INFO - "product": "firefox", 10:52:15 INFO - "script_repo_revision": "production", 10:52:15 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 10:52:15 INFO - "repository": "", 10:52:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 10:52:15 INFO - "buildid": "20160224084158", 10:52:15 INFO - "pgo_build": "False", 10:52:15 INFO - "basedir": "/builds/slave/test", 10:52:15 INFO - "buildnumber": 435, 10:52:15 INFO - "slavename": "t-yosemite-r7-0025", 10:52:15 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 10:52:15 INFO - "platform": "yosemite_r7", 10:52:15 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:52:15 INFO - "branch": "fx-team", 10:52:15 INFO - "repo_path": "integration/fx-team", 10:52:15 INFO - "revision": "37ab9a732b0635f2d7c5d85b20e14f870cbc4084", 10:52:15 INFO - "stage_platform": "macosx64", 10:52:15 INFO - "builduid": "db298f2fec8c4f69a7194cafd5bfe7af", 10:52:15 INFO - "slavebuilddir": "test" 10:52:15 INFO - } 10:52:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 10:52:15 INFO - Running post-action listener: _resource_record_post_action 10:52:15 INFO - ##### 10:52:15 INFO - ##### Running download-and-extract step. 10:52:15 INFO - ##### 10:52:15 INFO - Running pre-action listener: _resource_record_pre_action 10:52:15 INFO - Running main action method: download_and_extract 10:52:15 INFO - mkdir: /builds/slave/test/build/tests 10:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:15 INFO - https://queue.taskcluster.net/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:52:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/test_packages.json 10:52:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/test_packages.json 10:52:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:52:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:52:16 INFO - Downloaded 1277 bytes. 10:52:16 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:52:16 INFO - Using the following test package requirements: 10:52:16 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:52:16 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:52:16 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 10:52:16 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:52:16 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 10:52:16 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:52:16 INFO - u'jsshell-mac.zip'], 10:52:16 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:52:16 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 10:52:16 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:52:16 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:52:16 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 10:52:16 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:52:16 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 10:52:16 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:52:16 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 10:52:16 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:52:16 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:52:16 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 10:52:16 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:16 INFO - https://queue.taskcluster.net/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:52:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:52:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:52:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:52:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:52:17 INFO - Downloaded 17827753 bytes. 10:52:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:52:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:52:20 INFO - Return code: 0 10:52:20 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:20 INFO - https://queue.taskcluster.net/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:52:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:52:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:52:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:52:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:52:21 INFO - Downloaded 17827753 bytes. 10:52:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:52:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:52:24 INFO - Return code: 0 10:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:24 INFO - https://queue.taskcluster.net/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:52:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:52:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:52:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:52:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:52:25 INFO - Downloaded 10707015 bytes. 10:52:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:52:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:52:25 INFO - Return code: 0 10:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:25 INFO - https://queue.taskcluster.net/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:52:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:52:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:52:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 10:52:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 10:52:30 INFO - Downloaded 111432192 bytes. 10:52:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:52:30 INFO - mkdir: /builds/slave/test/properties 10:52:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:52:30 INFO - Writing to file /builds/slave/test/properties/build_url 10:52:30 INFO - Contents: 10:52:30 INFO - build_url:https://queue.taskcluster.net/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:52:32 INFO - Running post-action listener: _resource_record_post_action 10:52:32 INFO - Running post-action listener: set_extra_try_arguments 10:52:32 INFO - ##### 10:52:32 INFO - ##### Running populate-webroot step. 10:52:32 INFO - ##### 10:52:32 INFO - Running pre-action listener: _resource_record_pre_action 10:52:32 INFO - Running main action method: populate_webroot 10:52:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:52:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:52:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:52:32 INFO - '--tppagecycles', 10:52:32 INFO - '7'], 10:52:32 INFO - 'tests': ['tsvgm']}}, 10:52:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:52:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:52:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:52:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:52:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:52:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:52:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:32 INFO - 'talos_options': ['--e10s'], 10:52:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:32 INFO - 'tests': ['damp', 'tps']}, 10:52:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:32 INFO - 'talos_options': ['--e10s'], 10:52:32 INFO - 'tests': ['damp', 'tps']}, 10:52:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:52:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:52:32 INFO - 'other': {'tests': ['a11yr', 10:52:32 INFO - 'ts_paint', 10:52:32 INFO - 'tpaint', 10:52:32 INFO - 'sessionrestore', 10:52:32 INFO - 'sessionrestore_no_auto_restore']}, 10:52:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:52:32 INFO - 'tests': ['a11yr', 10:52:32 INFO - 'ts_paint', 10:52:32 INFO - 'tpaint', 10:52:32 INFO - 'sessionrestore', 10:52:32 INFO - 'sessionrestore_no_auto_restore']}, 10:52:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:52:32 INFO - 'tests': ['a11yr', 10:52:32 INFO - 'ts_paint', 10:52:32 INFO - 'tpaint', 10:52:32 INFO - 'sessionrestore', 10:52:32 INFO - 'sessionrestore_no_auto_restore']}, 10:52:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:52:32 INFO - 'tests': ['a11yr', 10:52:32 INFO - 'ts_paint', 10:52:32 INFO - 'tpaint', 10:52:32 INFO - 'sessionrestore', 10:52:32 INFO - 'sessionrestore_no_auto_restore']}, 10:52:32 INFO - 'other_l64': {'tests': ['a11yr', 10:52:32 INFO - 'ts_paint', 10:52:32 INFO - 'tpaint', 10:52:32 INFO - 'sessionrestore', 10:52:32 INFO - 'sessionrestore_no_auto_restore']}, 10:52:32 INFO - 'other_nol64': {'tests': ['a11yr', 10:52:32 INFO - 'ts_paint', 10:52:32 INFO - 'tpaint', 10:52:32 INFO - 'sessionrestore', 10:52:32 INFO - 'sessionrestore_no_auto_restore']}, 10:52:32 INFO - 'svgr': {'tests': ['tsvgx', 10:52:32 INFO - 'tsvgr_opacity', 10:52:32 INFO - 'tart', 10:52:32 INFO - 'tscrollx', 10:52:32 INFO - 'cart']}, 10:52:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:52:32 INFO - 'tests': ['tsvgx', 10:52:32 INFO - 'tsvgr_opacity', 10:52:32 INFO - 'tart', 10:52:32 INFO - 'tscrollx', 10:52:32 INFO - 'cart']}, 10:52:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:32 INFO - 'tests': ['tp5o']}, 10:52:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:32 INFO - 'talos_options': ['--e10s'], 10:52:32 INFO - 'tests': ['tp5o']}, 10:52:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:32 INFO - 'talos_options': ['--xperf_path', 10:52:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:32 INFO - 'tests': ['tp5n']}, 10:52:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:32 INFO - 'talos_options': ['--e10s', 10:52:32 INFO - '--xperf_path', 10:52:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:32 INFO - 'tests': ['tp5n']}}, 10:52:32 INFO - 'talos.zip': {'path': '', 10:52:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:52:32 INFO - Running post-action listener: _resource_record_post_action 10:52:32 INFO - ##### 10:52:32 INFO - ##### Running create-virtualenv step. 10:52:32 INFO - ##### 10:52:32 INFO - Running pre-action listener: _resource_record_pre_action 10:52:32 INFO - Running main action method: create_virtualenv 10:52:32 INFO - Creating virtualenv /builds/slave/test/build/venv 10:52:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:52:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:52:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:52:32 INFO - Using real prefix '/tools/python27' 10:52:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:52:32 INFO - Installing distribute.............................................................................................................................................................................................done. 10:52:35 INFO - Installing pip.................done. 10:52:35 INFO - Return code: 0 10:52:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:35 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 0x103739a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba1adc8750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ddd30>, '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 0x103401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d4b20>, '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.WzulBUUkPQ/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.4At5YuyX8N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:52:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:52:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WzulBUUkPQ/Render', 10:52:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:35 INFO - 'HOME': '/Users/cltbld', 10:52:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:35 INFO - 'LOGNAME': 'cltbld', 10:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:35 INFO - 'MOZ_NO_REMOTE': '1', 10:52:35 INFO - 'NO_EM_RESTART': '1', 10:52:35 INFO - 'PAGER': '/bin/cat', 10:52:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:35 INFO - 'PWD': '/builds/slave/test', 10:52:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:35 INFO - 'SHELL': '/bin/bash', 10:52:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4At5YuyX8N/Listeners', 10:52:35 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 10:52:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:35 INFO - 'USER': 'cltbld', 10:52:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:35 INFO - 'XPC_FLAGS': '0x0', 10:52:35 INFO - 'XPC_SERVICE_NAME': '0', 10:52:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:52:36 INFO - Cleaning up... 10:52:36 INFO - Return code: 0 10:52:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:36 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 0x103739a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba1adc8750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ddd30>, '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 0x103401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d4b20>, '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.WzulBUUkPQ/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.4At5YuyX8N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:52:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:52:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WzulBUUkPQ/Render', 10:52:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:36 INFO - 'HOME': '/Users/cltbld', 10:52:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:36 INFO - 'LOGNAME': 'cltbld', 10:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:36 INFO - 'MOZ_NO_REMOTE': '1', 10:52:36 INFO - 'NO_EM_RESTART': '1', 10:52:36 INFO - 'PAGER': '/bin/cat', 10:52:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:36 INFO - 'PWD': '/builds/slave/test', 10:52:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:36 INFO - 'SHELL': '/bin/bash', 10:52:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4At5YuyX8N/Listeners', 10:52:36 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 10:52:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:36 INFO - 'USER': 'cltbld', 10:52:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:36 INFO - 'XPC_FLAGS': '0x0', 10:52:36 INFO - 'XPC_SERVICE_NAME': '0', 10:52:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:36 INFO - Downloading/unpacking psutil>=0.7.1 10:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:52:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:39 INFO - Installing collected packages: psutil 10:52:39 INFO - Running setup.py install for psutil 10:52:39 INFO - building 'psutil._psutil_osx' extension 10:52:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:52:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:52:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:52:39 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:52:40 INFO - building 'psutil._psutil_posix' extension 10:52:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:52:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:52:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:52:40 INFO - ^ 10:52:40 INFO - 1 warning generated. 10:52:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:52:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:40 INFO - Successfully installed psutil 10:52:40 INFO - Cleaning up... 10:52:40 INFO - Return code: 0 10:52:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:40 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 0x103739a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba1adc8750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ddd30>, '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 0x103401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d4b20>, '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.WzulBUUkPQ/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.4At5YuyX8N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:52:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:52:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WzulBUUkPQ/Render', 10:52:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:40 INFO - 'HOME': '/Users/cltbld', 10:52:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:40 INFO - 'LOGNAME': 'cltbld', 10:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:40 INFO - 'MOZ_NO_REMOTE': '1', 10:52:40 INFO - 'NO_EM_RESTART': '1', 10:52:40 INFO - 'PAGER': '/bin/cat', 10:52:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:40 INFO - 'PWD': '/builds/slave/test', 10:52:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:40 INFO - 'SHELL': '/bin/bash', 10:52:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4At5YuyX8N/Listeners', 10:52:40 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 10:52:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:40 INFO - 'USER': 'cltbld', 10:52:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:40 INFO - 'XPC_FLAGS': '0x0', 10:52:40 INFO - 'XPC_SERVICE_NAME': '0', 10:52:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:52:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:52:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:52:43 INFO - Installing collected packages: mozsystemmonitor 10:52:43 INFO - Running setup.py install for mozsystemmonitor 10:52:43 INFO - Successfully installed mozsystemmonitor 10:52:43 INFO - Cleaning up... 10:52:43 INFO - Return code: 0 10:52:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103739a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba1adc8750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ddd30>, '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 0x103401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d4b20>, '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.WzulBUUkPQ/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.4At5YuyX8N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:52:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:52:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WzulBUUkPQ/Render', 10:52:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:43 INFO - 'HOME': '/Users/cltbld', 10:52:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:43 INFO - 'LOGNAME': 'cltbld', 10:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:43 INFO - 'MOZ_NO_REMOTE': '1', 10:52:43 INFO - 'NO_EM_RESTART': '1', 10:52:43 INFO - 'PAGER': '/bin/cat', 10:52:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:43 INFO - 'PWD': '/builds/slave/test', 10:52:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:43 INFO - 'SHELL': '/bin/bash', 10:52:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4At5YuyX8N/Listeners', 10:52:43 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 10:52:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:43 INFO - 'USER': 'cltbld', 10:52:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:43 INFO - 'XPC_FLAGS': '0x0', 10:52:43 INFO - 'XPC_SERVICE_NAME': '0', 10:52:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:43 INFO - Downloading/unpacking blobuploader==1.2.4 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52:46 INFO - Downloading blobuploader-1.2.4.tar.gz 10:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:52:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:52:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:47 INFO - Downloading docopt-0.6.1.tar.gz 10:52:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:52:47 INFO - Installing collected packages: blobuploader, requests, docopt 10:52:47 INFO - Running setup.py install for blobuploader 10:52:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:52:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:52:47 INFO - Running setup.py install for requests 10:52:47 INFO - Running setup.py install for docopt 10:52:48 INFO - Successfully installed blobuploader requests docopt 10:52:48 INFO - Cleaning up... 10:52:48 INFO - Return code: 0 10:52:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:48 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 0x103739a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba1adc8750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ddd30>, '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 0x103401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d4b20>, '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.WzulBUUkPQ/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.4At5YuyX8N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:52:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:52:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WzulBUUkPQ/Render', 10:52:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:48 INFO - 'HOME': '/Users/cltbld', 10:52:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:48 INFO - 'LOGNAME': 'cltbld', 10:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:48 INFO - 'MOZ_NO_REMOTE': '1', 10:52:48 INFO - 'NO_EM_RESTART': '1', 10:52:48 INFO - 'PAGER': '/bin/cat', 10:52:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:48 INFO - 'PWD': '/builds/slave/test', 10:52:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:48 INFO - 'SHELL': '/bin/bash', 10:52:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4At5YuyX8N/Listeners', 10:52:48 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 10:52:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:48 INFO - 'USER': 'cltbld', 10:52:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:48 INFO - 'XPC_FLAGS': '0x0', 10:52:48 INFO - 'XPC_SERVICE_NAME': '0', 10:52:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:48 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Q8jJRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:48 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-HmkhYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:48 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-zzTb27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:48 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-bKgZWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:48 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-j2VkBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:48 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-elao5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-B7WO0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-gHEGy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-3VIgop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-17tEsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-rYizmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-wOQ9wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-sWAYXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-VYWzj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-G_91tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:49 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-9dLprK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:50 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-XA5Q98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:52:50 INFO - Running setup.py install for manifestparser 10:52:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:52:50 INFO - Running setup.py install for mozcrash 10:52:50 INFO - Running setup.py install for mozdebug 10:52:50 INFO - Running setup.py install for mozdevice 10:52:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:52:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:52:50 INFO - Running setup.py install for mozfile 10:52:50 INFO - Running setup.py install for mozhttpd 10:52:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:52:51 INFO - Running setup.py install for mozinfo 10:52:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:52:51 INFO - Running setup.py install for mozInstall 10:52:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:52:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:52:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:52:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:52:51 INFO - Running setup.py install for mozleak 10:52:51 INFO - Running setup.py install for mozlog 10:52:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:52:51 INFO - Running setup.py install for moznetwork 10:52:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:52:51 INFO - Running setup.py install for mozprocess 10:52:51 INFO - Running setup.py install for mozprofile 10:52:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:52:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:52:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:52:52 INFO - Running setup.py install for mozrunner 10:52:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:52:52 INFO - Running setup.py install for mozscreenshot 10:52:52 INFO - Running setup.py install for moztest 10:52:52 INFO - Running setup.py install for mozversion 10:52:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:52:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:52:52 INFO - Cleaning up... 10:52:52 INFO - Return code: 0 10:52:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:52 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 0x103739a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba1adc8750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ddd30>, '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 0x103401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d4b20>, '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.WzulBUUkPQ/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.4At5YuyX8N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:52:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:52:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WzulBUUkPQ/Render', 10:52:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:52 INFO - 'HOME': '/Users/cltbld', 10:52:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:52 INFO - 'LOGNAME': 'cltbld', 10:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:52 INFO - 'MOZ_NO_REMOTE': '1', 10:52:52 INFO - 'NO_EM_RESTART': '1', 10:52:52 INFO - 'PAGER': '/bin/cat', 10:52:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:52 INFO - 'PWD': '/builds/slave/test', 10:52:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:52 INFO - 'SHELL': '/bin/bash', 10:52:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4At5YuyX8N/Listeners', 10:52:52 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 10:52:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:52 INFO - 'USER': 'cltbld', 10:52:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:52 INFO - 'XPC_FLAGS': '0x0', 10:52:52 INFO - 'XPC_SERVICE_NAME': '0', 10:52:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:53 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-xMSBHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:53 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-olB9UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:53 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-LjtvFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:53 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-5ceYnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:53 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-P2CvYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:53 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-vXwGL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:53 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-L46dGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:53 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Ey9MNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:53 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-4yZvSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:53 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-K3MICD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-p5Ga7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-uDAU9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-DEi9QX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-P5xLJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-9JsqGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-4OwlPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:54 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-WIfdjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:52:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:57 INFO - Downloading blessings-1.6.tar.gz 10:52:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:52:57 INFO - Installing collected packages: blessings 10:52:57 INFO - Running setup.py install for blessings 10:52:57 INFO - Successfully installed blessings 10:52:57 INFO - Cleaning up... 10:52:57 INFO - Return code: 0 10:52:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:52:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:57 INFO - Reading from file tmpfile_stdout 10:52:57 INFO - Current package versions: 10:52:57 INFO - blessings == 1.6 10:52:57 INFO - blobuploader == 1.2.4 10:52:57 INFO - docopt == 0.6.1 10:52:57 INFO - manifestparser == 1.1 10:52:57 INFO - mozInstall == 1.12 10:52:57 INFO - mozcrash == 0.16 10:52:57 INFO - mozdebug == 0.1 10:52:57 INFO - mozdevice == 0.48 10:52:57 INFO - mozfile == 1.2 10:52:57 INFO - mozhttpd == 0.7 10:52:57 INFO - mozinfo == 0.9 10:52:57 INFO - mozleak == 0.1 10:52:57 INFO - mozlog == 3.1 10:52:57 INFO - moznetwork == 0.27 10:52:57 INFO - mozprocess == 0.22 10:52:57 INFO - mozprofile == 0.28 10:52:57 INFO - mozrunner == 6.11 10:52:57 INFO - mozscreenshot == 0.1 10:52:57 INFO - mozsystemmonitor == 0.0 10:52:57 INFO - moztest == 0.7 10:52:57 INFO - mozversion == 1.4 10:52:57 INFO - psutil == 3.1.1 10:52:57 INFO - requests == 1.2.3 10:52:57 INFO - wsgiref == 0.1.2 10:52:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:57 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 0x103739a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba1adc8750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ddd30>, '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 0x103401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d4b20>, '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.WzulBUUkPQ/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.4At5YuyX8N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:52:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:52:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:52:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WzulBUUkPQ/Render', 10:52:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:57 INFO - 'HOME': '/Users/cltbld', 10:52:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:57 INFO - 'LOGNAME': 'cltbld', 10:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:57 INFO - 'MOZ_NO_REMOTE': '1', 10:52:57 INFO - 'NO_EM_RESTART': '1', 10:52:57 INFO - 'PAGER': '/bin/cat', 10:52:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:57 INFO - 'PWD': '/builds/slave/test', 10:52:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:57 INFO - 'SHELL': '/bin/bash', 10:52:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4At5YuyX8N/Listeners', 10:52:57 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 10:52:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:57 INFO - 'USER': 'cltbld', 10:52:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:57 INFO - 'XPC_FLAGS': '0x0', 10:52:57 INFO - 'XPC_SERVICE_NAME': '0', 10:52:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:52:58 INFO - Cleaning up... 10:52:58 INFO - Return code: 0 10:52:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:58 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 0x103739a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba1adc8750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ddd30>, '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 0x103401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d4b20>, '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.WzulBUUkPQ/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.4At5YuyX8N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:52:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:52:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WzulBUUkPQ/Render', 10:52:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:58 INFO - 'HOME': '/Users/cltbld', 10:52:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:58 INFO - 'LOGNAME': 'cltbld', 10:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:58 INFO - 'MOZ_NO_REMOTE': '1', 10:52:58 INFO - 'NO_EM_RESTART': '1', 10:52:58 INFO - 'PAGER': '/bin/cat', 10:52:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:58 INFO - 'PWD': '/builds/slave/test', 10:52:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:58 INFO - 'SHELL': '/bin/bash', 10:52:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4At5YuyX8N/Listeners', 10:52:58 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 10:52:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:58 INFO - 'USER': 'cltbld', 10:52:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:58 INFO - 'XPC_FLAGS': '0x0', 10:52:58 INFO - 'XPC_SERVICE_NAME': '0', 10:52:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:58 INFO - Downloading/unpacking jsonschema 10:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:53:00 INFO - Downloading/unpacking functools32 (from jsonschema) 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53:00 INFO - Downloading functools32-3.2.3-2.tar.gz 10:53:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:53:01 INFO - warning: no files found matching '*.txt' 10:53:01 INFO - no previously-included directories found matching 'build' 10:53:01 INFO - no previously-included directories found matching 'dist' 10:53:01 INFO - no previously-included directories found matching '.git*' 10:53:01 INFO - Installing collected packages: jsonschema, functools32 10:53:01 INFO - Running setup.py install for functools32 10:53:01 INFO - warning: no files found matching '*.txt' 10:53:01 INFO - no previously-included directories found matching 'build' 10:53:01 INFO - no previously-included directories found matching 'dist' 10:53:01 INFO - no previously-included directories found matching '.git*' 10:53:01 INFO - Successfully installed jsonschema functools32 10:53:01 INFO - Cleaning up... 10:53:01 INFO - Return code: 0 10:53:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103739a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037414c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba1adc8750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ddd30>, '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 0x103401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d4b20>, '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.WzulBUUkPQ/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.4At5YuyX8N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:53:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:53:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:53:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WzulBUUkPQ/Render', 10:53:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:01 INFO - 'HOME': '/Users/cltbld', 10:53:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:01 INFO - 'LOGNAME': 'cltbld', 10:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:01 INFO - 'MOZ_NO_REMOTE': '1', 10:53:01 INFO - 'NO_EM_RESTART': '1', 10:53:01 INFO - 'PAGER': '/bin/cat', 10:53:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:01 INFO - 'PWD': '/builds/slave/test', 10:53:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:01 INFO - 'SHELL': '/bin/bash', 10:53:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4At5YuyX8N/Listeners', 10:53:01 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 10:53:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:01 INFO - 'USER': 'cltbld', 10:53:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:01 INFO - 'XPC_FLAGS': '0x0', 10:53:01 INFO - 'XPC_SERVICE_NAME': '0', 10:53:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:01 INFO - Downloading/unpacking flake8 10:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:53:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:53:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:53:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:53:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:53:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:53:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:53:05 INFO - no previously-included directories found matching 'docs/_build' 10:53:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:53:05 INFO - Running setup.py install for pep8 10:53:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:53:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:53:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:53:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:53:05 INFO - no previously-included directories found matching 'docs/_build' 10:53:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:53:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:53:05 INFO - Cleaning up... 10:53:05 INFO - Return code: 0 10:53:05 INFO - Running post-action listener: _resource_record_post_action 10:53:05 INFO - Running post-action listener: _start_resource_monitoring 10:53:05 INFO - Starting resource monitoring. 10:53:05 INFO - ##### 10:53:05 INFO - ##### Running install step. 10:53:05 INFO - ##### 10:53:05 INFO - Running pre-action listener: _resource_record_pre_action 10:53:05 INFO - Running main action method: install 10:53:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:53:05 INFO - Reading from file tmpfile_stdout 10:53:05 INFO - Detecting whether we're running mozinstall >=1.0... 10:53:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:53:05 INFO - Reading from file tmpfile_stdout 10:53:05 INFO - Output received: 10:53:05 INFO - Usage: mozinstall [options] installer 10:53:05 INFO - Options: 10:53:05 INFO - -h, --help show this help message and exit 10:53:05 INFO - -d DEST, --destination=DEST 10:53:05 INFO - Directory to install application into. [default: 10:53:05 INFO - "/builds/slave/test"] 10:53:05 INFO - --app=APP Application being installed. [default: firefox] 10:53:05 INFO - mkdir: /builds/slave/test/build/application 10:53:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:53:39 INFO - Reading from file tmpfile_stdout 10:53:39 INFO - Output received: 10:53:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:53:39 INFO - Running post-action listener: _resource_record_post_action 10:53:39 INFO - ##### 10:53:39 INFO - ##### Running run-tests step. 10:53:39 INFO - ##### 10:53:39 INFO - Running pre-action listener: _resource_record_pre_action 10:53:39 INFO - Running main action method: run_tests 10:53:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:53:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:53:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:53:39 INFO - 2016-02-24 10:53:39.718 screenresolution[1653:7620] starting screenresolution argv=screenresolution get 10:53:39 INFO - 2016-02-24 10:53:39.721 screenresolution[1653:7620] Display 0: 1600x1200x32@60 10:53:39 INFO - 2016-02-24 10:53:39.727 screenresolution[1654:7622] starting screenresolution argv=screenresolution list 10:53:39 INFO - Available Modes on Display 0 10:53:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:53:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:53:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:53:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:53:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:53:39 INFO - Intel Iris: 10:53:39 INFO - Chipset Model: Intel Iris 10:53:39 INFO - Type: GPU 10:53:39 INFO - Bus: Built-In 10:53:39 INFO - VRAM (Dynamic, Max): 1536 MB 10:53:39 INFO - Vendor: Intel (0x8086) 10:53:39 INFO - Device ID: 0x0a2e 10:53:39 INFO - Revision ID: 0x0009 10:53:39 INFO - Displays: 10:53:39 INFO - Display: 10:53:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:53:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:53:39 INFO - Display Serial Number: 1600x1200 60 10:53:39 INFO - Main Display: Yes 10:53:39 INFO - Mirror: Off 10:53:39 INFO - Online: Yes 10:53:39 INFO - Rotation: Supported 10:53:39 INFO - Return code: 0 10:53:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:53:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:53:39 INFO - Python 2.7.3 10:53:39 INFO - Return code: 0 10:53:39 INFO - grabbing minidump binary from tooltool 10:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:39 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 0x1035ddd30>, '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 0x103401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:53:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:53:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:53:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:53:40 INFO - Return code: 0 10:53:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:53:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:53:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:53:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:53:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:53:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:53:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:53:41 INFO - Return code: 0 10:53:41 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/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--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 10:53:41 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/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0025 --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 10:53:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WzulBUUkPQ/Render', 10:53:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:41 INFO - 'HOME': '/Users/cltbld', 10:53:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:41 INFO - 'LOGNAME': 'cltbld', 10:53:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:53:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:41 INFO - 'MOZ_NO_REMOTE': '1', 10:53:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:53:41 INFO - 'NO_EM_RESTART': '1', 10:53:41 INFO - 'PAGER': '/bin/cat', 10:53:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:41 INFO - 'PWD': '/builds/slave/test', 10:53:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:53:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:41 INFO - 'SHELL': '/bin/bash', 10:53:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4At5YuyX8N/Listeners', 10:53:41 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 10:53:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:41 INFO - 'USER': 'cltbld', 10:53:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:41 INFO - 'XPC_FLAGS': '0x0', 10:53:41 INFO - 'XPC_SERVICE_NAME': '0', 10:53:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:41 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/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--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 10:53:41 INFO - mozversion application_buildid: 20160224084158 10:53:41 INFO - mozversion application_changeset: 37ab9a732b0635f2d7c5d85b20e14f870cbc4084 10:53:41 INFO - mozversion application_display_name: Nightly 10:53:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:53:41 INFO - mozversion application_name: Firefox 10:53:41 INFO - mozversion application_remotingname: firefox 10:53:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:53:41 INFO - mozversion application_vendor: Mozilla 10:53:41 INFO - mozversion application_version: 47.0a1 10:53:41 INFO - mozversion platform_buildid: 20160224084158 10:53:41 INFO - mozversion platform_changeset: 37ab9a732b0635f2d7c5d85b20e14f870cbc4084 10:53:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:53:41 INFO - mozversion platform_version: 47.0a1 10:53:41 INFO - using testdate: 1456340021 10:53:41 INFO - actual date: 1456340021 10:53:41 INFO - starting webserver on 'localhost:49282' 10:53:41 INFO - SUITE-START | Running 2 tests 10:53:41 INFO - TEST-START | dromaeo_css 10:53:41 INFO - operating with platform_type : mac_ 10:53:41 INFO - Initialising browser for dromaeo_css test... 10:53:41 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpzmqRmO/profile http://localhost:49282/getInfo.html) 10:53:44 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 10:53:44 INFO - PROCESS | 1672 | colorDepth:24 10:53:44 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 10:53:44 INFO - PROCESS | 1672 | __metrics 10:53:44 INFO - PROCESS | 1672 | 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" 10:53:44 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:53:44 INFO - TEST-INFO | 1672: exit 0 10:53:44 INFO - Browser initialized. 10:53:44 INFO - Running cycle 1/1 for dromaeo_css test... 10:53:44 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpzmqRmO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:56 INFO - PROCESS | 1675 | RSS: Main: 243134464 10:53:56 INFO - PROCESS | 1675 | 10:54:48 INFO - PROCESS | 1675 | 1456340088365 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:56:58 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49282/tests/dromaeo/cssquery-ext.html) 10:56:59 INFO - PROCESS | 1675 | RSS: Main: 357695488 10:56:59 INFO - PROCESS | 1675 | 11:00:02 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-ext.html (next: http://localhost:49282/tests/dromaeo/cssquery-jquery.html) 11:00:02 INFO - PROCESS | 1675 | RSS: Main: 375107584 11:00:02 INFO - PROCESS | 1675 | 11:03:05 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49282/tests/dromaeo/cssquery-mootools.html) 11:03:05 INFO - PROCESS | 1675 | RSS: Main: 375799808 11:03:05 INFO - PROCESS | 1675 | 11:06:07 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49282/tests/dromaeo/cssquery-prototype.html) 11:06:08 INFO - PROCESS | 1675 | RSS: Main: 333918208 11:06:08 INFO - PROCESS | 1675 | 11:09:11 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49282/tests/dromaeo/cssquery-yui.html) 11:09:11 INFO - PROCESS | 1675 | RSS: Main: 337035264 11:09:11 INFO - PROCESS | 1675 | 11:12:14 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-yui.html (next: http://localhost:49282/tests/dromaeo/cssquery-dojo.html) 11:12:15 INFO - PROCESS | 1675 | RSS: Main: 376242176 11:12:15 INFO - PROCESS | 1675 | 11:12:15 INFO - PROCESS | 1675 | __start_tp_report 11:12:15 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 11:12:15 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 11:12:15 INFO - PROCESS | 1675 | |i|pagename|runs| 11:12:15 INFO - PROCESS | 1675 | |0;dojo.html;3417.2652879630878;3467.358538670346;3502.334556434277;3527.8236088195586;3534.7879127252368;5537.640053396526;5637.492625663689;5641;5641.294838145232;5676.489115979561;5606.187102870082;5703.17303990921;5705.800296989606;5709.400512946143;5711.343195532515;5166.612504062192;5184.351956005499;5223.164293713006;5233.869153271161;5290.7354632268425;5296.999999999981;5310.973445132789;5311.203319502067;5314.149736042234;5316.069687804618;5183.637145399824;5227.059129356714;5229.267902493654;5243.659162154467;5294.867628309285;5199.272101905717;5265.552428043621;5266.8419947401635;5282.709450980195;5323.893522129536;4673.742944138071;4763.523647635208;5152.9742351288005;5177.637565370425;5201.323827902386;5564.638298510584;5585.218069470277;5621.550275977912;5636.774529018834;5641.746121424505;6217.347178546278;6218.844528886769;6228.470580000705;6235.251769787609;6240.843978900519;5331.893362132774;5885.829802663283;6085.375114912698;6243.62538247702;6284.905726414107;5764.106563482667;5789.594728368974;5794.449527294901;5800.709964501758;5804.738786754564;6129.325774164839;6249.0938813871735;6261.24865016201;6268.968655156695;6270.216222972129;6103.206583144163;6119.938800612026;6142.324344322121;6144.846378840475;6149.723262453201;6094.756209751649;6123.234595675541;6129.478994285447;6134.662593557308;6157.476614487729;6064.332923378513;6102.267727872683;6136.938630613726;6164.229471316085;6180.938190618036;6115.933800495066;6129.601575897553;6138.539609529304;6138.846528836815;6157.815265542041;4846.273059041101;4886.315915771724;4887.095887260868;4932.975335123301;4963.950360496348;3757.229767897574;4328.28583283761;4347;4406.361077643724;4417.8232870684815;5780.1907732917425;5838.795642152504;5854.443827836349;5860.062390017577;5861.3552509223955;6104.913929256131;6196.1635179251125;6210.4100110490335;6216.627002379872;6217;5749.367569567345;5829.59192856496;5852.122181672783;5857.824265272048;5874.060150375919;4714.787834547454;5252.422233554306;5393.541548968382;5395.028894798896;5399.919001214985;6173.876522469615;6342.682865856781;6354.93645063562;6368.363163683594;6390.648514331757;6104.4200800923845;6202.937970620236;6205.441510264098;6226.719797609209;6231.3145553988115;6330.778422755181;6353.983362661952;6356.364363563606;6366.363363663597;6369.522285828489;6011.669358185167;6104.732011601517;6112.602680825732;6160.876782464236;6177.536684748572;6166.290876549075;6215.627062376272;6239.344868788712;6250;6253.280872699515;6112.724927378367;6118.969405153124;6136.631802091711;6151.108089326933;6153.476954458921;5871.442212989759;6003.609765365237;6048.425399587032;6058.182145410313;6109.450149486567;4943.431505376784;5751.1085781703905;5997.31030931431;5999.100134979788;6002.399760023963;6130;6134.294556126102;6140.631562106288;6144.986077297374;6148.16999705052;4942.851714448572;5801.709914504342;5884.558658100574;5919.230500034968;5952.166696662557 11:12:15 INFO - PROCESS | 1675 | |1;ext.html;494.82928389705586;548.8545535433111;571.9742611582476;590.3624085987134;632.7753647455153;30224;38173.236535269316;38524.03689907754;38605.42091868617;38627;41413.58586414135;41629.58370416295;41669.58330416695;41716.37425438613;41791.79104104483;9399.577019034143;9607.2314214863;9610.663626773065;9614.038596140364;9617.182539484153;9396.060393960617;9540.475273859935;9543.522823858813;9556.61773529058;9658.468784216866;9595.088466595662;9663.178629816473;9677.806443871119;9679.70960871175;9684.322097453181;9562.235021198287;9654;9668.613255469772;9669.274804389664;9675.080867317594;9523.904760952371;9652.490352508328;9666.565004574812;9676.516174191333;9684.661036863676;39569.20861582781;39761.602383976366;39879.8006009971;39919.401208981595;39935.801925942265;2753.6833264174675;3161.525771134325;3183.0450864740487;3219.4687876500348;3509.4735789631504;28393.57409638857;28907.56638650422;28999.840006399718;29201;29748;2577.201067669029;2746.1761471558452;2795.51078561253;2802.5375812990833;2944.9852750736322;316355;374566;374755;375295;375992;43949;44297.33553996692;44417.11165776731;44543.77728111404;44551.55448445539;43309.56690433055;43928.78035609802;43936.560634393885;43969;44000.779996099816;12461.314627695563;14771.704565908622;14941.925290373696;14967.625809354635;14968;12056.578019769266;12131.150819442732;12138;12376.195547289397;12604.55884044054;14516.927415362856;14523.491677791226;14533.709325813425;14535.563933082025;14652;6228.626282422979;6365.2679941806355;6381.202349706286;6381.553291269659;6393.744250229939;947.2374738335706;1055.883852776194;1064.3986147826454;1096.9122470202365;1132.3092913322866;29088.7091129086;29642.83945113217;29791.957281495477;29879;30316.54525182124;899.4962820820361;1063.1016790811752;1096.3367162866512;1172.5954545681898;1180.3685028509706;13202.603921882359;13839.308034598229;14202.644933876736;14215.573532794033;14237.715245695028;436088;442470;565753;566544;677388;54496;54559.18161227585;55101.72449137729;55237.44762552404;55247.723761380934;1424.4871846135384;1436.9281535923162;1443.2422977936458;1443.2639353929571;1554.078332734452;26315.73684263133;31161.844190779808;31285.843570782912;31731.524027140073;31760.841195793873;53121;53164.20253696275;53728;53749.731251343495;53996;407821;411648;411692;411941;412865;40948.59051409567;41667.58332416759;42538.78730606327;43912.780436097615;44061.559384407024;41478.1704365917;41993.58006420019;42553.936151596456;42700.359494606986;42826.38422714403;35758.28483430369;36707.63292367042;37330.88007359784;37730.62269377381;37764.24471510499;35956.820215898755;36240;36242.27515449624;36590.45114323234;36673;35773.64226357703;36800.26399471942;37060;37114;37141.257174856895;26513.86743066272;29843.403131936804;32472.343169650638;33330.83334583312;34277.31445371128;23909.402264943517;24047.51904961856;24242;24452.51094978126;24481.75518244795 11:12:15 INFO - PROCESS | 1675 | |2;jquery.html;359.91901822090034;366.6480179028133;369.130697208075;369.85205917632936;370.80903334782573;15297.694046119072;16048.27782749776;19472;19752.407427777172;20136.59726805463;18988.76573022756;19411.32060377887;19640.21439142436;20325.898370508163;20370.18519259228;3937.665298449621;5427;5519.862003449915;5521.558275337963;5733.226014488053;4126.112885729567;4350.97824510877;4351;4355.782210889459;5676.971615141919;4342.370356298335;4852.781624826891;6237.812865614016;6247.094171345152;6259.71831267594;6124.203853499039;6136.803323351948;6208.503319734433;6224.221972253468;6254.124422580797;5390.730463476811;5401.216823560561;5409;5413.566914646858;5423.945760542423;23731.644025339632;24023;24655.506889862103;24928.37679058038;24963.87662555171;2274.351809734218;2425.6482809992453;2905.215591790226;2908.7672986161056;2911.0539074800777;14243.572692819233;14324.785128223086;14418.49535266271;14641.090963584636;15082.24588770557;1471.5511768910478;1742.4946765438008;1759.384215524556;1779.5817982774038;1821.5264031351944;99907;103768;104322.95677043208;104400.47799760953;104749;10170.644027459004;10439.008294212037;10628.521716522775;10647.414392208348;10694.572217111385;12643.3046182459;12677;12679.556215532411;12691.428885700165;12703.93648031754;8276.875846862302;8400.957995210107;8405.117462666332;8444.873326900102;8483;8565.871511927326;8614.310855131574;8624.698135565224;8678.175573320525;8703.216710496086;6050;6155.692215389213;6163.876722465526;6183.319834818167;6204.875902481925;1664.750287456867;1739.6085880676746;1745.851602613792;1773.8403543680872;1795.398541488616;900.3157600223877;952.172920162437;1078.4769386847372;1085.5332207150843;1115.4590023838432;19196.61606767857;20199.697004544945;20653.070611822204;20683.58632827335;20916;767.0344319866305;814.450246083891;935.8409070457902;965.9184457494111;972.7568107973007;10527.631532896312;10680.62617808373;10705.357678539312;10733.677989660322;10737.731556710989;626537;628136.396067855;634848;637432;647658;95947;103493.96506034843;104691.47654261833;104846;105516;993.3245393132595;1034.9534270957975;1043.3583346242158;1048.156234231451;1063.9202059845388;17909.462716118538;18000.279988800827;18032.09839507993;18103.456896293133;18454;47711.52288477071;49233.75383123205;49469.010619788125;49754.25368619546;49884;62478.68760656349;67332;68070.85256048242;68100.6594967022;68762;8028.157043510348;8032.236937490929;8095.392845536726;8107.391945603986;8266.586670666322;12384.75230495367;12652.114351995271;13103.475860965455;13204.537841175512;13207.867921320663;11341.20611557216;11353.829692554784;11435;11787.764244714886;11790.23363481371;9401.247900168108;10985.121190304597;11359.088657751363;11402.600908968478;11584.189106762446;7035.979782931344;8397.580120993804;10160.136388406772;11750.11874109428;11982.400879955792;7908.209179082046;7990.880136797837;8137.145599711945;8212.137725538732;8328.916710833057;8344.856850460428;11575.768484630093;11679.240849344766;11712.88287117118;11763.294202347886 11:12:15 INFO - PROCESS | 1675 | |3;mootools.html;1397.580725782265;1525.4584622459026;1535.3551508366486;1788.27574832193;1972.4575741671038;7723.768286951394;8523.232909038185;8738.300935925126;8742.125787421255;8746.86879696805;8641.827163456726;8653.61058752356;8789.648414063446;8802.03177650458;8807.427517211378;2171.413718296067;2416.3355077353694;2461.556919754439;2494.550980823451;2495.189063554343;2485.763852434025;2491.0533997081084;2494.114589320792;2501.2746303572035;2503.987480062597;2403.8798060096924;2451.4116612013077;2469.2098528470897;2469.5307891500647;2475.220305603738;2102.978970210309;2415.698037745282;2442.3039433761382;2462.5198086373166;2471.468634243646;2432.586460301753;2450.9754902450927;2462.4090218347646;2463.507298540299;2479.38015496126;8753.649854005833;8827.823443531157;8847.513386763725;8851.380403371766;8858.468491890442;4508.571685689854;5232.189010703347;5547.77808887644;5553.222548843165;5554.72226388683;3248.2691394436297;3608.7293452990866;3712.480252764615;3740.1584643455276;3761.793101379423;1065.1425602390073;1068.647346375702;1072.0619457974271;1101.4823033174396;1102.0742576236;12127.21173123753;12251.632451026484;12285.69285767863;12291.56979505713;12295.954843838284;4247.915041699149;4962.875928101754;4970.229614409773;5051.722155281422;5060.1903695408555;10424.322419042737;10425.895741042645;10432.68701938943;10433.26967112295;10433.895661043443;5549.889002219933;5585.357683866408;5586.301712285965;5586.748596313176;5598.356189038232;4109.547949725527;4450.554944505524;4569.565891240327;4951.257311403318;5012.924806127911;3964.088259700285;3985.621365970228;3997.620226078518;4024.4164596133396;4055.4525139105845;1286.2218357893528;1309.1752196116386;1321.9405126769318;1326.9601911942464;1329.2024785129038;1077.5851297250615;1164.947577359021;1299.6750812296925;1368.2201145347058;1378.4486205517674;8184.7953801155445;8196.631151598192;8219.589020549069;8229.753107406787;8231.382646301552;515.4561937156261;521.0620882411644;1242.136714983078;1274.9107562470724;1301.8177455156285;6250.812475625738;6260.217472815898;6329.968350158219;6338.651374174465;6351.872962540816;10376.792464150825;10920.617778377718;10935.234533582732;11085.50115244816;11095.50070246841;10607.045365917105;10662.733431664115;10875.891241087646;10900.563977440972;10956.397398143019;8252.711155109542;8311.667533298722;8337.95831020853;8480.830383392298;8495.830083398298;7759.806004849924;7942.205779422012;7980.361571074184;7990.800229994296;7993.280604745601;9226.446413215228;9452.810943781224;9679.70960871175;9800.509974501389;9912.603495860374;9702.902970970483;9992.600295988079;10000.099991000845;10192.082712555906;10194.796104077728;6399.360063993563;6629.801105966829;6977.79066628002;7056.8588628226125;7143.964280178566;8200.917990820015;8202.425830191829;8238.546879921661;8265.83468330618;8266.875996859932;7180.964095179491;7319.011933389137;7322.560646361236;7469.14104877946;7474.626268686435;7177.102862142232;7234.927650723425;7282.563046217244;7293.890591641023;7356.485046046725;7660.080790305199;7680.846383072196;7706.691732330868;7711.03612048494;7721.189275126031;6907.274736152632;6968.756093536702;6994.895076573957;7015.754448594274;7023.824404389931;7091.184513780981;7111.573305601681;7157.141143062658;7162.176349719849;7165.140183177844 11:12:15 INFO - PROCESS | 1675 | |4;prototype.html;278.77697841726615;282.6721003635783;316.4367425981753;324.8732994132287;329.1294525978785;6389.265234498034;6460.483161347092;6472.579282346656;6511.283758786536;6603.504737144709;5847;6344.238691357032;6481.64350960697;6497.870042599146;6528.738850445989;4454.910901781963;4618.099470603233;4840.6369522285795;4858;4858.149823780842;4713.811447542094;4716.693414928019;4777.546133117348;4811.302361157647;4820.758962051884;4814.879628009293;4827.61379089672;4851.956829281704;4866.805327786884;4867.975660121694;4596.816127354902;4671.205894997858;4845.394325709286;4845.685030473026;4848.612111031109;3362.8150451725146;4098.508179018507;4111.157212771374;4130.814113364906;4134.545200027995;6267.404596563365;6280;6283.717232724538;6302.4958003359625;6328.272248691414;5705.942940570582;5708.686022268774;5713.714314284311;5716.685582292972;5738.569607279471;5638.689872057076;6305.77037477692;7028.718851245944;7037.507374483788;7048.330408611174;4486.416765820422;4587.632989360844;4644.256918892961;4652.255639097728;4682.6019788318035;7424.406047516186;7447.776566703008;7458.664360103754;7474.663640136207;7479.813004674872;4754.310624959361;4756.6670333077045;4759.881002974884;4765.26138448541;4767.547083027107;4827.227643577011;4840.249761287007;4840.394950631171;4849.854504364875;4855.053264613437;5717.799877004285;5739.282589676291;5747.195392645033;5758.165066065397;5760.567957403212;6858.897116543256;7048.991037554272;7054.788356349318;7055.788326350218;7105.82235444118;1660.5350501859498;1667.733162693963;1681.9831801682071;1684.1410880451058;1685.0900513722452;912.7723212279474;1082.71849319176;1092.82514797632;1093.7320356512546;1103.100972707241;6476.805695829133;6590.80227593173;6670.799876003728;6756.189257289157;6794.626295553792;7418.777436676908;7422.406207503387;7428.220036896048;7438.4049276057785;7441;6731;6743.258241593421;6743.5953842769595;6751.797446076625;6753.49348798842;3836.1176929306416;3895.2793733159456;3895.844166233319;3897.590752970897;3902.3366027775346;7496.325330720261;7757.146713861471;7774.92225077742;7786.026746656668;7795.883061753965;7597.050368703912;7608.923910760932;7635.312821846061;7639.579823109782;7646.4265180111715;7691.884621730678;7701.730439434593;7702.614869256403;7703.34521565662;7718.112417072109;5921.733521991435;7058.682359293742;7348.191698913222;7363.453674728367;7367;7190.352868241884;7236.638168091469;7237.312455316736;7241.818954526179;7255.2019277878335;7665.425093117927;7690.577018264049;7692.461527693008;7695.038120234971;7697.807554811175;4183.64031689696;4306.806193721352;4616.884577885579;4619;4623.190941585141;6282.717277722422;6960.234374218933;6979.40675042627;7301.269873012869;7314.158871729819;7018.929810702032;7089.539179953286;7092.822679433056;7100.680469378787;7105.609191494517;6944.305569443015;6948.096747422803;6953.269906659728;6955.930440695528;6966.233714291525;5606.551475881838;6043.848903777441;6521.69566086775;6855.828604284933;6857.27998560164;6779.593224406552;7041.43668506508;7047.189573199148;7052.788416347517;7068.469864760061;5614.943850561442;6634.9004764927595;6729.091572637827;6769.1876974763345;6953.548019378724 11:12:15 INFO - PROCESS | 1675 | |5;yui.html;661.5666738286423;719.1190791280678;728.2644529025682;746.2015643261709;765.7319938021697;14609.443347414213;14830.48093316734;15034.09795412276;15062.246887655614;15101;13872.653183670413;13884;13904.791428128587;13915;13920.651983700413;710.1974768511575;719.7049209823973;860.148453031499;870.5516658920661;878.4597472554365;847.8770578266148;869.0006492533573;872.2585802068255;872.7425409504211;874.3573473496974;916.6791622931954;920.9309301802358;921.0559176843722;921.8663293822425;922.3267015078997;744.2334395572569;905.2622112977901;917.5366439947817;920.1212841736126;921.3412410126791;679.4937771360319;679.6601699150425;680.993190068098;684.4216636941776;685.5578152091923;14384;14412.495562655256;14415;14439.205843678594;14446.205458699767;10262.846057309147;12141.575044873387;12151.696207594792;12327.506899724;12581.559645412366;10090.64682736108;10142.543585538668;10193.184545236363;10273.537690803858;10829.620963266327;3457.792532448061;3501.894943151684;3516.859325626972;3518.894433167009;3520.7887526748477;79062.20937790607;80465.59767201127;80511.19488805038;81364;81569;9406.90593094074;9444.8583271251;9494.620215191453;9686.515674216262;10100.494975251208;20673.069711863;20859.58280834375;20882.47793805167;20912.895435522725;20918.895405522875;7305.269473052652;7453.105627324648;7613.885791713129;7661.233876612406;7726.227377262341;4030.294698427822;4050.5949405059846;4076.2662720709964;4081.571434999342;4100.815463304159;3477.078574177845;3481.669241422061;3505.8772942946875;3508.3509550733197;3520.06718219672;632.9240491141093;639.3734140542294;646.8997305417668;648.7826578096297;664.139938779282;526.7471613625481;552.7512619321321;603.9275088980257;613.2610204703321;624.5940138909745;8587.957060214783;9054.937149023772;9120.133587309196;9141.31440141992;9227.215686666574;437.1235672476664;585.1135529672549;592.5763079398251;609.5587173370623;615.8121772859321;3793.81030948457;3974.2250261199365;4048.332025215865;4089.7750623715388;4151.8339266429;91361.43192840331;92413;94812.57781133289;95902;96752.51623741836;63068.05397919035;80486;81850.59074704707;82723.58638206891;83153;70793.2920670797;72201.6389918047;72644.54710905858;73232.26767732362;75210;8773.912260877309;8823.69117080899;8913;8941.418807777474;8992.820143597222;37985.62014379821;52774;52900.47099528956;53786.46213537971;54255.45744542504;71062;73502.63248683722;73549.85151039589;73607;75064;10686;10824;10940.56237750481;11042.668719938414;11638.185327027366;10096.94951525267;11920.940395298316;12164.330961797186;12342.382880856101;12467.1273010892;11146.442677866236;11175.608853690082;11547.653570392902;11650.6504804856;11717.00405465545;11408.007286551705;11416.771664566828;11623.12826537996;11624.825627615422;11655.358955257543;10849.945750271514;11084.224104312621;11443.771124577628;11447.771044579229;11474.598389056342;8006.95996520037;9001.774955626162;9090.909090909006;9490.383125096847;9518.762030949281;9024.729258122266;9649.710508684751;9865.95067024689;9950.35322704022;10037.247206459399 11:12:15 INFO - PROCESS | 1675 | __end_tp_report 11:12:15 INFO - PROCESS | 1675 | __start_cc_report 11:12:15 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1073 11:12:15 INFO - PROCESS | 1675 | __end_cc_report 11:12:15 INFO - PROCESS | 1675 | __startTimestamp1456341135196__endTimestamp 11:12:15 INFO - PROCESS | 1675 | 11:12:15 INFO - PROCESS | 1675 | ------- Summary: start ------- 11:12:15 INFO - PROCESS | 1675 | Number of tests: 6 11:12:15 INFO - PROCESS | 1675 | 11:12:15 INFO - PROCESS | 1675 | [#0] dojo.html Cycles:165 Average:5708.46 Median:5885.83 stddev:640.51 (10.9%) stddev-sans-first:616.74 11:12:15 INFO - PROCESS | 1675 | Values: 3417.3 3467.4 3502.3 3527.8 3534.8 5537.6 5637.5 5641.0 5641.3 5676.5 5606.2 5703.2 5705.8 5709.4 5711.3 5166.6 5184.4 5223.2 5233.9 5290.7 5297.0 5311.0 5311.2 5314.1 5316.1 5183.6 5227.1 5229.3 5243.7 5294.9 5199.3 5265.6 5266.8 5282.7 5323.9 4673.7 4763.5 5153.0 5177.6 5201.3 5564.6 5585.2 5621.6 5636.8 5641.7 6217.3 6218.8 6228.5 6235.3 6240.8 5331.9 5885.8 6085.4 6243.6 6284.9 5764.1 5789.6 5794.4 5800.7 5804.7 6129.3 6249.1 6261.2 6269.0 6270.2 6103.2 6119.9 6142.3 6144.8 6149.7 6094.8 6123.2 6129.5 6134.7 6157.5 6064.3 6102.3 6136.9 6164.2 6180.9 6115.9 6129.6 6138.5 6138.8 6157.8 4846.3 4886.3 4887.1 4933.0 4964.0 3757.2 4328.3 4347.0 4406.4 4417.8 5780.2 5838.8 5854.4 5860.1 5861.4 6104.9 6196.2 6210.4 6216.6 6217.0 5749.4 5829.6 5852.1 5857.8 5874.1 4714.8 5252.4 5393.5 5395.0 5399.9 6173.9 6342.7 6354.9 6368.4 6390.6 6104.4 6202.9 6205.4 6226.7 6231.3 6330.8 6354.0 6356.4 6366.4 6369.5 6011.7 6104.7 6112.6 6160.9 6177.5 6166.3 6215.6 6239.3 6250.0 6253.3 6112.7 6119.0 6136.6 6151.1 6153.5 5871.4 6003.6 6048.4 6058.2 6109.5 4943.4 5751.1 5997.3 5999.1 6002.4 6130.0 6134.3 6140.6 6145.0 6148.2 4942.9 5801.7 5884.6 5919.2 5952.2 11:12:15 INFO - PROCESS | 1675 | 11:12:15 INFO - PROCESS | 1675 | [#1] ext.html Cycles:180 Average:57965.14 Median:38564.73 stddev:118833.29 (308.1%) stddev-sans-first:119088.31 11:12:15 INFO - PROCESS | 1675 | Values: 494.8 548.9 572.0 590.4 632.8 30224.0 38173.2 38524.0 38605.4 38627.0 41413.6 41629.6 41669.6 41716.4 41791.8 9399.6 9607.2 9610.7 9614.0 9617.2 9396.1 9540.5 9543.5 9556.6 9658.5 9595.1 9663.2 9677.8 9679.7 9684.3 9562.2 9654.0 9668.6 9669.3 9675.1 9523.9 9652.5 9666.6 9676.5 9684.7 39569.2 39761.6 39879.8 39919.4 39935.8 2753.7 3161.5 3183.0 3219.5 3509.5 28393.6 28907.6 28999.8 29201.0 29748.0 2577.2 2746.2 2795.5 2802.5 2945.0 316355.0 374566.0 374755.0 375295.0 375992.0 43949.0 44297.3 44417.1 44543.8 44551.6 43309.6 43928.8 43936.6 43969.0 44000.8 12461.3 14771.7 14941.9 14967.6 14968.0 12056.6 12131.2 12138.0 12376.2 12604.6 14516.9 14523.5 14533.7 14535.6 14652.0 6228.6 6365.3 6381.2 6381.6 6393.7 947.2 1055.9 1064.4 1096.9 1132.3 29088.7 29642.8 29792.0 29879.0 30316.5 899.5 1063.1 1096.3 1172.6 1180.4 13202.6 13839.3 14202.6 14215.6 14237.7 436088.0 442470.0 565753.0 566544.0 677388.0 54496.0 54559.2 55101.7 55237.4 55247.7 1424.5 1436.9 1443.2 1443.3 1554.1 26315.7 31161.8 31285.8 31731.5 31760.8 53121.0 53164.2 53728.0 53749.7 53996.0 407821.0 411648.0 411692.0 411941.0 412865.0 40948.6 41667.6 42538.8 43912.8 44061.6 41478.2 41993.6 42553.9 42700.4 42826.4 35758.3 36707.6 37330.9 37730.6 37764.2 35956.8 36240.0 36242.3 36590.5 36673.0 35773.6 36800.3 37060.0 37114.0 37141.3 26513.9 29843.4 32472.3 33330.8 34277.3 23909.4 24047.5 24242.0 24452.5 24481.8 11:12:15 INFO - PROCESS | 1675 | 11:12:15 INFO - PROCESS | 1675 | [#2] jquery.html Cycles:180 Average:34409.58 Median:24791.94 stddev:104714.85 (422.4%) stddev-sans-first:104977.39 11:12:15 INFO - PROCESS | 1675 | Values: 359.9 366.6 369.1 369.9 370.8 15297.7 16048.3 19472.0 19752.4 20136.6 18988.8 19411.3 19640.2 20325.9 20370.2 3937.7 5427.0 5519.9 5521.6 5733.2 4126.1 4351.0 4351.0 4355.8 5677.0 4342.4 4852.8 6237.8 6247.1 6259.7 6124.2 6136.8 6208.5 6224.2 6254.1 5390.7 5401.2 5409.0 5413.6 5423.9 23731.6 24023.0 24655.5 24928.4 24963.9 2274.4 2425.6 2905.2 2908.8 2911.1 14243.6 14324.8 14418.5 14641.1 15082.2 1471.6 1742.5 1759.4 1779.6 1821.5 99907.0 103768.0 104323.0 104400.5 104749.0 10170.6 10439.0 10628.5 10647.4 10694.6 12643.3 12677.0 12679.6 12691.4 12703.9 8276.9 8401.0 8405.1 8444.9 8483.0 8565.9 8614.3 8624.7 8678.2 8703.2 6050.0 6155.7 6163.9 6183.3 6204.9 1664.8 1739.6 1745.9 1773.8 1795.4 900.3 952.2 1078.5 1085.5 1115.5 19196.6 20199.7 20653.1 20683.6 20916.0 767.0 814.5 935.8 965.9 972.8 10527.6 10680.6 10705.4 10733.7 10737.7 626537.0 628136.4 634848.0 637432.0 647658.0 95947.0 103494.0 104691.5 104846.0 105516.0 993.3 1035.0 1043.4 1048.2 1063.9 17909.5 18000.3 18032.1 18103.5 18454.0 47711.5 49233.8 49469.0 49754.3 49884.0 62478.7 67332.0 68070.9 68100.7 68762.0 8028.2 8032.2 8095.4 8107.4 8266.6 12384.8 12652.1 13103.5 13204.5 13207.9 11341.2 11353.8 11435.0 11787.8 11790.2 9401.2 10985.1 11359.1 11402.6 11584.2 7036.0 8397.6 10160.1 11750.1 11982.4 7908.2 7990.9 8137.1 8212.1 8328.9 8344.9 11575.8 11679.2 11712.9 11763.3 11:12:15 INFO - PROCESS | 1675 | 11:12:15 INFO - PROCESS | 1675 | [#3] mootools.html Cycles:180 Average:6078.30 Median:5055.96 stddev:3240.47 (64.1%) stddev-sans-first:3230.46 11:12:15 INFO - PROCESS | 1675 | Values: 1397.6 1525.5 1535.4 1788.3 1972.5 7723.8 8523.2 8738.3 8742.1 8746.9 8641.8 8653.6 8789.6 8802.0 8807.4 2171.4 2416.3 2461.6 2494.6 2495.2 2485.8 2491.1 2494.1 2501.3 2504.0 2403.9 2451.4 2469.2 2469.5 2475.2 2103.0 2415.7 2442.3 2462.5 2471.5 2432.6 2451.0 2462.4 2463.5 2479.4 8753.6 8827.8 8847.5 8851.4 8858.5 4508.6 5232.2 5547.8 5553.2 5554.7 3248.3 3608.7 3712.5 3740.2 3761.8 1065.1 1068.6 1072.1 1101.5 1102.1 12127.2 12251.6 12285.7 12291.6 12296.0 4247.9 4962.9 4970.2 5051.7 5060.2 10424.3 10425.9 10432.7 10433.3 10433.9 5549.9 5585.4 5586.3 5586.7 5598.4 4109.5 4450.6 4569.6 4951.3 5012.9 3964.1 3985.6 3997.6 4024.4 4055.5 1286.2 1309.2 1321.9 1327.0 1329.2 1077.6 1164.9 1299.7 1368.2 1378.4 8184.8 8196.6 8219.6 8229.8 8231.4 515.5 521.1 1242.1 1274.9 1301.8 6250.8 6260.2 6330.0 6338.7 6351.9 10376.8 10920.6 10935.2 11085.5 11095.5 10607.0 10662.7 10875.9 10900.6 10956.4 8252.7 8311.7 8338.0 8480.8 8495.8 7759.8 7942.2 7980.4 7990.8 7993.3 9226.4 9452.8 9679.7 9800.5 9912.6 9702.9 9992.6 10000.1 10192.1 10194.8 6399.4 6629.8 6977.8 7056.9 7144.0 8200.9 8202.4 8238.5 8265.8 8266.9 7181.0 7319.0 7322.6 7469.1 7474.6 7177.1 7234.9 7282.6 7293.9 7356.5 7660.1 7680.8 7706.7 7711.0 7721.2 6907.3 6968.8 6994.9 7015.8 7023.8 7091.2 7111.6 7157.1 7162.2 7165.1 11:12:15 INFO - PROCESS | 1675 | 11:12:15 INFO - PROCESS | 1675 | [#4] prototype.html Cycles:180 Average:5752.38 Median:6474.69 stddev:1847.04 (28.5%) stddev-sans-first:1805.96 11:12:15 INFO - PROCESS | 1675 | Values: 278.8 282.7 316.4 324.9 329.1 6389.3 6460.5 6472.6 6511.3 6603.5 5847.0 6344.2 6481.6 6497.9 6528.7 4454.9 4618.1 4840.6 4858.0 4858.1 4713.8 4716.7 4777.5 4811.3 4820.8 4814.9 4827.6 4852.0 4866.8 4868.0 4596.8 4671.2 4845.4 4845.7 4848.6 3362.8 4098.5 4111.2 4130.8 4134.5 6267.4 6280.0 6283.7 6302.5 6328.3 5705.9 5708.7 5713.7 5716.7 5738.6 5638.7 6305.8 7028.7 7037.5 7048.3 4486.4 4587.6 4644.3 4652.3 4682.6 7424.4 7447.8 7458.7 7474.7 7479.8 4754.3 4756.7 4759.9 4765.3 4767.5 4827.2 4840.2 4840.4 4849.9 4855.1 5717.8 5739.3 5747.2 5758.2 5760.6 6858.9 7049.0 7054.8 7055.8 7105.8 1660.5 1667.7 1682.0 1684.1 1685.1 912.8 1082.7 1092.8 1093.7 1103.1 6476.8 6590.8 6670.8 6756.2 6794.6 7418.8 7422.4 7428.2 7438.4 7441.0 6731.0 6743.3 6743.6 6751.8 6753.5 3836.1 3895.3 3895.8 3897.6 3902.3 7496.3 7757.1 7774.9 7786.0 7795.9 7597.1 7608.9 7635.3 7639.6 7646.4 7691.9 7701.7 7702.6 7703.3 7718.1 5921.7 7058.7 7348.2 7363.5 7367.0 7190.4 7236.6 7237.3 7241.8 7255.2 7665.4 7690.6 7692.5 7695.0 7697.8 4183.6 4306.8 4616.9 4619.0 4623.2 6282.7 6960.2 6979.4 7301.3 7314.2 7018.9 7089.5 7092.8 7100.7 7105.6 6944.3 6948.1 6953.3 6955.9 6966.2 5606.6 6043.8 6521.7 6855.8 6857.3 6779.6 7041.4 7047.2 7052.8 7068.5 5614.9 6634.9 6729.1 6769.2 6953.5 11:12:15 INFO - PROCESS | 1675 | 11:12:15 INFO - PROCESS | 1675 | [#5] yui.html Cycles:180 Average:18571.39 Median:620.20 stddev:26382.43 (4253.8%) stddev-sans-first:26422.16 11:12:15 INFO - PROCESS | 1675 | Values: 661.6 719.1 728.3 746.2 765.7 14609.4 14830.5 15034.1 15062.2 15101.0 13872.7 13884.0 13904.8 13915.0 13920.7 710.2 719.7 860.1 870.6 878.5 847.9 869.0 872.3 872.7 874.4 916.7 920.9 921.1 921.9 922.3 744.2 905.3 917.5 920.1 921.3 679.5 679.7 681.0 684.4 685.6 14384.0 14412.5 14415.0 14439.2 14446.2 10262.8 12141.6 12151.7 12327.5 12581.6 10090.6 10142.5 10193.2 10273.5 10829.6 3457.8 3501.9 3516.9 3518.9 3520.8 79062.2 80465.6 80511.2 81364.0 81569.0 9406.9 9444.9 9494.6 9686.5 10100.5 20673.1 20859.6 20882.5 20912.9 20918.9 7305.3 7453.1 7613.9 7661.2 7726.2 4030.3 4050.6 4076.3 4081.6 4100.8 3477.1 3481.7 3505.9 3508.4 3520.1 632.9 639.4 646.9 648.8 664.1 526.7 552.8 603.9 613.3 624.6 8588.0 9054.9 9120.1 9141.3 9227.2 437.1 585.1 592.6 609.6 615.8 3793.8 3974.2 4048.3 4089.8 4151.8 91361.4 92413.0 94812.6 95902.0 96752.5 63068.1 80486.0 81850.6 82723.6 83153.0 70793.3 72201.6 72644.5 73232.3 75210.0 8773.9 8823.7 8913.0 8941.4 8992.8 37985.6 52774.0 52900.5 53786.5 54255.5 71062.0 73502.6 73549.9 73607.0 75064.0 10686.0 10824.0 10940.6 11042.7 11638.2 10096.9 11920.9 12164.3 12342.4 12467.1 11146.4 11175.6 11547.7 11650.7 11717.0 11408.0 11416.8 11623.1 11624.8 11655.4 10849.9 11084.2 11443.8 11447.8 11474.6 8007.0 9001.8 9090.9 9490.4 9518.8 9024.7 9649.7 9866.0 9950.4 10037.2 11:12:15 INFO - PROCESS | 1675 | -------- Summary: end -------- 11:12:15 INFO - PROCESS | 1675 | 11:12:15 INFO - TEST-INFO | 1675: exit 0 11:12:15 INFO - TEST-OK | dromaeo_css | took 1113815ms 11:12:15 INFO - TEST-START | kraken 11:12:15 INFO - operating with platform_type : mac_ 11:12:15 INFO - Initialising browser for kraken test... 11:12:15 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpLaMDty/profile http://localhost:49282/getInfo.html) 11:12:17 INFO - PROCESS | 1685 | __metrics Screen width/height:1600/1200 11:12:17 INFO - PROCESS | 1685 | colorDepth:24 11:12:17 INFO - PROCESS | 1685 | Browser inner width/height: 1024/689 11:12:17 INFO - PROCESS | 1685 | __metrics 11:12:17 INFO - PROCESS | 1685 | 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" 11:12:17 INFO - PROCESS | 1685 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:12:18 INFO - TEST-INFO | 1685: exit 0 11:12:18 INFO - Browser initialized. 11:12:18 INFO - Running cycle 1/1 for kraken test... 11:12:18 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpLaMDty/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:12:30 INFO - PROCESS | 1687 | RSS: Main: 243175424 11:12:30 INFO - PROCESS | 1687 | 11:12:33 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection) 11:12:33 INFO - PROCESS | 1687 | RSS: Main: 288837632 11:12:33 INFO - PROCESS | 1687 | 11:12:36 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-dft) 11:12:37 INFO - PROCESS | 1687 | RSS: Main: 300384256 11:12:37 INFO - PROCESS | 1687 | 11:12:40 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-fft) 11:12:41 INFO - PROCESS | 1687 | RSS: Main: 285413376 11:12:41 INFO - PROCESS | 1687 | 11:12:42 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator) 11:12:43 INFO - PROCESS | 1687 | RSS: Main: 287481856 11:12:43 INFO - PROCESS | 1687 | 11:12:45 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:12:46 INFO - PROCESS | 1687 | RSS: Main: 289452032 11:12:46 INFO - PROCESS | 1687 | 11:12:48 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom) 11:12:49 INFO - PROCESS | 1687 | RSS: Main: 289357824 11:12:49 INFO - PROCESS | 1687 | 11:12:52 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate) 11:12:52 INFO - PROCESS | 1687 | RSS: Main: 291577856 11:12:52 INFO - PROCESS | 1687 | 11:12:55 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial) 11:12:56 INFO - PROCESS | 1687 | RSS: Main: 291704832 11:12:56 INFO - PROCESS | 1687 | 11:12:57 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:12:58 INFO - PROCESS | 1687 | RSS: Main: 325292032 11:12:58 INFO - PROCESS | 1687 | 11:13:00 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:13:00 INFO - PROCESS | 1687 | RSS: Main: 325443584 11:13:00 INFO - PROCESS | 1687 | 11:13:02 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:13:03 INFO - PROCESS | 1687 | RSS: Main: 330866688 11:13:03 INFO - PROCESS | 1687 | 11:13:06 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:13:06 INFO - PROCESS | 1687 | RSS: Main: 333058048 11:13:06 INFO - PROCESS | 1687 | 11:13:09 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:13:09 INFO - PROCESS | 1687 | RSS: Main: 333631488 11:13:09 INFO - PROCESS | 1687 | 11:13:11 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49282/tests/kraken/driver.html?testName=ai-astar) 11:13:11 INFO - PROCESS | 1687 | RSS: Main: 394661888 11:13:11 INFO - PROCESS | 1687 | 11:13:11 INFO - PROCESS | 1687 | __start_tp_report 11:13:11 INFO - PROCESS | 1687 | _x_x_mozilla_page_load 11:13:11 INFO - PROCESS | 1687 | _x_x_mozilla_page_load_details 11:13:11 INFO - PROCESS | 1687 | |i|pagename|runs| 11:13:11 INFO - PROCESS | 1687 | |0;ai-astar;109;107;112;109;111;111;115;109;111;109 11:13:11 INFO - PROCESS | 1687 | |1;audio-beat-detection;157;121;143;157;121;150;172;143;178;120 11:13:11 INFO - PROCESS | 1687 | |2;audio-dft;183;184;185;183;189;185;185;185;181;183 11:13:11 INFO - PROCESS | 1687 | |3;audio-fft;80;75;88;78;58;58;57;80;102;55 11:13:11 INFO - PROCESS | 1687 | |4;audio-oscillator;94;92;124;80;79;83;109;79;78;114 11:13:11 INFO - PROCESS | 1687 | |5;imaging-gaussian-blur;83;89;84;89;84;89;82;89;83;89 11:13:11 INFO - PROCESS | 1687 | |6;imaging-darkroom;93;94;93;93;93;101;130;93;93;92 11:13:11 INFO - PROCESS | 1687 | |7;imaging-desaturate;86;85;84;84;84;85;85;86;84;83 11:13:11 INFO - PROCESS | 1687 | |8;json-parse-financial;55;54;53;54;54;53;52;64;53;52 11:13:11 INFO - PROCESS | 1687 | |9;json-stringify-tinderbox;61;69;67;75;70;66;65;67;68;66 11:13:11 INFO - PROCESS | 1687 | |10;stanford-crypto-aes;82;83;84;83;81;83;82;81;79;80 11:13:11 INFO - PROCESS | 1687 | |11;stanford-crypto-ccm;129;143;135;112;128;128;130;129;124;126 11:13:11 INFO - PROCESS | 1687 | |12;stanford-crypto-pbkdf2;133;128;140;138;140;128;140;139;134;138 11:13:11 INFO - PROCESS | 1687 | |13;stanford-crypto-sha256-iterative;67;68;66;67;66;68;67;64;65;62 11:13:11 INFO - PROCESS | 1687 | __end_tp_report 11:13:11 INFO - PROCESS | 1687 | __start_cc_report 11:13:11 INFO - PROCESS | 1687 | _x_x_mozilla_cycle_collect,1151 11:13:11 INFO - PROCESS | 1687 | __end_cc_report 11:13:11 INFO - PROCESS | 1687 | __startTimestamp1456341191614__endTimestamp 11:13:11 INFO - PROCESS | 1687 | 11:13:11 INFO - PROCESS | 1687 | ------- Summary: start ------- 11:13:11 INFO - PROCESS | 1687 | Number of tests: 14 11:13:11 INFO - PROCESS | 1687 | 11:13:11 INFO - PROCESS | 1687 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.21 (2.0%) stddev-sans-first:2.30 11:13:11 INFO - PROCESS | 1687 | Values: 109.0 107.0 112.0 109.0 111.0 111.0 115.0 109.0 111.0 109.0 11:13:11 INFO - PROCESS | 1687 | 11:13:11 INFO - PROCESS | 1687 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:153.50 stddev:20.82 (13.6%) stddev-sans-first:21.71 11:13:11 INFO - PROCESS | 1687 | Values: 157.0 121.0 143.0 157.0 121.0 150.0 172.0 143.0 178.0 120.0 11:13:11 INFO - PROCESS | 1687 | 11:13:11 INFO - PROCESS | 1687 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.00 stddev:2.11 (1.1%) stddev-sans-first:2.19 11:13:11 INFO - PROCESS | 1687 | Values: 183.0 184.0 185.0 183.0 189.0 185.0 185.0 185.0 181.0 183.0 11:13:11 INFO - PROCESS | 1687 | 11:13:11 INFO - PROCESS | 1687 | [#3] audio-fft Cycles:10 Average:73.10 Median:76.50 stddev:15.72 (20.5%) stddev-sans-first:16.47 11:13:11 INFO - PROCESS | 1687 | Values: 80.0 75.0 88.0 78.0 58.0 58.0 57.0 80.0 102.0 55.0 11:13:11 INFO - PROCESS | 1687 | 11:13:11 INFO - PROCESS | 1687 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:79.50 stddev:16.82 (21.2%) stddev-sans-first:17.84 11:13:11 INFO - PROCESS | 1687 | Values: 94.0 92.0 124.0 80.0 79.0 83.0 109.0 79.0 78.0 114.0 11:13:11 INFO - PROCESS | 1687 | 11:13:11 INFO - PROCESS | 1687 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:89.00 stddev:3.11 (3.5%) stddev-sans-first:3.09 11:13:11 INFO - PROCESS | 1687 | Values: 83.0 89.0 84.0 89.0 84.0 89.0 82.0 89.0 83.0 89.0 11:13:11 INFO - PROCESS | 1687 | 11:13:11 INFO - PROCESS | 1687 | [#6] imaging-darkroom Cycles:10 Average:97.50 Median:93.00 stddev:11.70 (12.6%) stddev-sans-first:12.30 11:13:11 INFO - PROCESS | 1687 | Values: 93.0 94.0 93.0 93.0 93.0 101.0 130.0 93.0 93.0 92.0 11:13:11 INFO - PROCESS | 1687 | 11:13:11 INFO - PROCESS | 1687 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.97 (1.1%) stddev-sans-first:0.88 11:13:11 INFO - PROCESS | 1687 | Values: 86.0 85.0 84.0 84.0 84.0 85.0 85.0 86.0 84.0 83.0 11:13:11 INFO - PROCESS | 1687 | 11:13:11 INFO - PROCESS | 1687 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:3.50 (6.5%) stddev-sans-first:3.71 11:13:11 INFO - PROCESS | 1687 | Values: 55.0 54.0 53.0 54.0 54.0 53.0 52.0 64.0 53.0 52.0 11:13:11 INFO - PROCESS | 1687 | 11:13:11 INFO - PROCESS | 1687 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:3.63 (5.4%) stddev-sans-first:3.02 11:13:11 INFO - PROCESS | 1687 | Values: 61.0 69.0 67.0 75.0 70.0 66.0 65.0 67.0 68.0 66.0 11:13:11 INFO - PROCESS | 1687 | 11:13:11 INFO - PROCESS | 1687 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.50 stddev:1.55 (1.9%) stddev-sans-first:1.64 11:13:11 INFO - PROCESS | 1687 | Values: 82.0 83.0 84.0 83.0 81.0 83.0 82.0 81.0 79.0 80.0 11:13:11 INFO - PROCESS | 1687 | 11:13:11 INFO - PROCESS | 1687 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:129.00 stddev:7.85 (6.1%) stddev-sans-first:8.32 11:13:11 INFO - PROCESS | 1687 | Values: 129.0 143.0 135.0 112.0 128.0 128.0 130.0 129.0 124.0 126.0 11:13:11 INFO - PROCESS | 1687 | 11:13:11 INFO - PROCESS | 1687 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.80 Median:138.50 stddev:4.78 (3.5%) stddev-sans-first:4.96 11:13:11 INFO - PROCESS | 1687 | Values: 133.0 128.0 140.0 138.0 140.0 128.0 140.0 139.0 134.0 138.0 11:13:11 INFO - PROCESS | 1687 | 11:13:11 INFO - PROCESS | 1687 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:67.00 stddev:1.89 (2.8%) stddev-sans-first:1.96 11:13:11 INFO - PROCESS | 1687 | Values: 67.0 68.0 66.0 67.0 66.0 68.0 67.0 64.0 65.0 62.0 11:13:11 INFO - PROCESS | 1687 | -------- Summary: end -------- 11:13:11 INFO - PROCESS | 1687 | 11:13:12 INFO - TEST-INFO | 1687: exit 0 11:13:12 INFO - TEST-OK | kraken | took 56593ms 11:13:12 INFO - SUITE-END | took 1170s 11:13:12 INFO - Completed test suite (00:19:30) 11:13:12 INFO - Working with test: dromaeo_css 11:13:12 INFO - Generating results file: dromaeo_css 11:13:12 INFO - Working with test: kraken 11:13:12 INFO - Generating results file: kraken 11:13:12 INFO - javascript benchmark 11:13:12 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:13:12 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 11:13:12 INFO - process_Request line: dromaeo_css 7473.59 graph.html#tests=[[72,64,59]] 11:13:12 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:13:12 INFO - process_Request line: kraken 1409.10 graph.html#tests=[[232,64,59]] 11:13:12 INFO - RETURN: dromaeo_css: 7473.59 11:13:12 INFO - RETURN: kraken: 1409.10 11:13:12 INFO - javascript benchmark 11:13:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3417.2652879630878, 3467.358538670346, 3502.334556434277, 3527.8236088195586, 3534.7879127252368, 5537.640053396526, 5637.492625663689, 5641.0, 5641.294838145232, 5676.489115979561, 5606.187102870082, 5703.17303990921, 5705.800296989606, 5709.400512946143, 5711.343195532515, 5166.612504062192, 5184.351956005499, 5223.164293713006, 5233.869153271161, 5290.7354632268425, 5296.999999999981, 5310.973445132789, 5311.203319502067, 5314.149736042234, 5316.069687804618, 5183.637145399824, 5227.059129356714, 5229.267902493654, 5243.659162154467, 5294.867628309285, 5199.272101905717, 5265.552428043621, 5266.8419947401635, 5282.709450980195, 5323.893522129536, 4673.742944138071, 4763.523647635208, 5152.9742351288005, 5177.637565370425, 5201.323827902386, 5564.638298510584, 5585.218069470277, 5621.550275977912, 5636.774529018834, 5641.746121424505, 6217.347178546278, 6218.844528886769, 6228.470580000705, 6235.251769787609, 6240.843978900519, 5331.893362132774, 5885.829802663283, 6085.375114912698, 6243.62538247702, 6284.905726414107, 5764.106563482667, 5789.594728368974, 5794.449527294901, 5800.709964501758, 5804.738786754564, 6129.325774164839, 6249.0938813871735, 6261.24865016201, 6268.968655156695, 6270.216222972129, 6103.206583144163, 6119.938800612026, 6142.324344322121, 6144.846378840475, 6149.723262453201, 6094.756209751649, 6123.234595675541, 6129.478994285447, 6134.662593557308, 6157.476614487729, 6064.332923378513, 6102.267727872683, 6136.938630613726, 6164.229471316085, 6180.938190618036, 6115.933800495066, 6129.601575897553, 6138.539609529304, 6138.846528836815, 6157.815265542041, 4846.273059041101, 4886.315915771724, 4887.095887260868, 4932.975335123301, 4963.950360496348, 3757.229767897574, 4328.28583283761, 4347.0, 4406.361077643724, 4417.8232870684815, 5780.1907732917425, 5838.795642152504, 5854.443827836349, 5860.062390017577, 5861.3552509223955, 6104.913929256131, 6196.1635179251125, 6210.4100110490335, 6216.627002379872, 6217.0, 5749.367569567345, 5829.59192856496, 5852.122181672783, 5857.824265272048, 5874.060150375919, 4714.787834547454, 5252.422233554306, 5393.541548968382, 5395.028894798896, 5399.919001214985, 6173.876522469615, 6342.682865856781, 6354.93645063562, 6368.363163683594, 6390.648514331757, 6104.4200800923845, 6202.937970620236, 6205.441510264098, 6226.719797609209, 6231.3145553988115, 6330.778422755181, 6353.983362661952, 6356.364363563606, 6366.363363663597, 6369.522285828489, 6011.669358185167, 6104.732011601517, 6112.602680825732, 6160.876782464236, 6177.536684748572, 6166.290876549075, 6215.627062376272, 6239.344868788712, 6250.0, 6253.280872699515, 6112.724927378367, 6118.969405153124, 6136.631802091711, 6151.108089326933, 6153.476954458921, 5871.442212989759, 6003.609765365237, 6048.425399587032, 6058.182145410313, 6109.450149486567, 4943.431505376784, 5751.1085781703905, 5997.31030931431, 5999.100134979788, 6002.399760023963, 6130.0, 6134.294556126102, 6140.631562106288, 6144.986077297374, 6148.16999705052, 4942.851714448572, 5801.709914504342, 5884.558658100574, 5919.230500034968, 5952.166696662557], "unit": "score", "name": "dojo.html", "value": 5668.663765333711}, {"lowerIsBetter": false, "replicates": [494.82928389705586, 548.8545535433111, 571.9742611582476, 590.3624085987134, 632.7753647455153, 30224.0, 38173.236535269316, 38524.03689907754, 38605.42091868617, 38627.0, 41413.58586414135, 41629.58370416295, 41669.58330416695, 41716.37425438613, 41791.79104104483, 9399.577019034143, 9607.2314214863, 9610.663626773065, 9614.038596140364, 9617.182539484153, 9396.060393960617, 9540.475273859935, 9543.522823858813, 9556.61773529058, 9658.468784216866, 9595.088466595662, 9663.178629816473, 9677.806443871119, 9679.70960871175, 9684.322097453181, 9562.235021198287, 9654.0, 9668.613255469772, 9669.274804389664, 9675.080867317594, 9523.904760952371, 9652.490352508328, 9666.565004574812, 9676.516174191333, 9684.661036863676, 39569.20861582781, 39761.602383976366, 39879.8006009971, 39919.401208981595, 39935.801925942265, 2753.6833264174675, 3161.525771134325, 3183.0450864740487, 3219.4687876500348, 3509.4735789631504, 28393.57409638857, 28907.56638650422, 28999.840006399718, 29201.0, 29748.0, 2577.201067669029, 2746.1761471558452, 2795.51078561253, 2802.5375812990833, 2944.9852750736322, 316355.0, 374566.0, 374755.0, 375295.0, 375992.0, 43949.0, 44297.33553996692, 44417.11165776731, 44543.77728111404, 44551.55448445539, 43309.56690433055, 43928.78035609802, 43936.560634393885, 43969.0, 44000.779996099816, 12461.314627695563, 14771.704565908622, 14941.925290373696, 14967.625809354635, 14968.0, 12056.578019769266, 12131.150819442732, 12138.0, 12376.195547289397, 12604.55884044054, 14516.927415362856, 14523.491677791226, 14533.709325813425, 14535.563933082025, 14652.0, 6228.626282422979, 6365.2679941806355, 6381.202349706286, 6381.553291269659, 6393.744250229939, 947.2374738335706, 1055.883852776194, 1064.3986147826454, 1096.9122470202365, 1132.3092913322866, 29088.7091129086, 29642.83945113217, 29791.957281495477, 29879.0, 30316.54525182124, 899.4962820820361, 1063.1016790811752, 1096.3367162866512, 1172.5954545681898, 1180.3685028509706, 13202.603921882359, 13839.308034598229, 14202.644933876736, 14215.573532794033, 14237.715245695028, 436088.0, 442470.0, 565753.0, 566544.0, 677388.0, 54496.0, 54559.18161227585, 55101.72449137729, 55237.44762552404, 55247.723761380934, 1424.4871846135384, 1436.9281535923162, 1443.2422977936458, 1443.2639353929571, 1554.078332734452, 26315.73684263133, 31161.844190779808, 31285.843570782912, 31731.524027140073, 31760.841195793873, 53121.0, 53164.20253696275, 53728.0, 53749.731251343495, 53996.0, 407821.0, 411648.0, 411692.0, 411941.0, 412865.0, 40948.59051409567, 41667.58332416759, 42538.78730606327, 43912.780436097615, 44061.559384407024, 41478.1704365917, 41993.58006420019, 42553.936151596456, 42700.359494606986, 42826.38422714403, 35758.28483430369, 36707.63292367042, 37330.88007359784, 37730.62269377381, 37764.24471510499, 35956.820215898755, 36240.0, 36242.27515449624, 36590.45114323234, 36673.0, 35773.64226357703, 36800.26399471942, 37060.0, 37114.0, 37141.257174856895, 26513.86743066272, 29843.403131936804, 32472.343169650638, 33330.83334583312, 34277.31445371128, 23909.402264943517, 24047.51904961856, 24242.0, 24452.51094978126, 24481.75518244795], "unit": "score", "name": "ext.html", "value": 18828.729070595735}, {"lowerIsBetter": false, "replicates": [359.91901822090034, 366.6480179028133, 369.130697208075, 369.85205917632936, 370.80903334782573, 15297.694046119072, 16048.27782749776, 19472.0, 19752.407427777172, 20136.59726805463, 18988.76573022756, 19411.32060377887, 19640.21439142436, 20325.898370508163, 20370.18519259228, 3937.665298449621, 5427.0, 5519.862003449915, 5521.558275337963, 5733.226014488053, 4126.112885729567, 4350.97824510877, 4351.0, 4355.782210889459, 5676.971615141919, 4342.370356298335, 4852.781624826891, 6237.812865614016, 6247.094171345152, 6259.71831267594, 6124.203853499039, 6136.803323351948, 6208.503319734433, 6224.221972253468, 6254.124422580797, 5390.730463476811, 5401.216823560561, 5409.0, 5413.566914646858, 5423.945760542423, 23731.644025339632, 24023.0, 24655.506889862103, 24928.37679058038, 24963.87662555171, 2274.351809734218, 2425.6482809992453, 2905.215591790226, 2908.7672986161056, 2911.0539074800777, 14243.572692819233, 14324.785128223086, 14418.49535266271, 14641.090963584636, 15082.24588770557, 1471.5511768910478, 1742.4946765438008, 1759.384215524556, 1779.5817982774038, 1821.5264031351944, 99907.0, 103768.0, 104322.95677043208, 104400.47799760953, 104749.0, 10170.644027459004, 10439.008294212037, 10628.521716522775, 10647.414392208348, 10694.572217111385, 12643.3046182459, 12677.0, 12679.556215532411, 12691.428885700165, 12703.93648031754, 8276.875846862302, 8400.957995210107, 8405.117462666332, 8444.873326900102, 8483.0, 8565.871511927326, 8614.310855131574, 8624.698135565224, 8678.175573320525, 8703.216710496086, 6050.0, 6155.692215389213, 6163.876722465526, 6183.319834818167, 6204.875902481925, 1664.750287456867, 1739.6085880676746, 1745.851602613792, 1773.8403543680872, 1795.398541488616, 900.3157600223877, 952.172920162437, 1078.4769386847372, 1085.5332207150843, 1115.4590023838432, 19196.61606767857, 20199.697004544945, 20653.070611822204, 20683.58632827335, 20916.0, 767.0344319866305, 814.450246083891, 935.8409070457902, 965.9184457494111, 972.7568107973007, 10527.631532896312, 10680.62617808373, 10705.357678539312, 10733.677989660322, 10737.731556710989, 626537.0, 628136.396067855, 634848.0, 637432.0, 647658.0, 95947.0, 103493.96506034843, 104691.47654261833, 104846.0, 105516.0, 993.3245393132595, 1034.9534270957975, 1043.3583346242158, 1048.156234231451, 1063.9202059845388, 17909.462716118538, 18000.279988800827, 18032.09839507993, 18103.456896293133, 18454.0, 47711.52288477071, 49233.75383123205, 49469.010619788125, 49754.25368619546, 49884.0, 62478.68760656349, 67332.0, 68070.85256048242, 68100.6594967022, 68762.0, 8028.157043510348, 8032.236937490929, 8095.392845536726, 8107.391945603986, 8266.586670666322, 12384.75230495367, 12652.114351995271, 13103.475860965455, 13204.537841175512, 13207.867921320663, 11341.20611557216, 11353.829692554784, 11435.0, 11787.764244714886, 11790.23363481371, 9401.247900168108, 10985.121190304597, 11359.088657751363, 11402.600908968478, 11584.189106762446, 7035.979782931344, 8397.580120993804, 10160.136388406772, 11750.11874109428, 11982.400879955792, 7908.209179082046, 7990.880136797837, 8137.145599711945, 8212.137725538732, 8328.916710833057, 8344.856850460428, 11575.768484630093, 11679.240849344766, 11712.88287117118, 11763.294202347886], "unit": "score", "name": "jquery.html", "value": 9373.331780291945}, {"lowerIsBetter": false, "replicates": [1397.580725782265, 1525.4584622459026, 1535.3551508366486, 1788.27574832193, 1972.4575741671038, 7723.768286951394, 8523.232909038185, 8738.300935925126, 8742.125787421255, 8746.86879696805, 8641.827163456726, 8653.61058752356, 8789.648414063446, 8802.03177650458, 8807.427517211378, 2171.413718296067, 2416.3355077353694, 2461.556919754439, 2494.550980823451, 2495.189063554343, 2485.763852434025, 2491.0533997081084, 2494.114589320792, 2501.2746303572035, 2503.987480062597, 2403.8798060096924, 2451.4116612013077, 2469.2098528470897, 2469.5307891500647, 2475.220305603738, 2102.978970210309, 2415.698037745282, 2442.3039433761382, 2462.5198086373166, 2471.468634243646, 2432.586460301753, 2450.9754902450927, 2462.4090218347646, 2463.507298540299, 2479.38015496126, 8753.649854005833, 8827.823443531157, 8847.513386763725, 8851.380403371766, 8858.468491890442, 4508.571685689854, 5232.189010703347, 5547.77808887644, 5553.222548843165, 5554.72226388683, 3248.2691394436297, 3608.7293452990866, 3712.480252764615, 3740.1584643455276, 3761.793101379423, 1065.1425602390073, 1068.647346375702, 1072.0619457974271, 1101.4823033174396, 1102.0742576236, 12127.21173123753, 12251.632451026484, 12285.69285767863, 12291.56979505713, 12295.954843838284, 4247.915041699149, 4962.875928101754, 4970.229614409773, 5051.722155281422, 5060.1903695408555, 10424.322419042737, 10425.895741042645, 10432.68701938943, 10433.26967112295, 10433.895661043443, 5549.889002219933, 5585.357683866408, 5586.301712285965, 5586.748596313176, 5598.356189038232, 4109.547949725527, 4450.554944505524, 4569.565891240327, 4951.257311403318, 5012.924806127911, 3964.088259700285, 3985.621365970228, 3997.620226078518, 4024.4164596133396, 4055.4525139105845, 1286.2218357893528, 1309.1752196116386, 1321.9405126769318, 1326.9601911942464, 1329.2024785129038, 1077.5851297250615, 1164.947577359021, 1299.6750812296925, 1368.2201145347058, 1378.4486205517674, 8184.7953801155445, 8196.631151598192, 8219.589020549069, 8229.753107406787, 8231.382646301552, 515.4561937156261, 521.0620882411644, 1242.136714983078, 1274.9107562470724, 1301.8177455156285, 6250.812475625738, 6260.217472815898, 6329.968350158219, 6338.651374174465, 6351.872962540816, 10376.792464150825, 10920.617778377718, 10935.234533582732, 11085.50115244816, 11095.50070246841, 10607.045365917105, 10662.733431664115, 10875.891241087646, 10900.563977440972, 10956.397398143019, 8252.711155109542, 8311.667533298722, 8337.95831020853, 8480.830383392298, 8495.830083398298, 7759.806004849924, 7942.205779422012, 7980.361571074184, 7990.800229994296, 7993.280604745601, 9226.446413215228, 9452.810943781224, 9679.70960871175, 9800.509974501389, 9912.603495860374, 9702.902970970483, 9992.600295988079, 10000.099991000845, 10192.082712555906, 10194.796104077728, 6399.360063993563, 6629.801105966829, 6977.79066628002, 7056.8588628226125, 7143.964280178566, 8200.917990820015, 8202.425830191829, 8238.546879921661, 8265.83468330618, 8266.875996859932, 7180.964095179491, 7319.011933389137, 7322.560646361236, 7469.14104877946, 7474.626268686435, 7177.102862142232, 7234.927650723425, 7282.563046217244, 7293.890591641023, 7356.485046046725, 7660.080790305199, 7680.846383072196, 7706.691732330868, 7711.03612048494, 7721.189275126031, 6907.274736152632, 6968.756093536702, 6994.895076573957, 7015.754448594274, 7023.824404389931, 7091.184513780981, 7111.573305601681, 7157.141143062658, 7162.176349719849, 7165.140183177844], "unit": "score", "name": "mootools.html", "value": 4932.175304584736}, {"lowerIsBetter": false, "replicates": [278.77697841726615, 282.6721003635783, 316.4367425981753, 324.8732994132287, 329.1294525978785, 6389.265234498034, 6460.483161347092, 6472.579282346656, 6511.283758786536, 6603.504737144709, 5847.0, 6344.238691357032, 6481.64350960697, 6497.870042599146, 6528.738850445989, 4454.910901781963, 4618.099470603233, 4840.6369522285795, 4858.0, 4858.149823780842, 4713.811447542094, 4716.693414928019, 4777.546133117348, 4811.302361157647, 4820.758962051884, 4814.879628009293, 4827.61379089672, 4851.956829281704, 4866.805327786884, 4867.975660121694, 4596.816127354902, 4671.205894997858, 4845.394325709286, 4845.685030473026, 4848.612111031109, 3362.8150451725146, 4098.508179018507, 4111.157212771374, 4130.814113364906, 4134.545200027995, 6267.404596563365, 6280.0, 6283.717232724538, 6302.4958003359625, 6328.272248691414, 5705.942940570582, 5708.686022268774, 5713.714314284311, 5716.685582292972, 5738.569607279471, 5638.689872057076, 6305.77037477692, 7028.718851245944, 7037.507374483788, 7048.330408611174, 4486.416765820422, 4587.632989360844, 4644.256918892961, 4652.255639097728, 4682.6019788318035, 7424.406047516186, 7447.776566703008, 7458.664360103754, 7474.663640136207, 7479.813004674872, 4754.310624959361, 4756.6670333077045, 4759.881002974884, 4765.26138448541, 4767.547083027107, 4827.227643577011, 4840.249761287007, 4840.394950631171, 4849.854504364875, 4855.053264613437, 5717.799877004285, 5739.282589676291, 5747.195392645033, 5758.165066065397, 5760.567957403212, 6858.897116543256, 7048.991037554272, 7054.788356349318, 7055.788326350218, 7105.82235444118, 1660.5350501859498, 1667.733162693963, 1681.9831801682071, 1684.1410880451058, 1685.0900513722452, 912.7723212279474, 1082.71849319176, 1092.82514797632, 1093.7320356512546, 1103.100972707241, 6476.805695829133, 6590.80227593173, 6670.799876003728, 6756.189257289157, 6794.626295553792, 7418.777436676908, 7422.406207503387, 7428.220036896048, 7438.4049276057785, 7441.0, 6731.0, 6743.258241593421, 6743.5953842769595, 6751.797446076625, 6753.49348798842, 3836.1176929306416, 3895.2793733159456, 3895.844166233319, 3897.590752970897, 3902.3366027775346, 7496.325330720261, 7757.146713861471, 7774.92225077742, 7786.026746656668, 7795.883061753965, 7597.050368703912, 7608.923910760932, 7635.312821846061, 7639.579823109782, 7646.4265180111715, 7691.884621730678, 7701.730439434593, 7702.614869256403, 7703.34521565662, 7718.112417072109, 5921.733521991435, 7058.682359293742, 7348.191698913222, 7363.453674728367, 7367.0, 7190.352868241884, 7236.638168091469, 7237.312455316736, 7241.818954526179, 7255.2019277878335, 7665.425093117927, 7690.577018264049, 7692.461527693008, 7695.038120234971, 7697.807554811175, 4183.64031689696, 4306.806193721352, 4616.884577885579, 4619.0, 4623.190941585141, 6282.717277722422, 6960.234374218933, 6979.40675042627, 7301.269873012869, 7314.158871729819, 7018.929810702032, 7089.539179953286, 7092.822679433056, 7100.680469378787, 7105.609191494517, 6944.305569443015, 6948.096747422803, 6953.269906659728, 6955.930440695528, 6966.233714291525, 5606.551475881838, 6043.848903777441, 6521.69566086775, 6855.828604284933, 6857.27998560164, 6779.593224406552, 7041.43668506508, 7047.189573199148, 7052.788416347517, 7068.469864760061, 5614.943850561442, 6634.9004764927595, 6729.091572637827, 6769.1876974763345, 6953.548019378724], "unit": "score", "name": "prototype.html", "value": 5127.680221880051}, {"lowerIsBetter": false, "replicates": [661.5666738286423, 719.1190791280678, 728.2644529025682, 746.2015643261709, 765.7319938021697, 14609.443347414213, 14830.48093316734, 15034.09795412276, 15062.246887655614, 15101.0, 13872.653183670413, 13884.0, 13904.791428128587, 13915.0, 13920.651983700413, 710.1974768511575, 719.7049209823973, 860.148453031499, 870.5516658920661, 878.4597472554365, 847.8770578266148, 869.0006492533573, 872.2585802068255, 872.7425409504211, 874.3573473496974, 916.6791622931954, 920.9309301802358, 921.0559176843722, 921.8663293822425, 922.3267015078997, 744.2334395572569, 905.2622112977901, 917.5366439947817, 920.1212841736126, 921.3412410126791, 679.4937771360319, 679.6601699150425, 680.993190068098, 684.4216636941776, 685.5578152091923, 14384.0, 14412.495562655256, 14415.0, 14439.205843678594, 14446.205458699767, 10262.846057309147, 12141.575044873387, 12151.696207594792, 12327.506899724, 12581.559645412366, 10090.64682736108, 10142.543585538668, 10193.184545236363, 10273.537690803858, 10829.620963266327, 3457.792532448061, 3501.894943151684, 3516.859325626972, 3518.894433167009, 3520.7887526748477, 79062.20937790607, 80465.59767201127, 80511.19488805038, 81364.0, 81569.0, 9406.90593094074, 9444.8583271251, 9494.620215191453, 9686.515674216262, 10100.494975251208, 20673.069711863, 20859.58280834375, 20882.47793805167, 20912.895435522725, 20918.895405522875, 7305.269473052652, 7453.105627324648, 7613.885791713129, 7661.233876612406, 7726.227377262341, 4030.294698427822, 4050.5949405059846, 4076.2662720709964, 4081.571434999342, 4100.815463304159, 3477.078574177845, 3481.669241422061, 3505.8772942946875, 3508.3509550733197, 3520.06718219672, 632.9240491141093, 639.3734140542294, 646.8997305417668, 648.7826578096297, 664.139938779282, 526.7471613625481, 552.7512619321321, 603.9275088980257, 613.2610204703321, 624.5940138909745, 8587.957060214783, 9054.937149023772, 9120.133587309196, 9141.31440141992, 9227.215686666574, 437.1235672476664, 585.1135529672549, 592.5763079398251, 609.5587173370623, 615.8121772859321, 3793.81030948457, 3974.2250261199365, 4048.332025215865, 4089.7750623715388, 4151.8339266429, 91361.43192840331, 92413.0, 94812.57781133289, 95902.0, 96752.51623741836, 63068.05397919035, 80486.0, 81850.59074704707, 82723.58638206891, 83153.0, 70793.2920670797, 72201.6389918047, 72644.54710905858, 73232.26767732362, 75210.0, 8773.912260877309, 8823.69117080899, 8913.0, 8941.418807777474, 8992.820143597222, 37985.62014379821, 52774.0, 52900.47099528956, 53786.46213537971, 54255.45744542504, 71062.0, 73502.63248683722, 73549.85151039589, 73607.0, 75064.0, 10686.0, 10824.0, 10940.56237750481, 11042.668719938414, 11638.185327027366, 10096.94951525267, 11920.940395298316, 12164.330961797186, 12342.382880856101, 12467.1273010892, 11146.442677866236, 11175.608853690082, 11547.653570392902, 11650.6504804856, 11717.00405465545, 11408.007286551705, 11416.771664566828, 11623.12826537996, 11624.825627615422, 11655.358955257543, 10849.945750271514, 11084.224104312621, 11443.771124577628, 11447.771044579229, 11474.598389056342, 8006.95996520037, 9001.774955626162, 9090.909090909006, 9490.383125096847, 9518.762030949281, 9024.729258122266, 9649.710508684751, 9865.95067024689, 9950.35322704022, 10037.247206459399], "unit": "score", "name": "yui.html", "value": 6886.328926104228}], "name": "dromaeo_css", "value": 7473.591253996857}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 107.0, 112.0, 109.0, 111.0, 111.0, 115.0, 109.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [157.0, 121.0, 143.0, 157.0, 121.0, 150.0, 172.0, 143.0, 178.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [183.0, 184.0, 185.0, 183.0, 189.0, 185.0, 185.0, 185.0, 181.0, 183.0], "unit": "score", "name": "audio-dft", "value": 184.3}, {"lowerIsBetter": true, "replicates": [80.0, 75.0, 88.0, 78.0, 58.0, 58.0, 57.0, 80.0, 102.0, 55.0], "unit": "score", "name": "audio-fft", "value": 73.1}, {"lowerIsBetter": true, "replicates": [94.0, 92.0, 124.0, 80.0, 79.0, 83.0, 109.0, 79.0, 78.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 93.2}, {"lowerIsBetter": true, "replicates": [83.0, 89.0, 84.0, 89.0, 84.0, 89.0, 82.0, 89.0, 83.0, 89.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.1}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 93.0, 93.0, 93.0, 101.0, 130.0, 93.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 97.5}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 84.0, 84.0, 84.0, 85.0, 85.0, 86.0, 84.0, 83.0], "unit": "score", "name": "imaging-desaturate", "value": 84.6}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 53.0, 54.0, 54.0, 53.0, 52.0, 64.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.4}, {"lowerIsBetter": true, "replicates": [61.0, 69.0, 67.0, 75.0, 70.0, 66.0, 65.0, 67.0, 68.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 84.0, 83.0, 81.0, 83.0, 82.0, 81.0, 79.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.8}, {"lowerIsBetter": true, "replicates": [129.0, 143.0, 135.0, 112.0, 128.0, 128.0, 130.0, 129.0, 124.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.4}, {"lowerIsBetter": true, "replicates": [133.0, 128.0, 140.0, 138.0, 140.0, 128.0, 140.0, 139.0, 134.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 66.0, 67.0, 66.0, 68.0, 67.0, 64.0, 65.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1409.1000000000001}]} 11:13:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1409.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7473.59"}}} 11:13:12 INFO - Return code: 0 11:13:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:13:12 INFO - # TBPL SUCCESS # 11:13:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:13:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:13:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:13:12 INFO - 2016-02-24 11:13:12.995 screenresolution[1691:10038] starting screenresolution argv=screenresolution get 11:13:12 INFO - 2016-02-24 11:13:12.997 screenresolution[1691:10038] Display 0: 1600x1200x32@60 11:13:13 INFO - 2016-02-24 11:13:13.003 screenresolution[1692:10041] starting screenresolution argv=screenresolution list 11:13:13 INFO - Available Modes on Display 0 11:13:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:13:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:13:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:13:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:13:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:13:13 INFO - Intel Iris: 11:13:13 INFO - Chipset Model: Intel Iris 11:13:13 INFO - Type: GPU 11:13:13 INFO - Bus: Built-In 11:13:13 INFO - VRAM (Dynamic, Max): 1536 MB 11:13:13 INFO - Vendor: Intel (0x8086) 11:13:13 INFO - Device ID: 0x0a2e 11:13:13 INFO - Revision ID: 0x0009 11:13:13 INFO - Displays: 11:13:13 INFO - Display: 11:13:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:13:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:13:13 INFO - Display Serial Number: 1600x1200 60 11:13:13 INFO - Main Display: Yes 11:13:13 INFO - Mirror: Off 11:13:13 INFO - Online: Yes 11:13:13 INFO - Rotation: Supported 11:13:13 INFO - Return code: 0 11:13:13 INFO - Running post-action listener: _resource_record_post_action 11:13:13 INFO - Running post-run listener: _resource_record_post_run 11:13:14 INFO - Total resource usage - Wall time: 1207s; CPU: 52.0%; Read bytes: 39376384; Write bytes: 707558912; Read time: 430; Write time: 1978 11:13:14 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404343296; Write bytes: 405558784; Read time: 30298; Write time: 725 11:13:14 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 37561856; Write bytes: 300500992; Read time: 410; Write time: 1250 11:13:14 INFO - Running post-run listener: _upload_blobber_files 11:13:14 INFO - Blob upload gear active. 11:13:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:13:14 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 11:13:14 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'] 11:13:14 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 11:13:14 INFO - (blobuploader) - INFO - Open directory for files ... 11:13:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:13:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:13:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:13:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:15 INFO - (blobuploader) - INFO - Done attempting. 11:13:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:13:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:13:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:13:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:16 INFO - (blobuploader) - INFO - Done attempting. 11:13:16 INFO - (blobuploader) - INFO - Iteration through files over. 11:13:16 INFO - Return code: 0 11:13:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:13:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:13:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1cffec7329649149baba8ffe19c94e5cdf27f6f1139223629383f372cd4eb089e8ec23b48d9af7f4d4a34df3c94f4693480128553dd9277c1c6230c39730a3b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c7611db583b35570feb92e0153aeb878c6f8f9b69e45ec350ebf6d97a76490e81776b138d2ea89423a7cb43fb67ba96db0604203fbb0a93768d4c9fa111c308"} 11:13:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:13:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:13:16 INFO - Contents: 11:13:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1cffec7329649149baba8ffe19c94e5cdf27f6f1139223629383f372cd4eb089e8ec23b48d9af7f4d4a34df3c94f4693480128553dd9277c1c6230c39730a3b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c7611db583b35570feb92e0153aeb878c6f8f9b69e45ec350ebf6d97a76490e81776b138d2ea89423a7cb43fb67ba96db0604203fbb0a93768d4c9fa111c308"} 11:13:16 INFO - Running post-run listener: copy_logs_to_upload_dir 11:13:16 INFO - Copying logs to upload dir... 11:13:16 INFO - mkdir: /builds/slave/test/build/upload/logs 11:13:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.486945 ========= master_lag: 3.60 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-24 11:13:20.516427) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 11:13:20.519813) ========= 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.WzulBUUkPQ/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.4At5YuyX8N/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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/b1cffec7329649149baba8ffe19c94e5cdf27f6f1139223629383f372cd4eb089e8ec23b48d9af7f4d4a34df3c94f4693480128553dd9277c1c6230c39730a3b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c7611db583b35570feb92e0153aeb878c6f8f9b69e45ec350ebf6d97a76490e81776b138d2ea89423a7cb43fb67ba96db0604203fbb0a93768d4c9fa111c308"} build_url:https://queue.taskcluster.net/v1/task/VaBw_VaGTnWGU1D0XGE3mA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010558 build_url: 'https://queue.taskcluster.net/v1/task/VaBw_VaGTnWGU1D0XGE3mA/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/b1cffec7329649149baba8ffe19c94e5cdf27f6f1139223629383f372cd4eb089e8ec23b48d9af7f4d4a34df3c94f4693480128553dd9277c1c6230c39730a3b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c7611db583b35570feb92e0153aeb878c6f8f9b69e45ec350ebf6d97a76490e81776b138d2ea89423a7cb43fb67ba96db0604203fbb0a93768d4c9fa111c308"}' ========= master_lag: 0.25 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 11:13:20.780665) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 11:13:20.787097) ========= 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.WzulBUUkPQ/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.4At5YuyX8N/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.004529 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 11:13:20.840108) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-02-24 11:13:20.840403) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-02-24 11:13:24.629607) ========= ========= Total master_lag: 4.09 =========