builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0052 starttime: 1454762323.72 results: success (0) buildid: 20160206043840 builduid: 3150426e53b945c8a0cc856d629e83f8 revision: 46d6d868ba0f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.722415) ========= 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:43.722813) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.723140) ========= 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.msrD17HqQk/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.GHjkBKavdg/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005556 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.779617) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.779921) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.809648) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.809945) ========= 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.msrD17HqQk/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.GHjkBKavdg/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005330 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.873730) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.874027) ========= 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:43.874389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.874714) ========= 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.msrD17HqQk/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.GHjkBKavdg/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 175M=0s 2016-02-06 04:38:44 (175 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.513065 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:44.403049) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:44.403455) ========= 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.msrD17HqQk/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.GHjkBKavdg/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.028607 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:44.452585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:44.452984) ========= 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.msrD17HqQk/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.GHjkBKavdg/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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:44,516 Setting DEBUG logging. 2016-02-06 04:38:44,516 attempt 1/10 2016-02-06 04:38:44,516 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:45,247 unpacking tar archive at: fx-team-46d6d868ba0f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.965515 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:45.435084) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:45.435465) ========= 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.msrD17HqQk/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.GHjkBKavdg/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005728 script_repo_revision: '46d6d868ba0f' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:45.484574) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:45.484910) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:45.499148) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-02-06 04:38:45.499479) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.msrD17HqQk/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.GHjkBKavdg/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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:45 INFO - MultiFileLogger online at 20160206 04:38:45 in /builds/slave/test 04:38:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:38:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:38:45 INFO - {'append_to_log': False, 04:38:45 INFO - 'base_work_dir': '/builds/slave/test', 04:38:45 INFO - 'blob_upload_branch': 'Fx-Team', 04:38:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:38:45 INFO - 'branch': 'Fx-Team', 04:38:45 INFO - 'buildbot_json_path': 'buildprops.json', 04:38:45 INFO - 'config_files': ('talos/mac_config.py',), 04:38:45 INFO - 'default_actions': ('clobber', 04:38:45 INFO - 'read-buildbot-config', 04:38:45 INFO - 'download-and-extract', 04:38:45 INFO - 'populate-webroot', 04:38:45 INFO - 'create-virtualenv', 04:38:45 INFO - 'install', 04:38:45 INFO - 'run-tests'), 04:38:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:38:45 INFO - 'download_minidump_stackwalk': True, 04:38:45 INFO - 'download_symbols': 'ondemand', 04:38:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:38:45 INFO - 'tooltool.py': '/tools/tooltool.py', 04:38:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:38:45 INFO - '/tools/misc-python/virtualenv.py')}, 04:38:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:38:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:38:45 INFO - 'installer_path': 'installer.exe', 04:38:45 INFO - 'log_level': 'info', 04:38:45 INFO - 'log_name': 'talos', 04:38:45 INFO - 'log_to_console': True, 04:38:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:38:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:38:45 INFO - 'opt_config_files': (), 04:38:45 INFO - 'pip_index': False, 04:38:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:38:45 INFO - 'cmd': ('bash', 04:38:45 INFO - '-c', 04:38:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:38:45 INFO - 'enabled': True, 04:38:45 INFO - 'halt_on_failure': False, 04:38:45 INFO - 'name': 'check_screen_resolution'},), 04:38:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:38:45 INFO - 'cmd': ('bash', 04:38:45 INFO - '-c', 04:38:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:38:45 INFO - 'enabled': True, 04:38:45 INFO - 'halt_on_failure': False, 04:38:45 INFO - 'name': 'check_screen_resolution'},), 04:38:45 INFO - 'run_cmd_checks_enabled': True, 04:38:45 INFO - 'sps_profile': False, 04:38:45 INFO - 'sps_profile_interval': 0, 04:38:45 INFO - 'suite': 'dromaeojs-e10s', 04:38:45 INFO - 'system_bits': '32', 04:38:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:38:45 INFO - 'title': 't-yosemite-r7-0052', 04:38:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:38:45 INFO - 'use_talos_json': True, 04:38:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:38:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:38:45 INFO - 'work_dir': 'build'} 04:38:45 INFO - ##### 04:38:45 INFO - ##### Running clobber 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: clobber 04:38:45 INFO - rmtree: /builds/slave/test/build 04:38:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:38:47 INFO - Running post-action listener: _resource_record_post_action 04:38:47 INFO - ##### 04:38:47 INFO - ##### Running read-buildbot-config step. 04:38:47 INFO - ##### 04:38:47 INFO - Running pre-action listener: _resource_record_pre_action 04:38:47 INFO - Running main action method: read_buildbot_config 04:38:47 INFO - Using buildbot properties: 04:38:47 INFO - { 04:38:47 INFO - "project": "", 04:38:47 INFO - "product": "firefox", 04:38:47 INFO - "script_repo_revision": "production", 04:38:47 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 04:38:47 INFO - "repository": "", 04:38:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 04:38:47 INFO - "buildid": "20160206043840", 04:38:47 INFO - "stage_platform": "macosx64", 04:38:47 INFO - "basedir": "/builds/slave/test", 04:38:47 INFO - "buildnumber": 317, 04:38:47 INFO - "platform": "yosemite_r7", 04:38:47 INFO - "mozci_request": { 04:38:47 INFO - "priority": -1, 04:38:47 INFO - "type": "trigger_all_talos_jobs", 04:38:47 INFO - "times": 6 04:38:47 INFO - }, 04:38:47 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:38:47 INFO - "slavebuilddir": "test", 04:38:47 INFO - "branch": "fx-team", 04:38:47 INFO - "revision": "46d6d868ba0f", 04:38:47 INFO - "slavename": "t-yosemite-r7-0052", 04:38:47 INFO - "builduid": "3150426e53b945c8a0cc856d629e83f8", 04:38:47 INFO - "repo_path": "integration/fx-team" 04:38:47 INFO - } 04:38:47 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:47 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/test_packages.json. 04:38:47 INFO - Running post-action listener: _resource_record_post_action 04:38:47 INFO - ##### 04:38:47 INFO - ##### Running download-and-extract step. 04:38:47 INFO - ##### 04:38:47 INFO - Running pre-action listener: _resource_record_pre_action 04:38:47 INFO - Running main action method: download_and_extract 04:38:47 INFO - mkdir: /builds/slave/test/build/tests 04:38:47 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:47 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/test_packages.json 04:38:47 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:47 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:47 INFO - Downloaded 1277 bytes. 04:38:47 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:38:47 INFO - Using the following test package requirements: 04:38:47 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:38:47 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:47 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:38:47 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:47 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:38:47 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:47 INFO - u'jsshell-mac.zip'], 04:38:47 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:47 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:38:47 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:38:47 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:47 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:38:47 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:47 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:38:47 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:47 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:38:47 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:38:47 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:47 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:38:47 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:38:47 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:47 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:47 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:47 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:51 INFO - Downloaded 17118689 bytes. 04:38:51 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:51 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:54 INFO - Return code: 0 04:38:54 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:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:54 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:54 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:54 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:54 INFO - Downloaded 17118689 bytes. 04:38:54 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:54 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:58 INFO - Return code: 0 04:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:58 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:58 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:58 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:58 INFO - Downloaded 10706582 bytes. 04:38:58 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:58 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:58 INFO - Return code: 0 04:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:58 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg 04:38:58 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:58 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:08 INFO - Downloaded 111104284 bytes. 04:39:08 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:08 INFO - mkdir: /builds/slave/test/properties 04:39:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:39:08 INFO - Writing to file /builds/slave/test/properties/build_url 04:39:08 INFO - Contents: 04:39:08 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg 04:39:08 INFO - Running post-action listener: _resource_record_post_action 04:39:08 INFO - Running post-action listener: set_extra_try_arguments 04:39:08 INFO - ##### 04:39:08 INFO - ##### Running populate-webroot step. 04:39:08 INFO - ##### 04:39:08 INFO - Running pre-action listener: _resource_record_pre_action 04:39:08 INFO - Running main action method: populate_webroot 04:39:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:39:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:39:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:39:08 INFO - '--tppagecycles', 04:39:08 INFO - '7'], 04:39:08 INFO - 'tests': ['tsvgm']}}, 04:39:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:39:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:39:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:39:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:39:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:39:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:39:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:08 INFO - 'talos_options': ['--e10s'], 04:39:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:08 INFO - 'tests': ['damp', 'tps']}, 04:39:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:08 INFO - 'talos_options': ['--e10s'], 04:39:08 INFO - 'tests': ['damp', 'tps']}, 04:39:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:39:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:39:08 INFO - 'other': {'tests': ['a11yr', 04:39:08 INFO - 'ts_paint', 04:39:08 INFO - 'tpaint', 04:39:08 INFO - 'sessionrestore', 04:39:08 INFO - 'sessionrestore_no_auto_restore']}, 04:39:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:39:08 INFO - 'tests': ['a11yr', 04:39:08 INFO - 'ts_paint', 04:39:08 INFO - 'tpaint', 04:39:08 INFO - 'sessionrestore', 04:39:08 INFO - 'sessionrestore_no_auto_restore']}, 04:39:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:39:08 INFO - 'tests': ['a11yr', 04:39:08 INFO - 'ts_paint', 04:39:08 INFO - 'tpaint', 04:39:08 INFO - 'sessionrestore', 04:39:08 INFO - 'sessionrestore_no_auto_restore']}, 04:39:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:39:08 INFO - 'tests': ['a11yr', 04:39:08 INFO - 'ts_paint', 04:39:08 INFO - 'tpaint', 04:39:08 INFO - 'sessionrestore', 04:39:08 INFO - 'sessionrestore_no_auto_restore']}, 04:39:08 INFO - 'other_l64': {'tests': ['a11yr', 04:39:08 INFO - 'ts_paint', 04:39:08 INFO - 'tpaint', 04:39:08 INFO - 'sessionrestore', 04:39:08 INFO - 'sessionrestore_no_auto_restore']}, 04:39:08 INFO - 'other_nol64': {'tests': ['a11yr', 04:39:08 INFO - 'ts_paint', 04:39:08 INFO - 'tpaint', 04:39:08 INFO - 'sessionrestore', 04:39:08 INFO - 'sessionrestore_no_auto_restore']}, 04:39:08 INFO - 'svgr': {'tests': ['tsvgx', 04:39:08 INFO - 'tsvgr_opacity', 04:39:08 INFO - 'tart', 04:39:08 INFO - 'tscrollx', 04:39:08 INFO - 'cart']}, 04:39:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:39:08 INFO - 'tests': ['tsvgx', 04:39:08 INFO - 'tsvgr_opacity', 04:39:08 INFO - 'tart', 04:39:08 INFO - 'tscrollx', 04:39:08 INFO - 'cart']}, 04:39:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:08 INFO - 'tests': ['tp5o']}, 04:39:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:08 INFO - 'talos_options': ['--e10s'], 04:39:08 INFO - 'tests': ['tp5o']}, 04:39:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:08 INFO - 'talos_options': ['--xperf_path', 04:39:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:08 INFO - 'tests': ['tp5n']}, 04:39:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:08 INFO - 'talos_options': ['--e10s', 04:39:08 INFO - '--xperf_path', 04:39:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:08 INFO - 'tests': ['tp5n']}}, 04:39:08 INFO - 'talos.zip': {'path': '', 04:39:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:39:08 INFO - Running post-action listener: _resource_record_post_action 04:39:08 INFO - ##### 04:39:08 INFO - ##### Running create-virtualenv step. 04:39:08 INFO - ##### 04:39:08 INFO - Running pre-action listener: _resource_record_pre_action 04:39:08 INFO - Running main action method: create_virtualenv 04:39:08 INFO - Creating virtualenv /builds/slave/test/build/venv 04:39:08 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:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:39:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:39:08 INFO - Using real prefix '/tools/python27' 04:39:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:39:09 INFO - Installing distribute.............................................................................................................................................................................................done. 04:39:12 INFO - Installing pip.................done. 04:39:12 INFO - Return code: 0 04:39:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:39: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:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:12 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 0x109fbfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fc64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca10d4ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e64d30>, '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 0x109cc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e5ab20>, '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.msrD17HqQk/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.GHjkBKavdg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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:12 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:12 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:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msrD17HqQk/Render', 04:39:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:12 INFO - 'HOME': '/Users/cltbld', 04:39:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:12 INFO - 'LOGNAME': 'cltbld', 04:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:12 INFO - 'MOZ_NO_REMOTE': '1', 04:39:12 INFO - 'NO_EM_RESTART': '1', 04:39:12 INFO - 'PAGER': '/bin/cat', 04:39:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:12 INFO - 'PWD': '/builds/slave/test', 04:39:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:12 INFO - 'SHELL': '/bin/bash', 04:39:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GHjkBKavdg/Listeners', 04:39:12 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 04:39:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:12 INFO - 'USER': 'cltbld', 04:39:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:12 INFO - 'XPC_FLAGS': '0x0', 04:39:12 INFO - 'XPC_SERVICE_NAME': '0', 04:39:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:12 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:12 INFO - Cleaning up... 04:39:12 INFO - Return code: 0 04:39:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:39: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:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:12 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 0x109fbfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fc64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca10d4ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e64d30>, '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 0x109cc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e5ab20>, '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.msrD17HqQk/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.GHjkBKavdg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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:12 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:12 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:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msrD17HqQk/Render', 04:39:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:12 INFO - 'HOME': '/Users/cltbld', 04:39:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:12 INFO - 'LOGNAME': 'cltbld', 04:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:12 INFO - 'MOZ_NO_REMOTE': '1', 04:39:12 INFO - 'NO_EM_RESTART': '1', 04:39:12 INFO - 'PAGER': '/bin/cat', 04:39:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:12 INFO - 'PWD': '/builds/slave/test', 04:39:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:12 INFO - 'SHELL': '/bin/bash', 04:39:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GHjkBKavdg/Listeners', 04:39:12 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 04:39:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:12 INFO - 'USER': 'cltbld', 04:39:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:12 INFO - 'XPC_FLAGS': '0x0', 04:39:12 INFO - 'XPC_SERVICE_NAME': '0', 04:39:12 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 psutil>=0.7.1 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:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:39:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:16 INFO - Installing collected packages: psutil 04:39:16 INFO - Running setup.py install for psutil 04:39:16 INFO - building 'psutil._psutil_osx' extension 04:39:16 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:17 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:17 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:17 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:17 INFO - building 'psutil._psutil_posix' extension 04:39:17 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:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:39:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:39:17 INFO - ^ 04:39:17 INFO - 1 warning generated. 04:39:17 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:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:17 INFO - Successfully installed psutil 04:39:17 INFO - Cleaning up... 04:39:17 INFO - Return code: 0 04:39:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:39:17 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:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:17 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:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:17 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 0x109fbfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fc64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca10d4ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e64d30>, '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 0x109cc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e5ab20>, '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.msrD17HqQk/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.GHjkBKavdg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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:17 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:17 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:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msrD17HqQk/Render', 04:39:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:17 INFO - 'HOME': '/Users/cltbld', 04:39:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:17 INFO - 'LOGNAME': 'cltbld', 04:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:17 INFO - 'MOZ_NO_REMOTE': '1', 04:39:17 INFO - 'NO_EM_RESTART': '1', 04:39:17 INFO - 'PAGER': '/bin/cat', 04:39:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:17 INFO - 'PWD': '/builds/slave/test', 04:39:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:17 INFO - 'SHELL': '/bin/bash', 04:39:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GHjkBKavdg/Listeners', 04:39:17 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 04:39:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:17 INFO - 'USER': 'cltbld', 04:39:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:17 INFO - 'XPC_FLAGS': '0x0', 04:39:17 INFO - 'XPC_SERVICE_NAME': '0', 04:39:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 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:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:39:20 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:20 INFO - Installing collected packages: mozsystemmonitor 04:39:20 INFO - Running setup.py install for mozsystemmonitor 04:39:20 INFO - Successfully installed mozsystemmonitor 04:39:20 INFO - Cleaning up... 04:39:20 INFO - Return code: 0 04:39:20 INFO - Installing blobuploader==1.2.4 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', '--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 0x109fbfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fc64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca10d4ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e64d30>, '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 0x109cc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e5ab20>, '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.msrD17HqQk/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.GHjkBKavdg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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', '--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:20 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:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msrD17HqQk/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.GHjkBKavdg/Listeners', 04:39:20 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 - Downloading/unpacking blobuploader==1.2.4 04:39:21 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:21 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:21 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:21 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:21 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:21 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:23 INFO - Downloading blobuploader-1.2.4.tar.gz 04:39:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:39:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:39:23 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:23 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:23 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:23 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:23 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:23 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:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:39:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:39:24 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:24 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:24 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:24 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:24 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:24 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:24 INFO - Downloading docopt-0.6.1.tar.gz 04:39:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:39:24 INFO - Installing collected packages: blobuploader, requests, docopt 04:39:24 INFO - Running setup.py install for blobuploader 04:39:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:39:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:39:24 INFO - Running setup.py install for requests 04:39:25 INFO - Running setup.py install for docopt 04:39:25 INFO - Successfully installed blobuploader requests docopt 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', '--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 0x109fbfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fc64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca10d4ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e64d30>, '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 0x109cc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e5ab20>, '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.msrD17HqQk/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.GHjkBKavdg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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', '--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:25 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:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msrD17HqQk/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.GHjkBKavdg/Listeners', 04:39:25 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-TlLfly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:25 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-oW2ZBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:25 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-HrH66s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:26 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-kiRAvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:26 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-4flMt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:26 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-drmZlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:26 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-oN_maX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:26 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-lPGqcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:26 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-GfW0GJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:26 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-6cP2dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:26 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-VzPcs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:26 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-H6gP7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:26 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-3lAvtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:27 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-AXTWRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:27 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-9XeSWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:27 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-fnwV0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:27 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-LBY9qX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:39:27 INFO - Running setup.py install for manifestparser 04:39:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Running setup.py install for mozcrash 04:39:27 INFO - Running setup.py install for mozdebug 04:39:27 INFO - Running setup.py install for mozdevice 04:39:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:39:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:39:28 INFO - Running setup.py install for mozfile 04:39:28 INFO - Running setup.py install for mozhttpd 04:39:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:39:28 INFO - Running setup.py install for mozinfo 04:39:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:39:28 INFO - Running setup.py install for mozInstall 04:39:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:39:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:39:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:39:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:39:28 INFO - Running setup.py install for mozleak 04:39:28 INFO - Running setup.py install for mozlog 04:39:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:39:28 INFO - Running setup.py install for moznetwork 04:39:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:39:29 INFO - Running setup.py install for mozprocess 04:39:29 INFO - Running setup.py install for mozprofile 04:39:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:39:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:39:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:39:29 INFO - Running setup.py install for mozrunner 04:39:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:39:29 INFO - Running setup.py install for mozscreenshot 04:39:29 INFO - Running setup.py install for moztest 04:39:29 INFO - Running setup.py install for mozversion 04:39:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:39:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:39:29 INFO - Cleaning up... 04:39:30 INFO - Return code: 0 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/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 0x109fbfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fc64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca10d4ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e64d30>, '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 0x109cc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e5ab20>, '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.msrD17HqQk/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.GHjkBKavdg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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/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:30 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:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msrD17HqQk/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.GHjkBKavdg/Listeners', 04:39:30 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:30 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-qNe2NE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:30 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-CcNqeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:30 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-y5jFCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:30 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-4oz3M2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:30 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-NfIh_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:30 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-Z_r35o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:30 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-bgtOIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:31 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-XoTa_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:31 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-D9RjPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:31 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-HE8zZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:31 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-VjB8eV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:31 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-bWBrWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:31 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-Lbhcu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:31 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-6M_CaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:31 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-F7OD7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:31 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-wk8CXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:31 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-EyBBdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:32 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:32 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:32 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:32 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:32 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:32 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:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:34 INFO - Downloading blessings-1.6.tar.gz 04:39:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:39:34 INFO - Installing collected packages: blessings 04:39:34 INFO - Running setup.py install for blessings 04:39:34 INFO - Successfully installed blessings 04:39:34 INFO - Cleaning up... 04:39:34 INFO - Return code: 0 04:39:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:39:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:34 INFO - Reading from file tmpfile_stdout 04:39:34 INFO - Current package versions: 04:39:34 INFO - blessings == 1.6 04:39:34 INFO - blobuploader == 1.2.4 04:39:34 INFO - docopt == 0.6.1 04:39:34 INFO - manifestparser == 1.1 04:39:34 INFO - mozInstall == 1.12 04:39:34 INFO - mozcrash == 0.16 04:39:34 INFO - mozdebug == 0.1 04:39:34 INFO - mozdevice == 0.48 04:39:34 INFO - mozfile == 1.2 04:39:34 INFO - mozhttpd == 0.7 04:39:34 INFO - mozinfo == 0.9 04:39:34 INFO - mozleak == 0.1 04:39:34 INFO - mozlog == 3.1 04:39:34 INFO - moznetwork == 0.27 04:39:34 INFO - mozprocess == 0.22 04:39:34 INFO - mozprofile == 0.28 04:39:34 INFO - mozrunner == 6.11 04:39:34 INFO - mozscreenshot == 0.1 04:39:34 INFO - mozsystemmonitor == 0.0 04:39:34 INFO - moztest == 0.7 04:39:34 INFO - mozversion == 1.4 04:39:34 INFO - psutil == 3.1.1 04:39:34 INFO - requests == 1.2.3 04:39:34 INFO - wsgiref == 0.1.2 04:39:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:34 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:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:34 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:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:34 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 0x109fbfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fc64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca10d4ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e64d30>, '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 0x109cc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e5ab20>, '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.msrD17HqQk/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.GHjkBKavdg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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:34 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:34 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:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msrD17HqQk/Render', 04:39:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:34 INFO - 'HOME': '/Users/cltbld', 04:39:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:34 INFO - 'LOGNAME': 'cltbld', 04:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:34 INFO - 'MOZ_NO_REMOTE': '1', 04:39:34 INFO - 'NO_EM_RESTART': '1', 04:39:34 INFO - 'PAGER': '/bin/cat', 04:39:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:34 INFO - 'PWD': '/builds/slave/test', 04:39:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:34 INFO - 'SHELL': '/bin/bash', 04:39:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GHjkBKavdg/Listeners', 04:39:34 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 04:39:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:34 INFO - 'USER': 'cltbld', 04:39:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:34 INFO - 'XPC_FLAGS': '0x0', 04:39:34 INFO - 'XPC_SERVICE_NAME': '0', 04:39:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:35 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:35 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:35 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:35 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:35 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:35 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:35 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:35 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:35 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:35 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:35 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:35 INFO - Cleaning up... 04:39:35 INFO - Return code: 0 04:39:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109fbfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fc64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca10d4ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e64d30>, '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 0x109cc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e5ab20>, '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.msrD17HqQk/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.GHjkBKavdg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:39:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:39:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msrD17HqQk/Render', 04:39:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:35 INFO - 'HOME': '/Users/cltbld', 04:39:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:35 INFO - 'LOGNAME': 'cltbld', 04:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:35 INFO - 'MOZ_NO_REMOTE': '1', 04:39:35 INFO - 'NO_EM_RESTART': '1', 04:39:35 INFO - 'PAGER': '/bin/cat', 04:39:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:35 INFO - 'PWD': '/builds/slave/test', 04:39:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:35 INFO - 'SHELL': '/bin/bash', 04:39:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GHjkBKavdg/Listeners', 04:39:35 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 04:39:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:35 INFO - 'USER': 'cltbld', 04:39:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:35 INFO - 'XPC_FLAGS': '0x0', 04:39:35 INFO - 'XPC_SERVICE_NAME': '0', 04:39:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:35 INFO - Downloading/unpacking jsonschema 04:39:35 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:35 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:35 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:35 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:35 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:35 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 jsonschema-2.5.1-py2.py3-none-any.whl 04:39:37 INFO - Downloading/unpacking functools32 (from jsonschema) 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:38 INFO - Downloading functools32-3.2.3-2.tar.gz 04:39:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:39:38 INFO - warning: no files found matching '*.txt' 04:39:38 INFO - no previously-included directories found matching 'build' 04:39:38 INFO - no previously-included directories found matching 'dist' 04:39:38 INFO - no previously-included directories found matching '.git*' 04:39:38 INFO - Installing collected packages: jsonschema, functools32 04:39:38 INFO - Running setup.py install for functools32 04:39:38 INFO - warning: no files found matching '*.txt' 04:39:38 INFO - no previously-included directories found matching 'build' 04:39:38 INFO - no previously-included directories found matching 'dist' 04:39:38 INFO - no previously-included directories found matching '.git*' 04:39:38 INFO - Successfully installed jsonschema functools32 04:39:38 INFO - Cleaning up... 04:39:38 INFO - Return code: 0 04:39:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109fbfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fc64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca10d4ca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e64d30>, '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 0x109cc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e5ab20>, '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.msrD17HqQk/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.GHjkBKavdg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:39:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msrD17HqQk/Render', 04:39:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:38 INFO - 'HOME': '/Users/cltbld', 04:39:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:38 INFO - 'LOGNAME': 'cltbld', 04:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:38 INFO - 'MOZ_NO_REMOTE': '1', 04:39:38 INFO - 'NO_EM_RESTART': '1', 04:39:38 INFO - 'PAGER': '/bin/cat', 04:39:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:38 INFO - 'PWD': '/builds/slave/test', 04:39:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:38 INFO - 'SHELL': '/bin/bash', 04:39:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GHjkBKavdg/Listeners', 04:39:38 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 04:39:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:38 INFO - 'USER': 'cltbld', 04:39:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:38 INFO - 'XPC_FLAGS': '0x0', 04:39:38 INFO - 'XPC_SERVICE_NAME': '0', 04:39:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:38 INFO - Downloading/unpacking flake8 04:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:39:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:39:41 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:41 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:41 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:41 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:41 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:41 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:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:39:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:39:41 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:41 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:41 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:41 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:41 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:41 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:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:39:41 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:41 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:41 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:41 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:41 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:41 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:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:39:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:42 INFO - no previously-included directories found matching 'docs/_build' 04:39:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:39:42 INFO - Running setup.py install for pep8 04:39:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:42 INFO - no previously-included directories found matching 'docs/_build' 04:39:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:39:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:39:42 INFO - Cleaning up... 04:39:42 INFO - Return code: 0 04:39:42 INFO - Running post-action listener: _resource_record_post_action 04:39:42 INFO - Running post-action listener: _start_resource_monitoring 04:39:42 INFO - Starting resource monitoring. 04:39:42 INFO - ##### 04:39:42 INFO - ##### Running install step. 04:39:42 INFO - ##### 04:39:42 INFO - Running pre-action listener: _resource_record_pre_action 04:39:42 INFO - Running main action method: install 04:39:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:42 INFO - Reading from file tmpfile_stdout 04:39:42 INFO - Detecting whether we're running mozinstall >=1.0... 04:39:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:39:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:39:42 INFO - Reading from file tmpfile_stdout 04:39:42 INFO - Output received: 04:39:42 INFO - Usage: mozinstall [options] installer 04:39:42 INFO - Options: 04:39:42 INFO - -h, --help show this help message and exit 04:39:42 INFO - -d DEST, --destination=DEST 04:39:42 INFO - Directory to install application into. [default: 04:39:42 INFO - "/builds/slave/test"] 04:39:42 INFO - --app=APP Application being installed. [default: firefox] 04:39:42 INFO - mkdir: /builds/slave/test/build/application 04:39:42 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:42 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:16 INFO - Reading from file tmpfile_stdout 04:40:16 INFO - Output received: 04:40:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:40:16 INFO - Running post-action listener: _resource_record_post_action 04:40:16 INFO - ##### 04:40:16 INFO - ##### Running run-tests step. 04:40:16 INFO - ##### 04:40:16 INFO - Running pre-action listener: _resource_record_pre_action 04:40:16 INFO - Running main action method: run_tests 04:40:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:40:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:40:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:40:16 INFO - 2016-02-06 04:40:16.678 screenresolution[1708:14949] starting screenresolution argv=screenresolution get 04:40:16 INFO - 2016-02-06 04:40:16.681 screenresolution[1708:14949] Display 0: 1600x1200x32@60 04:40:16 INFO - 2016-02-06 04:40:16.687 screenresolution[1709:14951] starting screenresolution argv=screenresolution list 04:40:16 INFO - Available Modes on Display 0 04:40:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:40:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:40:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:40:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:40:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:40:16 INFO - Intel Iris: 04:40:16 INFO - Chipset Model: Intel Iris 04:40:16 INFO - Type: GPU 04:40:16 INFO - Bus: Built-In 04:40:16 INFO - VRAM (Dynamic, Max): 1536 MB 04:40:16 INFO - Vendor: Intel (0x8086) 04:40:16 INFO - Device ID: 0x0a2e 04:40:16 INFO - Revision ID: 0x0009 04:40:16 INFO - Displays: 04:40:16 INFO - Display: 04:40:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:40:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:40:16 INFO - Display Serial Number: 1600x1200 60 04:40:16 INFO - Main Display: Yes 04:40:16 INFO - Mirror: Off 04:40:16 INFO - Online: Yes 04:40:16 INFO - Rotation: Supported 04:40:16 INFO - Return code: 0 04:40:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:40:16 INFO - Python 2.7.3 04:40:16 INFO - Return code: 0 04:40:16 INFO - grabbing minidump binary from tooltool 04:40: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:40:16 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 0x109e64d30>, '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 0x109cc7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e5ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:40:16 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:16 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:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:40:17 INFO - Return code: 0 04:40:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:40:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:40:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:40:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:40:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:40:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:40:18 INFO - Return code: 0 04:40:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', '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-0052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath 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-0052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:40:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msrD17HqQk/Render', 04:40:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:18 INFO - 'HOME': '/Users/cltbld', 04:40:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:18 INFO - 'LOGNAME': 'cltbld', 04:40:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:40:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:18 INFO - 'MOZ_NO_REMOTE': '1', 04:40:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:40:18 INFO - 'NO_EM_RESTART': '1', 04:40:18 INFO - 'PAGER': '/bin/cat', 04:40:18 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:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:18 INFO - 'PWD': '/builds/slave/test', 04:40:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:40:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:18 INFO - 'SHELL': '/bin/bash', 04:40:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GHjkBKavdg/Listeners', 04:40:18 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 04:40:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:18 INFO - 'USER': 'cltbld', 04:40:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:18 INFO - 'XPC_FLAGS': '0x0', 04:40:18 INFO - 'XPC_SERVICE_NAME': '0', 04:40:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', '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-0052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:40:18 INFO - mozversion application_buildid: 20160203075343 04:40:18 INFO - mozversion application_changeset: 46d6d868ba0f8ae089da8882b594fe359eba2978 04:40:18 INFO - mozversion application_display_name: Nightly 04:40:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:40:18 INFO - mozversion application_name: Firefox 04:40:18 INFO - mozversion application_remotingname: firefox 04:40:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:40:18 INFO - mozversion application_vendor: Mozilla 04:40:18 INFO - mozversion application_version: 47.0a1 04:40:18 INFO - mozversion platform_buildid: 20160203075343 04:40:18 INFO - mozversion platform_changeset: 46d6d868ba0f8ae089da8882b594fe359eba2978 04:40:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:40:18 INFO - mozversion platform_version: 47.0a1 04:40:18 INFO - using testdate: 1454762418 04:40:18 INFO - actual date: 1454762418 04:40:18 INFO - starting webserver on 'localhost:49270' 04:40:18 INFO - SUITE-START | Running 2 tests 04:40:18 INFO - TEST-START | dromaeo_css 04:40:18 INFO - operating with platform_type : mac_ 04:40:18 INFO - Initialising browser for dromaeo_css test... 04:40:18 INFO - TEST-INFO | started process 1727 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpsIHrr0/profile http://localhost:49270/getInfo.html) 04:40:18 INFO - PROCESS | 1727 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:40:21 INFO - PROCESS | 1727 | __metrics Screen width/height:1600/1200 04:40:21 INFO - PROCESS | 1727 | colorDepth:24 04:40:21 INFO - PROCESS | 1727 | Browser inner width/height: 1024/689 04:40:21 INFO - PROCESS | 1727 | __metrics 04:40:21 ERROR - PROCESS | 1727 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2830: TypeError: this.tabs is undefined 04:40:21 INFO - PROCESS | 1727 | ************************* 04:40:21 INFO - PROCESS | 1727 | A coding exception was thrown in a Promise resolution callback. 04:40:21 INFO - PROCESS | 1727 | See https://developer.mozilla.org/Mozilla/JavaScript_code_modules/Promise.jsm/Promise 04:40:21 INFO - PROCESS | 1727 | 04:40:21 ERROR - PROCESS | 1727 | Full message: TypeError: this.tabs is undefined 04:40:21 INFO - PROCESS | 1727 | Full stack: .get@chrome://browser/content/tabbrowser.xml:2830:17 04:40:21 INFO - PROCESS | 1727 | ssi_onClose/<@resource:///modules/sessionstore/SessionStore.jsm:1323:9 04:40:21 INFO - PROCESS | 1727 | Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 04:40:21 INFO - PROCESS | 1727 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 04:40:21 INFO - PROCESS | 1727 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 04:40:21 INFO - PROCESS | 1727 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 04:40:21 INFO - PROCESS | 1727 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 04:40:21 INFO - PROCESS | 1727 | resolve@resource://app/modules/sessionstore/TabStateFlusher.jsm:146:5 04:40:21 INFO - PROCESS | 1727 | resolve@resource://app/modules/sessionstore/TabStateFlusher.jsm:52:5 04:40:21 INFO - PROCESS | 1727 | receiveMessage@resource:///modules/sessionstore/SessionStore.jsm:734:11 04:40:21 INFO - PROCESS | 1727 | 04:40:21 INFO - PROCESS | 1727 | ************************* 04:40:21 INFO - PROCESS | 1727 | 04:40:21 INFO - PROCESS | 1727 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 04:40:21 INFO - PROCESS | 1727 | 04:40:22 INFO - TEST-INFO | 1727: exit 0 04:40:22 INFO - Browser initialized. 04:40:22 INFO - Running cycle 1/1 for dromaeo_css test... 04:40:22 INFO - TEST-INFO | started process 1732 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpsIHrr0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:34 INFO - PROCESS | 1732 | RSS: Main: 254775296 04:40:34 INFO - PROCESS | 1732 | 04:41:23 INFO - PROCESS | 1732 | 1454762483957 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:34 INFO - PROCESS | 1732 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 04:43:36 INFO - PROCESS | 1732 | RSS: Main: 271290368 04:43:36 INFO - PROCESS | 1732 | 04:46:38 INFO - PROCESS | 1732 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 04:46:38 INFO - PROCESS | 1732 | RSS: Main: 283185152 04:46:38 INFO - PROCESS | 1732 | 04:49:40 INFO - PROCESS | 1732 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 04:49:41 INFO - PROCESS | 1732 | RSS: Main: 284737536 04:49:41 INFO - PROCESS | 1732 | 04:52:42 INFO - PROCESS | 1732 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 04:52:43 INFO - PROCESS | 1732 | RSS: Main: 286724096 04:52:43 INFO - PROCESS | 1732 | 04:55:45 INFO - PROCESS | 1732 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 04:55:46 INFO - PROCESS | 1732 | RSS: Main: 288288768 04:55:46 INFO - PROCESS | 1732 | 04:58:48 INFO - PROCESS | 1732 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 04:58:49 INFO - PROCESS | 1732 | RSS: Main: 291684352 04:58:49 INFO - PROCESS | 1732 | 04:58:49 INFO - PROCESS | 1732 | __start_tp_report 04:58:49 INFO - PROCESS | 1732 | _x_x_mozilla_page_load 04:58:49 INFO - PROCESS | 1732 | _x_x_mozilla_page_load_details 04:58:49 INFO - PROCESS | 1732 | |i|pagename|runs| 04:58:49 INFO - PROCESS | 1732 | |0;dojo.html;2860.7711383089354;3527.3474407234658;3534.452159915214;3576.8032758198287;3582.462630605409;5795.130730390443;5821.970890145554;5831.446012628793;5860.941390586093;5867.618604790691;5714.57140714447;5741.19623252745;5823.767049318022;5827.883442331151;5837.357890632027;5226.947730522694;5307.52232299093;5360.115580929142;5372.382176049746;5408.188771684239;5381.81163659272;5396.001739678152;5399.649022813524;5402.6758394496455;5418;5226.372835259755;5269.077911365495;5388.380336261341;5391.919121213185;5488.17677348397;5331.413544510101;5339.279197308352;5340.252364668911;5343.438938911398;5345;5331.760070796785;5345.1714984177515;5347.572194224453;5358.196270559447;5363.195520671891;5026.798928042874;5604.159376093618;5675.886482270332;5847.619904706223;5848.64908105515;6228.937710622881;6231.011379453112;6253;6261.749530018794;6288.748450061992;6259.061140828867;6275.780347687809;6279.529035322369;6282.277538083134;6305.0857625644485;5846.181534585162;5905.6751878646655;5937.732802023919;5951.434613711691;6024.789132380433;6349.206349206349;6374.330695277022;6408.711607977652;6419.935800642027;6426.518011149183;6030.758769649165;6153.446189842935;6160.907586386208;6165.599236049642;6173.41352571505;6126.120738204555;6175.476947535717;6185.896795089601;6226.346233645402;6265.906011409833;6180.81457556274;6191.9690401547705;6206.193194884636;6215.595986260969;6217;6136.846578835475;6191.752329906843;6201.7519299228425;6231.532635052389;6248.781292654735;4796.8081276749235;4927.211646136601;4938.358013458227;4949.727764972889;4990.80036798524;4457.64338852891;4467.687261891637;4476.462824461086;4480.932786008212;4584.885377865513;5796.275465566804;5884.7940322088525;5972.402759723993;6029.095635654599;6044.576879618472;6198.380161983766;6235.407636274546;6295.779647712308;6296.716647750863;6312.936870631235;5801.274840644919;5815.680137592389;5820.970895145582;5822.388649191858;5857.765689372377;5259.500347466985;5309.283246761715;5313.1764576490705;5350.4649535046965;5471.042567550663;6394.680265986682;6468.450181734605;6486.870262594722;6490.156279683611;6517.51118666102;6246.718897649707;6278.215223097113;6279;6281.842953926189;6283.434490895841;6270.717817698306;6312.210973628296;6350.555461117678;6397.456216221487;6436.292007879036;6189.071639254148;6246.46905013079;6251.843703907439;6266.780662676784;6289.339619339903;6269.7178626962805;6280.183576135073;6282;6282.308946016026;6287.74849006053;5535.612507124623;5699.487046165865;6125.387461253839;6143.109249158758;6265.404786545271;5450.828071964546;5527.336719593674;5904.763809447746;6219.968900155471;6239.407256310643;5819.563532734977;6026.096085587197;6055.061465472859;6083.270007599116;6093.512518998381;5857.5313974881055;6069.817905462844;6117.611910571165;6121.32665406796;6125.510168486406;6118.3065437153555;6120.90429240112;6122.215079804129;6130.049842274455;6166.630002199882 04:58:49 INFO - PROCESS | 1732 | |1;ext.html;462.4104267059499;467.9274712419575;507.3480577457967;549.8700171148289;553.7595785440612;37226.813865930664;37910.620893791056;37967;38050.04874878129;38069.428958565644;39417.605823941754;39825.203495930065;39836.80081599595;39866;39938.600613993854;9430.811383772338;9583.712488625317;9692.46691431971;9708.320417570772;9721;9506.334556581007;9617.278704097185;9653.17947974423;9725.562349694246;9749.171320437772;9720.659776907809;9801.803963920718;9811.65659201928;9818.852717209247;9820.508974551243;9699.806003879918;9752.26857985654;9753.463559504224;9770.87634921986;9809.901900981042;8600.5699715014;9177.954110229473;9612.471314077722;9620.567074481665;9629.662961796303;38891.8055409724;38995.41506877399;39187.21625567501;39263.21473570541;39304.80347598244;3412.7611067225303;3413.7098346640564;3497.160681436437;3604.1530240393486;3814.179951310454;27954.16137515878;28179.718202817916;28511.714882851113;28623.28441788951;28803.855980719964;2828.8161269517414;2830.547112461996;2854.6868440517387;2867.197184788263;2893.1609833148364;417480;483006.58496707643;483597;484141;486456;51051;53253.73373133109;58356;58702.706486467294;58857.41142588605;61283.69358153181;61337.69331153405;61702.691486543175;61992.380076199566;62095.51617935232;16463.423780167876;16473.34106635745;16669.666606667797;16699.415520456725;16730.996140231382;12784.552540661032;12817.935910320388;12902.161359511601;12910.741785164244;12917.741645167043;18479.44561663152;18689.532761680795;18809.717854232196;18811.623767524845;18879.43361699151;8425.36809739272;8625.956870215608;8650.740477785677;8661.350398720122;8705.825883482295;751.3763576231714;984.1634610581092;988.9406635601744;991.1872264742842;1107.3854011023798;21198.78801211999;22116.668249976265;24436.755632443448;26762.5985610216;27314.5902811458;983.9901600983899;1047.7694907120422;1093.10365500289;1105.3699391347016;1192.9978817793096;15263.542093737206;15473.381064757508;15722.899397042325;15812.446564370422;15924.620729299304;495959;528045;532877;536184;538294;54750.72624636931;56106.158407623916;56429;56506.15240771392;56532.5866853332;1437.741206582825;1454.7236025155187;1470.7426200415098;1474.4691910912063;1480.178500931993;23275.650865237374;24475.75524244806;29132.126036218946;29238.26904327409;29707.405851883275;47741.761291193325;48051;48131.27803083027;48185.75907120442;48460;494297;495353;496769;499132;503945;27413.86293068522;32055.358892822478;32823.83588082044;32845.67154328426;32958.01125966129;40886.59113408947;42481.36277955771;43490;43716.56283437125;44311.67064988056;26169;33128.006159815246;34138;34164.658353417144;34299.31401372008;33495;33548.161295967795;33833.83083084569;34028.48957265593;34078.318433630695;33364.332713346084;33541.16147096342;33943;34071.31857362889;34272.82863585766;29615.555766663085;31332.530012050294;31446;31484;31621.683783162793;23994;24009.879950600833;24304;24449.266522004367;24602.753972460763 04:58:49 INFO - PROCESS | 1732 | |2;jquery.html;323.37265704533206;361.1981401289139;365.5668033380443;366.3680151738252;367.1701953584899;15030.699386012273;17451.65096698065;18752.531186720338;18869.433916982478;19567.60864782705;18207.726884096748;18693.813061869376;18721;18798.53003674909;19018.809811901876;5693.202951586781;6004.519638428916;6005.399460053982;6012.699365031753;6019.939800602004;4141.855035073773;4362.934555981647;5554.611177217596;6028.969855150718;6041.637501749887;6308.905366419507;6516.609003459807;6551.9344806552035;6570.211574611053;6570.737170513174;5032;6458.6770661466735;6465.224173099235;6529.967350163242;6546.378094081055;5048.268001139851;5439.347278326587;5470.097433923398;5471.179323101527;5501.889962200734;10282.742931426774;10437.895621043768;10452.895471045344;12602;12838.80741788874;2120.8409369297365;2165.101482884601;2297.9770202298096;2355.211004313557;2609.699884513267;7834.451588388815;9231.907680923172;9575.042495750438;9860.964598717175;9894.406335619886;1743.1545700335328;1809.8734884463445;1825.6531259060737;1827.3695575026727;1889.5748456597294;66257.66871165662;68425.65787171082;70849;86993.26013479759;92222;10560;10981.341119532693;11061.612843550438;11161.274517156522;11208.439578021067;11248.26886252391;13308;13315;13393.799093013613;13399.397027133802;8315.708950186836;8326.833463330699;8336;8391.62237699305;8424.28393586552;6599.8020059398295;8377.706780262783;8444.535550544657;8475.830483390298;8509.276711479593;3943.8225279862477;4285.807138678767;4374;4389.341598760211;4408.515063343029;1630.3560093762896;1687.9240434180492;1855.2393518657286;1855.8051404602593;1899.7435346228083;846.7417437681443;945.8013817098349;1044.0290529807353;1047.8480620310013;1077.9489997252772;18796.154173061972;19560.21759129619;19752.901235494017;19809.811411315368;19963.20147194096;865.6450855149359;914.7758799094264;949.2595775295281;981.7251169672503;1022.4172221833484;9239.445633262027;10388.013138751807;10407.271490995558;10502.947485262677;10543.31468454548;688385;715445;730029;730298;739940;71512.64243678749;93870.0612993875;103111.9999999985;111943;119549.60900781935;1220.5483970930634;1222.7493363860387;1225.8957988570894;1247.9812802807965;1277.6997405609675;18088.638227235646;18297;18312.633747325246;18439.723404149216;18465.446036618923;50923;51048.744756275984;51403.71490712762;51412.22881656703;51875;73642;73834.63082684552;74230.62884685758;74525;75337.62331188309;7107.147142342952;7317.8902316466365;7363.521371110861;7581.431392645684;7682.385409167141;9828.852567211354;11419.486123124645;11441.713957150805;11863.822042669195;12088.576899808464;10112.988701129829;10144.695659130239;10257.17942564608;10296.279260451696;10334.948325258325;8540.829183416421;9958.55186516594;9972.40165590038;10171.389716617026;10187.134093602126;10042.69871903844;10289.43408112561;10318.587256509656;10428.426436546062;10479.947600262254;6602.900956485752;7441.776746697607;7556.206598307319;7585.544867307979;7672.80817979555;8349.958250208952;8475.025372082042;8779.253763429924;9394.67118650844;9680.806383872425 04:58:49 INFO - PROCESS | 1732 | |3;mootools.html;1324.5099313254098;1567.1145802621518;1746.4673274651234;1900.9809901900976;1910.3600293901543;7075.4339652827775;8071.596420178997;8835.867461988068;9007.864882026766;9011.3241506887;8505.574721263944;8639.95680021599;8749.03760586335;8773.56132193391;8778.736637900858;2486.129854550906;2513.987430062856;2518.785903198221;2519.672442582462;2521.4578865543904;2438.085717855804;2455.70531536215;2462.445949661321;2466.371075375777;2467.5064987002584;2452.141750387359;2457.6559281700575;2522.735112813156;2536.8985240590355;2543.36415896026;2377.500724847784;2398.0647547456506;2413.179518963543;2415.7342692303832;2420.1287536486852;2485.7389974052644;2499.450120973401;2510.698716154055;2524.633928080418;2526.5957446808607;8910.599023043913;8950.86573701395;8958.37291389603;8960;9020.684276050373;4821.517848215186;5395.757190926418;5587;5593.468620481048;5595.440455954413;3593.4250519916686;3708.5178926739623;3745.569259535161;3752.0994961209385;3754.868579599728;917.6879860847343;1052.1950707708609;1073.924825262232;1085.137315833906;1108.4956344863149;11992.340421276826;12093.576724814677;12143.696407589792;12144.817827732591;12159.209651372721;4947.455779864212;4977.776000080005;5014.623903207274;5035.1188542005;5047.671901326402;10309.123724483503;10350.430726309974;10360.274780765425;10367.481625918674;10378.221633377527;5555.111182210827;5558.110702287615;5585.162225666101;5585.938671652373;5588.245586845724;4360.149770794728;4421.712588681789;4842.4189097308545;4917.237828136645;5059.468755780664;3976.1252524444576;4006.819693113817;4021.5375231848125;4038.7374820636564;4039.6768258539246;1156.8611766588062;1321.2204799168537;1337.4917531338028;1339.3571085878832;1344.946202151903;1180.7366118253387;1182.4737991593659;1323.5367621332457;1334.4595438847282;1340.671535473815;7097.00641910133;8142.4300298978505;8184.877226841602;8191.8771218431775;8271.503709777433;505.09839935714575;510.1480527519052;515.0265997265171;516.506736067055;536.083297561167;6193.597416167935;6215.316315205324;6302.621842689453;6309.558330916791;6312.779052733133;10584;10880.347179169275;10920.126389888948;10949;11009.669709908716;10321.432321222404;10653.84019239712;10663.146948244123;10746.194035447374;10762.892371076188;8373.581320933929;8418.368622353348;8425.11536288693;8499.235068843835;8514.191151840565;7745.845083098194;7756.108047574376;7797.649105790139;7921.049474063149;7934;6993.650317484207;8287.709930152416;9566.426014439156;9829.655962041294;9887.901120988698;7793.947817044626;10049.296549241482;10061.798764024825;10099.242556808122;10226.897731022893;6796.898046529207;6852.800759866904;7232.312930271616;7604.2395760425725;7655.923440765744;7756.224377562198;8091;8162;8168.3465322772845;8179.877301840596;6856.588604683536;7668.1181664109345;7671.117821450604;7762.92237077622;7772.106207785951;7415.480916335805;7462.216467270859;7484.625768711651;7567.091948966159;7595.430342724208;7592.810179745329;7615.238476152341;7649.808754781175;7652.120006199136;7657.157712651492;6881.862362752617;6928.16861976566;6979.755708550177;7005.649717514206;7035.648217589202;7082.858342833218;7128.928710712827;7165.426765858614;7181.640917953977;7195.316444937723 04:58:49 INFO - PROCESS | 1732 | |4;prototype.html;324.4273856643025;329.44652982988583;333.72967896004224;335.6844566107858;340.97783644063134;6567.770128045519;6718.025886246497;6733.225679046911;6780.220274668414;6807.353301436368;6551.639659818708;6698.2297035840775;6713.530052896299;6783.050372947791;6795.184577850652;4098.344264917614;4958.033183529214;4983.327250821129;5008.398992120932;5009.023240468119;4027.6507370031077;4873.298201556211;5004.274380214867;5025.3467049283545;5046.571041461461;4891;4983.975080124595;4996.950030499703;4998.2752500887345;5001.924971125436;4982.676126051795;4990.875228119308;5004.974975125101;5019;5031.295618613379;4068.2677118118727;4151.086760912594;4184.246835569596;4296.398504209413;4302.053548219386;5202.557782588485;6442.903356449657;6446.129772480702;6451.387118223761;6468.8706225875685;5895.145203945404;5899.823005309848;5906.173135760997;5914.142449344821;5971.910421343683;6938.444924406035;7215.134183897966;7223.38601218897;7251.166115896686;7286.307800758919;4636.976815115937;4649.860784107881;4650.0932318197965;4652.13935421948;4657.4411070671395;7635.770926872203;7714.922850771477;7721;7734.2265773422205;7737.690492380298;4603.49361570227;4708.081924024782;4709.270063140219;4717.386739723814;4725.881852953704;4795.904081918412;4796.544328288807;4816;4818.301346304766;4826.8069277228515;5753.050746626844;5770.16332631766;5776.451237132465;5791.436312195768;5802.332731735904;6024.608400453956;7174.1032370953635;7329.377002954702;7345.816354591071;7349.853002939912;1626;1647.5881029742563;1648.5796121988817;1666.1086318819616;1666.7999840019274;1051.9894801052044;1052.7736536644504;1058.9470526473644;1066.5733706517456;1068.220199254533;6864.965675171692;6924.826879328057;6927.930720692729;6946.0622815919205;6964.895526567106;6093.69531523422;7070.858582828418;7557.2820582044615;7568.167501574822;7568.356689681329;5438.483344082306;6627.900581491282;6872.656367181621;6885.554033652989;6998.4751143664425;3871.10964478166;3941.5270167580074;3951;3974.741641793274;3994.121293315466;7894.092179399443;8034.035915690155;8037.678492860337;8050.07424146219;8071.071826739882;7163.42692584592;7869.331106855867;7886.566238856918;7919.366450683931;7922.830867652985;7792.688292468351;8022.197780222048;8026.719064832703;8049.074356449083;8053;6802.67347867181;6950.165980082423;7585.582792946441;7588.506747061423;7611.581363025087;6460.644664543495;6464.838379040373;7301;7339.972403863357;7503.249675032672;6560.639164845788;7937;8018.759437216893;8023.919760802317;8029.759107226792;3769.3403654359827;4681.882952926067;4751.83368582098;4753.548412900769;4760.809567617256;7474.32731054186;7575.507592006502;7591.848163036819;7600.2779735925;7759.72840950564;7273.272672732684;7283.963580182065;7306.926930730625;7325.084364454443;7326.120865496175;5906.852328691817;7275.527090739085;7306.744263950736;7307.817304567428;7316.634168291671;6184.350643182401;6732.192136943402;6962.860742785218;7093.113360829896;7159.069320988238;7322.890156647548;7329.230430804689;7336.055945174639;7339.155997060407;7348.96325518369;6974.012406464133;7084.858302834017;7140.214576396488;7155.141383034069;7164.749233776793 04:58:49 INFO - PROCESS | 1732 | |5;yui.html;720.9927056591971;733.1788396995366;734.1373885684321;749.5165618176273;760.4790718357925;14540.41838326467;14688.192149431778;14768.630784230387;14795.03832250903;14849.40602375905;13635.113717608348;15469.45856895006;15757.921210393932;15763.684726305468;15825;578.5863107877866;728.4754976416971;866.1728049712541;884.5488800711619;888.4225253585157;844.9028361738417;858.4463021351224;874.7856775090112;881.0572687224673;890.3011136258039;719.4891626944875;775.9146493885668;820.4707963363627;922.4511415707643;925.4308600210856;882.386741214856;922.3174850610567;922.524899676667;924.1867156901917;925.6482536636103;637.158950185755;657.4937298280345;665.5939876675225;680.0139797293944;681.8908974564046;14088;15041;15155.090694558361;15178.544643660598;15190.316435760416;12594.181378210387;12613.936930315382;12653.620391388182;12767.42546585406;13176.934115329457;10273.589056437733;10429.5828166874;11401.657950261506;11530;11675.649730508097;3484.163800687842;3507.6141624421293;3581.391163502185;3588.6411358864166;3702.3520883845217;77961.61019194925;78862.60568697177;78966.6051669738;80598.19401806024;80761.59619201867;9430.481323527272;9599.808003839884;9715.562799674031;10077.647282345082;10466.476676166161;21088.578228435344;21117.788822111583;21174.894125529583;21211.257605983716;21303.147874085174;6209.5032397408095;7512.39900807934;7578.583177925267;7672.578008209491;7786.328203078221;3443.741719371057;3806.1816709407613;4190.078182799779;4272.508661503967;4455.86632401022;3562.71498280137;3598.730095242815;3601.045722883438;3601.405768048243;3643.107438677488;663.8274048747361;667.256009549349;668.7458765669014;669.0365873142756;687.5771400588602;558.3662543013709;589.4370875813588;592.2596754057428;623.7120346484495;625.9217597800275;8463.449875758057;8595.742127736054;8627.95686021566;8777.912220877837;8802.955985220033;598.1267349669531;625.146674788919;629.7386584567354;631.4790298004165;631.797824696102;4013.13717550728;4281.657467402601;4319.805608747614;4425.468943726773;4433.512313645497;83719.07581285054;83918;84948;85062.29875402457;94818;72482;72520.63739681373;72931.63534182296;73456.63271683607;73729.26270737224;68913;69728.60542789116;71168.64415677889;71415.6429217861;72197.2780272201;8827.509074659285;8878.51168185756;8930.106989301017;8961.596728147379;9089.181973622406;47726.76136619295;48673.539793806245;49100.52698419053;49561.50438495569;50237;68039;68165;68374;69825.65087174531;70034.29965700278;11205.495752690986;11313.604023859125;11327.490262938352;11337.09303255721;11815.995640370666;9432.386894852087;11864.82202766942;11868.169228153947;12048.75902481963;12153.210041347284;11350.375729334966;11396.031337336419;11568.768624627628;12158.878411216128;12275.570355037531;11257.774844503228;11918.52325906954;12074.215176013882;12078.03375729957;12181;10183.490825458846;10620.09729172998;10835;11151.665450036511;11647.184697071123;8587.527685977331;9067.63729450841;9158.771030724285;9587.328886977844;10051.899481005388;7426.5915374654915;9112.678661594164;9879.209663227068;9969.601215951281;10056.949715251669 04:58:49 INFO - PROCESS | 1732 | __end_tp_report 04:58:49 INFO - PROCESS | 1732 | __start_cc_report 04:58:49 INFO - PROCESS | 1732 | _x_x_mozilla_cycle_collect,360 04:58:49 INFO - PROCESS | 1732 | __end_cc_report 04:58:49 INFO - PROCESS | 1732 | __startTimestamp1454763529193__endTimestamp 04:58:49 INFO - PROCESS | 1732 | 04:58:49 INFO - PROCESS | 1732 | ------- Summary: start ------- 04:58:49 INFO - PROCESS | 1732 | Number of tests: 6 04:58:49 INFO - PROCESS | 1732 | 04:58:49 INFO - PROCESS | 1732 | [#0] dojo.html Cycles:165 Average:5801.95 Median:6030.76 stddev:633.22 (10.5%) stddev-sans-first:591.64 04:58:49 INFO - PROCESS | 1732 | Values: 2860.8 3527.3 3534.5 3576.8 3582.5 5795.1 5822.0 5831.4 5860.9 5867.6 5714.6 5741.2 5823.8 5827.9 5837.4 5226.9 5307.5 5360.1 5372.4 5408.2 5381.8 5396.0 5399.6 5402.7 5418.0 5226.4 5269.1 5388.4 5391.9 5488.2 5331.4 5339.3 5340.3 5343.4 5345.0 5331.8 5345.2 5347.6 5358.2 5363.2 5026.8 5604.2 5675.9 5847.6 5848.6 6228.9 6231.0 6253.0 6261.7 6288.7 6259.1 6275.8 6279.5 6282.3 6305.1 5846.2 5905.7 5937.7 5951.4 6024.8 6349.2 6374.3 6408.7 6419.9 6426.5 6030.8 6153.4 6160.9 6165.6 6173.4 6126.1 6175.5 6185.9 6226.3 6265.9 6180.8 6192.0 6206.2 6215.6 6217.0 6136.8 6191.8 6201.8 6231.5 6248.8 4796.8 4927.2 4938.4 4949.7 4990.8 4457.6 4467.7 4476.5 4480.9 4584.9 5796.3 5884.8 5972.4 6029.1 6044.6 6198.4 6235.4 6295.8 6296.7 6312.9 5801.3 5815.7 5821.0 5822.4 5857.8 5259.5 5309.3 5313.2 5350.5 5471.0 6394.7 6468.5 6486.9 6490.2 6517.5 6246.7 6278.2 6279.0 6281.8 6283.4 6270.7 6312.2 6350.6 6397.5 6436.3 6189.1 6246.5 6251.8 6266.8 6289.3 6269.7 6280.2 6282.0 6282.3 6287.7 5535.6 5699.5 6125.4 6143.1 6265.4 5450.8 5527.3 5904.8 6220.0 6239.4 5819.6 6026.1 6055.1 6083.3 6093.5 5857.5 6069.8 6117.6 6121.3 6125.5 6118.3 6120.9 6122.2 6130.0 6166.6 04:58:49 INFO - PROCESS | 1732 | 04:58:49 INFO - PROCESS | 1732 | [#1] ext.html Cycles:180 Average:63187.11 Median:38943.61 stddev:132903.86 (341.3%) stddev-sans-first:133193.25 04:58:49 INFO - PROCESS | 1732 | Values: 462.4 467.9 507.3 549.9 553.8 37226.8 37910.6 37967.0 38050.0 38069.4 39417.6 39825.2 39836.8 39866.0 39938.6 9430.8 9583.7 9692.5 9708.3 9721.0 9506.3 9617.3 9653.2 9725.6 9749.2 9720.7 9801.8 9811.7 9818.9 9820.5 9699.8 9752.3 9753.5 9770.9 9809.9 8600.6 9178.0 9612.5 9620.6 9629.7 38891.8 38995.4 39187.2 39263.2 39304.8 3412.8 3413.7 3497.2 3604.2 3814.2 27954.2 28179.7 28511.7 28623.3 28803.9 2828.8 2830.5 2854.7 2867.2 2893.2 417480.0 483006.6 483597.0 484141.0 486456.0 51051.0 53253.7 58356.0 58702.7 58857.4 61283.7 61337.7 61702.7 61992.4 62095.5 16463.4 16473.3 16669.7 16699.4 16731.0 12784.6 12817.9 12902.2 12910.7 12917.7 18479.4 18689.5 18809.7 18811.6 18879.4 8425.4 8626.0 8650.7 8661.4 8705.8 751.4 984.2 988.9 991.2 1107.4 21198.8 22116.7 24436.8 26762.6 27314.6 984.0 1047.8 1093.1 1105.4 1193.0 15263.5 15473.4 15722.9 15812.4 15924.6 495959.0 528045.0 532877.0 536184.0 538294.0 54750.7 56106.2 56429.0 56506.2 56532.6 1437.7 1454.7 1470.7 1474.5 1480.2 23275.7 24475.8 29132.1 29238.3 29707.4 47741.8 48051.0 48131.3 48185.8 48460.0 494297.0 495353.0 496769.0 499132.0 503945.0 27413.9 32055.4 32823.8 32845.7 32958.0 40886.6 42481.4 43490.0 43716.6 44311.7 26169.0 33128.0 34138.0 34164.7 34299.3 33495.0 33548.2 33833.8 34028.5 34078.3 33364.3 33541.2 33943.0 34071.3 34272.8 29615.6 31332.5 31446.0 31484.0 31621.7 23994.0 24009.9 24304.0 24449.3 24602.8 04:58:49 INFO - PROCESS | 1732 | 04:58:49 INFO - PROCESS | 1732 | [#2] jquery.html Cycles:180 Average:35485.33 Median:4368.47 stddev:118417.31 (2710.7%) stddev-sans-first:118720.06 04:58:49 INFO - PROCESS | 1732 | Values: 323.4 361.2 365.6 366.4 367.2 15030.7 17451.7 18752.5 18869.4 19567.6 18207.7 18693.8 18721.0 18798.5 19018.8 5693.2 6004.5 6005.4 6012.7 6019.9 4141.9 4362.9 5554.6 6029.0 6041.6 6308.9 6516.6 6551.9 6570.2 6570.7 5032.0 6458.7 6465.2 6530.0 6546.4 5048.3 5439.3 5470.1 5471.2 5501.9 10282.7 10437.9 10452.9 12602.0 12838.8 2120.8 2165.1 2298.0 2355.2 2609.7 7834.5 9231.9 9575.0 9861.0 9894.4 1743.2 1809.9 1825.7 1827.4 1889.6 66257.7 68425.7 70849.0 86993.3 92222.0 10560.0 10981.3 11061.6 11161.3 11208.4 11248.3 13308.0 13315.0 13393.8 13399.4 8315.7 8326.8 8336.0 8391.6 8424.3 6599.8 8377.7 8444.5 8475.8 8509.3 3943.8 4285.8 4374.0 4389.3 4408.5 1630.4 1687.9 1855.2 1855.8 1899.7 846.7 945.8 1044.0 1047.8 1077.9 18796.2 19560.2 19752.9 19809.8 19963.2 865.6 914.8 949.3 981.7 1022.4 9239.4 10388.0 10407.3 10502.9 10543.3 688385.0 715445.0 730029.0 730298.0 739940.0 71512.6 93870.1 103112.0 111943.0 119549.6 1220.5 1222.7 1225.9 1248.0 1277.7 18088.6 18297.0 18312.6 18439.7 18465.4 50923.0 51048.7 51403.7 51412.2 51875.0 73642.0 73834.6 74230.6 74525.0 75337.6 7107.1 7317.9 7363.5 7581.4 7682.4 9828.9 11419.5 11441.7 11863.8 12088.6 10113.0 10144.7 10257.2 10296.3 10334.9 8540.8 9958.6 9972.4 10171.4 10187.1 10042.7 10289.4 10318.6 10428.4 10479.9 6602.9 7441.8 7556.2 7585.5 7672.8 8350.0 8475.0 8779.3 9394.7 9680.8 04:58:49 INFO - PROCESS | 1732 | 04:58:49 INFO - PROCESS | 1732 | [#3] mootools.html Cycles:180 Average:6050.80 Median:512.59 stddev:3210.54 (626.3%) stddev-sans-first:3199.88 04:58:49 INFO - PROCESS | 1732 | Values: 1324.5 1567.1 1746.5 1901.0 1910.4 7075.4 8071.6 8835.9 9007.9 9011.3 8505.6 8640.0 8749.0 8773.6 8778.7 2486.1 2514.0 2518.8 2519.7 2521.5 2438.1 2455.7 2462.4 2466.4 2467.5 2452.1 2457.7 2522.7 2536.9 2543.4 2377.5 2398.1 2413.2 2415.7 2420.1 2485.7 2499.5 2510.7 2524.6 2526.6 8910.6 8950.9 8958.4 8960.0 9020.7 4821.5 5395.8 5587.0 5593.5 5595.4 3593.4 3708.5 3745.6 3752.1 3754.9 917.7 1052.2 1073.9 1085.1 1108.5 11992.3 12093.6 12143.7 12144.8 12159.2 4947.5 4977.8 5014.6 5035.1 5047.7 10309.1 10350.4 10360.3 10367.5 10378.2 5555.1 5558.1 5585.2 5585.9 5588.2 4360.1 4421.7 4842.4 4917.2 5059.5 3976.1 4006.8 4021.5 4038.7 4039.7 1156.9 1321.2 1337.5 1339.4 1344.9 1180.7 1182.5 1323.5 1334.5 1340.7 7097.0 8142.4 8184.9 8191.9 8271.5 505.1 510.1 515.0 516.5 536.1 6193.6 6215.3 6302.6 6309.6 6312.8 10584.0 10880.3 10920.1 10949.0 11009.7 10321.4 10653.8 10663.1 10746.2 10762.9 8373.6 8418.4 8425.1 8499.2 8514.2 7745.8 7756.1 7797.6 7921.0 7934.0 6993.7 8287.7 9566.4 9829.7 9887.9 7793.9 10049.3 10061.8 10099.2 10226.9 6796.9 6852.8 7232.3 7604.2 7655.9 7756.2 8091.0 8162.0 8168.3 8179.9 6856.6 7668.1 7671.1 7762.9 7772.1 7415.5 7462.2 7484.6 7567.1 7595.4 7592.8 7615.2 7649.8 7652.1 7657.2 6881.9 6928.2 6979.8 7005.6 7035.6 7082.9 7128.9 7165.4 7181.6 7195.3 04:58:49 INFO - PROCESS | 1732 | 04:58:49 INFO - PROCESS | 1732 | [#4] prototype.html Cycles:180 Average:5899.61 Median:6663.07 stddev:1921.71 (28.8%) stddev-sans-first:1880.99 04:58:49 INFO - PROCESS | 1732 | Values: 324.4 329.4 333.7 335.7 341.0 6567.8 6718.0 6733.2 6780.2 6807.4 6551.6 6698.2 6713.5 6783.1 6795.2 4098.3 4958.0 4983.3 5008.4 5009.0 4027.7 4873.3 5004.3 5025.3 5046.6 4891.0 4984.0 4997.0 4998.3 5001.9 4982.7 4990.9 5005.0 5019.0 5031.3 4068.3 4151.1 4184.2 4296.4 4302.1 5202.6 6442.9 6446.1 6451.4 6468.9 5895.1 5899.8 5906.2 5914.1 5971.9 6938.4 7215.1 7223.4 7251.2 7286.3 4637.0 4649.9 4650.1 4652.1 4657.4 7635.8 7714.9 7721.0 7734.2 7737.7 4603.5 4708.1 4709.3 4717.4 4725.9 4795.9 4796.5 4816.0 4818.3 4826.8 5753.1 5770.2 5776.5 5791.4 5802.3 6024.6 7174.1 7329.4 7345.8 7349.9 1626.0 1647.6 1648.6 1666.1 1666.8 1052.0 1052.8 1058.9 1066.6 1068.2 6865.0 6924.8 6927.9 6946.1 6964.9 6093.7 7070.9 7557.3 7568.2 7568.4 5438.5 6627.9 6872.7 6885.6 6998.5 3871.1 3941.5 3951.0 3974.7 3994.1 7894.1 8034.0 8037.7 8050.1 8071.1 7163.4 7869.3 7886.6 7919.4 7922.8 7792.7 8022.2 8026.7 8049.1 8053.0 6802.7 6950.2 7585.6 7588.5 7611.6 6460.6 6464.8 7301.0 7340.0 7503.2 6560.6 7937.0 8018.8 8023.9 8029.8 3769.3 4681.9 4751.8 4753.5 4760.8 7474.3 7575.5 7591.8 7600.3 7759.7 7273.3 7284.0 7306.9 7325.1 7326.1 5906.9 7275.5 7306.7 7307.8 7316.6 6184.4 6732.2 6962.9 7093.1 7159.1 7322.9 7329.2 7336.1 7339.2 7349.0 6974.0 7084.9 7140.2 7155.1 7164.7 04:58:49 INFO - PROCESS | 1732 | 04:58:49 INFO - PROCESS | 1732 | [#5] yui.html Cycles:180 Average:18070.30 Median:625.53 stddev:24876.35 (3976.8%) stddev-sans-first:24912.03 04:58:49 INFO - PROCESS | 1732 | Values: 721.0 733.2 734.1 749.5 760.5 14540.4 14688.2 14768.6 14795.0 14849.4 13635.1 15469.5 15757.9 15763.7 15825.0 578.6 728.5 866.2 884.5 888.4 844.9 858.4 874.8 881.1 890.3 719.5 775.9 820.5 922.5 925.4 882.4 922.3 922.5 924.2 925.6 637.2 657.5 665.6 680.0 681.9 14088.0 15041.0 15155.1 15178.5 15190.3 12594.2 12613.9 12653.6 12767.4 13176.9 10273.6 10429.6 11401.7 11530.0 11675.6 3484.2 3507.6 3581.4 3588.6 3702.4 77961.6 78862.6 78966.6 80598.2 80761.6 9430.5 9599.8 9715.6 10077.6 10466.5 21088.6 21117.8 21174.9 21211.3 21303.1 6209.5 7512.4 7578.6 7672.6 7786.3 3443.7 3806.2 4190.1 4272.5 4455.9 3562.7 3598.7 3601.0 3601.4 3643.1 663.8 667.3 668.7 669.0 687.6 558.4 589.4 592.3 623.7 625.9 8463.4 8595.7 8628.0 8777.9 8803.0 598.1 625.1 629.7 631.5 631.8 4013.1 4281.7 4319.8 4425.5 4433.5 83719.1 83918.0 84948.0 85062.3 94818.0 72482.0 72520.6 72931.6 73456.6 73729.3 68913.0 69728.6 71168.6 71415.6 72197.3 8827.5 8878.5 8930.1 8961.6 9089.2 47726.8 48673.5 49100.5 49561.5 50237.0 68039.0 68165.0 68374.0 69825.7 70034.3 11205.5 11313.6 11327.5 11337.1 11816.0 9432.4 11864.8 11868.2 12048.8 12153.2 11350.4 11396.0 11568.8 12158.9 12275.6 11257.8 11918.5 12074.2 12078.0 12181.0 10183.5 10620.1 10835.0 11151.7 11647.2 8587.5 9067.6 9158.8 9587.3 10051.9 7426.6 9112.7 9879.2 9969.6 10056.9 04:58:49 INFO - PROCESS | 1732 | -------- Summary: end -------- 04:58:49 INFO - PROCESS | 1732 | 04:58:49 INFO - TEST-INFO | 1732: exit 0 04:58:49 INFO - TEST-OK | dromaeo_css | took 1111148ms 04:58:49 INFO - TEST-START | kraken 04:58:49 INFO - operating with platform_type : mac_ 04:58:49 INFO - Initialising browser for kraken test... 04:58:49 INFO - TEST-INFO | started process 1804 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpoDh2I0/profile http://localhost:49270/getInfo.html) 04:58:49 INFO - PROCESS | 1804 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:58:52 INFO - PROCESS | 1804 | __metrics Screen width/height:1600/1200 04:58:52 INFO - PROCESS | 1804 | colorDepth:24 04:58:52 INFO - PROCESS | 1804 | Browser inner width/height: 1024/689 04:58:52 INFO - PROCESS | 1804 | __metrics 04:58:52 ERROR - PROCESS | 1804 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2830: TypeError: this.tabs is undefined 04:58:52 INFO - PROCESS | 1804 | ************************* 04:58:52 INFO - PROCESS | 1804 | A coding exception was thrown in a Promise resolution callback. 04:58:52 INFO - PROCESS | 1804 | See https://developer.mozilla.org/Mozilla/JavaScript_code_modules/Promise.jsm/Promise 04:58:52 INFO - PROCESS | 1804 | 04:58:52 ERROR - PROCESS | 1804 | Full message: TypeError: this.tabs is undefined 04:58:52 INFO - PROCESS | 1804 | Full stack: .get@chrome://browser/content/tabbrowser.xml:2830:17 04:58:52 INFO - PROCESS | 1804 | ssi_onClose/<@resource:///modules/sessionstore/SessionStore.jsm:1323:9 04:58:52 INFO - PROCESS | 1804 | Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 04:58:52 INFO - PROCESS | 1804 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 04:58:52 INFO - PROCESS | 1804 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 04:58:52 INFO - PROCESS | 1804 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 04:58:52 INFO - PROCESS | 1804 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 04:58:52 INFO - PROCESS | 1804 | resolve@resource://app/modules/sessionstore/TabStateFlusher.jsm:146:5 04:58:52 INFO - PROCESS | 1804 | resolve@resource://app/modules/sessionstore/TabStateFlusher.jsm:52:5 04:58:52 INFO - PROCESS | 1804 | receiveMessage@resource:///modules/sessionstore/SessionStore.jsm:734:11 04:58:52 INFO - PROCESS | 1804 | 04:58:52 INFO - PROCESS | 1804 | ************************* 04:58:53 INFO - TEST-INFO | 1804: exit 0 04:58:53 INFO - Browser initialized. 04:58:53 INFO - Running cycle 1/1 for kraken test... 04:58:53 INFO - TEST-INFO | started process 1807 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpoDh2I0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:59:05 INFO - PROCESS | 1807 | RSS: Main: 255696896 04:59:05 INFO - PROCESS | 1807 | 04:59:08 INFO - PROCESS | 1807 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 04:59:08 INFO - PROCESS | 1807 | RSS: Main: 268791808 04:59:08 INFO - PROCESS | 1807 | 04:59:11 INFO - PROCESS | 1807 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 04:59:11 INFO - PROCESS | 1807 | RSS: Main: 276660224 04:59:11 INFO - PROCESS | 1807 | 04:59:15 INFO - PROCESS | 1807 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 04:59:15 INFO - PROCESS | 1807 | RSS: Main: 281092096 04:59:15 INFO - PROCESS | 1807 | 04:59:17 INFO - PROCESS | 1807 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 04:59:18 INFO - PROCESS | 1807 | RSS: Main: 283090944 04:59:18 INFO - PROCESS | 1807 | 04:59:20 INFO - PROCESS | 1807 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:59:21 INFO - PROCESS | 1807 | RSS: Main: 284393472 04:59:21 INFO - PROCESS | 1807 | 04:59:23 INFO - PROCESS | 1807 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 04:59:24 INFO - PROCESS | 1807 | RSS: Main: 283762688 04:59:24 INFO - PROCESS | 1807 | 04:59:27 INFO - PROCESS | 1807 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 04:59:28 INFO - PROCESS | 1807 | RSS: Main: 283648000 04:59:28 INFO - PROCESS | 1807 | 04:59:30 INFO - PROCESS | 1807 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 04:59:31 INFO - PROCESS | 1807 | RSS: Main: 283942912 04:59:31 INFO - PROCESS | 1807 | 04:59:32 INFO - PROCESS | 1807 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:59:33 INFO - PROCESS | 1807 | RSS: Main: 283545600 04:59:33 INFO - PROCESS | 1807 | 04:59:35 INFO - PROCESS | 1807 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:59:35 INFO - PROCESS | 1807 | RSS: Main: 284741632 04:59:35 INFO - PROCESS | 1807 | 04:59:37 INFO - PROCESS | 1807 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:59:38 INFO - PROCESS | 1807 | RSS: Main: 284979200 04:59:38 INFO - PROCESS | 1807 | 04:59:41 INFO - PROCESS | 1807 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:59:41 INFO - PROCESS | 1807 | RSS: Main: 284803072 04:59:41 INFO - PROCESS | 1807 | 04:59:44 INFO - PROCESS | 1807 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:59:44 INFO - PROCESS | 1807 | RSS: Main: 284704768 04:59:44 INFO - PROCESS | 1807 | 04:59:46 INFO - PROCESS | 1807 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 04:59:46 INFO - PROCESS | 1807 | RSS: Main: 285401088 04:59:46 INFO - PROCESS | 1807 | 04:59:46 INFO - PROCESS | 1807 | __start_tp_report 04:59:46 INFO - PROCESS | 1807 | _x_x_mozilla_page_load 04:59:46 INFO - PROCESS | 1807 | _x_x_mozilla_page_load_details 04:59:46 INFO - PROCESS | 1807 | |i|pagename|runs| 04:59:46 INFO - PROCESS | 1807 | |0;ai-astar;115;106;126;158;115;126;117;114;114;137 04:59:46 INFO - PROCESS | 1807 | |1;audio-beat-detection;150;129;149;153;125;140;141;123;157;120 04:59:46 INFO - PROCESS | 1807 | |2;audio-dft;245;257;202;214;225;200;198;199;199;228 04:59:46 INFO - PROCESS | 1807 | |3;audio-fft;71;69;77;106;57;58;60;57;116;57 04:59:46 INFO - PROCESS | 1807 | |4;audio-oscillator;85;80;126;78;81;83;115;98;120;143 04:59:46 INFO - PROCESS | 1807 | |5;imaging-gaussian-blur;100;142;86;91;85;91;86;92;90;92 04:59:46 INFO - PROCESS | 1807 | |6;imaging-darkroom;95;97;96;106;128;95;95;96;133;151 04:59:46 INFO - PROCESS | 1807 | |7;imaging-desaturate;95;95;91;90;91;91;93;92;91;91 04:59:46 INFO - PROCESS | 1807 | |8;json-parse-financial;57;56;55;52;56;60;73;91;58;54 04:59:46 INFO - PROCESS | 1807 | |9;json-stringify-tinderbox;66;64;68;72;72;69;65;66;65;66 04:59:46 INFO - PROCESS | 1807 | |10;stanford-crypto-aes;85;86;84;87;86;86;84;83;88;83 04:59:46 INFO - PROCESS | 1807 | |11;stanford-crypto-ccm;138;132;141;110;126;124;134;128;152;110 04:59:46 INFO - PROCESS | 1807 | |12;stanford-crypto-pbkdf2;130;139;141;140;145;132;142;183;168;144 04:59:46 INFO - PROCESS | 1807 | |13;stanford-crypto-sha256-iterative;66;69;67;74;95;96;98;99;95;85 04:59:46 INFO - PROCESS | 1807 | __end_tp_report 04:59:46 INFO - PROCESS | 1807 | __start_cc_report 04:59:46 INFO - PROCESS | 1807 | _x_x_mozilla_cycle_collect,884 04:59:46 INFO - PROCESS | 1807 | __end_cc_report 04:59:46 INFO - PROCESS | 1807 | __startTimestamp1454763586966__endTimestamp 04:59:46 INFO - PROCESS | 1807 | 04:59:46 INFO - PROCESS | 1807 | ------- Summary: start ------- 04:59:46 INFO - PROCESS | 1807 | Number of tests: 14 04:59:46 INFO - PROCESS | 1807 | 04:59:46 INFO - PROCESS | 1807 | [#0] ai-astar Cycles:10 Average:122.80 Median:121.50 stddev:15.11 (12.4%) stddev-sans-first:15.76 04:59:46 INFO - PROCESS | 1807 | Values: 115.0 106.0 126.0 158.0 115.0 126.0 117.0 114.0 114.0 137.0 04:59:46 INFO - PROCESS | 1807 | 04:59:46 INFO - PROCESS | 1807 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:145.00 stddev:13.57 (9.4%) stddev-sans-first:13.77 04:59:46 INFO - PROCESS | 1807 | Values: 150.0 129.0 149.0 153.0 125.0 140.0 141.0 123.0 157.0 120.0 04:59:46 INFO - PROCESS | 1807 | 04:59:46 INFO - PROCESS | 1807 | [#2] audio-dft Cycles:10 Average:216.70 Median:219.50 stddev:21.34 (9.7%) stddev-sans-first:20.03 04:59:46 INFO - PROCESS | 1807 | Values: 245.0 257.0 202.0 214.0 225.0 200.0 198.0 199.0 199.0 228.0 04:59:46 INFO - PROCESS | 1807 | 04:59:46 INFO - PROCESS | 1807 | [#3] audio-fft Cycles:10 Average:72.80 Median:59.00 stddev:21.44 (36.3%) stddev-sans-first:22.73 04:59:46 INFO - PROCESS | 1807 | Values: 71.0 69.0 77.0 106.0 57.0 58.0 60.0 57.0 116.0 57.0 04:59:46 INFO - PROCESS | 1807 | 04:59:46 INFO - PROCESS | 1807 | [#4] audio-oscillator Cycles:10 Average:100.90 Median:80.50 stddev:23.34 (29.0%) stddev-sans-first:24.04 04:59:46 INFO - PROCESS | 1807 | Values: 85.0 80.0 126.0 78.0 81.0 83.0 115.0 98.0 120.0 143.0 04:59:46 INFO - PROCESS | 1807 | 04:59:46 INFO - PROCESS | 1807 | [#5] imaging-gaussian-blur Cycles:10 Average:95.50 Median:90.50 stddev:16.89 (18.7%) stddev-sans-first:17.84 04:59:46 INFO - PROCESS | 1807 | Values: 100.0 142.0 86.0 91.0 85.0 91.0 86.0 92.0 90.0 92.0 04:59:46 INFO - PROCESS | 1807 | 04:59:46 INFO - PROCESS | 1807 | [#6] imaging-darkroom Cycles:10 Average:109.20 Median:95.00 stddev:20.49 (21.6%) stddev-sans-first:21.08 04:59:46 INFO - PROCESS | 1807 | Values: 95.0 97.0 96.0 106.0 128.0 95.0 95.0 96.0 133.0 151.0 04:59:46 INFO - PROCESS | 1807 | 04:59:46 INFO - PROCESS | 1807 | [#7] imaging-desaturate Cycles:10 Average:92.00 Median:91.50 stddev:1.76 (1.9%) stddev-sans-first:1.50 04:59:46 INFO - PROCESS | 1807 | Values: 95.0 95.0 91.0 90.0 91.0 91.0 93.0 92.0 91.0 91.0 04:59:46 INFO - PROCESS | 1807 | 04:59:46 INFO - PROCESS | 1807 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:57.50 stddev:11.95 (20.8%) stddev-sans-first:12.58 04:59:46 INFO - PROCESS | 1807 | Values: 57.0 56.0 55.0 52.0 56.0 60.0 73.0 91.0 58.0 54.0 04:59:46 INFO - PROCESS | 1807 | 04:59:46 INFO - PROCESS | 1807 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:2.87 (4.3%) stddev-sans-first:3.00 04:59:46 INFO - PROCESS | 1807 | Values: 66.0 64.0 68.0 72.0 72.0 69.0 65.0 66.0 65.0 66.0 04:59:46 INFO - PROCESS | 1807 | 04:59:46 INFO - PROCESS | 1807 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:86.00 stddev:1.69 (2.0%) stddev-sans-first:1.79 04:59:46 INFO - PROCESS | 1807 | Values: 85.0 86.0 84.0 87.0 86.0 86.0 84.0 83.0 88.0 83.0 04:59:46 INFO - PROCESS | 1807 | 04:59:46 INFO - PROCESS | 1807 | [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:133.00 stddev:13.09 (9.8%) stddev-sans-first:13.52 04:59:46 INFO - PROCESS | 1807 | Values: 138.0 132.0 141.0 110.0 126.0 124.0 134.0 128.0 152.0 110.0 04:59:46 INFO - PROCESS | 1807 | 04:59:46 INFO - PROCESS | 1807 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.40 Median:143.00 stddev:16.45 (11.5%) stddev-sans-first:16.34 04:59:46 INFO - PROCESS | 1807 | Values: 130.0 139.0 141.0 140.0 145.0 132.0 142.0 183.0 168.0 144.0 04:59:46 INFO - PROCESS | 1807 | 04:59:46 INFO - PROCESS | 1807 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:84.40 Median:95.00 stddev:13.92 (14.7%) stddev-sans-first:13.08 04:59:46 INFO - PROCESS | 1807 | Values: 66.0 69.0 67.0 74.0 95.0 96.0 98.0 99.0 95.0 85.0 04:59:46 INFO - PROCESS | 1807 | -------- Summary: end -------- 04:59:46 INFO - PROCESS | 1807 | 04:59:47 INFO - TEST-INFO | 1807: exit 0 04:59:47 INFO - TEST-OK | kraken | took 57972ms 04:59:47 INFO - SUITE-END | took 1169s 04:59:48 INFO - Completed test suite (00:19:29) 04:59:48 INFO - Working with test: dromaeo_css 04:59:48 INFO - Generating results file: dromaeo_css 04:59:48 INFO - Working with test: kraken 04:59:48 INFO - Generating results file: kraken 04:59:48 INFO - javascript benchmark 04:59:48 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:59:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 04:59:48 INFO - process_Request line: dromaeo_css 7468.82 graph.html#tests=[[72,64,61]] 04:59:48 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:59:48 INFO - process_Request line: kraken 1522.60 graph.html#tests=[[232,64,61]] 04:59:48 INFO - RETURN: dromaeo_css: 7468.82 04:59:48 INFO - RETURN: kraken: 1522.60 04:59:48 INFO - javascript benchmark 04:59:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2860.7711383089354, 3527.3474407234658, 3534.452159915214, 3576.8032758198287, 3582.462630605409, 5795.130730390443, 5821.970890145554, 5831.446012628793, 5860.941390586093, 5867.618604790691, 5714.57140714447, 5741.19623252745, 5823.767049318022, 5827.883442331151, 5837.357890632027, 5226.947730522694, 5307.52232299093, 5360.115580929142, 5372.382176049746, 5408.188771684239, 5381.81163659272, 5396.001739678152, 5399.649022813524, 5402.6758394496455, 5418.0, 5226.372835259755, 5269.077911365495, 5388.380336261341, 5391.919121213185, 5488.17677348397, 5331.413544510101, 5339.279197308352, 5340.252364668911, 5343.438938911398, 5345.0, 5331.760070796785, 5345.1714984177515, 5347.572194224453, 5358.196270559447, 5363.195520671891, 5026.798928042874, 5604.159376093618, 5675.886482270332, 5847.619904706223, 5848.64908105515, 6228.937710622881, 6231.011379453112, 6253.0, 6261.749530018794, 6288.748450061992, 6259.061140828867, 6275.780347687809, 6279.529035322369, 6282.277538083134, 6305.0857625644485, 5846.181534585162, 5905.6751878646655, 5937.732802023919, 5951.434613711691, 6024.789132380433, 6349.206349206349, 6374.330695277022, 6408.711607977652, 6419.935800642027, 6426.518011149183, 6030.758769649165, 6153.446189842935, 6160.907586386208, 6165.599236049642, 6173.41352571505, 6126.120738204555, 6175.476947535717, 6185.896795089601, 6226.346233645402, 6265.906011409833, 6180.81457556274, 6191.9690401547705, 6206.193194884636, 6215.595986260969, 6217.0, 6136.846578835475, 6191.752329906843, 6201.7519299228425, 6231.532635052389, 6248.781292654735, 4796.8081276749235, 4927.211646136601, 4938.358013458227, 4949.727764972889, 4990.80036798524, 4457.64338852891, 4467.687261891637, 4476.462824461086, 4480.932786008212, 4584.885377865513, 5796.275465566804, 5884.7940322088525, 5972.402759723993, 6029.095635654599, 6044.576879618472, 6198.380161983766, 6235.407636274546, 6295.779647712308, 6296.716647750863, 6312.936870631235, 5801.274840644919, 5815.680137592389, 5820.970895145582, 5822.388649191858, 5857.765689372377, 5259.500347466985, 5309.283246761715, 5313.1764576490705, 5350.4649535046965, 5471.042567550663, 6394.680265986682, 6468.450181734605, 6486.870262594722, 6490.156279683611, 6517.51118666102, 6246.718897649707, 6278.215223097113, 6279.0, 6281.842953926189, 6283.434490895841, 6270.717817698306, 6312.210973628296, 6350.555461117678, 6397.456216221487, 6436.292007879036, 6189.071639254148, 6246.46905013079, 6251.843703907439, 6266.780662676784, 6289.339619339903, 6269.7178626962805, 6280.183576135073, 6282.0, 6282.308946016026, 6287.74849006053, 5535.612507124623, 5699.487046165865, 6125.387461253839, 6143.109249158758, 6265.404786545271, 5450.828071964546, 5527.336719593674, 5904.763809447746, 6219.968900155471, 6239.407256310643, 5819.563532734977, 6026.096085587197, 6055.061465472859, 6083.270007599116, 6093.512518998381, 5857.5313974881055, 6069.817905462844, 6117.611910571165, 6121.32665406796, 6125.510168486406, 6118.3065437153555, 6120.90429240112, 6122.215079804129, 6130.049842274455, 6166.630002199882], "unit": "score", "name": "dojo.html", "value": 5762.157783409622}, {"lowerIsBetter": false, "replicates": [462.4104267059499, 467.9274712419575, 507.3480577457967, 549.8700171148289, 553.7595785440612, 37226.813865930664, 37910.620893791056, 37967.0, 38050.04874878129, 38069.428958565644, 39417.605823941754, 39825.203495930065, 39836.80081599595, 39866.0, 39938.600613993854, 9430.811383772338, 9583.712488625317, 9692.46691431971, 9708.320417570772, 9721.0, 9506.334556581007, 9617.278704097185, 9653.17947974423, 9725.562349694246, 9749.171320437772, 9720.659776907809, 9801.803963920718, 9811.65659201928, 9818.852717209247, 9820.508974551243, 9699.806003879918, 9752.26857985654, 9753.463559504224, 9770.87634921986, 9809.901900981042, 8600.5699715014, 9177.954110229473, 9612.471314077722, 9620.567074481665, 9629.662961796303, 38891.8055409724, 38995.41506877399, 39187.21625567501, 39263.21473570541, 39304.80347598244, 3412.7611067225303, 3413.7098346640564, 3497.160681436437, 3604.1530240393486, 3814.179951310454, 27954.16137515878, 28179.718202817916, 28511.714882851113, 28623.28441788951, 28803.855980719964, 2828.8161269517414, 2830.547112461996, 2854.6868440517387, 2867.197184788263, 2893.1609833148364, 417480.0, 483006.58496707643, 483597.0, 484141.0, 486456.0, 51051.0, 53253.73373133109, 58356.0, 58702.706486467294, 58857.41142588605, 61283.69358153181, 61337.69331153405, 61702.691486543175, 61992.380076199566, 62095.51617935232, 16463.423780167876, 16473.34106635745, 16669.666606667797, 16699.415520456725, 16730.996140231382, 12784.552540661032, 12817.935910320388, 12902.161359511601, 12910.741785164244, 12917.741645167043, 18479.44561663152, 18689.532761680795, 18809.717854232196, 18811.623767524845, 18879.43361699151, 8425.36809739272, 8625.956870215608, 8650.740477785677, 8661.350398720122, 8705.825883482295, 751.3763576231714, 984.1634610581092, 988.9406635601744, 991.1872264742842, 1107.3854011023798, 21198.78801211999, 22116.668249976265, 24436.755632443448, 26762.5985610216, 27314.5902811458, 983.9901600983899, 1047.7694907120422, 1093.10365500289, 1105.3699391347016, 1192.9978817793096, 15263.542093737206, 15473.381064757508, 15722.899397042325, 15812.446564370422, 15924.620729299304, 495959.0, 528045.0, 532877.0, 536184.0, 538294.0, 54750.72624636931, 56106.158407623916, 56429.0, 56506.15240771392, 56532.5866853332, 1437.741206582825, 1454.7236025155187, 1470.7426200415098, 1474.4691910912063, 1480.178500931993, 23275.650865237374, 24475.75524244806, 29132.126036218946, 29238.26904327409, 29707.405851883275, 47741.761291193325, 48051.0, 48131.27803083027, 48185.75907120442, 48460.0, 494297.0, 495353.0, 496769.0, 499132.0, 503945.0, 27413.86293068522, 32055.358892822478, 32823.83588082044, 32845.67154328426, 32958.01125966129, 40886.59113408947, 42481.36277955771, 43490.0, 43716.56283437125, 44311.67064988056, 26169.0, 33128.006159815246, 34138.0, 34164.658353417144, 34299.31401372008, 33495.0, 33548.161295967795, 33833.83083084569, 34028.48957265593, 34078.318433630695, 33364.332713346084, 33541.16147096342, 33943.0, 34071.31857362889, 34272.82863585766, 29615.555766663085, 31332.530012050294, 31446.0, 31484.0, 31621.683783162793, 23994.0, 24009.879950600833, 24304.0, 24449.266522004367, 24602.753972460763], "unit": "score", "name": "ext.html", "value": 19243.04610882894}, {"lowerIsBetter": false, "replicates": [323.37265704533206, 361.1981401289139, 365.5668033380443, 366.3680151738252, 367.1701953584899, 15030.699386012273, 17451.65096698065, 18752.531186720338, 18869.433916982478, 19567.60864782705, 18207.726884096748, 18693.813061869376, 18721.0, 18798.53003674909, 19018.809811901876, 5693.202951586781, 6004.519638428916, 6005.399460053982, 6012.699365031753, 6019.939800602004, 4141.855035073773, 4362.934555981647, 5554.611177217596, 6028.969855150718, 6041.637501749887, 6308.905366419507, 6516.609003459807, 6551.9344806552035, 6570.211574611053, 6570.737170513174, 5032.0, 6458.6770661466735, 6465.224173099235, 6529.967350163242, 6546.378094081055, 5048.268001139851, 5439.347278326587, 5470.097433923398, 5471.179323101527, 5501.889962200734, 10282.742931426774, 10437.895621043768, 10452.895471045344, 12602.0, 12838.80741788874, 2120.8409369297365, 2165.101482884601, 2297.9770202298096, 2355.211004313557, 2609.699884513267, 7834.451588388815, 9231.907680923172, 9575.042495750438, 9860.964598717175, 9894.406335619886, 1743.1545700335328, 1809.8734884463445, 1825.6531259060737, 1827.3695575026727, 1889.5748456597294, 66257.66871165662, 68425.65787171082, 70849.0, 86993.26013479759, 92222.0, 10560.0, 10981.341119532693, 11061.612843550438, 11161.274517156522, 11208.439578021067, 11248.26886252391, 13308.0, 13315.0, 13393.799093013613, 13399.397027133802, 8315.708950186836, 8326.833463330699, 8336.0, 8391.62237699305, 8424.28393586552, 6599.8020059398295, 8377.706780262783, 8444.535550544657, 8475.830483390298, 8509.276711479593, 3943.8225279862477, 4285.807138678767, 4374.0, 4389.341598760211, 4408.515063343029, 1630.3560093762896, 1687.9240434180492, 1855.2393518657286, 1855.8051404602593, 1899.7435346228083, 846.7417437681443, 945.8013817098349, 1044.0290529807353, 1047.8480620310013, 1077.9489997252772, 18796.154173061972, 19560.21759129619, 19752.901235494017, 19809.811411315368, 19963.20147194096, 865.6450855149359, 914.7758799094264, 949.2595775295281, 981.7251169672503, 1022.4172221833484, 9239.445633262027, 10388.013138751807, 10407.271490995558, 10502.947485262677, 10543.31468454548, 688385.0, 715445.0, 730029.0, 730298.0, 739940.0, 71512.64243678749, 93870.0612993875, 103111.9999999985, 111943.0, 119549.60900781935, 1220.5483970930634, 1222.7493363860387, 1225.8957988570894, 1247.9812802807965, 1277.6997405609675, 18088.638227235646, 18297.0, 18312.633747325246, 18439.723404149216, 18465.446036618923, 50923.0, 51048.744756275984, 51403.71490712762, 51412.22881656703, 51875.0, 73642.0, 73834.63082684552, 74230.62884685758, 74525.0, 75337.62331188309, 7107.147142342952, 7317.8902316466365, 7363.521371110861, 7581.431392645684, 7682.385409167141, 9828.852567211354, 11419.486123124645, 11441.713957150805, 11863.822042669195, 12088.576899808464, 10112.988701129829, 10144.695659130239, 10257.17942564608, 10296.279260451696, 10334.948325258325, 8540.829183416421, 9958.55186516594, 9972.40165590038, 10171.389716617026, 10187.134093602126, 10042.69871903844, 10289.43408112561, 10318.587256509656, 10428.426436546062, 10479.947600262254, 6602.900956485752, 7441.776746697607, 7556.206598307319, 7585.544867307979, 7672.80817979555, 8349.958250208952, 8475.025372082042, 8779.253763429924, 9394.67118650844, 9680.806383872425], "unit": "score", "name": "jquery.html", "value": 8873.70929911742}, {"lowerIsBetter": false, "replicates": [1324.5099313254098, 1567.1145802621518, 1746.4673274651234, 1900.9809901900976, 1910.3600293901543, 7075.4339652827775, 8071.596420178997, 8835.867461988068, 9007.864882026766, 9011.3241506887, 8505.574721263944, 8639.95680021599, 8749.03760586335, 8773.56132193391, 8778.736637900858, 2486.129854550906, 2513.987430062856, 2518.785903198221, 2519.672442582462, 2521.4578865543904, 2438.085717855804, 2455.70531536215, 2462.445949661321, 2466.371075375777, 2467.5064987002584, 2452.141750387359, 2457.6559281700575, 2522.735112813156, 2536.8985240590355, 2543.36415896026, 2377.500724847784, 2398.0647547456506, 2413.179518963543, 2415.7342692303832, 2420.1287536486852, 2485.7389974052644, 2499.450120973401, 2510.698716154055, 2524.633928080418, 2526.5957446808607, 8910.599023043913, 8950.86573701395, 8958.37291389603, 8960.0, 9020.684276050373, 4821.517848215186, 5395.757190926418, 5587.0, 5593.468620481048, 5595.440455954413, 3593.4250519916686, 3708.5178926739623, 3745.569259535161, 3752.0994961209385, 3754.868579599728, 917.6879860847343, 1052.1950707708609, 1073.924825262232, 1085.137315833906, 1108.4956344863149, 11992.340421276826, 12093.576724814677, 12143.696407589792, 12144.817827732591, 12159.209651372721, 4947.455779864212, 4977.776000080005, 5014.623903207274, 5035.1188542005, 5047.671901326402, 10309.123724483503, 10350.430726309974, 10360.274780765425, 10367.481625918674, 10378.221633377527, 5555.111182210827, 5558.110702287615, 5585.162225666101, 5585.938671652373, 5588.245586845724, 4360.149770794728, 4421.712588681789, 4842.4189097308545, 4917.237828136645, 5059.468755780664, 3976.1252524444576, 4006.819693113817, 4021.5375231848125, 4038.7374820636564, 4039.6768258539246, 1156.8611766588062, 1321.2204799168537, 1337.4917531338028, 1339.3571085878832, 1344.946202151903, 1180.7366118253387, 1182.4737991593659, 1323.5367621332457, 1334.4595438847282, 1340.671535473815, 7097.00641910133, 8142.4300298978505, 8184.877226841602, 8191.8771218431775, 8271.503709777433, 505.09839935714575, 510.1480527519052, 515.0265997265171, 516.506736067055, 536.083297561167, 6193.597416167935, 6215.316315205324, 6302.621842689453, 6309.558330916791, 6312.779052733133, 10584.0, 10880.347179169275, 10920.126389888948, 10949.0, 11009.669709908716, 10321.432321222404, 10653.84019239712, 10663.146948244123, 10746.194035447374, 10762.892371076188, 8373.581320933929, 8418.368622353348, 8425.11536288693, 8499.235068843835, 8514.191151840565, 7745.845083098194, 7756.108047574376, 7797.649105790139, 7921.049474063149, 7934.0, 6993.650317484207, 8287.709930152416, 9566.426014439156, 9829.655962041294, 9887.901120988698, 7793.947817044626, 10049.296549241482, 10061.798764024825, 10099.242556808122, 10226.897731022893, 6796.898046529207, 6852.800759866904, 7232.312930271616, 7604.2395760425725, 7655.923440765744, 7756.224377562198, 8091.0, 8162.0, 8168.3465322772845, 8179.877301840596, 6856.588604683536, 7668.1181664109345, 7671.117821450604, 7762.92237077622, 7772.106207785951, 7415.480916335805, 7462.216467270859, 7484.625768711651, 7567.091948966159, 7595.430342724208, 7592.810179745329, 7615.238476152341, 7649.808754781175, 7652.120006199136, 7657.157712651492, 6881.862362752617, 6928.16861976566, 6979.755708550177, 7005.649717514206, 7035.648217589202, 7082.858342833218, 7128.928710712827, 7165.426765858614, 7181.640917953977, 7195.316444937723], "unit": "score", "name": "mootools.html", "value": 4855.758283027488}, {"lowerIsBetter": false, "replicates": [324.4273856643025, 329.44652982988583, 333.72967896004224, 335.6844566107858, 340.97783644063134, 6567.770128045519, 6718.025886246497, 6733.225679046911, 6780.220274668414, 6807.353301436368, 6551.639659818708, 6698.2297035840775, 6713.530052896299, 6783.050372947791, 6795.184577850652, 4098.344264917614, 4958.033183529214, 4983.327250821129, 5008.398992120932, 5009.023240468119, 4027.6507370031077, 4873.298201556211, 5004.274380214867, 5025.3467049283545, 5046.571041461461, 4891.0, 4983.975080124595, 4996.950030499703, 4998.2752500887345, 5001.924971125436, 4982.676126051795, 4990.875228119308, 5004.974975125101, 5019.0, 5031.295618613379, 4068.2677118118727, 4151.086760912594, 4184.246835569596, 4296.398504209413, 4302.053548219386, 5202.557782588485, 6442.903356449657, 6446.129772480702, 6451.387118223761, 6468.8706225875685, 5895.145203945404, 5899.823005309848, 5906.173135760997, 5914.142449344821, 5971.910421343683, 6938.444924406035, 7215.134183897966, 7223.38601218897, 7251.166115896686, 7286.307800758919, 4636.976815115937, 4649.860784107881, 4650.0932318197965, 4652.13935421948, 4657.4411070671395, 7635.770926872203, 7714.922850771477, 7721.0, 7734.2265773422205, 7737.690492380298, 4603.49361570227, 4708.081924024782, 4709.270063140219, 4717.386739723814, 4725.881852953704, 4795.904081918412, 4796.544328288807, 4816.0, 4818.301346304766, 4826.8069277228515, 5753.050746626844, 5770.16332631766, 5776.451237132465, 5791.436312195768, 5802.332731735904, 6024.608400453956, 7174.1032370953635, 7329.377002954702, 7345.816354591071, 7349.853002939912, 1626.0, 1647.5881029742563, 1648.5796121988817, 1666.1086318819616, 1666.7999840019274, 1051.9894801052044, 1052.7736536644504, 1058.9470526473644, 1066.5733706517456, 1068.220199254533, 6864.965675171692, 6924.826879328057, 6927.930720692729, 6946.0622815919205, 6964.895526567106, 6093.69531523422, 7070.858582828418, 7557.2820582044615, 7568.167501574822, 7568.356689681329, 5438.483344082306, 6627.900581491282, 6872.656367181621, 6885.554033652989, 6998.4751143664425, 3871.10964478166, 3941.5270167580074, 3951.0, 3974.741641793274, 3994.121293315466, 7894.092179399443, 8034.035915690155, 8037.678492860337, 8050.07424146219, 8071.071826739882, 7163.42692584592, 7869.331106855867, 7886.566238856918, 7919.366450683931, 7922.830867652985, 7792.688292468351, 8022.197780222048, 8026.719064832703, 8049.074356449083, 8053.0, 6802.67347867181, 6950.165980082423, 7585.582792946441, 7588.506747061423, 7611.581363025087, 6460.644664543495, 6464.838379040373, 7301.0, 7339.972403863357, 7503.249675032672, 6560.639164845788, 7937.0, 8018.759437216893, 8023.919760802317, 8029.759107226792, 3769.3403654359827, 4681.882952926067, 4751.83368582098, 4753.548412900769, 4760.809567617256, 7474.32731054186, 7575.507592006502, 7591.848163036819, 7600.2779735925, 7759.72840950564, 7273.272672732684, 7283.963580182065, 7306.926930730625, 7325.084364454443, 7326.120865496175, 5906.852328691817, 7275.527090739085, 7306.744263950736, 7307.817304567428, 7316.634168291671, 6184.350643182401, 6732.192136943402, 6962.860742785218, 7093.113360829896, 7159.069320988238, 7322.890156647548, 7329.230430804689, 7336.055945174639, 7339.155997060407, 7348.96325518369, 6974.012406464133, 7084.858302834017, 7140.214576396488, 7155.141383034069, 7164.749233776793], "unit": "score", "name": "prototype.html", "value": 5256.042856663697}, {"lowerIsBetter": false, "replicates": [720.9927056591971, 733.1788396995366, 734.1373885684321, 749.5165618176273, 760.4790718357925, 14540.41838326467, 14688.192149431778, 14768.630784230387, 14795.03832250903, 14849.40602375905, 13635.113717608348, 15469.45856895006, 15757.921210393932, 15763.684726305468, 15825.0, 578.5863107877866, 728.4754976416971, 866.1728049712541, 884.5488800711619, 888.4225253585157, 844.9028361738417, 858.4463021351224, 874.7856775090112, 881.0572687224673, 890.3011136258039, 719.4891626944875, 775.9146493885668, 820.4707963363627, 922.4511415707643, 925.4308600210856, 882.386741214856, 922.3174850610567, 922.524899676667, 924.1867156901917, 925.6482536636103, 637.158950185755, 657.4937298280345, 665.5939876675225, 680.0139797293944, 681.8908974564046, 14088.0, 15041.0, 15155.090694558361, 15178.544643660598, 15190.316435760416, 12594.181378210387, 12613.936930315382, 12653.620391388182, 12767.42546585406, 13176.934115329457, 10273.589056437733, 10429.5828166874, 11401.657950261506, 11530.0, 11675.649730508097, 3484.163800687842, 3507.6141624421293, 3581.391163502185, 3588.6411358864166, 3702.3520883845217, 77961.61019194925, 78862.60568697177, 78966.6051669738, 80598.19401806024, 80761.59619201867, 9430.481323527272, 9599.808003839884, 9715.562799674031, 10077.647282345082, 10466.476676166161, 21088.578228435344, 21117.788822111583, 21174.894125529583, 21211.257605983716, 21303.147874085174, 6209.5032397408095, 7512.39900807934, 7578.583177925267, 7672.578008209491, 7786.328203078221, 3443.741719371057, 3806.1816709407613, 4190.078182799779, 4272.508661503967, 4455.86632401022, 3562.71498280137, 3598.730095242815, 3601.045722883438, 3601.405768048243, 3643.107438677488, 663.8274048747361, 667.256009549349, 668.7458765669014, 669.0365873142756, 687.5771400588602, 558.3662543013709, 589.4370875813588, 592.2596754057428, 623.7120346484495, 625.9217597800275, 8463.449875758057, 8595.742127736054, 8627.95686021566, 8777.912220877837, 8802.955985220033, 598.1267349669531, 625.146674788919, 629.7386584567354, 631.4790298004165, 631.797824696102, 4013.13717550728, 4281.657467402601, 4319.805608747614, 4425.468943726773, 4433.512313645497, 83719.07581285054, 83918.0, 84948.0, 85062.29875402457, 94818.0, 72482.0, 72520.63739681373, 72931.63534182296, 73456.63271683607, 73729.26270737224, 68913.0, 69728.60542789116, 71168.64415677889, 71415.6429217861, 72197.2780272201, 8827.509074659285, 8878.51168185756, 8930.106989301017, 8961.596728147379, 9089.181973622406, 47726.76136619295, 48673.539793806245, 49100.52698419053, 49561.50438495569, 50237.0, 68039.0, 68165.0, 68374.0, 69825.65087174531, 70034.29965700278, 11205.495752690986, 11313.604023859125, 11327.490262938352, 11337.09303255721, 11815.995640370666, 9432.386894852087, 11864.82202766942, 11868.169228153947, 12048.75902481963, 12153.210041347284, 11350.375729334966, 11396.031337336419, 11568.768624627628, 12158.878411216128, 12275.570355037531, 11257.774844503228, 11918.52325906954, 12074.215176013882, 12078.03375729957, 12181.0, 10183.490825458846, 10620.09729172998, 10835.0, 11151.665450036511, 11647.184697071123, 8587.527685977331, 9067.63729450841, 9158.771030724285, 9587.328886977844, 10051.899481005388, 7426.5915374654915, 9112.678661594164, 9879.209663227068, 9969.601215951281, 10056.949715251669], "unit": "score", "name": "yui.html", "value": 6911.933592844795}], "name": "dromaeo_css", "value": 7468.821737856043}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 106.0, 126.0, 158.0, 115.0, 126.0, 117.0, 114.0, 114.0, 137.0], "unit": "score", "name": "ai-astar", "value": 122.8}, {"lowerIsBetter": true, "replicates": [150.0, 129.0, 149.0, 153.0, 125.0, 140.0, 141.0, 123.0, 157.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 138.7}, {"lowerIsBetter": true, "replicates": [245.0, 257.0, 202.0, 214.0, 225.0, 200.0, 198.0, 199.0, 199.0, 228.0], "unit": "score", "name": "audio-dft", "value": 216.7}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 77.0, 106.0, 57.0, 58.0, 60.0, 57.0, 116.0, 57.0], "unit": "score", "name": "audio-fft", "value": 72.8}, {"lowerIsBetter": true, "replicates": [85.0, 80.0, 126.0, 78.0, 81.0, 83.0, 115.0, 98.0, 120.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 100.9}, {"lowerIsBetter": true, "replicates": [100.0, 142.0, 86.0, 91.0, 85.0, 91.0, 86.0, 92.0, 90.0, 92.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 95.5}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 96.0, 106.0, 128.0, 95.0, 95.0, 96.0, 133.0, 151.0], "unit": "score", "name": "imaging-darkroom", "value": 109.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 91.0, 90.0, 91.0, 91.0, 93.0, 92.0, 91.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 92.0}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 55.0, 52.0, 56.0, 60.0, 73.0, 91.0, 58.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 61.2}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 68.0, 72.0, 72.0, 69.0, 65.0, 66.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 84.0, 87.0, 86.0, 86.0, 84.0, 83.0, 88.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [138.0, 132.0, 141.0, 110.0, 126.0, 124.0, 134.0, 128.0, 152.0, 110.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.5}, {"lowerIsBetter": true, "replicates": [130.0, 139.0, 141.0, 140.0, 145.0, 132.0, 142.0, 183.0, 168.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.4}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 67.0, 74.0, 95.0, 96.0, 98.0, 99.0, 95.0, 85.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 84.4}], "name": "kraken", "value": 1522.6000000000004}]} 04:59:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1522.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7468.82"}}} 04:59:48 INFO - Return code: 0 04:59:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:59:48 ERROR - # TBPL SUCCESS # 04:59:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:59:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:59:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:59:48 INFO - 2016-02-06 04:59:48.323 screenresolution[1812:17705] starting screenresolution argv=screenresolution get 04:59:48 INFO - 2016-02-06 04:59:48.326 screenresolution[1812:17705] Display 0: 1600x1200x32@60 04:59:48 INFO - 2016-02-06 04:59:48.332 screenresolution[1813:17708] starting screenresolution argv=screenresolution list 04:59:48 INFO - Available Modes on Display 0 04:59:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:59:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:59:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:59:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:59:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:59:48 INFO - Intel Iris: 04:59:48 INFO - Chipset Model: Intel Iris 04:59:48 INFO - Type: GPU 04:59:48 INFO - Bus: Built-In 04:59:48 INFO - VRAM (Dynamic, Max): 1536 MB 04:59:48 INFO - Vendor: Intel (0x8086) 04:59:48 INFO - Device ID: 0x0a2e 04:59:48 INFO - Revision ID: 0x0009 04:59:48 INFO - Displays: 04:59:48 INFO - Display: 04:59:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:59:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:59:48 INFO - Display Serial Number: 1600x1200 60 04:59:48 INFO - Main Display: Yes 04:59:48 INFO - Mirror: Off 04:59:48 INFO - Online: Yes 04:59:48 INFO - Rotation: Supported 04:59:48 INFO - Return code: 0 04:59:48 INFO - Running post-action listener: _resource_record_post_action 04:59:48 INFO - Running post-run listener: _resource_record_post_run 04:59:49 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 33803776; Write bytes: 713695744; Read time: 350; Write time: 2077 04:59:49 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 404644352; Write bytes: 407440384; Read time: 30228; Write time: 772 04:59:49 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 32017920; Write bytes: 305407488; Read time: 332; Write time: 1304 04:59:49 INFO - Running post-run listener: _upload_blobber_files 04:59:49 INFO - Blob upload gear active. 04:59:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:59:49 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:49 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:49 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:50 INFO - (blobuploader) - INFO - Open directory for files ... 04:59:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:59:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:59:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:51 INFO - (blobuploader) - INFO - Done attempting. 04:59:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:59:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:59:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:52 INFO - (blobuploader) - INFO - Done attempting. 04:59:52 INFO - (blobuploader) - INFO - Iteration through files over. 04:59:52 INFO - Return code: 0 04:59:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:59:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:59:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0543103bc48cea9ddb4d9470992cf93b2a8c2aaa2f3bd4b033db887e266c01bc872380f2ff55e273124c6bb5fe6c1a4e44d2d2e1f7db3beb67a1425dd0fe9340", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5ff15de6d0151f41caab18bb3ff7082c735277ad7605aa3db4ac1fbd581e9a42c9ce32ebd4e0b7fee335d840c1e18dad949e5caf6c6658bd6e515a7c9f6261d"} 04:59:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:59:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:59:52 INFO - Contents: 04:59:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0543103bc48cea9ddb4d9470992cf93b2a8c2aaa2f3bd4b033db887e266c01bc872380f2ff55e273124c6bb5fe6c1a4e44d2d2e1f7db3beb67a1425dd0fe9340", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5ff15de6d0151f41caab18bb3ff7082c735277ad7605aa3db4ac1fbd581e9a42c9ce32ebd4e0b7fee335d840c1e18dad949e5caf6c6658bd6e515a7c9f6261d"} 04:59:52 INFO - Running post-run listener: copy_logs_to_upload_dir 04:59:52 INFO - Copying logs to upload dir... 04:59:52 INFO - mkdir: /builds/slave/test/build/upload/logs 04:59:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.992533 ========= master_lag: 23.50 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-02-06 05:00:15.987906) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 8 secs) (at 2016-02-06 05:00:15.991817) ========= 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.msrD17HqQk/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.GHjkBKavdg/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0543103bc48cea9ddb4d9470992cf93b2a8c2aaa2f3bd4b033db887e266c01bc872380f2ff55e273124c6bb5fe6c1a4e44d2d2e1f7db3beb67a1425dd0fe9340", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5ff15de6d0151f41caab18bb3ff7082c735277ad7605aa3db4ac1fbd581e9a42c9ce32ebd4e0b7fee335d840c1e18dad949e5caf6c6658bd6e515a7c9f6261d"} 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.011448 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0543103bc48cea9ddb4d9470992cf93b2a8c2aaa2f3bd4b033db887e266c01bc872380f2ff55e273124c6bb5fe6c1a4e44d2d2e1f7db3beb67a1425dd0fe9340", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5ff15de6d0151f41caab18bb3ff7082c735277ad7605aa3db4ac1fbd581e9a42c9ce32ebd4e0b7fee335d840c1e18dad949e5caf6c6658bd6e515a7c9f6261d"}' ========= master_lag: 8.58 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 8 secs) (at 2016-02-06 05:00:24.586832) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:00:24.587112) ========= 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.msrD17HqQk/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.GHjkBKavdg/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005154 ========= master_lag: 0.59 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:00:25.185999) ========= ========= Started reboot skipped (results: 3, elapsed: 58 secs) (at 2016-02-06 05:00:25.186475) ========= ========= Finished reboot skipped (results: 3, elapsed: 58 secs) (at 2016-02-06 05:01:23.770211) ========= ========= Total master_lag: 32.88 =========