builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0075 starttime: 1454762318.24 results: success (0) buildid: 20160206043836 builduid: 0fd0ff1a9f2747e5b2c6d53c8988262c revision: 46d6d868ba0f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.241851) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.242295) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.242640) ========= 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.u5mNTTwVJT/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.1R0YjwcNF6/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.005462 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.283365) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.283705) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.305928) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.306243) ========= 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.u5mNTTwVJT/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.1R0YjwcNF6/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.005297 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.359428) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.359724) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.360093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.360410) ========= 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.u5mNTTwVJT/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.1R0YjwcNF6/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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-06 04:38:38-- 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% 20.0M=0.001s 2016-02-06 04:38:39 (20.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.650372 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:39.032737) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:39.033072) ========= 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.u5mNTTwVJT/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.1R0YjwcNF6/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.026372 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:39.084810) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-02-06 04:38:39.085180) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 46d6d868ba0f --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 46d6d868ba0f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.u5mNTTwVJT/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.1R0YjwcNF6/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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-06 04:38:39,184 Setting DEBUG logging. 2016-02-06 04:38:39,184 attempt 1/10 2016-02-06 04:38:39,184 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/46d6d868ba0f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-06 04:38:40,288 unpacking tar archive at: fx-team-46d6d868ba0f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.351873 ========= master_lag: 2.94 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-02-06 04:38:43.373921) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.374353) ========= echo 46d6d868ba0f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'46d6d868ba0f'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.u5mNTTwVJT/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.1R0YjwcNF6/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 46d6d868ba0f program finished with exit code 0 elapsedTime=0.005702 script_repo_revision: '46d6d868ba0f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.428392) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.428724) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.756730) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-02-06 04:38:43.757030) ========= /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.u5mNTTwVJT/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.1R0YjwcNF6/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:38:43 INFO - MultiFileLogger online at 20160206 04:38:43 in /builds/slave/test 04:38:43 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 04:38:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:38:43 INFO - {'append_to_log': False, 04:38:43 INFO - 'base_work_dir': '/builds/slave/test', 04:38:43 INFO - 'blob_upload_branch': 'Fx-Team', 04:38:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:38:43 INFO - 'branch': 'Fx-Team', 04:38:43 INFO - 'buildbot_json_path': 'buildprops.json', 04:38:43 INFO - 'config_files': ('talos/mac_config.py',), 04:38:43 INFO - 'default_actions': ('clobber', 04:38:43 INFO - 'read-buildbot-config', 04:38:43 INFO - 'download-and-extract', 04:38:43 INFO - 'populate-webroot', 04:38:43 INFO - 'create-virtualenv', 04:38:43 INFO - 'install', 04:38:43 INFO - 'run-tests'), 04:38:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:38:43 INFO - 'download_minidump_stackwalk': True, 04:38:43 INFO - 'download_symbols': 'ondemand', 04:38:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:38:43 INFO - 'tooltool.py': '/tools/tooltool.py', 04:38:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:38:43 INFO - '/tools/misc-python/virtualenv.py')}, 04:38:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:38:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:38:43 INFO - 'installer_path': 'installer.exe', 04:38:43 INFO - 'log_level': 'info', 04:38:43 INFO - 'log_name': 'talos', 04:38:43 INFO - 'log_to_console': True, 04:38:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:38:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:38:43 INFO - 'opt_config_files': (), 04:38:43 INFO - 'pip_index': False, 04:38:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:38:43 INFO - 'cmd': ('bash', 04:38:43 INFO - '-c', 04:38:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:38:43 INFO - 'enabled': True, 04:38:43 INFO - 'halt_on_failure': False, 04:38:43 INFO - 'name': 'check_screen_resolution'},), 04:38:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:38:43 INFO - 'cmd': ('bash', 04:38:43 INFO - '-c', 04:38:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:38:43 INFO - 'enabled': True, 04:38:43 INFO - 'halt_on_failure': False, 04:38:43 INFO - 'name': 'check_screen_resolution'},), 04:38:43 INFO - 'run_cmd_checks_enabled': True, 04:38:43 INFO - 'sps_profile': False, 04:38:43 INFO - 'sps_profile_interval': 0, 04:38:43 INFO - 'suite': 'dromaeojs', 04:38:43 INFO - 'system_bits': '32', 04:38:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:38:43 INFO - 'title': 't-yosemite-r7-0075', 04:38:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:38:43 INFO - 'use_talos_json': True, 04:38:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:38:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:38:43 INFO - 'work_dir': 'build'} 04:38:43 INFO - ##### 04:38:43 INFO - ##### Running clobber step. 04:38:43 INFO - ##### 04:38:43 INFO - Running pre-action listener: _resource_record_pre_action 04:38:43 INFO - Running main action method: clobber 04:38:43 INFO - rmtree: /builds/slave/test/build 04:38:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:38:45 INFO - Running post-action listener: _resource_record_post_action 04:38:45 INFO - ##### 04:38:45 INFO - ##### Running read-buildbot-config step. 04:38:45 INFO - ##### 04:38:45 INFO - Running pre-action listener: _resource_record_pre_action 04:38:45 INFO - Running main action method: read_buildbot_config 04:38:45 INFO - Using buildbot properties: 04:38:45 INFO - { 04:38:45 INFO - "project": "", 04:38:45 INFO - "product": "firefox", 04:38:45 INFO - "script_repo_revision": "production", 04:38:45 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:38:45 INFO - "repository": "", 04:38:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:38:45 INFO - "buildid": "20160206043836", 04:38:45 INFO - "stage_platform": "macosx64", 04:38:45 INFO - "basedir": "/builds/slave/test", 04:38:45 INFO - "buildnumber": 300, 04:38:45 INFO - "platform": "yosemite_r7", 04:38:45 INFO - "mozci_request": { 04:38:45 INFO - "priority": -1, 04:38:45 INFO - "type": "trigger_all_talos_jobs", 04:38:45 INFO - "times": 6 04:38:45 INFO - }, 04:38:45 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:38:45 INFO - "slavebuilddir": "test", 04:38:45 INFO - "branch": "fx-team", 04:38:45 INFO - "revision": "46d6d868ba0f", 04:38:45 INFO - "slavename": "t-yosemite-r7-0075", 04:38:45 INFO - "builduid": "0fd0ff1a9f2747e5b2c6d53c8988262c", 04:38:45 INFO - "repo_path": "integration/fx-team" 04:38:45 INFO - } 04:38:45 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg. 04:38:45 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/test_packages.json. 04:38:45 INFO - Running post-action listener: _resource_record_post_action 04:38:45 INFO - ##### 04:38:45 INFO - ##### Running download-and-extract step. 04:38:45 INFO - ##### 04:38:45 INFO - Running pre-action listener: _resource_record_pre_action 04:38:45 INFO - Running main action method: download_and_extract 04:38:45 INFO - mkdir: /builds/slave/test/build/tests 04:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:45 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/test_packages.json 04:38:45 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/test_packages.json to /builds/slave/test/build/test_packages.json 04:38:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:38:45 INFO - Downloaded 1277 bytes. 04:38:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:38:45 INFO - Using the following test package requirements: 04:38:45 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:38:45 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:45 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:38:45 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:45 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:38:45 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:45 INFO - u'jsshell-mac.zip'], 04:38:45 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:45 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:38:45 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:38:45 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:45 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:38:45 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:45 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:38:45 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:45 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:38:45 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:38:45 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:45 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:38:45 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:45 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip 04:38:45 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:38:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:38:46 INFO - Downloaded 17118689 bytes. 04:38:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:38:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:38:49 INFO - Return code: 0 04:38:49 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:49 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip 04:38:49 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:38:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:38:49 INFO - Downloaded 17118689 bytes. 04:38:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:38:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:38:52 INFO - Return code: 0 04:38: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')]} 04:38:52 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.talos.tests.zip 04:38:52 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:38:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:38:53 INFO - Downloaded 10706582 bytes. 04:38:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:38:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:38:53 INFO - Return code: 0 04:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:53 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg 04:38:53 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:38:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 04:39:04 INFO - Downloaded 111104284 bytes. 04:39:04 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg 04:39:04 INFO - mkdir: /builds/slave/test/properties 04:39:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:39:04 INFO - Writing to file /builds/slave/test/properties/build_url 04:39:04 INFO - Contents: 04:39:04 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg 04:39:04 INFO - Running post-action listener: _resource_record_post_action 04:39:04 INFO - Running post-action listener: set_extra_try_arguments 04:39:04 INFO - ##### 04:39:04 INFO - ##### Running populate-webroot step. 04:39:04 INFO - ##### 04:39:04 INFO - Running pre-action listener: _resource_record_pre_action 04:39:04 INFO - Running main action method: populate_webroot 04:39:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:39:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:39:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:39:04 INFO - '--tppagecycles', 04:39:04 INFO - '7'], 04:39:04 INFO - 'tests': ['tsvgm']}}, 04:39:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:39:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:39:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:39:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:39:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:39:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:39:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:04 INFO - 'talos_options': ['--e10s'], 04:39:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:04 INFO - 'tests': ['damp', 'tps']}, 04:39:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:04 INFO - 'talos_options': ['--e10s'], 04:39:04 INFO - 'tests': ['damp', 'tps']}, 04:39:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:39:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:39:04 INFO - 'other': {'tests': ['a11yr', 04:39:04 INFO - 'ts_paint', 04:39:04 INFO - 'tpaint', 04:39:04 INFO - 'sessionrestore', 04:39:04 INFO - 'sessionrestore_no_auto_restore']}, 04:39:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:39:04 INFO - 'tests': ['a11yr', 04:39:04 INFO - 'ts_paint', 04:39:04 INFO - 'tpaint', 04:39:04 INFO - 'sessionrestore', 04:39:04 INFO - 'sessionrestore_no_auto_restore']}, 04:39:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:39:04 INFO - 'tests': ['a11yr', 04:39:04 INFO - 'ts_paint', 04:39:04 INFO - 'tpaint', 04:39:04 INFO - 'sessionrestore', 04:39:04 INFO - 'sessionrestore_no_auto_restore']}, 04:39:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:39:04 INFO - 'tests': ['a11yr', 04:39:04 INFO - 'ts_paint', 04:39:04 INFO - 'tpaint', 04:39:04 INFO - 'sessionrestore', 04:39:04 INFO - 'sessionrestore_no_auto_restore']}, 04:39:04 INFO - 'other_l64': {'tests': ['a11yr', 04:39:04 INFO - 'ts_paint', 04:39:04 INFO - 'tpaint', 04:39:04 INFO - 'sessionrestore', 04:39:04 INFO - 'sessionrestore_no_auto_restore']}, 04:39:04 INFO - 'other_nol64': {'tests': ['a11yr', 04:39:04 INFO - 'ts_paint', 04:39:04 INFO - 'tpaint', 04:39:04 INFO - 'sessionrestore', 04:39:04 INFO - 'sessionrestore_no_auto_restore']}, 04:39:04 INFO - 'svgr': {'tests': ['tsvgx', 04:39:04 INFO - 'tsvgr_opacity', 04:39:04 INFO - 'tart', 04:39:04 INFO - 'tscrollx', 04:39:04 INFO - 'cart']}, 04:39:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:39:04 INFO - 'tests': ['tsvgx', 04:39:04 INFO - 'tsvgr_opacity', 04:39:04 INFO - 'tart', 04:39:04 INFO - 'tscrollx', 04:39:04 INFO - 'cart']}, 04:39:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:04 INFO - 'tests': ['tp5o']}, 04:39:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:04 INFO - 'talos_options': ['--e10s'], 04:39:04 INFO - 'tests': ['tp5o']}, 04:39:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:04 INFO - 'talos_options': ['--xperf_path', 04:39:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:04 INFO - 'tests': ['tp5n']}, 04:39:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:04 INFO - 'talos_options': ['--e10s', 04:39:04 INFO - '--xperf_path', 04:39:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:04 INFO - 'tests': ['tp5n']}}, 04:39:04 INFO - 'talos.zip': {'path': '', 04:39:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:39:04 INFO - Running post-action listener: _resource_record_post_action 04:39:04 INFO - ##### 04:39:04 INFO - ##### Running create-virtualenv step. 04:39:04 INFO - ##### 04:39:04 INFO - Running pre-action listener: _resource_record_pre_action 04:39:04 INFO - Running main action method: create_virtualenv 04:39:04 INFO - Creating virtualenv /builds/slave/test/build/venv 04:39:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:39:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:39:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:39:04 INFO - Using real prefix '/tools/python27' 04:39:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:39:05 INFO - Installing distribute.............................................................................................................................................................................................done. 04:39:08 INFO - Installing pip.................done. 04:39:08 INFO - Return code: 0 04:39:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110042a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100494c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f48d5f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fee7d30>, '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 0x10fd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feddb20>, '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.u5mNTTwVJT/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.1R0YjwcNF6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:39:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5mNTTwVJT/Render', 04:39:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:08 INFO - 'HOME': '/Users/cltbld', 04:39:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:08 INFO - 'LOGNAME': 'cltbld', 04:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:08 INFO - 'MOZ_NO_REMOTE': '1', 04:39:08 INFO - 'NO_EM_RESTART': '1', 04:39:08 INFO - 'PAGER': '/bin/cat', 04:39:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:08 INFO - 'PWD': '/builds/slave/test', 04:39:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:08 INFO - 'SHELL': '/bin/bash', 04:39:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1R0YjwcNF6/Listeners', 04:39:08 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 04:39:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:08 INFO - 'USER': 'cltbld', 04:39:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:08 INFO - 'XPC_FLAGS': '0x0', 04:39:08 INFO - 'XPC_SERVICE_NAME': '0', 04:39:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:39:08 INFO - Cleaning up... 04:39:08 INFO - Return code: 0 04:39:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110042a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100494c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f48d5f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fee7d30>, '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 0x10fd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feddb20>, '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.u5mNTTwVJT/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.1R0YjwcNF6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:39:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5mNTTwVJT/Render', 04:39:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:08 INFO - 'HOME': '/Users/cltbld', 04:39:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:08 INFO - 'LOGNAME': 'cltbld', 04:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:08 INFO - 'MOZ_NO_REMOTE': '1', 04:39:08 INFO - 'NO_EM_RESTART': '1', 04:39:08 INFO - 'PAGER': '/bin/cat', 04:39:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:08 INFO - 'PWD': '/builds/slave/test', 04:39:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:08 INFO - 'SHELL': '/bin/bash', 04:39:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1R0YjwcNF6/Listeners', 04:39:08 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 04:39:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:08 INFO - 'USER': 'cltbld', 04:39:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:08 INFO - 'XPC_FLAGS': '0x0', 04:39:08 INFO - 'XPC_SERVICE_NAME': '0', 04:39:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:08 INFO - Downloading/unpacking psutil>=0.7.1 04:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:39:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:11 INFO - Installing collected packages: psutil 04:39:11 INFO - Running setup.py install for psutil 04:39:12 INFO - building 'psutil._psutil_osx' extension 04:39:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:39:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:39:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:39:12 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:39:12 INFO - building 'psutil._psutil_posix' extension 04:39:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:39:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:39:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:39:12 INFO - ^ 04:39:12 INFO - 1 warning generated. 04:39:12 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:39:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:13 INFO - Successfully installed psutil 04:39:13 INFO - Cleaning up... 04:39:13 INFO - Return code: 0 04:39:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:13 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 0x110042a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100494c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f48d5f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fee7d30>, '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 0x10fd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feddb20>, '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.u5mNTTwVJT/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.1R0YjwcNF6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:39:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5mNTTwVJT/Render', 04:39:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:13 INFO - 'HOME': '/Users/cltbld', 04:39:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:13 INFO - 'LOGNAME': 'cltbld', 04:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:13 INFO - 'MOZ_NO_REMOTE': '1', 04:39:13 INFO - 'NO_EM_RESTART': '1', 04:39:13 INFO - 'PAGER': '/bin/cat', 04:39:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:13 INFO - 'PWD': '/builds/slave/test', 04:39:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:13 INFO - 'SHELL': '/bin/bash', 04:39:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1R0YjwcNF6/Listeners', 04:39:13 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 04:39:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:13 INFO - 'USER': 'cltbld', 04:39:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:13 INFO - 'XPC_FLAGS': '0x0', 04:39:13 INFO - 'XPC_SERVICE_NAME': '0', 04:39:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:39:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:39:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:39:15 INFO - Installing collected packages: mozsystemmonitor 04:39:15 INFO - Running setup.py install for mozsystemmonitor 04:39:16 INFO - Successfully installed mozsystemmonitor 04:39:16 INFO - Cleaning up... 04:39:16 INFO - Return code: 0 04:39:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:16 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 0x110042a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100494c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f48d5f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fee7d30>, '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 0x10fd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feddb20>, '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.u5mNTTwVJT/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.1R0YjwcNF6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:39:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5mNTTwVJT/Render', 04:39:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:16 INFO - 'HOME': '/Users/cltbld', 04:39:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:16 INFO - 'LOGNAME': 'cltbld', 04:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:16 INFO - 'MOZ_NO_REMOTE': '1', 04:39:16 INFO - 'NO_EM_RESTART': '1', 04:39:16 INFO - 'PAGER': '/bin/cat', 04:39:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:16 INFO - 'PWD': '/builds/slave/test', 04:39:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:16 INFO - 'SHELL': '/bin/bash', 04:39:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1R0YjwcNF6/Listeners', 04:39:16 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 04:39:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:16 INFO - 'USER': 'cltbld', 04:39:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:16 INFO - 'XPC_FLAGS': '0x0', 04:39:16 INFO - 'XPC_SERVICE_NAME': '0', 04:39:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:16 INFO - Downloading/unpacking blobuploader==1.2.4 04:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:18 INFO - Downloading blobuploader-1.2.4.tar.gz 04:39:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:39:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:39:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:19 INFO - Downloading docopt-0.6.1.tar.gz 04:39:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:39:19 INFO - Installing collected packages: blobuploader, requests, docopt 04:39:19 INFO - Running setup.py install for blobuploader 04:39:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:39:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:39:20 INFO - Running setup.py install for requests 04:39:20 INFO - Running setup.py install for docopt 04:39:20 INFO - Successfully installed blobuploader requests docopt 04:39:20 INFO - Cleaning up... 04:39:20 INFO - Return code: 0 04:39:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:20 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 0x110042a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100494c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f48d5f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fee7d30>, '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 0x10fd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feddb20>, '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.u5mNTTwVJT/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.1R0YjwcNF6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:39:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5mNTTwVJT/Render', 04:39:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:20 INFO - 'HOME': '/Users/cltbld', 04:39:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:20 INFO - 'LOGNAME': 'cltbld', 04:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:20 INFO - 'MOZ_NO_REMOTE': '1', 04:39:20 INFO - 'NO_EM_RESTART': '1', 04:39:20 INFO - 'PAGER': '/bin/cat', 04:39:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:20 INFO - 'PWD': '/builds/slave/test', 04:39:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:20 INFO - 'SHELL': '/bin/bash', 04:39:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1R0YjwcNF6/Listeners', 04:39:20 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 04:39:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:20 INFO - 'USER': 'cltbld', 04:39:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:20 INFO - 'XPC_FLAGS': '0x0', 04:39:20 INFO - 'XPC_SERVICE_NAME': '0', 04:39:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:21 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-VXDH3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:21 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-cRZ2lS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:21 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Yc4HJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:21 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-wuS5aN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:21 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-XsSCNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:21 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-wL_axe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:21 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-NwLjAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:21 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-rsZr5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:21 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-mSCa_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:21 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-DMhxlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:22 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-WaUJjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:22 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-O2MN_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:22 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-RyMezk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:22 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-NE83MF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:22 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-vl1Gmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:22 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-KSHHP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:22 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-3q2tCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:39:22 INFO - Running setup.py install for manifestparser 04:39:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:39:22 INFO - Running setup.py install for mozcrash 04:39:23 INFO - Running setup.py install for mozdebug 04:39:23 INFO - Running setup.py install for mozdevice 04:39:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:39:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:39:23 INFO - Running setup.py install for mozfile 04:39:23 INFO - Running setup.py install for mozhttpd 04:39:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:39:23 INFO - Running setup.py install for mozinfo 04:39:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:39:23 INFO - Running setup.py install for mozInstall 04:39:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:39:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:39:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:39:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:39:23 INFO - Running setup.py install for mozleak 04:39:24 INFO - Running setup.py install for mozlog 04:39:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Running setup.py install for moznetwork 04:39:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Running setup.py install for mozprocess 04:39:24 INFO - Running setup.py install for mozprofile 04:39:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Running setup.py install for mozrunner 04:39:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Running setup.py install for mozscreenshot 04:39:25 INFO - Running setup.py install for moztest 04:39:25 INFO - Running setup.py install for mozversion 04:39:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:39:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:39:25 INFO - Cleaning up... 04:39:25 INFO - Return code: 0 04:39:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:25 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 0x110042a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100494c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f48d5f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fee7d30>, '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 0x10fd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feddb20>, '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.u5mNTTwVJT/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.1R0YjwcNF6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:39:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5mNTTwVJT/Render', 04:39:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:25 INFO - 'HOME': '/Users/cltbld', 04:39:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:25 INFO - 'LOGNAME': 'cltbld', 04:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:25 INFO - 'MOZ_NO_REMOTE': '1', 04:39:25 INFO - 'NO_EM_RESTART': '1', 04:39:25 INFO - 'PAGER': '/bin/cat', 04:39:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:25 INFO - 'PWD': '/builds/slave/test', 04:39:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:25 INFO - 'SHELL': '/bin/bash', 04:39:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1R0YjwcNF6/Listeners', 04:39:25 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 04:39:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:25 INFO - 'USER': 'cltbld', 04:39:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:25 INFO - 'XPC_FLAGS': '0x0', 04:39:25 INFO - 'XPC_SERVICE_NAME': '0', 04:39:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:25 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-r3VCV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:25 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-LJhJXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:25 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-9PK8_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:25 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-dgdhEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:26 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-IIr_aE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:26 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Kva4GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:26 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Nb0Bdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:26 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Wv6vFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:26 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Hp_GCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:26 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-d5yfD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:26 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-rgZ265-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:26 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-VYf1My-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:26 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-_l3J9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:27 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-yPmFui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:27 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-to1UqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:27 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-XBj1nJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:27 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-e58RtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:39:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:29 INFO - Downloading blessings-1.6.tar.gz 04:39:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:39:29 INFO - Installing collected packages: blessings 04:39:29 INFO - Running setup.py install for blessings 04:39:29 INFO - Successfully installed blessings 04:39:29 INFO - Cleaning up... 04:39:30 INFO - Return code: 0 04:39:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:39:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:30 INFO - Reading from file tmpfile_stdout 04:39:30 INFO - Current package versions: 04:39:30 INFO - blessings == 1.6 04:39:30 INFO - blobuploader == 1.2.4 04:39:30 INFO - docopt == 0.6.1 04:39:30 INFO - manifestparser == 1.1 04:39:30 INFO - mozInstall == 1.12 04:39:30 INFO - mozcrash == 0.16 04:39:30 INFO - mozdebug == 0.1 04:39:30 INFO - mozdevice == 0.48 04:39:30 INFO - mozfile == 1.2 04:39:30 INFO - mozhttpd == 0.7 04:39:30 INFO - mozinfo == 0.9 04:39:30 INFO - mozleak == 0.1 04:39:30 INFO - mozlog == 3.1 04:39:30 INFO - moznetwork == 0.27 04:39:30 INFO - mozprocess == 0.22 04:39:30 INFO - mozprofile == 0.28 04:39:30 INFO - mozrunner == 6.11 04:39:30 INFO - mozscreenshot == 0.1 04:39:30 INFO - mozsystemmonitor == 0.0 04:39:30 INFO - moztest == 0.7 04:39:30 INFO - mozversion == 1.4 04:39:30 INFO - psutil == 3.1.1 04:39:30 INFO - requests == 1.2.3 04:39:30 INFO - wsgiref == 0.1.2 04:39:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:30 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 0x110042a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100494c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f48d5f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fee7d30>, '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 0x10fd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feddb20>, '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.u5mNTTwVJT/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.1R0YjwcNF6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:39:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5mNTTwVJT/Render', 04:39:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:30 INFO - 'HOME': '/Users/cltbld', 04:39:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:30 INFO - 'LOGNAME': 'cltbld', 04:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:30 INFO - 'MOZ_NO_REMOTE': '1', 04:39:30 INFO - 'NO_EM_RESTART': '1', 04:39:30 INFO - 'PAGER': '/bin/cat', 04:39:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:30 INFO - 'PWD': '/builds/slave/test', 04:39:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:30 INFO - 'SHELL': '/bin/bash', 04:39:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1R0YjwcNF6/Listeners', 04:39:30 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 04:39:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:30 INFO - 'USER': 'cltbld', 04:39:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:30 INFO - 'XPC_FLAGS': '0x0', 04:39:30 INFO - 'XPC_SERVICE_NAME': '0', 04:39:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:39:30 INFO - Cleaning up... 04:39:30 INFO - Return code: 0 04:39:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:30 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 0x110042a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100494c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f48d5f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fee7d30>, '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 0x10fd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feddb20>, '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.u5mNTTwVJT/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.1R0YjwcNF6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:39:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5mNTTwVJT/Render', 04:39:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:30 INFO - 'HOME': '/Users/cltbld', 04:39:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:30 INFO - 'LOGNAME': 'cltbld', 04:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:30 INFO - 'MOZ_NO_REMOTE': '1', 04:39:30 INFO - 'NO_EM_RESTART': '1', 04:39:30 INFO - 'PAGER': '/bin/cat', 04:39:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:30 INFO - 'PWD': '/builds/slave/test', 04:39:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:30 INFO - 'SHELL': '/bin/bash', 04:39:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1R0YjwcNF6/Listeners', 04:39:30 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 04:39:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:30 INFO - 'USER': 'cltbld', 04:39:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:30 INFO - 'XPC_FLAGS': '0x0', 04:39:30 INFO - 'XPC_SERVICE_NAME': '0', 04:39:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:30 INFO - Downloading/unpacking jsonschema 04:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:39:33 INFO - Downloading/unpacking functools32 (from jsonschema) 04:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:33 INFO - Downloading functools32-3.2.3-2.tar.gz 04:39:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:39:33 INFO - warning: no files found matching '*.txt' 04:39:33 INFO - no previously-included directories found matching 'build' 04:39:33 INFO - no previously-included directories found matching 'dist' 04:39:33 INFO - no previously-included directories found matching '.git*' 04:39:33 INFO - Installing collected packages: jsonschema, functools32 04:39:33 INFO - Running setup.py install for functools32 04:39:33 INFO - warning: no files found matching '*.txt' 04:39:33 INFO - no previously-included directories found matching 'build' 04:39:33 INFO - no previously-included directories found matching 'dist' 04:39:33 INFO - no previously-included directories found matching '.git*' 04:39:33 INFO - Successfully installed jsonschema functools32 04:39:33 INFO - Cleaning up... 04:39:33 INFO - Return code: 0 04:39:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:33 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 0x110042a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100494c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f48d5f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fee7d30>, '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 0x10fd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feddb20>, '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.u5mNTTwVJT/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.1R0YjwcNF6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:39:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5mNTTwVJT/Render', 04:39:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:33 INFO - 'HOME': '/Users/cltbld', 04:39:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:33 INFO - 'LOGNAME': 'cltbld', 04:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:33 INFO - 'MOZ_NO_REMOTE': '1', 04:39:33 INFO - 'NO_EM_RESTART': '1', 04:39:33 INFO - 'PAGER': '/bin/cat', 04:39:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:33 INFO - 'PWD': '/builds/slave/test', 04:39:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:33 INFO - 'SHELL': '/bin/bash', 04:39:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1R0YjwcNF6/Listeners', 04:39:33 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 04:39:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:33 INFO - 'USER': 'cltbld', 04:39:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:33 INFO - 'XPC_FLAGS': '0x0', 04:39:33 INFO - 'XPC_SERVICE_NAME': '0', 04:39:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:34 INFO - Downloading/unpacking flake8 04:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:39:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:39: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 04:39: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 04:39: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 04:39: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 04:39: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 04:39: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 04:39:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:39:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:39: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 04:39: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 04:39: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 04:39: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 04:39: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 04:39: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 04:39:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:39:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:37 INFO - no previously-included directories found matching 'docs/_build' 04:39:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:39:37 INFO - Running setup.py install for pep8 04:39:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:37 INFO - no previously-included directories found matching 'docs/_build' 04:39:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:39:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:39:37 INFO - Cleaning up... 04:39:37 INFO - Return code: 0 04:39:37 INFO - Running post-action listener: _resource_record_post_action 04:39:37 INFO - Running post-action listener: _start_resource_monitoring 04:39:37 INFO - Starting resource monitoring. 04:39:37 INFO - ##### 04:39:37 INFO - ##### Running install step. 04:39:37 INFO - ##### 04:39:37 INFO - Running pre-action listener: _resource_record_pre_action 04:39:37 INFO - Running main action method: install 04:39:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:38 INFO - Reading from file tmpfile_stdout 04:39:38 INFO - Detecting whether we're running mozinstall >=1.0... 04:39:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:39:38 INFO - Reading from file tmpfile_stdout 04:39:38 INFO - Output received: 04:39:38 INFO - Usage: mozinstall [options] installer 04:39:38 INFO - Options: 04:39:38 INFO - -h, --help show this help message and exit 04:39:38 INFO - -d DEST, --destination=DEST 04:39:38 INFO - Directory to install application into. [default: 04:39:38 INFO - "/builds/slave/test"] 04:39:38 INFO - --app=APP Application being installed. [default: firefox] 04:39:38 INFO - mkdir: /builds/slave/test/build/application 04:39:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:40:12 INFO - Reading from file tmpfile_stdout 04:40:12 INFO - Output received: 04:40:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:40:12 INFO - Running post-action listener: _resource_record_post_action 04:40:12 INFO - ##### 04:40:12 INFO - ##### Running run-tests step. 04:40:12 INFO - ##### 04:40:12 INFO - Running pre-action listener: _resource_record_pre_action 04:40:12 INFO - Running main action method: run_tests 04:40:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:40:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:40:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:40:12 INFO - 2016-02-06 04:40:12.035 screenresolution[1699:14278] starting screenresolution argv=screenresolution get 04:40:12 INFO - 2016-02-06 04:40:12.038 screenresolution[1699:14278] Display 0: 1600x1200x32@60 04:40:12 INFO - 2016-02-06 04:40:12.043 screenresolution[1700:14280] starting screenresolution argv=screenresolution list 04:40:12 INFO - Available Modes on Display 0 04:40:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:40:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:40:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:40:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:40:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:40:12 INFO - Intel Iris: 04:40:12 INFO - Chipset Model: Intel Iris 04:40:12 INFO - Type: GPU 04:40:12 INFO - Bus: Built-In 04:40:12 INFO - VRAM (Dynamic, Max): 1536 MB 04:40:12 INFO - Vendor: Intel (0x8086) 04:40:12 INFO - Device ID: 0x0a2e 04:40:12 INFO - Revision ID: 0x0009 04:40:12 INFO - Displays: 04:40:12 INFO - Display: 04:40:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:40:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:40:12 INFO - Display Serial Number: 1600x1200 60 04:40:12 INFO - Main Display: Yes 04:40:12 INFO - Mirror: Off 04:40:12 INFO - Online: Yes 04:40:12 INFO - Rotation: Supported 04:40:12 INFO - Return code: 0 04:40:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:40:12 INFO - Python 2.7.3 04:40:12 INFO - Return code: 0 04:40:12 INFO - grabbing minidump binary from tooltool 04:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:12 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 0x10fee7d30>, '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 0x10fd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feddb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:40:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:40:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:40:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:40:12 INFO - Return code: 0 04:40:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:40:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:40:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:40:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:40:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:40:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:40:13 INFO - Return code: 0 04:40:13 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0075', '--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 04:40:13 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 http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0075 --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 04:40:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5mNTTwVJT/Render', 04:40:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:13 INFO - 'HOME': '/Users/cltbld', 04:40:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:13 INFO - 'LOGNAME': 'cltbld', 04:40:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:40:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:13 INFO - 'MOZ_NO_REMOTE': '1', 04:40:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:40:13 INFO - 'NO_EM_RESTART': '1', 04:40:13 INFO - 'PAGER': '/bin/cat', 04:40:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:13 INFO - 'PWD': '/builds/slave/test', 04:40:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:40:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:13 INFO - 'SHELL': '/bin/bash', 04:40:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1R0YjwcNF6/Listeners', 04:40:13 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 04:40:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:13 INFO - 'USER': 'cltbld', 04:40:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:13 INFO - 'XPC_FLAGS': '0x0', 04:40:13 INFO - 'XPC_SERVICE_NAME': '0', 04:40:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:13 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0075', '--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 04:40:13 INFO - mozversion application_buildid: 20160203075343 04:40:13 INFO - mozversion application_changeset: 46d6d868ba0f8ae089da8882b594fe359eba2978 04:40:13 INFO - mozversion application_display_name: Nightly 04:40:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:40:13 INFO - mozversion application_name: Firefox 04:40:13 INFO - mozversion application_remotingname: firefox 04:40:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:40:13 INFO - mozversion application_vendor: Mozilla 04:40:13 INFO - mozversion application_version: 47.0a1 04:40:13 INFO - mozversion platform_buildid: 20160203075343 04:40:13 INFO - mozversion platform_changeset: 46d6d868ba0f8ae089da8882b594fe359eba2978 04:40:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:40:13 INFO - mozversion platform_version: 47.0a1 04:40:13 INFO - using testdate: 1454762413 04:40:13 INFO - actual date: 1454762413 04:40:14 INFO - starting webserver on 'localhost:49271' 04:40:14 INFO - SUITE-START | Running 2 tests 04:40:14 INFO - TEST-START | dromaeo_css 04:40:14 INFO - operating with platform_type : mac_ 04:40:14 INFO - Initialising browser for dromaeo_css test... 04:40:14 INFO - TEST-INFO | started process 1718 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpy8YYWQ/profile http://localhost:49271/getInfo.html) 04:40:14 INFO - PROCESS | 1718 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:40:16 INFO - PROCESS | 1718 | __metrics Screen width/height:1600/1200 04:40:16 INFO - PROCESS | 1718 | colorDepth:24 04:40:16 INFO - PROCESS | 1718 | Browser inner width/height: 1024/689 04:40:16 INFO - PROCESS | 1718 | __metrics 04:40:16 INFO - PROCESS | 1718 | 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" 04:40:16 INFO - PROCESS | 1718 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:40:17 INFO - TEST-INFO | 1718: exit 0 04:40:17 INFO - Browser initialized. 04:40:17 INFO - Running cycle 1/1 for dromaeo_css test... 04:40:17 INFO - TEST-INFO | started process 1722 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpy8YYWQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:29 INFO - PROCESS | 1722 | RSS: Main: 243175424 04:40:29 INFO - PROCESS | 1722 | 04:41:20 INFO - PROCESS | 1722 | 1454762480793 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:43:30 INFO - PROCESS | 1722 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 04:43:32 INFO - PROCESS | 1722 | RSS: Main: 369913856 04:43:32 INFO - PROCESS | 1722 | 04:46:34 INFO - PROCESS | 1722 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 04:46:35 INFO - PROCESS | 1722 | RSS: Main: 382750720 04:46:35 INFO - PROCESS | 1722 | 04:49:37 INFO - PROCESS | 1722 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 04:49:38 INFO - PROCESS | 1722 | RSS: Main: 378744832 04:49:38 INFO - PROCESS | 1722 | 04:52:40 INFO - PROCESS | 1722 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 04:52:40 INFO - PROCESS | 1722 | RSS: Main: 374136832 04:52:40 INFO - PROCESS | 1722 | 04:55:43 INFO - PROCESS | 1722 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 04:55:44 INFO - PROCESS | 1722 | RSS: Main: 345665536 04:55:44 INFO - PROCESS | 1722 | 04:58:47 INFO - PROCESS | 1722 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 04:58:47 INFO - PROCESS | 1722 | RSS: Main: 407109632 04:58:47 INFO - PROCESS | 1722 | 04:58:47 INFO - PROCESS | 1722 | __start_tp_report 04:58:47 INFO - PROCESS | 1722 | _x_x_mozilla_page_load 04:58:47 INFO - PROCESS | 1722 | _x_x_mozilla_page_load_details 04:58:47 INFO - PROCESS | 1722 | |i|pagename|runs| 04:58:47 INFO - PROCESS | 1722 | |0;dojo.html;3379.9831000844997;3445.948310775337;3482.4602186661045;3491.7206623470115;3525.0129963610198;5534.944650553503;5590.301212348457;5600.411956744544;5612.298462692158;5652.745626446809;5612.102063669803;5662.518685911692;5731.426857314266;5810.825675229739;5819.243498345219;5102.846914592568;5119.641625086236;5162.328897243353;5175.715335656538;5208.869778255536;5268.420473747885;5269.736513174326;5271.103912334912;5290.814821481249;5332.973335133319;5075.21334193197;5160.638755287131;5196.844094677166;5223.242629818655;5227.947720522803;5176.948230517722;5191.402988656315;5202.843914682566;5215.295935048758;5216.921746173811;5069.1129052416045;5154.5103215194495;5157.638965272433;5172.948270517322;5195.246689230078;5573.219749235111;5573.41479144692;5588.6646801192055;5596.300462442195;5603.831885043455;5452.645578037414;6109.694515274263;6198.535109866778;6235.064740288947;6240.157578726905;6152.5693201475915;6186.133941248228;6186.164867742842;6191.380861913818;6200.596961197508;5608.186812912105;5701.771929122871;5732.22614946981;5745.281839769987;5765.682887441189;6210.534209934273;6215.96892015537;6225.657588832658;6227.439530442282;6246.812595622138;6032.263044918261;6038.45448098352;6068.817935461943;6074.967255566565;6090.573659843857;6085.152228562294;6232.626042437469;6236.875262494725;6244.750209991549;6248.125262463259;6142.140100385949;6147.44672979434;6160.045192995093;6170.81487555374;6179.783707570214;6110.358412366726;6164.260288765377;6194.938050619527;6201.069839524108;6209.161763162006;4848.442429120626;4850.587700045465;4884.511548845087;4884.560389564886;4945.901081978341;4346.739195648208;4348.978255108767;4350.58669426404;4374.321980093091;4377.3433984901885;5579.079451890392;5663.122216056518;5699.202111704365;5708.686022268732;5718.51392631631;5965.13505541694;6128.961487065963;6148.415900489446;6177.938220617826;6180.072989051679;5701.743421546041;5710.914336284959;5714.942850571524;5715.1713001614535;5732.426757324234;5302.761375738101;5310.867228319323;5315.867103322448;5320.255164277004;5372.382176049804;6182.196314479179;6224.1597384352535;6264.812055638247;6269.749210031548;6283.465905398001;6117.3402608778015;6132.600268413531;6190.659513726789;6262.655553944577;6278.843028924313;6250.593711408744;6277.372262773869;6279.340669229665;6294.402031806971;6298.02380631003;6010.2186715726675;6101.2068431105445;6140.539459540463;6198.2252218472695;6207.317195108625;6069.969650151721;6122.367660829284;6123.404636889863;6129.358790882775;6198.044557784222;6026.819195424145;6033.879322413615;6034.487068599043;6041.697915104315;6062.454379105901;5930.28836539618;5977.880442391041;6013.428724271187;6029;6035.577509574463;5848.385919478564;5865.853353666193;5882.49998750111;5939.138824870456;5968.373320801427;6007.008843540767;6044.093385992136;6050.273967123973;6062.939370606237;6067.211262535842;5759.7408116634015;5887.911681324698;5903.380145084704;5925;5968.074948383008 04:58:47 INFO - PROCESS | 1722 | |1;ext.html;492.90141971605686;539.6411386428025;573.5239751006665;580.4166812353582;601.9969900150498;30043.699563004364;31581.368372632533;38089.80955095224;38578.61421385785;38760.03099922503;37984;38138.855834324946;41759.956001099985;41925.58074419255;41969.160616787645;9474.33679642427;9700.854487182698;9706.757331066709;9717.951410242975;9720.902790972106;9568.09103135201;9691.819340648333;9693.466859322734;9694.563744631509;9837.606495740198;9772.462514561696;9831.557579908886;9840.704778856645;9850.90149098507;9854.70435886921;9715.319927605071;9819;9819.754506137368;9831.262655300881;9832.754181145458;9688.612455501772;9829.311948163631;9829.55766990487;9837.114659680592;9840.11438970496;40113.59886401128;40382.79808600967;40569.391459128135;40574.39138412926;40654.79672601618;3158.7630927680284;3214.7428205743486;3318.2202182487094;3359.2105855124028;3558.2527669189503;28458.573121403195;29482.262943426373;30224.697753022407;30332.69667303321;30422;2695.6360891279624;2784.5266304728243;2787.8048536602446;2790.5674620433865;2853.1725799518113;426347;493319;498857.5057124727;499628;499927;67630;67912.66043669848;68165;68316;68381;67493.66253168801;67518.66240668863;67588.32411675919;67797.66101169462;67945.3205467939;16794;16897.577560561083;16954.321827127023;16972.23624936881;17024.744628830576;12836.614901552968;12919.612411627666;12925.15986460877;12943.223406595635;12944.352782360844;20705.171793128407;21345;21579.352619421443;21639.35081947544;21684.78315216859;7542.886856697154;7803.264600518728;8732.519711415933;9155.954220228989;9204.539773011322;883.5935469683889;920.5443305563655;933.2207606648388;971.4511301114848;984.6209209454269;27902.883884644387;27995.44009119847;28453.857730711214;28554.71503782335;28589.857050714614;1079.8434227037035;1146.7075895646556;1157.8842115788354;1164.8136298192248;1170.3913964738458;14568.927155364156;14642.560723178109;14689.412423503154;14725.484608038667;14896.404143834125;754690;757049;757812;918498;927929;57580;57803.13295300574;58677.41322586805;58810.70594646999;58822.70588647029;1313.6256166992362;1341.4500054977607;1348.1776116568885;1454.7526920423554;1570.1756577796748;30813.383732325678;31032.844835775675;31608;31662.36675266436;33420.498692520116;56250.43749562452;56979;57080.714596428414;57104.42895570991;57124.71437642785;492769;498537;499314;499557;499778;43354.34968475538;43461.91345216395;44124.77937610292;44227;44323.33514997213;35062.82468587743;36307.45538816973;42076.158476830904;43613.127737445706;44025;34504.48243276403;36026;37027.81486092552;37424.25151497009;38063.42904856374;36427.089322766085;36817.815910921345;36954;37210.06974825651;37330.62669373272;37785;38290;38836;38875.6112438872;38991;29939.700602993693;32376;33177.66822331746;33503.66496335006;33873;24900.62649060229;25092.498150036532;25312.74687253104;25331.113411030525;25470.49059018772 04:58:47 INFO - PROCESS | 1722 | |2;jquery.html;307.59244001697755;343.10946683772414;365.58688681789573;366.2967103161929;370.6293706293706;18605.81394186058;19420.41738747838;20003;20068.695534790248;20095.698564521506;15371.923140384282;15868;16314.83685163148;17466.825331746677;20241.392758217276;5499.697516636584;5525.143602741581;5710.314762228539;5730.19777231188;5792.4497172768515;5591.049521581321;5612.242347283105;5648;5666.121751128561;5680.602357834953;4067.0849058961794;4251.681123915703;4259.424977628027;5503.889922201553;5900.29196496421;5968.582199246054;6025.78909738157;6106.900757863583;6116.724747386356;6134.079888016789;4648.976755116203;5262.684238945675;5352.277442545284;5353.812616558402;5361.731913404353;23471.530569388517;24854.751452485423;24994.375140621447;25247.24258272255;25491.872540637363;2206.2167930384803;2239.93603038557;2297.425643589103;2337.976620233793;2346.4603141277603;9455.716328510087;10028.749281267954;13909.234992075431;14403.495877644336;14566.198859062748;1690.357664087651;1698.583846957491;1701.6426550424303;1745.8516026137793;1813.0572102506624;78898.68810495205;101908;104062;104782;106089.46955265252;10868.239223254297;10986.340819550853;11023;11066.225364224589;11277.605283815026;11794.233374830781;13507.797383039262;13586.93206533961;13762.311884405739;13792.103513271806;8369.665213391396;8380.16198380157;8493.830123397498;8502.404831661725;8537.359698022674;8670.86993695095;8672.306215502746;8673.783155421164;8719.60761765722;8732.257758090507;4439.64482841372;4465.307877279027;4499.4150760400935;4514.616257618073;4521.344405061248;1759.8504127149079;1850.7594012778522;1892.0539730134933;1894.2612381171355;1896.9039211671181;791.7110254757088;814.5031530766228;882.9470231786113;904.7783293093103;957.1242313283268;18141.909290453463;19363.8063619362;19364.806351936582;19511.609767804566;19815.702764458543;822.6956026270318;920.6731610278389;952.8046750416148;962.1773383756927;987.6247026130025;7947.642356093989;8987.730368088967;10947.288426252268;10962.616308429167;10968.670939871816;734663.5935023518;748251;748922;748941;754461;67433.3141671462;67456.32543674599;67684.64630707358;86720.56639716761;97918;1171.9003884669728;1176.5764324843049;1196.4873765093234;1201.4473342262481;1205.9939700301618;17769.55576110556;17879.910600447434;18016.639667206844;18047.729284060486;18484.81515184831;34350.65649343475;48360.51639483701;50255.74872125616;51204.74397627988;51293.7435312821;67408.32591674216;67518.66240668962;69384.3061569398;70303.64848175726;71075;7465.3654439371085;7676.6161691916295;7741.341985931259;7754.34088102495;7759.61201939912;10082.899171008195;12003.399830008639;12059.69850753703;12068.862095854965;12139.453724582592;9976.351537150062;10100.343477673927;10432.061114499731;10523.894761052597;10706.73233169177;7917.802054948673;10105.848412273968;10170.593176272867;10179.061299815334;10219.693409197438;10390.272680912565;10490.324967133332;10546.26176167661;10661.8933810664;10762.300450470695;5854.970725146347;6275.780347687809;7598.924010760043;7609.896564998155;7613.7817949127875;9720.222382209548;10114.241431892491;10234;10314.638987635397;10419.42693151884 04:58:47 INFO - PROCESS | 1722 | |3;mootools.html;1362.80920671106;1486.6134804950714;1523.961900952476;1739.6085880676842;1928.238345853388;7865.4494185406975;8069.4754840935375;8561.657533698652;8748.212660860521;8755.912440875589;8537.74386768398;8621.568921553913;8702.129787021311;8720.389572729911;8725.127487251271;2164.848460607758;2218.7670294619074;2456.189457479032;2483.255023492954;2483.801295896324;2232.408411770874;2241.05875532276;2243.9789895597464;2386.689730335054;2437.7196622388387;2405.0139442828445;2457.9631305530434;2459.434330104077;2465.432950421395;2470.629405589158;2444.841085329448;2468.839525430841;2470.1601455505215;2476.8885400156855;2478.330850670318;2435.4641978764644;2473.6165894286414;2474.985256045031;2475.10896077412;2476.727559968402;8744.300455963508;8825.338099642488;8837.690680826141;8838.602262898185;8865.867011994826;5375.22059301403;5467.234587157801;5524.116141417394;5530.751116199781;5535.446455354472;3607.3326434609417;3748.861152737464;3778.886633401002;3779.7543159694533;3802.410626352892;1049.9107575856062;1055.2665897201448;1080;1088.842117892909;1091.770728147082;12343;12363.258204507758;12373.814392784116;12374.010079193642;12389.380530973416;4857.757112144379;4873.244647079709;4944.25836124577;4957.90084198314;4996.825111121093;8687.739367818975;8702.782430439163;10332.328398654063;10334;10349.482525873676;5479.780808767684;5513.751881165357;5514.09017512106;5522.3649280333275;5533.1976863354585;4974.701517908865;4986.276989836453;4993.975030124899;4998.4251811042195;5018.4981501849525;3586.372384832644;3722.925541489155;3905.062784931596;3942.5860284669698;3995.6403923647013;1207.209277922962;1231.907606929466;1272.6563827766452;1278.6931136527166;1295.2099219476113;1314.5859054397833;1325.0989327257557;1335.1855368225374;1337.0573745509394;1363.6863521390135;7880.014998125234;7915.525068495908;7986.361091112697;8023.438359314792;8026.117127116013;1159.5072094359864;1164.4527072276187;1166.0904494494307;1169.8069818480026;1181.8109102543551;6232.532560058014;6338.461230795434;6341.270753863272;6347.587406818542;6358.237011558643;10202.564857167043;10558.894411055944;10560.94390560953;10575.841362379571;10726.678199654023;10001.699949001542;10407.167426605853;10440.321379110334;10521.158307335394;10563;8084.434089613788;8103.635336409876;8189.918100819034;8191.221833925887;8206.917930820735;7902.407319450949;7903.328217101611;7918.089419716576;7958.204179581995;8007.079185893696;9194.95402522983;9403.294752893697;9429.245660347293;9486.762830929007;9526.809463810823;9764.9023509764;9785.902140978498;9841.212702983601;10162.847557286499;10173.745656358355;7518.962405187939;7522.247775222434;7562.054743157106;7628.771136865903;7650.579218143055;7197.532160409557;8108.986376702912;8179.018517777905;8184.9768778902635;8188.976377952756;6959.860802784017;7540.095188577406;7574.431917606092;7686;7732;7354.080739907512;7448.664810083451;7487.700491980259;7555.508891922007;7598.848023039619;7579.810504737426;7631.084269887649;7631.236876312324;7642.7325043623205;7665.3101220890385;6624.238212605612;6860.931390686229;6864.553804002724;6871.175458944758;6891.75878844238;7008.789736307919;7077.858442831011;7091.1490621125795;7094.432445404252;7096.503244772816 04:58:47 INFO - PROCESS | 1722 | |4;prototype.html;323.3452259175171;328.57941834451896;333.7546903026277;334.17292201800547;337.94592865141584;6434.420902118808;6564.934350656492;6596.373344532268;6616.569922955011;6809.557378770376;5965.955957707395;6326.145970294009;6457.580257283285;6477.643729594871;6513.576617519858;4243.405923170759;4858.368412106422;4871.318015477836;4898.755062246892;4905.901881962359;4659.347691323217;4766.094442056015;4898.093852637274;4915.434725006617;4916.385451818523;4534.31985202219;4779.259214821708;4792.233242681172;4859.125357435661;4869.780859861315;4839.709617422948;4841.2012018016985;4842.29786680931;4848.763565290828;4871.585915197213;4147.212029714345;4160.646345060643;4161.56303588125;4169.374593810922;4169.854055108087;6021.608595441282;6207.658578778165;6228.532860035515;6233.470155036827;6243.157173781572;5629.240052592889;5631.239782629334;5651.802186923438;5656.490915817555;5666.46168613981;6906.482013848981;6914.377706006433;6922.757703480404;6927.792166235021;6950.235474097845;4356.259435895905;4485.663575231838;4487.640988720895;4612.4003879495785;4643.071385722869;7145.499815012951;7250.1299844018;7263.89104163438;7268;7290.088738907637;4657.60410365116;4760.904781904343;4766.332713420124;4775.617950563947;4776.09254241693;4653.744044077608;4820.373351464287;4833.154198015403;4834.903301933941;4863.975680121647;5665.3768085510565;5711.371749107595;5713.628614140068;5721.084626459747;5724.4561766632105;5701.40135285789;7020.438364930793;7027.227005029443;7031.332023457866;7035.613041282676;1661.858742006943;1691.6785810695928;1693.8052124005897;1694.195257252795;1698.405558054671;1076.8600081989448;1098.4892025208317;1102.4377567440663;1114.2033446086086;1123.6067376418353;6510.707018184098;6540.70566824494;6550.541462097703;6571.605703657796;6582;7247.4926755126635;7259.854802904018;7259.89110163348;7273.454490913203;7287.0526831512625;6405.871882562323;6505.642189679518;6520.380563846522;6528.053432252297;6554.049662798868;3830.2339532093692;3849.8652547160714;3859.9807000964815;3865.5747867734526;3870.9806450967567;6107.389261073857;7494;7512.962435187789;7535.585542795089;7550;6351.98368261076;7146.2496437874315;7391.704331826667;7419.925800741924;7435.7025718970635;7246.166690830517;7557.735479258199;7559.1684914659345;7566.394688424803;7570.16728159902;6923.826904327432;7208.927910721035;7219.350258476762;7231.2768723127265;7232.89150662751;6710.865782684416;6924.6537673117155;6940.340667636567;7062.293770623102;7102.857942841011;7576.545407275581;7588.544687318778;7628.694852205849;7639.388848891964;7640.847183056197;4615.26155815068;4808.422989241313;4811.109944660249;4811.759412029454;4821.975890120667;7235.819104522429;7243.710251589878;7253.601051942193;7254.202037775946;7258.637068146466;5702.6863522506665;6983.930160698328;6995.335443132894;7003.6498175092065;7011.929880701127;6712.899306510309;6933.930660693531;6984;7020.684069217;7041.3310735480045;6882.380585747307;6883;6888.448924086161;6898.517103802686;6909.861802764017;7044.682989265598;7047;7047.859042819217;7052.753153639598;7053.153621565445;6634.436072933855;6886.8622627548175;6902.620355880475;6917;6919.792406227822 04:58:47 INFO - PROCESS | 1722 | |5;yui.html;663.5454713521237;694.9652517374133;698.8602279544091;722.1478655186877;766.7967988483053;12464.81302780459;14634.195119268436;14654.120752754841;14903.701925961488;14914.776278355834;13589;13806.171629702225;13906.304684765746;14054.859451405482;14210.218437985906;696.7073828991836;712.3766704133883;849.5200211880283;868.9789497340631;870.5473153959969;711.2318695808515;712.1845486917503;712.8217945513621;712.8609921065395;830.0371568979984;900.9504477253748;913.5980168725739;913.8355096082703;914.5930061122802;917.9810410444402;903.4172958441801;904.1410659873147;905.8958219804741;906.419891269588;906.9909300907038;534.0280689145757;543.6330476928058;546.1234718277148;656.5305806348437;668.1381018486147;14511.564653060424;14513.782293265609;14537.491187808377;14565.198914059722;14570.417183312655;12321.383930803424;12419.937900310531;12514.499420023189;12529;12930.806037909439;10068;10092.192624590016;10094.848577271347;10095.192384609214;10096.798064038678;3518.82405879705;3547.5033495310677;3551.485034669958;3559.75081744278;3562.412201986669;57548.71225643887;72206.63896680484;74836.5032699343;76657;82515.7622635661;9455.338126331228;9456.385334953206;9466.526673666289;9491.810163796823;9521.238300936047;20023.199072036954;20040.997950102435;20054.799452005584;20068;20088;7426.331630153312;7677.577733224614;7690.384769218449;7691.807704807425;7754.6898124074405;4186.413902053715;4189.4344263524035;4222.493300803923;4258.488981322199;4271.081717430768;3536.451849963208;3578.087587665129;3579.9105022374647;3581.0152208142968;3582.6417358264484;661.1141070964834;672.2672287206871;673.6699017481399;679.8198477403492;680.5712401187319;554.5397320224204;604.5979423683201;620.525298146918;626.6803929995735;633.1389310537666;8749.25631321332;8983.281337492985;9100.59047342858;9150.954245228731;9223;517.8420581722611;530.4986787485866;567.4552429667483;621.5338496127904;632.8734253149388;3103.984480077585;3905.4922860028582;3937.724359294822;4037.4953130858644;4079;83919.16080839235;85198.57400713081;89948.5502572496;90625;90960;71059.2894071063;71721.56556868834;71919;72024.55950881058;72883.63558182176;39336.606633933865;60674.69662651658;60746.48133796602;61662;64509.03236451457;8681.565921704016;8758.562071896253;8849.690260841096;8857.335699822668;8946.37375383717;45535.089298214516;46371.768141159075;46561.53438465572;46948.7652561735;47183;65997.67001164964;67117;68316.316836831;69055.65472172807;69928;10999.450027498753;11171.944140279247;11296.152788540729;11307.547698091985;11645.025307698708;12082.879171208175;12102.515899363927;12204;12205.511779528719;12553.246805191719;9630.566624501775;11651.941740291244;11735.647930562096;11812.70468238301;12171.634850954486;10901.618443354762;11546.134039947206;11603.883961160618;11707.765844682888;12208.633740987785;9724.513774311115;10636.627718029831;10981.780364392827;11124.276922000368;12152.392380380768;9025.684101056431;9450;9491.715248542554;9549;9691.030896910535;9310.137972405411;9354.95552700396;9504.857427138737;9731.756706082404;10087.89912100899 04:58:47 INFO - PROCESS | 1722 | __end_tp_report 04:58:47 INFO - PROCESS | 1722 | __start_cc_report 04:58:47 INFO - PROCESS | 1722 | _x_x_mozilla_cycle_collect,1073 04:58:47 INFO - PROCESS | 1722 | __end_cc_report 04:58:47 INFO - PROCESS | 1722 | __startTimestamp1454763527691__endTimestamp 04:58:47 INFO - PROCESS | 1722 | 04:58:47 INFO - PROCESS | 1722 | ------- Summary: start ------- 04:58:47 INFO - PROCESS | 1722 | Number of tests: 6 04:58:47 INFO - PROCESS | 1722 | 04:58:47 INFO - PROCESS | 1722 | [#0] dojo.html Cycles:165 Average:5698.44 Median:5925.00 stddev:613.75 (10.4%) stddev-sans-first:588.06 04:58:47 INFO - PROCESS | 1722 | Values: 3380.0 3445.9 3482.5 3491.7 3525.0 5534.9 5590.3 5600.4 5612.3 5652.7 5612.1 5662.5 5731.4 5810.8 5819.2 5102.8 5119.6 5162.3 5175.7 5208.9 5268.4 5269.7 5271.1 5290.8 5333.0 5075.2 5160.6 5196.8 5223.2 5227.9 5176.9 5191.4 5202.8 5215.3 5216.9 5069.1 5154.5 5157.6 5172.9 5195.2 5573.2 5573.4 5588.7 5596.3 5603.8 5452.6 6109.7 6198.5 6235.1 6240.2 6152.6 6186.1 6186.2 6191.4 6200.6 5608.2 5701.8 5732.2 5745.3 5765.7 6210.5 6216.0 6225.7 6227.4 6246.8 6032.3 6038.5 6068.8 6075.0 6090.6 6085.2 6232.6 6236.9 6244.8 6248.1 6142.1 6147.4 6160.0 6170.8 6179.8 6110.4 6164.3 6194.9 6201.1 6209.2 4848.4 4850.6 4884.5 4884.6 4945.9 4346.7 4349.0 4350.6 4374.3 4377.3 5579.1 5663.1 5699.2 5708.7 5718.5 5965.1 6129.0 6148.4 6177.9 6180.1 5701.7 5710.9 5714.9 5715.2 5732.4 5302.8 5310.9 5315.9 5320.3 5372.4 6182.2 6224.2 6264.8 6269.7 6283.5 6117.3 6132.6 6190.7 6262.7 6278.8 6250.6 6277.4 6279.3 6294.4 6298.0 6010.2 6101.2 6140.5 6198.2 6207.3 6070.0 6122.4 6123.4 6129.4 6198.0 6026.8 6033.9 6034.5 6041.7 6062.5 5930.3 5977.9 6013.4 6029.0 6035.6 5848.4 5865.9 5882.5 5939.1 5968.4 6007.0 6044.1 6050.3 6062.9 6067.2 5759.7 5887.9 5903.4 5925.0 5968.1 04:58:47 INFO - PROCESS | 1722 | 04:58:47 INFO - PROCESS | 1722 | [#1] ext.html Cycles:180 Average:73589.26 Median:40476.09 stddev:167659.55 (414.2%) stddev-sans-first:168040.05 04:58:47 INFO - PROCESS | 1722 | Values: 492.9 539.6 573.5 580.4 602.0 30043.7 31581.4 38089.8 38578.6 38760.0 37984.0 38138.9 41760.0 41925.6 41969.2 9474.3 9700.9 9706.8 9718.0 9720.9 9568.1 9691.8 9693.5 9694.6 9837.6 9772.5 9831.6 9840.7 9850.9 9854.7 9715.3 9819.0 9819.8 9831.3 9832.8 9688.6 9829.3 9829.6 9837.1 9840.1 40113.6 40382.8 40569.4 40574.4 40654.8 3158.8 3214.7 3318.2 3359.2 3558.3 28458.6 29482.3 30224.7 30332.7 30422.0 2695.6 2784.5 2787.8 2790.6 2853.2 426347.0 493319.0 498857.5 499628.0 499927.0 67630.0 67912.7 68165.0 68316.0 68381.0 67493.7 67518.7 67588.3 67797.7 67945.3 16794.0 16897.6 16954.3 16972.2 17024.7 12836.6 12919.6 12925.2 12943.2 12944.4 20705.2 21345.0 21579.4 21639.4 21684.8 7542.9 7803.3 8732.5 9156.0 9204.5 883.6 920.5 933.2 971.5 984.6 27902.9 27995.4 28453.9 28554.7 28589.9 1079.8 1146.7 1157.9 1164.8 1170.4 14568.9 14642.6 14689.4 14725.5 14896.4 754690.0 757049.0 757812.0 918498.0 927929.0 57580.0 57803.1 58677.4 58810.7 58822.7 1313.6 1341.5 1348.2 1454.8 1570.2 30813.4 31032.8 31608.0 31662.4 33420.5 56250.4 56979.0 57080.7 57104.4 57124.7 492769.0 498537.0 499314.0 499557.0 499778.0 43354.3 43461.9 44124.8 44227.0 44323.3 35062.8 36307.5 42076.2 43613.1 44025.0 34504.5 36026.0 37027.8 37424.3 38063.4 36427.1 36817.8 36954.0 37210.1 37330.6 37785.0 38290.0 38836.0 38875.6 38991.0 29939.7 32376.0 33177.7 33503.7 33873.0 24900.6 25092.5 25312.7 25331.1 25470.5 04:58:47 INFO - PROCESS | 1722 | 04:58:47 INFO - PROCESS | 1722 | [#2] jquery.html Cycles:180 Average:36410.16 Median:17358.12 stddev:122483.72 (705.6%) stddev-sans-first:122797.31 04:58:47 INFO - PROCESS | 1722 | Values: 307.6 343.1 365.6 366.3 370.6 18605.8 19420.4 20003.0 20068.7 20095.7 15371.9 15868.0 16314.8 17466.8 20241.4 5499.7 5525.1 5710.3 5730.2 5792.4 5591.0 5612.2 5648.0 5666.1 5680.6 4067.1 4251.7 4259.4 5503.9 5900.3 5968.6 6025.8 6106.9 6116.7 6134.1 4649.0 5262.7 5352.3 5353.8 5361.7 23471.5 24854.8 24994.4 25247.2 25491.9 2206.2 2239.9 2297.4 2338.0 2346.5 9455.7 10028.7 13909.2 14403.5 14566.2 1690.4 1698.6 1701.6 1745.9 1813.1 78898.7 101908.0 104062.0 104782.0 106089.5 10868.2 10986.3 11023.0 11066.2 11277.6 11794.2 13507.8 13586.9 13762.3 13792.1 8369.7 8380.2 8493.8 8502.4 8537.4 8670.9 8672.3 8673.8 8719.6 8732.3 4439.6 4465.3 4499.4 4514.6 4521.3 1759.9 1850.8 1892.1 1894.3 1896.9 791.7 814.5 882.9 904.8 957.1 18141.9 19363.8 19364.8 19511.6 19815.7 822.7 920.7 952.8 962.2 987.6 7947.6 8987.7 10947.3 10962.6 10968.7 734663.6 748251.0 748922.0 748941.0 754461.0 67433.3 67456.3 67684.6 86720.6 97918.0 1171.9 1176.6 1196.5 1201.4 1206.0 17769.6 17879.9 18016.6 18047.7 18484.8 34350.7 48360.5 50255.7 51204.7 51293.7 67408.3 67518.7 69384.3 70303.6 71075.0 7465.4 7676.6 7741.3 7754.3 7759.6 10082.9 12003.4 12059.7 12068.9 12139.5 9976.4 10100.3 10432.1 10523.9 10706.7 7917.8 10105.8 10170.6 10179.1 10219.7 10390.3 10490.3 10546.3 10661.9 10762.3 5855.0 6275.8 7598.9 7609.9 7613.8 9720.2 10114.2 10234.0 10314.6 10419.4 04:58:47 INFO - PROCESS | 1722 | 04:58:47 INFO - PROCESS | 1722 | [#3] mootools.html Cycles:180 Average:6045.46 Median:5421.23 stddev:3165.62 (58.4%) stddev-sans-first:3154.93 04:58:47 INFO - PROCESS | 1722 | Values: 1362.8 1486.6 1524.0 1739.6 1928.2 7865.4 8069.5 8561.7 8748.2 8755.9 8537.7 8621.6 8702.1 8720.4 8725.1 2164.8 2218.8 2456.2 2483.3 2483.8 2232.4 2241.1 2244.0 2386.7 2437.7 2405.0 2458.0 2459.4 2465.4 2470.6 2444.8 2468.8 2470.2 2476.9 2478.3 2435.5 2473.6 2475.0 2475.1 2476.7 8744.3 8825.3 8837.7 8838.6 8865.9 5375.2 5467.2 5524.1 5530.8 5535.4 3607.3 3748.9 3778.9 3779.8 3802.4 1049.9 1055.3 1080.0 1088.8 1091.8 12343.0 12363.3 12373.8 12374.0 12389.4 4857.8 4873.2 4944.3 4957.9 4996.8 8687.7 8702.8 10332.3 10334.0 10349.5 5479.8 5513.8 5514.1 5522.4 5533.2 4974.7 4986.3 4994.0 4998.4 5018.5 3586.4 3722.9 3905.1 3942.6 3995.6 1207.2 1231.9 1272.7 1278.7 1295.2 1314.6 1325.1 1335.2 1337.1 1363.7 7880.0 7915.5 7986.4 8023.4 8026.1 1159.5 1164.5 1166.1 1169.8 1181.8 6232.5 6338.5 6341.3 6347.6 6358.2 10202.6 10558.9 10560.9 10575.8 10726.7 10001.7 10407.2 10440.3 10521.2 10563.0 8084.4 8103.6 8189.9 8191.2 8206.9 7902.4 7903.3 7918.1 7958.2 8007.1 9195.0 9403.3 9429.2 9486.8 9526.8 9764.9 9785.9 9841.2 10162.8 10173.7 7519.0 7522.2 7562.1 7628.8 7650.6 7197.5 8109.0 8179.0 8185.0 8189.0 6959.9 7540.1 7574.4 7686.0 7732.0 7354.1 7448.7 7487.7 7555.5 7598.8 7579.8 7631.1 7631.2 7642.7 7665.3 6624.2 6860.9 6864.6 6871.2 6891.8 7008.8 7077.9 7091.1 7094.4 7096.5 04:58:47 INFO - PROCESS | 1722 | 04:58:47 INFO - PROCESS | 1722 | [#4] prototype.html Cycles:180 Average:5729.49 Median:6508.17 stddev:1794.43 (27.6%) stddev-sans-first:1752.98 04:58:47 INFO - PROCESS | 1722 | Values: 323.3 328.6 333.8 334.2 337.9 6434.4 6564.9 6596.4 6616.6 6809.6 5966.0 6326.1 6457.6 6477.6 6513.6 4243.4 4858.4 4871.3 4898.8 4905.9 4659.3 4766.1 4898.1 4915.4 4916.4 4534.3 4779.3 4792.2 4859.1 4869.8 4839.7 4841.2 4842.3 4848.8 4871.6 4147.2 4160.6 4161.6 4169.4 4169.9 6021.6 6207.7 6228.5 6233.5 6243.2 5629.2 5631.2 5651.8 5656.5 5666.5 6906.5 6914.4 6922.8 6927.8 6950.2 4356.3 4485.7 4487.6 4612.4 4643.1 7145.5 7250.1 7263.9 7268.0 7290.1 4657.6 4760.9 4766.3 4775.6 4776.1 4653.7 4820.4 4833.2 4834.9 4864.0 5665.4 5711.4 5713.6 5721.1 5724.5 5701.4 7020.4 7027.2 7031.3 7035.6 1661.9 1691.7 1693.8 1694.2 1698.4 1076.9 1098.5 1102.4 1114.2 1123.6 6510.7 6540.7 6550.5 6571.6 6582.0 7247.5 7259.9 7259.9 7273.5 7287.1 6405.9 6505.6 6520.4 6528.1 6554.0 3830.2 3849.9 3860.0 3865.6 3871.0 6107.4 7494.0 7513.0 7535.6 7550.0 6352.0 7146.2 7391.7 7419.9 7435.7 7246.2 7557.7 7559.2 7566.4 7570.2 6923.8 7208.9 7219.4 7231.3 7232.9 6710.9 6924.7 6940.3 7062.3 7102.9 7576.5 7588.5 7628.7 7639.4 7640.8 4615.3 4808.4 4811.1 4811.8 4822.0 7235.8 7243.7 7253.6 7254.2 7258.6 5702.7 6983.9 6995.3 7003.6 7011.9 6712.9 6933.9 6984.0 7020.7 7041.3 6882.4 6883.0 6888.4 6898.5 6909.9 7044.7 7047.0 7047.9 7052.8 7053.2 6634.4 6886.9 6902.6 6917.0 6919.8 04:58:47 INFO - PROCESS | 1722 | 04:58:47 INFO - PROCESS | 1722 | [#5] yui.html Cycles:180 Average:17315.87 Median:61204.24 stddev:23742.95 (38.8%) stddev-sans-first:23776.63 04:58:47 INFO - PROCESS | 1722 | Values: 663.5 695.0 698.9 722.1 766.8 12464.8 14634.2 14654.1 14903.7 14914.8 13589.0 13806.2 13906.3 14054.9 14210.2 696.7 712.4 849.5 869.0 870.5 711.2 712.2 712.8 712.9 830.0 901.0 913.6 913.8 914.6 918.0 903.4 904.1 905.9 906.4 907.0 534.0 543.6 546.1 656.5 668.1 14511.6 14513.8 14537.5 14565.2 14570.4 12321.4 12419.9 12514.5 12529.0 12930.8 10068.0 10092.2 10094.8 10095.2 10096.8 3518.8 3547.5 3551.5 3559.8 3562.4 57548.7 72206.6 74836.5 76657.0 82515.8 9455.3 9456.4 9466.5 9491.8 9521.2 20023.2 20041.0 20054.8 20068.0 20088.0 7426.3 7677.6 7690.4 7691.8 7754.7 4186.4 4189.4 4222.5 4258.5 4271.1 3536.5 3578.1 3579.9 3581.0 3582.6 661.1 672.3 673.7 679.8 680.6 554.5 604.6 620.5 626.7 633.1 8749.3 8983.3 9100.6 9151.0 9223.0 517.8 530.5 567.5 621.5 632.9 3104.0 3905.5 3937.7 4037.5 4079.0 83919.2 85198.6 89948.6 90625.0 90960.0 71059.3 71721.6 71919.0 72024.6 72883.6 39336.6 60674.7 60746.5 61662.0 64509.0 8681.6 8758.6 8849.7 8857.3 8946.4 45535.1 46371.8 46561.5 46948.8 47183.0 65997.7 67117.0 68316.3 69055.7 69928.0 10999.5 11171.9 11296.2 11307.5 11645.0 12082.9 12102.5 12204.0 12205.5 12553.2 9630.6 11651.9 11735.6 11812.7 12171.6 10901.6 11546.1 11603.9 11707.8 12208.6 9724.5 10636.6 10981.8 11124.3 12152.4 9025.7 9450.0 9491.7 9549.0 9691.0 9310.1 9355.0 9504.9 9731.8 10087.9 04:58:47 INFO - PROCESS | 1722 | -------- Summary: end -------- 04:58:47 INFO - PROCESS | 1722 | 04:58:48 INFO - TEST-INFO | 1722: exit 0 04:58:48 INFO - TEST-OK | dromaeo_css | took 1113960ms 04:58:48 INFO - TEST-START | kraken 04:58:48 INFO - operating with platform_type : mac_ 04:58:48 INFO - Initialising browser for kraken test... 04:58:48 INFO - TEST-INFO | started process 1729 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpZB49Bi/profile http://localhost:49271/getInfo.html) 04:58:48 INFO - PROCESS | 1729 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:58:50 INFO - PROCESS | 1729 | __metrics Screen width/height:1600/1200 04:58:50 INFO - PROCESS | 1729 | colorDepth:24 04:58:50 INFO - PROCESS | 1729 | Browser inner width/height: 1024/689 04:58:50 INFO - PROCESS | 1729 | __metrics 04:58:50 INFO - PROCESS | 1729 | 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" 04:58:50 INFO - PROCESS | 1729 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:58:51 INFO - TEST-INFO | 1729: exit 0 04:58:51 INFO - Browser initialized. 04:58:51 INFO - Running cycle 1/1 for kraken test... 04:58:51 INFO - TEST-INFO | started process 1731 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpZB49Bi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:59:03 INFO - PROCESS | 1731 | RSS: Main: 242819072 04:59:03 INFO - PROCESS | 1731 | 04:59:05 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 04:59:06 INFO - PROCESS | 1731 | RSS: Main: 288473088 04:59:06 INFO - PROCESS | 1731 | 04:59:08 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 04:59:09 INFO - PROCESS | 1731 | RSS: Main: 300638208 04:59:09 INFO - PROCESS | 1731 | 04:59:12 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 04:59:13 INFO - PROCESS | 1731 | RSS: Main: 286253056 04:59:13 INFO - PROCESS | 1731 | 04:59:15 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 04:59:16 INFO - PROCESS | 1731 | RSS: Main: 287211520 04:59:16 INFO - PROCESS | 1731 | 04:59:18 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:59:18 INFO - PROCESS | 1731 | RSS: Main: 288972800 04:59:18 INFO - PROCESS | 1731 | 04:59:21 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 04:59:22 INFO - PROCESS | 1731 | RSS: Main: 288243712 04:59:22 INFO - PROCESS | 1731 | 04:59:24 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 04:59:25 INFO - PROCESS | 1731 | RSS: Main: 290480128 04:59:25 INFO - PROCESS | 1731 | 04:59:28 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 04:59:28 INFO - PROCESS | 1731 | RSS: Main: 291500032 04:59:28 INFO - PROCESS | 1731 | 04:59:30 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:59:30 INFO - PROCESS | 1731 | RSS: Main: 326234112 04:59:30 INFO - PROCESS | 1731 | 04:59:32 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:59:33 INFO - PROCESS | 1731 | RSS: Main: 326144000 04:59:33 INFO - PROCESS | 1731 | 04:59:35 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:59:35 INFO - PROCESS | 1731 | RSS: Main: 331845632 04:59:35 INFO - PROCESS | 1731 | 04:59:38 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:59:39 INFO - PROCESS | 1731 | RSS: Main: 333725696 04:59:39 INFO - PROCESS | 1731 | 04:59:41 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:59:42 INFO - PROCESS | 1731 | RSS: Main: 333578240 04:59:42 INFO - PROCESS | 1731 | 04:59:43 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 04:59:44 INFO - PROCESS | 1731 | RSS: Main: 394649600 04:59:44 INFO - PROCESS | 1731 | 04:59:44 INFO - PROCESS | 1731 | __start_tp_report 04:59:44 INFO - PROCESS | 1731 | _x_x_mozilla_page_load 04:59:44 INFO - PROCESS | 1731 | _x_x_mozilla_page_load_details 04:59:44 INFO - PROCESS | 1731 | |i|pagename|runs| 04:59:44 INFO - PROCESS | 1731 | |0;ai-astar;111;110;110;110;111;111;115;108;111;110 04:59:44 INFO - PROCESS | 1731 | |1;audio-beat-detection;152;120;142;152;120;139;137;118;159;120 04:59:44 INFO - PROCESS | 1731 | |2;audio-dft;208;260;264;188;185;183;186;182;183;182 04:59:44 INFO - PROCESS | 1731 | |3;audio-fft;71;76;88;77;61;83;90;103;78;56 04:59:44 INFO - PROCESS | 1731 | |4;audio-oscillator;95;92;125;80;79;82;111;83;112;149 04:59:44 INFO - PROCESS | 1731 | |5;imaging-gaussian-blur;84;90;84;90;83;88;84;89;87;134 04:59:44 INFO - PROCESS | 1731 | |6;imaging-darkroom;93;94;93;93;94;92;93;92;93;93 04:59:44 INFO - PROCESS | 1731 | |7;imaging-desaturate;84;85;84;84;86;85;84;83;87;85 04:59:44 INFO - PROCESS | 1731 | |8;json-parse-financial;55;54;53;53;53;52;54;63;51;52 04:59:44 INFO - PROCESS | 1731 | |9;json-stringify-tinderbox;64;70;77;71;69;66;66;66;67;76 04:59:44 INFO - PROCESS | 1731 | |10;stanford-crypto-aes;83;84;83;83;83;82;83;83;80;83 04:59:44 INFO - PROCESS | 1731 | |11;stanford-crypto-ccm;127;125;148;144;118;124;119;121;120;123 04:59:44 INFO - PROCESS | 1731 | |12;stanford-crypto-pbkdf2;139;125;137;137;136;126;138;136;133;135 04:59:44 INFO - PROCESS | 1731 | |13;stanford-crypto-sha256-iterative;66;67;65;66;69;67;66;65;67;64 04:59:44 INFO - PROCESS | 1731 | __end_tp_report 04:59:44 INFO - PROCESS | 1731 | __start_cc_report 04:59:44 INFO - PROCESS | 1731 | _x_x_mozilla_cycle_collect,1140 04:59:44 INFO - PROCESS | 1731 | __end_cc_report 04:59:44 INFO - PROCESS | 1731 | __startTimestamp1454763584021__endTimestamp 04:59:44 INFO - PROCESS | 1731 | 04:59:44 INFO - PROCESS | 1731 | ------- Summary: start ------- 04:59:44 INFO - PROCESS | 1731 | Number of tests: 14 04:59:44 INFO - PROCESS | 1731 | 04:59:44 INFO - PROCESS | 1731 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.77 (1.6%) stddev-sans-first:1.87 04:59:44 INFO - PROCESS | 1731 | Values: 111.0 110.0 110.0 110.0 111.0 111.0 115.0 108.0 111.0 110.0 04:59:44 INFO - PROCESS | 1731 | 04:59:44 INFO - PROCESS | 1731 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:140.50 stddev:15.56 (11.1%) stddev-sans-first:15.37 04:59:44 INFO - PROCESS | 1731 | Values: 152.0 120.0 142.0 152.0 120.0 139.0 137.0 118.0 159.0 120.0 04:59:44 INFO - PROCESS | 1731 | 04:59:44 INFO - PROCESS | 1731 | [#2] audio-dft Cycles:10 Average:202.10 Median:187.00 stddev:32.50 (17.4%) stddev-sans-first:34.40 04:59:44 INFO - PROCESS | 1731 | Values: 208.0 260.0 264.0 188.0 185.0 183.0 186.0 182.0 183.0 182.0 04:59:44 INFO - PROCESS | 1731 | 04:59:44 INFO - PROCESS | 1731 | [#3] audio-fft Cycles:10 Average:78.30 Median:77.50 stddev:13.82 (17.8%) stddev-sans-first:14.41 04:59:44 INFO - PROCESS | 1731 | Values: 71.0 76.0 88.0 77.0 61.0 83.0 90.0 103.0 78.0 56.0 04:59:44 INFO - PROCESS | 1731 | 04:59:44 INFO - PROCESS | 1731 | [#4] audio-oscillator Cycles:10 Average:100.80 Median:81.00 stddev:23.16 (28.6%) stddev-sans-first:24.47 04:59:44 INFO - PROCESS | 1731 | Values: 95.0 92.0 125.0 80.0 79.0 82.0 111.0 83.0 112.0 149.0 04:59:44 INFO - PROCESS | 1731 | 04:59:44 INFO - PROCESS | 1731 | [#5] imaging-gaussian-blur Cycles:10 Average:91.30 Median:87.50 stddev:15.24 (17.4%) stddev-sans-first:15.93 04:59:44 INFO - PROCESS | 1731 | Values: 84.0 90.0 84.0 90.0 83.0 88.0 84.0 89.0 87.0 134.0 04:59:44 INFO - PROCESS | 1731 | 04:59:44 INFO - PROCESS | 1731 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 04:59:44 INFO - PROCESS | 1731 | Values: 93.0 94.0 93.0 93.0 94.0 92.0 93.0 92.0 93.0 93.0 04:59:44 INFO - PROCESS | 1731 | 04:59:44 INFO - PROCESS | 1731 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.16 (1.4%) stddev-sans-first:1.20 04:59:44 INFO - PROCESS | 1731 | Values: 84.0 85.0 84.0 84.0 86.0 85.0 84.0 83.0 87.0 85.0 04:59:44 INFO - PROCESS | 1731 | 04:59:44 INFO - PROCESS | 1731 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:53.50 stddev:3.37 (6.3%) stddev-sans-first:3.55 04:59:44 INFO - PROCESS | 1731 | Values: 55.0 54.0 53.0 53.0 53.0 52.0 54.0 63.0 51.0 52.0 04:59:44 INFO - PROCESS | 1731 | 04:59:44 INFO - PROCESS | 1731 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.50 stddev:4.39 (6.3%) stddev-sans-first:4.24 04:59:44 INFO - PROCESS | 1731 | Values: 64.0 70.0 77.0 71.0 69.0 66.0 66.0 66.0 67.0 76.0 04:59:44 INFO - PROCESS | 1731 | 04:59:44 INFO - PROCESS | 1731 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.06 (1.3%) stddev-sans-first:1.12 04:59:44 INFO - PROCESS | 1731 | Values: 83.0 84.0 83.0 83.0 83.0 82.0 83.0 83.0 80.0 83.0 04:59:44 INFO - PROCESS | 1731 | 04:59:44 INFO - PROCESS | 1731 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:124.50 stddev:10.48 (8.4%) stddev-sans-first:11.12 04:59:44 INFO - PROCESS | 1731 | Values: 127.0 125.0 148.0 144.0 118.0 124.0 119.0 121.0 120.0 123.0 04:59:44 INFO - PROCESS | 1731 | 04:59:44 INFO - PROCESS | 1731 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.20 Median:136.50 stddev:4.87 (3.6%) stddev-sans-first:4.85 04:59:44 INFO - PROCESS | 1731 | Values: 139.0 125.0 137.0 137.0 136.0 126.0 138.0 136.0 133.0 135.0 04:59:44 INFO - PROCESS | 1731 | 04:59:44 INFO - PROCESS | 1731 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.40 (2.1%) stddev-sans-first:1.48 04:59:44 INFO - PROCESS | 1731 | Values: 66.0 67.0 65.0 66.0 69.0 67.0 66.0 65.0 67.0 64.0 04:59:44 INFO - PROCESS | 1731 | -------- Summary: end -------- 04:59:44 INFO - PROCESS | 1731 | 04:59:44 INFO - TEST-INFO | 1731: exit 0 04:59:44 INFO - TEST-OK | kraken | took 56605ms 04:59:44 INFO - SUITE-END | took 1170s 04:59:45 INFO - Completed test suite (00:19:30) 04:59:45 INFO - Working with test: dromaeo_css 04:59:45 INFO - Generating results file: dromaeo_css 04:59:45 INFO - Working with test: kraken 04:59:45 INFO - Generating results file: kraken 04:59:45 INFO - javascript benchmark 04:59:45 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:59:45 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 04:59:45 INFO - process_Request line: dromaeo_css 7501.70 graph.html#tests=[[72,64,59]] 04:59:45 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:59:45 INFO - process_Request line: kraken 1430.00 graph.html#tests=[[232,64,59]] 04:59:45 INFO - RETURN: dromaeo_css: 7501.70 04:59:45 INFO - RETURN: kraken: 1430.00 04:59:45 INFO - javascript benchmark 04:59:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3379.9831000844997, 3445.948310775337, 3482.4602186661045, 3491.7206623470115, 3525.0129963610198, 5534.944650553503, 5590.301212348457, 5600.411956744544, 5612.298462692158, 5652.745626446809, 5612.102063669803, 5662.518685911692, 5731.426857314266, 5810.825675229739, 5819.243498345219, 5102.846914592568, 5119.641625086236, 5162.328897243353, 5175.715335656538, 5208.869778255536, 5268.420473747885, 5269.736513174326, 5271.103912334912, 5290.814821481249, 5332.973335133319, 5075.21334193197, 5160.638755287131, 5196.844094677166, 5223.242629818655, 5227.947720522803, 5176.948230517722, 5191.402988656315, 5202.843914682566, 5215.295935048758, 5216.921746173811, 5069.1129052416045, 5154.5103215194495, 5157.638965272433, 5172.948270517322, 5195.246689230078, 5573.219749235111, 5573.41479144692, 5588.6646801192055, 5596.300462442195, 5603.831885043455, 5452.645578037414, 6109.694515274263, 6198.535109866778, 6235.064740288947, 6240.157578726905, 6152.5693201475915, 6186.133941248228, 6186.164867742842, 6191.380861913818, 6200.596961197508, 5608.186812912105, 5701.771929122871, 5732.22614946981, 5745.281839769987, 5765.682887441189, 6210.534209934273, 6215.96892015537, 6225.657588832658, 6227.439530442282, 6246.812595622138, 6032.263044918261, 6038.45448098352, 6068.817935461943, 6074.967255566565, 6090.573659843857, 6085.152228562294, 6232.626042437469, 6236.875262494725, 6244.750209991549, 6248.125262463259, 6142.140100385949, 6147.44672979434, 6160.045192995093, 6170.81487555374, 6179.783707570214, 6110.358412366726, 6164.260288765377, 6194.938050619527, 6201.069839524108, 6209.161763162006, 4848.442429120626, 4850.587700045465, 4884.511548845087, 4884.560389564886, 4945.901081978341, 4346.739195648208, 4348.978255108767, 4350.58669426404, 4374.321980093091, 4377.3433984901885, 5579.079451890392, 5663.122216056518, 5699.202111704365, 5708.686022268732, 5718.51392631631, 5965.13505541694, 6128.961487065963, 6148.415900489446, 6177.938220617826, 6180.072989051679, 5701.743421546041, 5710.914336284959, 5714.942850571524, 5715.1713001614535, 5732.426757324234, 5302.761375738101, 5310.867228319323, 5315.867103322448, 5320.255164277004, 5372.382176049804, 6182.196314479179, 6224.1597384352535, 6264.812055638247, 6269.749210031548, 6283.465905398001, 6117.3402608778015, 6132.600268413531, 6190.659513726789, 6262.655553944577, 6278.843028924313, 6250.593711408744, 6277.372262773869, 6279.340669229665, 6294.402031806971, 6298.02380631003, 6010.2186715726675, 6101.2068431105445, 6140.539459540463, 6198.2252218472695, 6207.317195108625, 6069.969650151721, 6122.367660829284, 6123.404636889863, 6129.358790882775, 6198.044557784222, 6026.819195424145, 6033.879322413615, 6034.487068599043, 6041.697915104315, 6062.454379105901, 5930.28836539618, 5977.880442391041, 6013.428724271187, 6029.0, 6035.577509574463, 5848.385919478564, 5865.853353666193, 5882.49998750111, 5939.138824870456, 5968.373320801427, 6007.008843540767, 6044.093385992136, 6050.273967123973, 6062.939370606237, 6067.211262535842, 5759.7408116634015, 5887.911681324698, 5903.380145084704, 5925.0, 5968.074948383008], "unit": "score", "name": "dojo.html", "value": 5660.275842111627}, {"lowerIsBetter": false, "replicates": [492.90141971605686, 539.6411386428025, 573.5239751006665, 580.4166812353582, 601.9969900150498, 30043.699563004364, 31581.368372632533, 38089.80955095224, 38578.61421385785, 38760.03099922503, 37984.0, 38138.855834324946, 41759.956001099985, 41925.58074419255, 41969.160616787645, 9474.33679642427, 9700.854487182698, 9706.757331066709, 9717.951410242975, 9720.902790972106, 9568.09103135201, 9691.819340648333, 9693.466859322734, 9694.563744631509, 9837.606495740198, 9772.462514561696, 9831.557579908886, 9840.704778856645, 9850.90149098507, 9854.70435886921, 9715.319927605071, 9819.0, 9819.754506137368, 9831.262655300881, 9832.754181145458, 9688.612455501772, 9829.311948163631, 9829.55766990487, 9837.114659680592, 9840.11438970496, 40113.59886401128, 40382.79808600967, 40569.391459128135, 40574.39138412926, 40654.79672601618, 3158.7630927680284, 3214.7428205743486, 3318.2202182487094, 3359.2105855124028, 3558.2527669189503, 28458.573121403195, 29482.262943426373, 30224.697753022407, 30332.69667303321, 30422.0, 2695.6360891279624, 2784.5266304728243, 2787.8048536602446, 2790.5674620433865, 2853.1725799518113, 426347.0, 493319.0, 498857.5057124727, 499628.0, 499927.0, 67630.0, 67912.66043669848, 68165.0, 68316.0, 68381.0, 67493.66253168801, 67518.66240668863, 67588.32411675919, 67797.66101169462, 67945.3205467939, 16794.0, 16897.577560561083, 16954.321827127023, 16972.23624936881, 17024.744628830576, 12836.614901552968, 12919.612411627666, 12925.15986460877, 12943.223406595635, 12944.352782360844, 20705.171793128407, 21345.0, 21579.352619421443, 21639.35081947544, 21684.78315216859, 7542.886856697154, 7803.264600518728, 8732.519711415933, 9155.954220228989, 9204.539773011322, 883.5935469683889, 920.5443305563655, 933.2207606648388, 971.4511301114848, 984.6209209454269, 27902.883884644387, 27995.44009119847, 28453.857730711214, 28554.71503782335, 28589.857050714614, 1079.8434227037035, 1146.7075895646556, 1157.8842115788354, 1164.8136298192248, 1170.3913964738458, 14568.927155364156, 14642.560723178109, 14689.412423503154, 14725.484608038667, 14896.404143834125, 754690.0, 757049.0, 757812.0, 918498.0, 927929.0, 57580.0, 57803.13295300574, 58677.41322586805, 58810.70594646999, 58822.70588647029, 1313.6256166992362, 1341.4500054977607, 1348.1776116568885, 1454.7526920423554, 1570.1756577796748, 30813.383732325678, 31032.844835775675, 31608.0, 31662.36675266436, 33420.498692520116, 56250.43749562452, 56979.0, 57080.714596428414, 57104.42895570991, 57124.71437642785, 492769.0, 498537.0, 499314.0, 499557.0, 499778.0, 43354.34968475538, 43461.91345216395, 44124.77937610292, 44227.0, 44323.33514997213, 35062.82468587743, 36307.45538816973, 42076.158476830904, 43613.127737445706, 44025.0, 34504.48243276403, 36026.0, 37027.81486092552, 37424.25151497009, 38063.42904856374, 36427.089322766085, 36817.815910921345, 36954.0, 37210.06974825651, 37330.62669373272, 37785.0, 38290.0, 38836.0, 38875.6112438872, 38991.0, 29939.700602993693, 32376.0, 33177.66822331746, 33503.66496335006, 33873.0, 24900.62649060229, 25092.498150036532, 25312.74687253104, 25331.113411030525, 25470.49059018772], "unit": "score", "name": "ext.html", "value": 20411.966157643838}, {"lowerIsBetter": false, "replicates": [307.59244001697755, 343.10946683772414, 365.58688681789573, 366.2967103161929, 370.6293706293706, 18605.81394186058, 19420.41738747838, 20003.0, 20068.695534790248, 20095.698564521506, 15371.923140384282, 15868.0, 16314.83685163148, 17466.825331746677, 20241.392758217276, 5499.697516636584, 5525.143602741581, 5710.314762228539, 5730.19777231188, 5792.4497172768515, 5591.049521581321, 5612.242347283105, 5648.0, 5666.121751128561, 5680.602357834953, 4067.0849058961794, 4251.681123915703, 4259.424977628027, 5503.889922201553, 5900.29196496421, 5968.582199246054, 6025.78909738157, 6106.900757863583, 6116.724747386356, 6134.079888016789, 4648.976755116203, 5262.684238945675, 5352.277442545284, 5353.812616558402, 5361.731913404353, 23471.530569388517, 24854.751452485423, 24994.375140621447, 25247.24258272255, 25491.872540637363, 2206.2167930384803, 2239.93603038557, 2297.425643589103, 2337.976620233793, 2346.4603141277603, 9455.716328510087, 10028.749281267954, 13909.234992075431, 14403.495877644336, 14566.198859062748, 1690.357664087651, 1698.583846957491, 1701.6426550424303, 1745.8516026137793, 1813.0572102506624, 78898.68810495205, 101908.0, 104062.0, 104782.0, 106089.46955265252, 10868.239223254297, 10986.340819550853, 11023.0, 11066.225364224589, 11277.605283815026, 11794.233374830781, 13507.797383039262, 13586.93206533961, 13762.311884405739, 13792.103513271806, 8369.665213391396, 8380.16198380157, 8493.830123397498, 8502.404831661725, 8537.359698022674, 8670.86993695095, 8672.306215502746, 8673.783155421164, 8719.60761765722, 8732.257758090507, 4439.64482841372, 4465.307877279027, 4499.4150760400935, 4514.616257618073, 4521.344405061248, 1759.8504127149079, 1850.7594012778522, 1892.0539730134933, 1894.2612381171355, 1896.9039211671181, 791.7110254757088, 814.5031530766228, 882.9470231786113, 904.7783293093103, 957.1242313283268, 18141.909290453463, 19363.8063619362, 19364.806351936582, 19511.609767804566, 19815.702764458543, 822.6956026270318, 920.6731610278389, 952.8046750416148, 962.1773383756927, 987.6247026130025, 7947.642356093989, 8987.730368088967, 10947.288426252268, 10962.616308429167, 10968.670939871816, 734663.5935023518, 748251.0, 748922.0, 748941.0, 754461.0, 67433.3141671462, 67456.32543674599, 67684.64630707358, 86720.56639716761, 97918.0, 1171.9003884669728, 1176.5764324843049, 1196.4873765093234, 1201.4473342262481, 1205.9939700301618, 17769.55576110556, 17879.910600447434, 18016.639667206844, 18047.729284060486, 18484.81515184831, 34350.65649343475, 48360.51639483701, 50255.74872125616, 51204.74397627988, 51293.7435312821, 67408.32591674216, 67518.66240668962, 69384.3061569398, 70303.64848175726, 71075.0, 7465.3654439371085, 7676.6161691916295, 7741.341985931259, 7754.34088102495, 7759.61201939912, 10082.899171008195, 12003.399830008639, 12059.69850753703, 12068.862095854965, 12139.453724582592, 9976.351537150062, 10100.343477673927, 10432.061114499731, 10523.894761052597, 10706.73233169177, 7917.802054948673, 10105.848412273968, 10170.593176272867, 10179.061299815334, 10219.693409197438, 10390.272680912565, 10490.324967133332, 10546.26176167661, 10661.8933810664, 10762.300450470695, 5854.970725146347, 6275.780347687809, 7598.924010760043, 7609.896564998155, 7613.7817949127875, 9720.222382209548, 10114.241431892491, 10234.0, 10314.638987635397, 10419.42693151884], "unit": "score", "name": "jquery.html", "value": 9039.742472523683}, {"lowerIsBetter": false, "replicates": [1362.80920671106, 1486.6134804950714, 1523.961900952476, 1739.6085880676842, 1928.238345853388, 7865.4494185406975, 8069.4754840935375, 8561.657533698652, 8748.212660860521, 8755.912440875589, 8537.74386768398, 8621.568921553913, 8702.129787021311, 8720.389572729911, 8725.127487251271, 2164.848460607758, 2218.7670294619074, 2456.189457479032, 2483.255023492954, 2483.801295896324, 2232.408411770874, 2241.05875532276, 2243.9789895597464, 2386.689730335054, 2437.7196622388387, 2405.0139442828445, 2457.9631305530434, 2459.434330104077, 2465.432950421395, 2470.629405589158, 2444.841085329448, 2468.839525430841, 2470.1601455505215, 2476.8885400156855, 2478.330850670318, 2435.4641978764644, 2473.6165894286414, 2474.985256045031, 2475.10896077412, 2476.727559968402, 8744.300455963508, 8825.338099642488, 8837.690680826141, 8838.602262898185, 8865.867011994826, 5375.22059301403, 5467.234587157801, 5524.116141417394, 5530.751116199781, 5535.446455354472, 3607.3326434609417, 3748.861152737464, 3778.886633401002, 3779.7543159694533, 3802.410626352892, 1049.9107575856062, 1055.2665897201448, 1080.0, 1088.842117892909, 1091.770728147082, 12343.0, 12363.258204507758, 12373.814392784116, 12374.010079193642, 12389.380530973416, 4857.757112144379, 4873.244647079709, 4944.25836124577, 4957.90084198314, 4996.825111121093, 8687.739367818975, 8702.782430439163, 10332.328398654063, 10334.0, 10349.482525873676, 5479.780808767684, 5513.751881165357, 5514.09017512106, 5522.3649280333275, 5533.1976863354585, 4974.701517908865, 4986.276989836453, 4993.975030124899, 4998.4251811042195, 5018.4981501849525, 3586.372384832644, 3722.925541489155, 3905.062784931596, 3942.5860284669698, 3995.6403923647013, 1207.209277922962, 1231.907606929466, 1272.6563827766452, 1278.6931136527166, 1295.2099219476113, 1314.5859054397833, 1325.0989327257557, 1335.1855368225374, 1337.0573745509394, 1363.6863521390135, 7880.014998125234, 7915.525068495908, 7986.361091112697, 8023.438359314792, 8026.117127116013, 1159.5072094359864, 1164.4527072276187, 1166.0904494494307, 1169.8069818480026, 1181.8109102543551, 6232.532560058014, 6338.461230795434, 6341.270753863272, 6347.587406818542, 6358.237011558643, 10202.564857167043, 10558.894411055944, 10560.94390560953, 10575.841362379571, 10726.678199654023, 10001.699949001542, 10407.167426605853, 10440.321379110334, 10521.158307335394, 10563.0, 8084.434089613788, 8103.635336409876, 8189.918100819034, 8191.221833925887, 8206.917930820735, 7902.407319450949, 7903.328217101611, 7918.089419716576, 7958.204179581995, 8007.079185893696, 9194.95402522983, 9403.294752893697, 9429.245660347293, 9486.762830929007, 9526.809463810823, 9764.9023509764, 9785.902140978498, 9841.212702983601, 10162.847557286499, 10173.745656358355, 7518.962405187939, 7522.247775222434, 7562.054743157106, 7628.771136865903, 7650.579218143055, 7197.532160409557, 8108.986376702912, 8179.018517777905, 8184.9768778902635, 8188.976377952756, 6959.860802784017, 7540.095188577406, 7574.431917606092, 7686.0, 7732.0, 7354.080739907512, 7448.664810083451, 7487.700491980259, 7555.508891922007, 7598.848023039619, 7579.810504737426, 7631.084269887649, 7631.236876312324, 7642.7325043623205, 7665.3101220890385, 6624.238212605612, 6860.931390686229, 6864.553804002724, 6871.175458944758, 6891.75878844238, 7008.789736307919, 7077.858442831011, 7091.1490621125795, 7094.432445404252, 7096.503244772816], "unit": "score", "name": "mootools.html", "value": 4940.143096023559}, {"lowerIsBetter": false, "replicates": [323.3452259175171, 328.57941834451896, 333.7546903026277, 334.17292201800547, 337.94592865141584, 6434.420902118808, 6564.934350656492, 6596.373344532268, 6616.569922955011, 6809.557378770376, 5965.955957707395, 6326.145970294009, 6457.580257283285, 6477.643729594871, 6513.576617519858, 4243.405923170759, 4858.368412106422, 4871.318015477836, 4898.755062246892, 4905.901881962359, 4659.347691323217, 4766.094442056015, 4898.093852637274, 4915.434725006617, 4916.385451818523, 4534.31985202219, 4779.259214821708, 4792.233242681172, 4859.125357435661, 4869.780859861315, 4839.709617422948, 4841.2012018016985, 4842.29786680931, 4848.763565290828, 4871.585915197213, 4147.212029714345, 4160.646345060643, 4161.56303588125, 4169.374593810922, 4169.854055108087, 6021.608595441282, 6207.658578778165, 6228.532860035515, 6233.470155036827, 6243.157173781572, 5629.240052592889, 5631.239782629334, 5651.802186923438, 5656.490915817555, 5666.46168613981, 6906.482013848981, 6914.377706006433, 6922.757703480404, 6927.792166235021, 6950.235474097845, 4356.259435895905, 4485.663575231838, 4487.640988720895, 4612.4003879495785, 4643.071385722869, 7145.499815012951, 7250.1299844018, 7263.89104163438, 7268.0, 7290.088738907637, 4657.60410365116, 4760.904781904343, 4766.332713420124, 4775.617950563947, 4776.09254241693, 4653.744044077608, 4820.373351464287, 4833.154198015403, 4834.903301933941, 4863.975680121647, 5665.3768085510565, 5711.371749107595, 5713.628614140068, 5721.084626459747, 5724.4561766632105, 5701.40135285789, 7020.438364930793, 7027.227005029443, 7031.332023457866, 7035.613041282676, 1661.858742006943, 1691.6785810695928, 1693.8052124005897, 1694.195257252795, 1698.405558054671, 1076.8600081989448, 1098.4892025208317, 1102.4377567440663, 1114.2033446086086, 1123.6067376418353, 6510.707018184098, 6540.70566824494, 6550.541462097703, 6571.605703657796, 6582.0, 7247.4926755126635, 7259.854802904018, 7259.89110163348, 7273.454490913203, 7287.0526831512625, 6405.871882562323, 6505.642189679518, 6520.380563846522, 6528.053432252297, 6554.049662798868, 3830.2339532093692, 3849.8652547160714, 3859.9807000964815, 3865.5747867734526, 3870.9806450967567, 6107.389261073857, 7494.0, 7512.962435187789, 7535.585542795089, 7550.0, 6351.98368261076, 7146.2496437874315, 7391.704331826667, 7419.925800741924, 7435.7025718970635, 7246.166690830517, 7557.735479258199, 7559.1684914659345, 7566.394688424803, 7570.16728159902, 6923.826904327432, 7208.927910721035, 7219.350258476762, 7231.2768723127265, 7232.89150662751, 6710.865782684416, 6924.6537673117155, 6940.340667636567, 7062.293770623102, 7102.857942841011, 7576.545407275581, 7588.544687318778, 7628.694852205849, 7639.388848891964, 7640.847183056197, 4615.26155815068, 4808.422989241313, 4811.109944660249, 4811.759412029454, 4821.975890120667, 7235.819104522429, 7243.710251589878, 7253.601051942193, 7254.202037775946, 7258.637068146466, 5702.6863522506665, 6983.930160698328, 6995.335443132894, 7003.6498175092065, 7011.929880701127, 6712.899306510309, 6933.930660693531, 6984.0, 7020.684069217, 7041.3310735480045, 6882.380585747307, 6883.0, 6888.448924086161, 6898.517103802686, 6909.861802764017, 7044.682989265598, 7047.0, 7047.859042819217, 7052.753153639598, 7053.153621565445, 6634.436072933855, 6886.8622627548175, 6902.620355880475, 6917.0, 6919.792406227822], "unit": "score", "name": "prototype.html", "value": 5134.3270178948305}, {"lowerIsBetter": false, "replicates": [663.5454713521237, 694.9652517374133, 698.8602279544091, 722.1478655186877, 766.7967988483053, 12464.81302780459, 14634.195119268436, 14654.120752754841, 14903.701925961488, 14914.776278355834, 13589.0, 13806.171629702225, 13906.304684765746, 14054.859451405482, 14210.218437985906, 696.7073828991836, 712.3766704133883, 849.5200211880283, 868.9789497340631, 870.5473153959969, 711.2318695808515, 712.1845486917503, 712.8217945513621, 712.8609921065395, 830.0371568979984, 900.9504477253748, 913.5980168725739, 913.8355096082703, 914.5930061122802, 917.9810410444402, 903.4172958441801, 904.1410659873147, 905.8958219804741, 906.419891269588, 906.9909300907038, 534.0280689145757, 543.6330476928058, 546.1234718277148, 656.5305806348437, 668.1381018486147, 14511.564653060424, 14513.782293265609, 14537.491187808377, 14565.198914059722, 14570.417183312655, 12321.383930803424, 12419.937900310531, 12514.499420023189, 12529.0, 12930.806037909439, 10068.0, 10092.192624590016, 10094.848577271347, 10095.192384609214, 10096.798064038678, 3518.82405879705, 3547.5033495310677, 3551.485034669958, 3559.75081744278, 3562.412201986669, 57548.71225643887, 72206.63896680484, 74836.5032699343, 76657.0, 82515.7622635661, 9455.338126331228, 9456.385334953206, 9466.526673666289, 9491.810163796823, 9521.238300936047, 20023.199072036954, 20040.997950102435, 20054.799452005584, 20068.0, 20088.0, 7426.331630153312, 7677.577733224614, 7690.384769218449, 7691.807704807425, 7754.6898124074405, 4186.413902053715, 4189.4344263524035, 4222.493300803923, 4258.488981322199, 4271.081717430768, 3536.451849963208, 3578.087587665129, 3579.9105022374647, 3581.0152208142968, 3582.6417358264484, 661.1141070964834, 672.2672287206871, 673.6699017481399, 679.8198477403492, 680.5712401187319, 554.5397320224204, 604.5979423683201, 620.525298146918, 626.6803929995735, 633.1389310537666, 8749.25631321332, 8983.281337492985, 9100.59047342858, 9150.954245228731, 9223.0, 517.8420581722611, 530.4986787485866, 567.4552429667483, 621.5338496127904, 632.8734253149388, 3103.984480077585, 3905.4922860028582, 3937.724359294822, 4037.4953130858644, 4079.0, 83919.16080839235, 85198.57400713081, 89948.5502572496, 90625.0, 90960.0, 71059.2894071063, 71721.56556868834, 71919.0, 72024.55950881058, 72883.63558182176, 39336.606633933865, 60674.69662651658, 60746.48133796602, 61662.0, 64509.03236451457, 8681.565921704016, 8758.562071896253, 8849.690260841096, 8857.335699822668, 8946.37375383717, 45535.089298214516, 46371.768141159075, 46561.53438465572, 46948.7652561735, 47183.0, 65997.67001164964, 67117.0, 68316.316836831, 69055.65472172807, 69928.0, 10999.450027498753, 11171.944140279247, 11296.152788540729, 11307.547698091985, 11645.025307698708, 12082.879171208175, 12102.515899363927, 12204.0, 12205.511779528719, 12553.246805191719, 9630.566624501775, 11651.941740291244, 11735.647930562096, 11812.70468238301, 12171.634850954486, 10901.618443354762, 11546.134039947206, 11603.883961160618, 11707.765844682888, 12208.633740987785, 9724.513774311115, 10636.627718029831, 10981.780364392827, 11124.276922000368, 12152.392380380768, 9025.684101056431, 9450.0, 9491.715248542554, 9549.0, 9691.030896910535, 9310.137972405411, 9354.95552700396, 9504.857427138737, 9731.756706082404, 10087.89912100899], "unit": "score", "name": "yui.html", "value": 6727.008267441861}], "name": "dromaeo_css", "value": 7501.703152700645}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 110.0, 111.0, 111.0, 115.0, 108.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [152.0, 120.0, 142.0, 152.0, 120.0, 139.0, 137.0, 118.0, 159.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 135.9}, {"lowerIsBetter": true, "replicates": [208.0, 260.0, 264.0, 188.0, 185.0, 183.0, 186.0, 182.0, 183.0, 182.0], "unit": "score", "name": "audio-dft", "value": 202.1}, {"lowerIsBetter": true, "replicates": [71.0, 76.0, 88.0, 77.0, 61.0, 83.0, 90.0, 103.0, 78.0, 56.0], "unit": "score", "name": "audio-fft", "value": 78.3}, {"lowerIsBetter": true, "replicates": [95.0, 92.0, 125.0, 80.0, 79.0, 82.0, 111.0, 83.0, 112.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 100.8}, {"lowerIsBetter": true, "replicates": [84.0, 90.0, 84.0, 90.0, 83.0, 88.0, 84.0, 89.0, 87.0, 134.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.3}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 93.0, 93.0, 94.0, 92.0, 93.0, 92.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.0}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 84.0, 86.0, 85.0, 84.0, 83.0, 87.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 84.7}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 53.0, 53.0, 53.0, 52.0, 54.0, 63.0, 51.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.0}, {"lowerIsBetter": true, "replicates": [64.0, 70.0, 77.0, 71.0, 69.0, 66.0, 66.0, 66.0, 67.0, 76.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 83.0, 83.0, 83.0, 82.0, 83.0, 83.0, 80.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [127.0, 125.0, 148.0, 144.0, 118.0, 124.0, 119.0, 121.0, 120.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.9}, {"lowerIsBetter": true, "replicates": [139.0, 125.0, 137.0, 137.0, 136.0, 126.0, 138.0, 136.0, 133.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.2}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 65.0, 66.0, 69.0, 67.0, 66.0, 65.0, 67.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1430.0000000000002}]} 04:59:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1430.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7501.70"}}} 04:59:45 INFO - Return code: 0 04:59:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:59:45 INFO - # TBPL SUCCESS # 04:59:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:59:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:59:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:59:45 INFO - 2016-02-06 04:59:45.399 screenresolution[1735:16551] starting screenresolution argv=screenresolution get 04:59:45 INFO - 2016-02-06 04:59:45.401 screenresolution[1735:16551] Display 0: 1600x1200x32@60 04:59:45 INFO - 2016-02-06 04:59:45.407 screenresolution[1736:16554] starting screenresolution argv=screenresolution list 04:59:45 INFO - Available Modes on Display 0 04:59:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:59:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:59:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:59:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:59:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:59:45 INFO - Intel Iris: 04:59:45 INFO - Chipset Model: Intel Iris 04:59:45 INFO - Type: GPU 04:59:45 INFO - Bus: Built-In 04:59:45 INFO - VRAM (Dynamic, Max): 1536 MB 04:59:45 INFO - Vendor: Intel (0x8086) 04:59:45 INFO - Device ID: 0x0a2e 04:59:45 INFO - Revision ID: 0x0009 04:59:45 INFO - Displays: 04:59:45 INFO - Display: 04:59:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:59:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:59:45 INFO - Display Serial Number: 1600x1200 60 04:59:45 INFO - Main Display: Yes 04:59:45 INFO - Mirror: Off 04:59:45 INFO - Online: Yes 04:59:45 INFO - Rotation: Supported 04:59:45 INFO - Return code: 0 04:59:45 INFO - Running post-action listener: _resource_record_post_action 04:59:45 INFO - Running post-run listener: _resource_record_post_run 04:59:46 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 33922560; Write bytes: 711795712; Read time: 352; Write time: 2601 04:59:46 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 404640256; Write bytes: 407115776; Read time: 30376; Write time: 896 04:59:46 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 32140800; Write bytes: 303832064; Read time: 334; Write time: 1703 04:59:46 INFO - Running post-run listener: _upload_blobber_files 04:59:46 INFO - Blob upload gear active. 04:59:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:59:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:59:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:59:47 INFO - (blobuploader) - INFO - Open directory for files ... 04:59:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:59:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:48 INFO - (blobuploader) - WARNING - File uploaded to blobserver but failed uploading to Amazon S3. 04:59:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:48 INFO - (blobuploader) - INFO - Done attempting. 04:59:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:59:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:59:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:49 INFO - (blobuploader) - INFO - Done attempting. 04:59:49 INFO - (blobuploader) - INFO - Iteration through files over. 04:59:49 INFO - Return code: 0 04:59:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:59:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:59:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e411459d3f47b92d3a9bd2afc828d451eda8afe9400ca0a8397934d94324ea5e924d821cf5ba3d8919b4fa3b1ad449dc7b983f611e099d4539cff582778e3109", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b96a4c6c8d7094435646ad9c546ab1fd2c475749e5e35bba8f1679add9f68a8477cb19bfd9c3067007c582790ae64f75ef7df968407870e65cbeae0823417e2e"} 04:59:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:59:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:59:49 INFO - Contents: 04:59:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e411459d3f47b92d3a9bd2afc828d451eda8afe9400ca0a8397934d94324ea5e924d821cf5ba3d8919b4fa3b1ad449dc7b983f611e099d4539cff582778e3109", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b96a4c6c8d7094435646ad9c546ab1fd2c475749e5e35bba8f1679add9f68a8477cb19bfd9c3067007c582790ae64f75ef7df968407870e65cbeae0823417e2e"} 04:59:49 INFO - Running post-run listener: copy_logs_to_upload_dir 04:59:49 INFO - Copying logs to upload dir... 04:59:49 INFO - mkdir: /builds/slave/test/build/upload/logs 04:59:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.743710 ========= master_lag: 26.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-02-06 05:00:15.636419) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 8 secs) (at 2016-02-06 05:00:15.643863) ========= 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.u5mNTTwVJT/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.1R0YjwcNF6/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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/e411459d3f47b92d3a9bd2afc828d451eda8afe9400ca0a8397934d94324ea5e924d821cf5ba3d8919b4fa3b1ad449dc7b983f611e099d4539cff582778e3109", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b96a4c6c8d7094435646ad9c546ab1fd2c475749e5e35bba8f1679add9f68a8477cb19bfd9c3067007c582790ae64f75ef7df968407870e65cbeae0823417e2e"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011049 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e411459d3f47b92d3a9bd2afc828d451eda8afe9400ca0a8397934d94324ea5e924d821cf5ba3d8919b4fa3b1ad449dc7b983f611e099d4539cff582778e3109", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b96a4c6c8d7094435646ad9c546ab1fd2c475749e5e35bba8f1679add9f68a8477cb19bfd9c3067007c582790ae64f75ef7df968407870e65cbeae0823417e2e"}' ========= master_lag: 8.89 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 8 secs) (at 2016-02-06 05:00:24.542198) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:00:24.542528) ========= 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.u5mNTTwVJT/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.1R0YjwcNF6/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.005595 ========= master_lag: 0.61 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:00:25.157967) ========= ========= Started reboot skipped (results: 3, elapsed: 25 secs) (at 2016-02-06 05:00:25.158442) ========= ========= Finished reboot skipped (results: 3, elapsed: 25 secs) (at 2016-02-06 05:00:50.549296) ========= ========= Total master_lag: 38.75 =========