builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0053 starttime: 1454761903.65 results: success (0) buildid: 20160206043139 builduid: 4fc398871efd41c9ac77bb9838af693e revision: f5bd25c789b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:43.653729) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:43.654125) ========= ========= Started set props: basedir (results: 0, elapsed: 5 secs) (at 2016-02-06 04:31:43.654403) ========= 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.u7qZXGcZbs/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.yneuf9Xgzq/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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.005751 basedir: '/builds/slave/test' ========= master_lag: 5.43 ========= ========= Finished set props: basedir (results: 0, elapsed: 5 secs) (at 2016-02-06 04:31:49.089556) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.089833) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.168340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.168645) ========= 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.u7qZXGcZbs/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.yneuf9Xgzq/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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.005453 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.225897) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.226167) ========= 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:31:49.226480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.226743) ========= 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.u7qZXGcZbs/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.yneuf9Xgzq/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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:31:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.99M=0.001s 2016-02-06 04:31:50 (8.99 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.789838 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:50.032609) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:50.032937) ========= 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.u7qZXGcZbs/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.yneuf9Xgzq/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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.026809 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:50.082179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-06 04:31:50.082552) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f5bd25c789b6 --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 f5bd25c789b6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.u7qZXGcZbs/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.yneuf9Xgzq/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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:31:50,153 Setting DEBUG logging. 2016-02-06 04:31:50,154 attempt 1/10 2016-02-06 04:31:50,154 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f5bd25c789b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-06 04:31:51,722 unpacking tar archive at: fx-team-f5bd25c789b6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.812265 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-06 04:31:51.910820) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:51.911176) ========= echo f5bd25c789b6 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f5bd25c789b6'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.u7qZXGcZbs/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.yneuf9Xgzq/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 f5bd25c789b6 program finished with exit code 0 elapsedTime=0.005366 script_repo_revision: 'f5bd25c789b6' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:51.960717) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:51.961041) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:51.974970) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-06 04:31:51.975351) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.u7qZXGcZbs/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.yneuf9Xgzq/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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:31:52 INFO - MultiFileLogger online at 20160206 04:31:52 in /builds/slave/test 04:31:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:31:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:31:52 INFO - {'append_to_log': False, 04:31:52 INFO - 'base_work_dir': '/builds/slave/test', 04:31:52 INFO - 'blob_upload_branch': 'Fx-Team', 04:31:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:31:52 INFO - 'branch': 'Fx-Team', 04:31:52 INFO - 'buildbot_json_path': 'buildprops.json', 04:31:52 INFO - 'config_files': ('talos/mac_config.py',), 04:31:52 INFO - 'default_actions': ('clobber', 04:31:52 INFO - 'read-buildbot-config', 04:31:52 INFO - 'download-and-extract', 04:31:52 INFO - 'populate-webroot', 04:31:52 INFO - 'create-virtualenv', 04:31:52 INFO - 'install', 04:31:52 INFO - 'run-tests'), 04:31:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:31:52 INFO - 'download_minidump_stackwalk': True, 04:31:52 INFO - 'download_symbols': 'ondemand', 04:31:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:31:52 INFO - 'tooltool.py': '/tools/tooltool.py', 04:31:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:31:52 INFO - '/tools/misc-python/virtualenv.py')}, 04:31:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:31:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:31:52 INFO - 'installer_path': 'installer.exe', 04:31:52 INFO - 'log_level': 'info', 04:31:52 INFO - 'log_name': 'talos', 04:31:52 INFO - 'log_to_console': True, 04:31:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:31:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:31:52 INFO - 'opt_config_files': (), 04:31:52 INFO - 'pip_index': False, 04:31:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:31:52 INFO - 'cmd': ('bash', 04:31:52 INFO - '-c', 04:31:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:31:52 INFO - 'enabled': True, 04:31:52 INFO - 'halt_on_failure': False, 04:31:52 INFO - 'name': 'check_screen_resolution'},), 04:31:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:31:52 INFO - 'cmd': ('bash', 04:31:52 INFO - '-c', 04:31:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:31:52 INFO - 'enabled': True, 04:31:52 INFO - 'halt_on_failure': False, 04:31:52 INFO - 'name': 'check_screen_resolution'},), 04:31:52 INFO - 'run_cmd_checks_enabled': True, 04:31:52 INFO - 'sps_profile': False, 04:31:52 INFO - 'sps_profile_interval': 0, 04:31:52 INFO - 'suite': 'dromaeojs', 04:31:52 INFO - 'system_bits': '32', 04:31:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:31:52 INFO - 'title': 't-yosemite-r7-0053', 04:31:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:31:52 INFO - 'use_talos_json': True, 04:31:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:31:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:31:52 INFO - 'work_dir': 'build'} 04:31:52 INFO - ##### 04:31:52 INFO - ##### Running clobber step. 04:31:52 INFO - ##### 04:31:52 INFO - Running pre-action listener: _resource_record_pre_action 04:31:52 INFO - Running main action method: clobber 04:31:52 INFO - rmtree: /builds/slave/test/build 04:31:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:31:53 INFO - Running post-action listener: _resource_record_post_action 04:31:53 INFO - ##### 04:31:53 INFO - ##### Running read-buildbot-config step. 04:31:53 INFO - ##### 04:31:53 INFO - Running pre-action listener: _resource_record_pre_action 04:31:53 INFO - Running main action method: read_buildbot_config 04:31:53 INFO - Using buildbot properties: 04:31:53 INFO - { 04:31:53 INFO - "project": "", 04:31:53 INFO - "product": "firefox", 04:31:53 INFO - "script_repo_revision": "production", 04:31:53 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:31:53 INFO - "repository": "", 04:31:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:31:53 INFO - "buildid": "20160206043139", 04:31:53 INFO - "stage_platform": "macosx64", 04:31:53 INFO - "basedir": "/builds/slave/test", 04:31:53 INFO - "buildnumber": 334, 04:31:53 INFO - "platform": "yosemite_r7", 04:31:53 INFO - "mozci_request": { 04:31:53 INFO - "priority": -1, 04:31:53 INFO - "type": "trigger_all_talos_jobs", 04:31:53 INFO - "times": 6 04:31:53 INFO - }, 04:31:53 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:31:53 INFO - "slavebuilddir": "test", 04:31:53 INFO - "branch": "fx-team", 04:31:53 INFO - "revision": "f5bd25c789b6", 04:31:53 INFO - "slavename": "t-yosemite-r7-0053", 04:31:53 INFO - "builduid": "4fc398871efd41c9ac77bb9838af693e", 04:31:53 INFO - "repo_path": "integration/fx-team" 04:31:53 INFO - } 04:31:53 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg. 04:31:53 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/test_packages.json. 04:31:53 INFO - Running post-action listener: _resource_record_post_action 04:31:53 INFO - ##### 04:31:53 INFO - ##### Running download-and-extract step. 04:31:53 INFO - ##### 04:31:53 INFO - Running pre-action listener: _resource_record_pre_action 04:31:53 INFO - Running main action method: download_and_extract 04:31:53 INFO - mkdir: /builds/slave/test/build/tests 04:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:53 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/test_packages.json 04:31:53 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/test_packages.json to /builds/slave/test/build/test_packages.json 04:31:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:31:53 INFO - Downloaded 1277 bytes. 04:31:53 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:31:53 INFO - Using the following test package requirements: 04:31:53 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:31:53 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:53 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:31:53 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:53 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:31:53 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:53 INFO - u'jsshell-mac.zip'], 04:31:53 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:53 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:31:53 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:31:53 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:53 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:31:53 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:53 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:31:53 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:53 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:31:53 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:31:53 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:53 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:31:53 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:53 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip 04:31:53 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:31:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/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:31:54 INFO - Downloaded 17118738 bytes. 04:31: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:31: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:31:57 INFO - Return code: 0 04:31:57 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:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:57 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip 04:31:57 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:31:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/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:31:57 INFO - Downloaded 17118738 bytes. 04:31:57 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:31:57 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:32:01 INFO - Return code: 0 04:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:01 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.talos.tests.zip 04:32:01 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:32:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/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:32:01 INFO - Downloaded 10706582 bytes. 04:32:01 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:32:01 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:32:01 INFO - Return code: 0 04:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:01 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg 04:32:01 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:32:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 04:32:02 INFO - Downloaded 111115296 bytes. 04:32:02 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg 04:32:02 INFO - mkdir: /builds/slave/test/properties 04:32:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:32:02 INFO - Writing to file /builds/slave/test/properties/build_url 04:32:02 INFO - Contents: 04:32:02 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg 04:32:02 INFO - Running post-action listener: _resource_record_post_action 04:32:02 INFO - Running post-action listener: set_extra_try_arguments 04:32:02 INFO - ##### 04:32:02 INFO - ##### Running populate-webroot step. 04:32:02 INFO - ##### 04:32:02 INFO - Running pre-action listener: _resource_record_pre_action 04:32:02 INFO - Running main action method: populate_webroot 04:32:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:32:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:32:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:32:02 INFO - '--tppagecycles', 04:32:02 INFO - '7'], 04:32:02 INFO - 'tests': ['tsvgm']}}, 04:32:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:32:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:32:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:32:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:32:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:32:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:32:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:02 INFO - 'talos_options': ['--e10s'], 04:32:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:02 INFO - 'tests': ['damp', 'tps']}, 04:32:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:02 INFO - 'talos_options': ['--e10s'], 04:32:02 INFO - 'tests': ['damp', 'tps']}, 04:32:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:32:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:32:02 INFO - 'other': {'tests': ['a11yr', 04:32:02 INFO - 'ts_paint', 04:32:02 INFO - 'tpaint', 04:32:02 INFO - 'sessionrestore', 04:32:02 INFO - 'sessionrestore_no_auto_restore']}, 04:32:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:32:02 INFO - 'tests': ['a11yr', 04:32:02 INFO - 'ts_paint', 04:32:02 INFO - 'tpaint', 04:32:02 INFO - 'sessionrestore', 04:32:02 INFO - 'sessionrestore_no_auto_restore']}, 04:32:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:32:02 INFO - 'tests': ['a11yr', 04:32:02 INFO - 'ts_paint', 04:32:02 INFO - 'tpaint', 04:32:02 INFO - 'sessionrestore', 04:32:02 INFO - 'sessionrestore_no_auto_restore']}, 04:32:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:32:02 INFO - 'tests': ['a11yr', 04:32:02 INFO - 'ts_paint', 04:32:02 INFO - 'tpaint', 04:32:02 INFO - 'sessionrestore', 04:32:02 INFO - 'sessionrestore_no_auto_restore']}, 04:32:02 INFO - 'other_l64': {'tests': ['a11yr', 04:32:02 INFO - 'ts_paint', 04:32:02 INFO - 'tpaint', 04:32:02 INFO - 'sessionrestore', 04:32:02 INFO - 'sessionrestore_no_auto_restore']}, 04:32:02 INFO - 'other_nol64': {'tests': ['a11yr', 04:32:02 INFO - 'ts_paint', 04:32:02 INFO - 'tpaint', 04:32:02 INFO - 'sessionrestore', 04:32:02 INFO - 'sessionrestore_no_auto_restore']}, 04:32:02 INFO - 'svgr': {'tests': ['tsvgx', 04:32:02 INFO - 'tsvgr_opacity', 04:32:02 INFO - 'tart', 04:32:02 INFO - 'tscrollx', 04:32:02 INFO - 'cart']}, 04:32:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:32:02 INFO - 'tests': ['tsvgx', 04:32:02 INFO - 'tsvgr_opacity', 04:32:02 INFO - 'tart', 04:32:02 INFO - 'tscrollx', 04:32:02 INFO - 'cart']}, 04:32:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:02 INFO - 'tests': ['tp5o']}, 04:32:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:02 INFO - 'talos_options': ['--e10s'], 04:32:02 INFO - 'tests': ['tp5o']}, 04:32:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:02 INFO - 'talos_options': ['--xperf_path', 04:32:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:02 INFO - 'tests': ['tp5n']}, 04:32:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:02 INFO - 'talos_options': ['--e10s', 04:32:02 INFO - '--xperf_path', 04:32:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:02 INFO - 'tests': ['tp5n']}}, 04:32:02 INFO - 'talos.zip': {'path': '', 04:32:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:32:02 INFO - Running post-action listener: _resource_record_post_action 04:32:02 INFO - ##### 04:32:02 INFO - ##### Running create-virtualenv step. 04:32:02 INFO - ##### 04:32:02 INFO - Running pre-action listener: _resource_record_pre_action 04:32:02 INFO - Running main action method: create_virtualenv 04:32:02 INFO - Creating virtualenv /builds/slave/test/build/venv 04:32:02 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:32:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:32:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:32:03 INFO - Using real prefix '/tools/python27' 04:32:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:32:03 INFO - Installing distribute.............................................................................................................................................................................................done. 04:32:06 INFO - Installing pip.................done. 04:32:06 INFO - Return code: 0 04:32:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:32:06 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:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:06 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:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:06 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 0x1043f3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043fa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff153c73530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104298d30>, '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 0x1040bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428eb20>, '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.u7qZXGcZbs/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.yneuf9Xgzq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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:32:06 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:32:06 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:32:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u7qZXGcZbs/Render', 04:32:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:06 INFO - 'HOME': '/Users/cltbld', 04:32:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:06 INFO - 'LOGNAME': 'cltbld', 04:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:06 INFO - 'MOZ_NO_REMOTE': '1', 04:32:06 INFO - 'NO_EM_RESTART': '1', 04:32:06 INFO - 'PAGER': '/bin/cat', 04:32:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:06 INFO - 'PWD': '/builds/slave/test', 04:32:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:06 INFO - 'SHELL': '/bin/bash', 04:32:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yneuf9Xgzq/Listeners', 04:32:06 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 04:32:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:06 INFO - 'USER': 'cltbld', 04:32:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:06 INFO - 'XPC_FLAGS': '0x0', 04:32:06 INFO - 'XPC_SERVICE_NAME': '0', 04:32:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:06 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:32:06 INFO - Cleaning up... 04:32:06 INFO - Return code: 0 04:32:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:32:06 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:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:06 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:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:06 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 0x1043f3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043fa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff153c73530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104298d30>, '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 0x1040bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428eb20>, '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.u7qZXGcZbs/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.yneuf9Xgzq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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:32:06 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:32:06 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:32:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u7qZXGcZbs/Render', 04:32:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:06 INFO - 'HOME': '/Users/cltbld', 04:32:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:06 INFO - 'LOGNAME': 'cltbld', 04:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:06 INFO - 'MOZ_NO_REMOTE': '1', 04:32:06 INFO - 'NO_EM_RESTART': '1', 04:32:06 INFO - 'PAGER': '/bin/cat', 04:32:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:06 INFO - 'PWD': '/builds/slave/test', 04:32:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:06 INFO - 'SHELL': '/bin/bash', 04:32:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yneuf9Xgzq/Listeners', 04:32:06 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 04:32:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:06 INFO - 'USER': 'cltbld', 04:32:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:06 INFO - 'XPC_FLAGS': '0x0', 04:32:06 INFO - 'XPC_SERVICE_NAME': '0', 04:32:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:07 INFO - Downloading/unpacking psutil>=0.7.1 04:32:07 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:32:07 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:32:07 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:32:07 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:32:07 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:32:07 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:32:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:32:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:10 INFO - Installing collected packages: psutil 04:32:10 INFO - Running setup.py install for psutil 04:32:10 INFO - building 'psutil._psutil_osx' extension 04:32:10 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:32:10 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:32:10 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:32:10 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:32:11 INFO - building 'psutil._psutil_posix' extension 04:32:11 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:32:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:32:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:32:11 INFO - ^ 04:32:11 INFO - 1 warning generated. 04:32:11 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:32:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:11 INFO - Successfully installed psutil 04:32:11 INFO - Cleaning up... 04:32:11 INFO - Return code: 0 04:32:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1043f3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043fa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff153c73530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104298d30>, '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 0x1040bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428eb20>, '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.u7qZXGcZbs/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.yneuf9Xgzq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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:32:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:32:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u7qZXGcZbs/Render', 04:32:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:11 INFO - 'HOME': '/Users/cltbld', 04:32:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:11 INFO - 'LOGNAME': 'cltbld', 04:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:11 INFO - 'MOZ_NO_REMOTE': '1', 04:32:11 INFO - 'NO_EM_RESTART': '1', 04:32:11 INFO - 'PAGER': '/bin/cat', 04:32:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:11 INFO - 'PWD': '/builds/slave/test', 04:32:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:11 INFO - 'SHELL': '/bin/bash', 04:32:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yneuf9Xgzq/Listeners', 04:32:11 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 04:32:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:11 INFO - 'USER': 'cltbld', 04:32:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:11 INFO - 'XPC_FLAGS': '0x0', 04:32:11 INFO - 'XPC_SERVICE_NAME': '0', 04:32:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:32:13 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:32:13 INFO - Installing collected packages: mozsystemmonitor 04:32:13 INFO - Running setup.py install for mozsystemmonitor 04:32:14 INFO - Successfully installed mozsystemmonitor 04:32:14 INFO - Cleaning up... 04:32:14 INFO - Return code: 0 04:32:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:32:14 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:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:14 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:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:14 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 0x1043f3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043fa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff153c73530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104298d30>, '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 0x1040bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428eb20>, '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.u7qZXGcZbs/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.yneuf9Xgzq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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:32:14 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:32:14 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:32:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u7qZXGcZbs/Render', 04:32:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:14 INFO - 'HOME': '/Users/cltbld', 04:32:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:14 INFO - 'LOGNAME': 'cltbld', 04:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:14 INFO - 'MOZ_NO_REMOTE': '1', 04:32:14 INFO - 'NO_EM_RESTART': '1', 04:32:14 INFO - 'PAGER': '/bin/cat', 04:32:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:14 INFO - 'PWD': '/builds/slave/test', 04:32:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:14 INFO - 'SHELL': '/bin/bash', 04:32:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yneuf9Xgzq/Listeners', 04:32:14 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 04:32:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:14 INFO - 'USER': 'cltbld', 04:32:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:14 INFO - 'XPC_FLAGS': '0x0', 04:32:14 INFO - 'XPC_SERVICE_NAME': '0', 04:32:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:14 INFO - Downloading/unpacking blobuploader==1.2.4 04:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:16 INFO - Downloading blobuploader-1.2.4.tar.gz 04:32:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:32:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:32:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:32:17 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:32:17 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:32:17 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:32:17 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:32:17 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:32:17 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:32:17 INFO - Downloading docopt-0.6.1.tar.gz 04:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:32:17 INFO - Installing collected packages: blobuploader, requests, docopt 04:32:17 INFO - Running setup.py install for blobuploader 04:32:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:32:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:32:18 INFO - Running setup.py install for requests 04:32:18 INFO - Running setup.py install for docopt 04:32:18 INFO - Successfully installed blobuploader requests docopt 04:32:18 INFO - Cleaning up... 04:32:18 INFO - Return code: 0 04:32:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:18 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:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:18 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:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:18 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 0x1043f3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043fa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff153c73530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104298d30>, '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 0x1040bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428eb20>, '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.u7qZXGcZbs/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.yneuf9Xgzq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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:32:18 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:32:18 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:32:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u7qZXGcZbs/Render', 04:32:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:18 INFO - 'HOME': '/Users/cltbld', 04:32:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:18 INFO - 'LOGNAME': 'cltbld', 04:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:18 INFO - 'MOZ_NO_REMOTE': '1', 04:32:18 INFO - 'NO_EM_RESTART': '1', 04:32:18 INFO - 'PAGER': '/bin/cat', 04:32:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:18 INFO - 'PWD': '/builds/slave/test', 04:32:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:18 INFO - 'SHELL': '/bin/bash', 04:32:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yneuf9Xgzq/Listeners', 04:32:18 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 04:32:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:18 INFO - 'USER': 'cltbld', 04:32:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:18 INFO - 'XPC_FLAGS': '0x0', 04:32:18 INFO - 'XPC_SERVICE_NAME': '0', 04:32:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:18 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-y3GExF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:19 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-MfTWCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:19 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-4RFBFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:19 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-FqHS80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:19 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-pxSMKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:19 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-9MOScB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:19 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-PvAzcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:19 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-ebNa_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:19 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-veeVpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:19 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-cssBz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:20 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-3hugn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:20 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-5v1Y2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:20 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-vBafu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:20 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-PYj3El-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:20 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-kuTaY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:20 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-WqIwYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:20 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-paMlGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:32:20 INFO - Running setup.py install for manifestparser 04:32:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:32:20 INFO - Running setup.py install for mozcrash 04:32:21 INFO - Running setup.py install for mozdebug 04:32:21 INFO - Running setup.py install for mozdevice 04:32:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:32:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:32:21 INFO - Running setup.py install for mozfile 04:32:21 INFO - Running setup.py install for mozhttpd 04:32:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:32:21 INFO - Running setup.py install for mozinfo 04:32:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:32:21 INFO - Running setup.py install for mozInstall 04:32:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:32:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:32:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:32:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:32:21 INFO - Running setup.py install for mozleak 04:32:22 INFO - Running setup.py install for mozlog 04:32:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:32:22 INFO - Running setup.py install for moznetwork 04:32:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:32:22 INFO - Running setup.py install for mozprocess 04:32:22 INFO - Running setup.py install for mozprofile 04:32:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:32:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:32:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:32:22 INFO - Running setup.py install for mozrunner 04:32:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:32:22 INFO - Running setup.py install for mozscreenshot 04:32:22 INFO - Running setup.py install for moztest 04:32:23 INFO - Running setup.py install for mozversion 04:32:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:32:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:32:23 INFO - Cleaning up... 04:32:23 INFO - Return code: 0 04:32:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:23 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:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:23 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:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:23 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 0x1043f3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043fa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff153c73530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104298d30>, '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 0x1040bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428eb20>, '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.u7qZXGcZbs/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.yneuf9Xgzq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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:32:23 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:32:23 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:32:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u7qZXGcZbs/Render', 04:32:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:23 INFO - 'HOME': '/Users/cltbld', 04:32:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:23 INFO - 'LOGNAME': 'cltbld', 04:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:23 INFO - 'MOZ_NO_REMOTE': '1', 04:32:23 INFO - 'NO_EM_RESTART': '1', 04:32:23 INFO - 'PAGER': '/bin/cat', 04:32:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:23 INFO - 'PWD': '/builds/slave/test', 04:32:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:23 INFO - 'SHELL': '/bin/bash', 04:32:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yneuf9Xgzq/Listeners', 04:32:23 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 04:32:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:23 INFO - 'USER': 'cltbld', 04:32:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:23 INFO - 'XPC_FLAGS': '0x0', 04:32:23 INFO - 'XPC_SERVICE_NAME': '0', 04:32:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:23 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-PmBP2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:23 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:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:23 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-eiWyGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:23 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:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:23 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-lE_vum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:23 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:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:23 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-O4lIdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:23 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:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:23 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-C6LCFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:24 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:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:24 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-mzv0T4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:24 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:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:24 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-UYzih4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:24 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:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:24 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-y9lNgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:24 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:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:24 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-niO3Eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:24 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:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:24 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-4fq9rP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:24 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:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:24 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-VnWTeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:24 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:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:24 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-6Gg8YD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:24 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:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:24 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-eg9Piz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:24 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:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:24 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-6wf6xD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:25 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:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:25 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-8DNdbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:25 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:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:25 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-FcjgJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:25 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:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:25 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-dIaqGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:25 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:32:25 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:32:25 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:32:25 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:32:25 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:32:25 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:32:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:25 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:32:25 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:32:25 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:32:25 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:32:25 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:32:25 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:32:27 INFO - Downloading blessings-1.6.tar.gz 04:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:32:27 INFO - Installing collected packages: blessings 04:32:27 INFO - Running setup.py install for blessings 04:32:27 INFO - Successfully installed blessings 04:32:27 INFO - Cleaning up... 04:32:28 INFO - Return code: 0 04:32:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:32:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:28 INFO - Reading from file tmpfile_stdout 04:32:28 INFO - Current package versions: 04:32:28 INFO - blessings == 1.6 04:32:28 INFO - blobuploader == 1.2.4 04:32:28 INFO - docopt == 0.6.1 04:32:28 INFO - manifestparser == 1.1 04:32:28 INFO - mozInstall == 1.12 04:32:28 INFO - mozcrash == 0.16 04:32:28 INFO - mozdebug == 0.1 04:32:28 INFO - mozdevice == 0.48 04:32:28 INFO - mozfile == 1.2 04:32:28 INFO - mozhttpd == 0.7 04:32:28 INFO - mozinfo == 0.9 04:32:28 INFO - mozleak == 0.1 04:32:28 INFO - mozlog == 3.1 04:32:28 INFO - moznetwork == 0.27 04:32:28 INFO - mozprocess == 0.22 04:32:28 INFO - mozprofile == 0.28 04:32:28 INFO - mozrunner == 6.11 04:32:28 INFO - mozscreenshot == 0.1 04:32:28 INFO - mozsystemmonitor == 0.0 04:32:28 INFO - moztest == 0.7 04:32:28 INFO - mozversion == 1.4 04:32:28 INFO - psutil == 3.1.1 04:32:28 INFO - requests == 1.2.3 04:32:28 INFO - wsgiref == 0.1.2 04:32:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:28 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:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:28 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:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:28 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 0x1043f3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043fa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff153c73530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104298d30>, '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 0x1040bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428eb20>, '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.u7qZXGcZbs/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.yneuf9Xgzq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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:32:28 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:32:28 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:32:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u7qZXGcZbs/Render', 04:32:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:28 INFO - 'HOME': '/Users/cltbld', 04:32:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:28 INFO - 'LOGNAME': 'cltbld', 04:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:28 INFO - 'MOZ_NO_REMOTE': '1', 04:32:28 INFO - 'NO_EM_RESTART': '1', 04:32:28 INFO - 'PAGER': '/bin/cat', 04:32:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:28 INFO - 'PWD': '/builds/slave/test', 04:32:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:28 INFO - 'SHELL': '/bin/bash', 04:32:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yneuf9Xgzq/Listeners', 04:32:28 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 04:32:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:28 INFO - 'USER': 'cltbld', 04:32:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:28 INFO - 'XPC_FLAGS': '0x0', 04:32:28 INFO - 'XPC_SERVICE_NAME': '0', 04:32:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:28 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:32:28 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:32:28 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:32:28 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:32:28 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:32:28 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:32:28 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:32:28 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:32:28 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:32:28 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:32:28 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:32:28 INFO - Cleaning up... 04:32:28 INFO - Return code: 0 04:32:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:32:28 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:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:28 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:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:28 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 0x1043f3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043fa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff153c73530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104298d30>, '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 0x1040bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428eb20>, '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.u7qZXGcZbs/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.yneuf9Xgzq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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:32:28 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:32:28 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:32:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u7qZXGcZbs/Render', 04:32:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:28 INFO - 'HOME': '/Users/cltbld', 04:32:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:28 INFO - 'LOGNAME': 'cltbld', 04:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:28 INFO - 'MOZ_NO_REMOTE': '1', 04:32:28 INFO - 'NO_EM_RESTART': '1', 04:32:28 INFO - 'PAGER': '/bin/cat', 04:32:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:28 INFO - 'PWD': '/builds/slave/test', 04:32:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:28 INFO - 'SHELL': '/bin/bash', 04:32:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yneuf9Xgzq/Listeners', 04:32:28 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 04:32:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:28 INFO - 'USER': 'cltbld', 04:32:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:28 INFO - 'XPC_FLAGS': '0x0', 04:32:28 INFO - 'XPC_SERVICE_NAME': '0', 04:32:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:28 INFO - Downloading/unpacking jsonschema 04:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:32:31 INFO - Downloading/unpacking functools32 (from jsonschema) 04:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:31 INFO - Downloading functools32-3.2.3-2.tar.gz 04:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:32:31 INFO - warning: no files found matching '*.txt' 04:32:31 INFO - no previously-included directories found matching 'build' 04:32:31 INFO - no previously-included directories found matching 'dist' 04:32:31 INFO - no previously-included directories found matching '.git*' 04:32:31 INFO - Installing collected packages: jsonschema, functools32 04:32:31 INFO - Running setup.py install for functools32 04:32:31 INFO - warning: no files found matching '*.txt' 04:32:31 INFO - no previously-included directories found matching 'build' 04:32:31 INFO - no previously-included directories found matching 'dist' 04:32:31 INFO - no previously-included directories found matching '.git*' 04:32:31 INFO - Successfully installed jsonschema functools32 04:32:31 INFO - Cleaning up... 04:32:31 INFO - Return code: 0 04:32:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:32:31 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:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:31 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:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:31 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 0x1043f3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043fa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff153c73530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104298d30>, '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 0x1040bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428eb20>, '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.u7qZXGcZbs/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.yneuf9Xgzq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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:32:31 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:32:31 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:32:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u7qZXGcZbs/Render', 04:32:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:31 INFO - 'HOME': '/Users/cltbld', 04:32:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:31 INFO - 'LOGNAME': 'cltbld', 04:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:31 INFO - 'MOZ_NO_REMOTE': '1', 04:32:31 INFO - 'NO_EM_RESTART': '1', 04:32:31 INFO - 'PAGER': '/bin/cat', 04:32:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:31 INFO - 'PWD': '/builds/slave/test', 04:32:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:31 INFO - 'SHELL': '/bin/bash', 04:32:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yneuf9Xgzq/Listeners', 04:32:31 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 04:32:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:31 INFO - 'USER': 'cltbld', 04:32:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:31 INFO - 'XPC_FLAGS': '0x0', 04:32:31 INFO - 'XPC_SERVICE_NAME': '0', 04:32:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:32 INFO - Downloading/unpacking flake8 04:32: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:32: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:32: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:32: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:32: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:32: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:32:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:32:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:32:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:32: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:32: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:32: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:32: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:32: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:32: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:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:32:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:32:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:32:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:32:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:32:35 INFO - no previously-included directories found matching 'docs/_build' 04:32:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:32:35 INFO - Running setup.py install for pep8 04:32:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:32:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:32:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:32:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:32:35 INFO - no previously-included directories found matching 'docs/_build' 04:32:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:32:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:32:35 INFO - Cleaning up... 04:32:36 INFO - Return code: 0 04:32:36 INFO - Running post-action listener: _resource_record_post_action 04:32:36 INFO - Running post-action listener: _start_resource_monitoring 04:32:36 INFO - Starting resource monitoring. 04:32:36 INFO - ##### 04:32:36 INFO - ##### Running install step. 04:32:36 INFO - ##### 04:32:36 INFO - Running pre-action listener: _resource_record_pre_action 04:32:36 INFO - Running main action method: install 04:32:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:36 INFO - Reading from file tmpfile_stdout 04:32:36 INFO - Detecting whether we're running mozinstall >=1.0... 04:32:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:32:36 INFO - Reading from file tmpfile_stdout 04:32:36 INFO - Output received: 04:32:36 INFO - Usage: mozinstall [options] installer 04:32:36 INFO - Options: 04:32:36 INFO - -h, --help show this help message and exit 04:32:36 INFO - -d DEST, --destination=DEST 04:32:36 INFO - Directory to install application into. [default: 04:32:36 INFO - "/builds/slave/test"] 04:32:36 INFO - --app=APP Application being installed. [default: firefox] 04:32:36 INFO - mkdir: /builds/slave/test/build/application 04:32:36 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:32:36 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:33:10 INFO - Reading from file tmpfile_stdout 04:33:10 INFO - Output received: 04:33:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:33:10 INFO - Running post-action listener: _resource_record_post_action 04:33:10 INFO - ##### 04:33:10 INFO - ##### Running run-tests step. 04:33:10 INFO - ##### 04:33:10 INFO - Running pre-action listener: _resource_record_pre_action 04:33:10 INFO - Running main action method: run_tests 04:33:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:33:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:33:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:33:10 INFO - 2016-02-06 04:33:10.518 screenresolution[1668:8482] starting screenresolution argv=screenresolution get 04:33:10 INFO - 2016-02-06 04:33:10.521 screenresolution[1668:8482] Display 0: 1600x1200x32@60 04:33:10 INFO - 2016-02-06 04:33:10.526 screenresolution[1669:8485] starting screenresolution argv=screenresolution list 04:33:10 INFO - Available Modes on Display 0 04:33:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:33:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:33:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:33:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:33:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:33:10 INFO - Intel Iris: 04:33:10 INFO - Chipset Model: Intel Iris 04:33:10 INFO - Type: GPU 04:33:10 INFO - Bus: Built-In 04:33:10 INFO - VRAM (Dynamic, Max): 1536 MB 04:33:10 INFO - Vendor: Intel (0x8086) 04:33:10 INFO - Device ID: 0x0a2e 04:33:10 INFO - Revision ID: 0x0009 04:33:10 INFO - Displays: 04:33:10 INFO - Display: 04:33:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:33:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:33:10 INFO - Display Serial Number: 1600x1200 60 04:33:10 INFO - Main Display: Yes 04:33:10 INFO - Mirror: Off 04:33:10 INFO - Online: Yes 04:33:10 INFO - Rotation: Supported 04:33:10 INFO - Return code: 0 04:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:33:10 INFO - Python 2.7.3 04:33:10 INFO - Return code: 0 04:33:10 INFO - grabbing minidump binary from tooltool 04:33:10 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:33:10 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 0x104298d30>, '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 0x1040bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:33:10 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:33:10 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:33:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:33:10 INFO - Return code: 0 04:33:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:33:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:33:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:33:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:33:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:33:12 INFO - Return code: 0 04:33:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:33:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u7qZXGcZbs/Render', 04:33:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:12 INFO - 'HOME': '/Users/cltbld', 04:33:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:12 INFO - 'LOGNAME': 'cltbld', 04:33:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:33:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:12 INFO - 'MOZ_NO_REMOTE': '1', 04:33:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:33:12 INFO - 'NO_EM_RESTART': '1', 04:33:12 INFO - 'PAGER': '/bin/cat', 04:33:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:12 INFO - 'PWD': '/builds/slave/test', 04:33:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:33:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:12 INFO - 'SHELL': '/bin/bash', 04:33:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yneuf9Xgzq/Listeners', 04:33:12 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 04:33:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:12 INFO - 'USER': 'cltbld', 04:33:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:12 INFO - 'XPC_FLAGS': '0x0', 04:33:12 INFO - 'XPC_SERVICE_NAME': '0', 04:33:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:33:12 INFO - mozversion application_buildid: 20160203075643 04:33:12 INFO - mozversion application_changeset: f5bd25c789b6bab468de449782b4985e39239968 04:33:12 INFO - mozversion application_display_name: Nightly 04:33:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:33:12 INFO - mozversion application_name: Firefox 04:33:12 INFO - mozversion application_remotingname: firefox 04:33:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:33:12 INFO - mozversion application_vendor: Mozilla 04:33:12 INFO - mozversion application_version: 47.0a1 04:33:12 INFO - mozversion platform_buildid: 20160203075643 04:33:12 INFO - mozversion platform_changeset: f5bd25c789b6bab468de449782b4985e39239968 04:33:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:33:12 INFO - mozversion platform_version: 47.0a1 04:33:12 INFO - using testdate: 1454761992 04:33:12 INFO - actual date: 1454761992 04:33:12 INFO - starting webserver on 'localhost:49282' 04:33:12 INFO - SUITE-START | Running 2 tests 04:33:12 INFO - TEST-START | dromaeo_css 04:33:12 INFO - operating with platform_type : mac_ 04:33:12 INFO - Initialising browser for dromaeo_css test... 04:33:12 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmpDDm_XZ/profile http://localhost:49282/getInfo.html) 04:33:13 INFO - PROCESS | 1687 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:33:15 INFO - PROCESS | 1687 | __metrics Screen width/height:1600/1200 04:33:15 INFO - PROCESS | 1687 | colorDepth:24 04:33:15 INFO - PROCESS | 1687 | Browser inner width/height: 1024/689 04:33:15 INFO - PROCESS | 1687 | __metrics 04:33:15 INFO - PROCESS | 1687 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:33:15 INFO - PROCESS | 1687 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:33:15 INFO - TEST-INFO | 1687: exit 0 04:33:15 INFO - Browser initialized. 04:33:15 INFO - Running cycle 1/1 for dromaeo_css test... 04:33:15 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmpDDm_XZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:27 INFO - PROCESS | 1691 | RSS: Main: 243027968 04:33:27 INFO - PROCESS | 1691 | 04:34:18 INFO - PROCESS | 1691 | 1454762058951 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:36:30 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49282/tests/dromaeo/cssquery-ext.html) 04:36:31 INFO - PROCESS | 1691 | RSS: Main: 360259584 04:36:31 INFO - PROCESS | 1691 | 04:39:34 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-ext.html (next: http://localhost:49282/tests/dromaeo/cssquery-jquery.html) 04:39:34 INFO - PROCESS | 1691 | RSS: Main: 380669952 04:39:34 INFO - PROCESS | 1691 | 04:42:37 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49282/tests/dromaeo/cssquery-mootools.html) 04:42:37 INFO - PROCESS | 1691 | RSS: Main: 377298944 04:42:37 INFO - PROCESS | 1691 | 04:45:39 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49282/tests/dromaeo/cssquery-prototype.html) 04:45:40 INFO - PROCESS | 1691 | RSS: Main: 371380224 04:45:40 INFO - PROCESS | 1691 | 04:48:43 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49282/tests/dromaeo/cssquery-yui.html) 04:48:44 INFO - PROCESS | 1691 | RSS: Main: 338296832 04:48:44 INFO - PROCESS | 1691 | 04:51:46 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-yui.html (next: http://localhost:49282/tests/dromaeo/cssquery-dojo.html) 04:51:47 INFO - PROCESS | 1691 | RSS: Main: 382504960 04:51:47 INFO - PROCESS | 1691 | 04:51:47 INFO - PROCESS | 1691 | __start_tp_report 04:51:47 INFO - PROCESS | 1691 | _x_x_mozilla_page_load 04:51:47 INFO - PROCESS | 1691 | _x_x_mozilla_page_load_details 04:51:47 INFO - PROCESS | 1691 | |i|pagename|runs| 04:51:47 INFO - PROCESS | 1691 | |0;dojo.html;3453.671901169389;3489.947650785237;3496.37065328241;3525.995091398951;3560.0921764949935;5630.887382252353;5685.829425117248;5687.061634830248;5714.828555143342;5771.394003629622;5644.689542075184;5707.229524014268;5709.086546152616;5714.3999880012625;5721.7711291548285;5148.021875843597;5214.348206474191;5243.68537887728;5244.659097158691;5302.522772950434;5309.522143007129;5318.893622127555;5320.494553017476;5321.281626980366;5321.361436627591;5285.154375299952;5288.15389537674;5297.364316282052;5298.09932311508;5306.575473962093;5265.104932161542;5290.65610735301;5294.073537131006;5299.1786273127345;5300.522952934216;5208;5209.843704688866;5302.734863256822;5304.708241046741;5317.229001794718;5603.215549823028;5654.37801841797;5663.5186009189265;5692.174634677948;5704.857378565527;6237.469815065725;6261.27995280544;6264;6270.122182894398;6289.811305660792;6152.354002829683;6163.691815409256;6200.193974783249;6290.685465726741;6333.936660633427;5775.768969241268;5779.162021506858;5785.074388097884;5797.01450753373;5850.9414905851245;6280.403361680633;6321.462675672619;6329.905051424233;6343.238811342669;6343.492520598341;6038;6062.090686397076;6108.053251745987;6115.694215289218;6115.877682446326;6173.56785025044;6198.163247961557;6222.408871157233;6236.438720515175;6323.810285691437;6190.164327815687;6213.565050446426;6220.564560480813;6237.812865614039;6249.96875015622;6253.906191407133;6265.749370025239;6288.874222515616;6293.3391993840905;6298.811035668938;4840.806367745251;4883.267509873547;4917.631177661689;4925.581325587365;4956.925646115311;4333.133373325348;4374.168907907488;4378.846740364072;4395.934060989088;4407.867763967086;5705.6291341063525;5715.828525144252;5728.112142617901;5733.082706766981;5737.282839645044;6154.076888466676;6247.9062814057825;6263.78076767311;6277.1525844011385;6289.968550157311;5719.28508936383;5747.942520574825;5766.336871259775;5794.333651630032;5819.82540523785;4461.598456138963;5349.22436246742;5352.545033672103;5356.812511562077;5357.5446087082255;6215.316315205233;6311.715972781236;6334.144890439732;6336.873262534724;6343.873122537616;6201.782937597162;6220.906686399617;6320.905186422116;6334.3665633436285;6350.650714210763;6232.937670623236;6293;6307.526935479766;6320.968395158179;6336.3030066693545;4967.478414766398;6193.318734939063;6218.129461875251;6224.190855188796;6225.782097626561;6214.161088253028;6216.968915155395;6226.719797609027;6332.588381755171;6336.1446204763615;5361.517463428154;5415.296011518478;6120.990036643904;6126.632402055891;6134.04922237054;6110.694465276807;6119.877602448015;6122.448979591858;6126.23422072241;6127.417895299939;5785.103308987113;5916.171735957056;5952.255968003999;5960.046392577166;6046.153538504701;6089.6925282777975;6141.232345956755;6156.846078848064;6157.291911430243;6166.691665416801;6005.099235114593;6009.369016253405;6023.216981792339;6028.457438830526;6052.122442245762 04:51:47 INFO - PROCESS | 1691 | |1;ext.html;447.0165635601673;518.9429162792094;579.2440864671604;582.4670426559699;603.9184710064143;29041.854790726044;29371.706282937164;29401.264968375803;29408.558871616944;29451.410971780577;30037;30412.239694007607;37948.051298717546;38477.61522384775;38537;9406.623735050589;9559.904400955971;9579.281553883451;9584.137427631511;9595.80808383832;9380.577873995653;9502;9508.857367139499;9513.571889265;9542.713718588453;9507.524623768819;9552.904470955305;9554.996725343843;9562.521873906277;9562.856557151614;9582.856257156149;9648.179904708108;9659.71020869375;9669.468179250138;9673.419594824332;9437.433753974783;9557.378770379903;9573.90426095744;9575;9589.472579008152;38653.80673096645;38903;38942.415863762064;39050.50919144307;39086.60913390858;3101.379724055198;3108.5026395776795;3117.7194052535156;3156.321390900944;3309.520119582647;27304.317392065157;27508.724912751015;27893.58159627607;27958.161255162173;28872.566911496346;2714.4571085782923;2753.5318995770767;2778.4165325281715;2903.651561812575;2945.5581662750546;482712;482768;483982;484061.15938840515;484311.57844210905;51562.22656660078;52424.68938276498;52444.737776310874;58444.12333814996;58732.7063364689;62664;63598.36401636017;63599.682001589696;63652.68173659195;63958;15405.38378464849;15835.762463563056;15837.68324633501;15846.366145354057;15894.92052539753;11337.60318388869;11487.770244595229;11495.942520287512;12296;12344.62966111018;18410.723839142425;18648.34730784416;18649.160787764584;18693.439196823845;18820.341288054853;7515.722327204388;7863.37093032556;8105.635246413925;8383.832323353621;8438.36712246584;936.6440752514137;1040.69819752271;1129.4352823588206;1134.6142311614092;1185.3184418959133;28633.28416789597;28725.317761246697;28820.42359152805;28975.13074607723;29182.708172918425;1066.3495267886583;1093.4642025407493;1174.6123779152858;1204.692803335144;1235.8640549539543;14572.854271457361;14783.265095957282;14800.629984250265;14929.776053359208;15098.797679101983;497428;506378;506765.9323406792;507452;507780;55505.72247138739;55791.88416231653;55815.720921395136;55962.16056759152;56067.43932560704;1309.796981467874;1331.1214598365227;1441.502681574876;1466.8973171878079;1568.1767072287141;25289.49421011533;27824.44351113007;28104.156875293775;28266.010689625764;28371.148865534065;44291.33562996493;44560.55439445564;44614.55385446234;44630.3305450412;44810.77594612006;491110;501637;648657;649033;652918;29110.690018949623;29119.7088029117;29396;29472.705272946994;29482.705172947997;40449.595504044584;40876.1824763509;40916.18167636571;40936.27030165329;41259.587404126774;33912.660873391935;34377.828110859286;34923.825380872935;35229.647703522634;35264.47103293504;34641.960741177805;34741.65258347384;34930.825345874124;34949.30101397907;35177.296454071286;33183.336333273684;33245.83377083196;33518.497222542166;33603.66396336005;33661.49507757435;28355.716442835306;29381.85309073441;29611.96358127455;29918.952836650613;29985.950491732685;18014.2794288227;18304.633907322044;22151;22626.868656566778;23454.296371108892 04:51:47 INFO - PROCESS | 1691 | |2;jquery.html;361.36039210597244;367.08778684967865;368.193655893593;370.54793152354137;374.7844989131247;12764.489420423195;13994.930025349884;18683.813161868376;19189.32837350693;19975.500612484695;11640;12023.819642705366;12027.579034733786;12030.879691203085;20180.798192018112;4628.259478483444;6316.968415157918;6517.67411629419;6521.3478652134645;6527.053577231299;4745.335653008581;4789.497102804207;4789.832355867546;7049.647517624124;7386.963065184666;7193.496455248135;7372.631368431584;7466.738664146756;7467.813304667399;7495.287947644965;7250.202477727472;7294.27057294269;7300.379467745248;7355.852882942365;7369.410447164214;6459;6835.14560679915;7170.067891174166;7181.425485961111;7217.566945983258;26214.73785262142;26302.6054609181;26996.460070798475;27086.1874143776;27806.721932780816;2367.739548649647;2416.891239894209;2427.478092210183;2477.393038705529;2812.437512497488;15077.623059423602;15097.094174349575;15348.762937014177;15596;15739.92130039354;1800.4148651688254;1814.5372929902921;1872.7284543741082;1883.340830709241;1913.5885784556249;95087;97046;97290.54064189043;97774.0222597765;99040.0095999038;10791.244612877023;11124.49939752713;11128.332300062022;11139.721506962229;11243.100551955824;11023.944880275707;13195.73608527824;13265;13304.13523120994;13312.201267923956;8527.74416767498;8530.957345213359;8557.27263182624;8632.741017769476;8642.654293828302;8663.913360866436;8677.002144753435;8684.956575217084;8739.344549158839;8769.605367758466;3531.5232443619784;4035.5762644922447;4199.559046300155;4207.137536804948;4425.491068527161;1470.2501724120775;1794.8474379677612;1798.4874310821615;1804.9368272110414;1817.7727784026997;796.9203079691985;903.6114470777628;904.9321300902459;1026.9691909242736;1052.6421016854306;15537;18610.534736631693;18679.90660046691;19594.90202548978;20167;891.251348866942;931.7204838548544;968.8982656821073;989.4904124375952;1028.2082796246848;10206.132478739242;10547.525361358757;10873.184511161695;10898.346099234072;11375.326798202415;728063;733427;741601;742457;745761.2711936514;100954;102492.48753756333;107195;107594;109097;978.6819283732815;1088.1621151713296;1122.2705241592867;1139.2537887683582;1139.3790384240608;15972.920135399248;17656.73514897303;17869;17926.91036544809;17975.460736177934;49918.251226232365;50089.24866126938;50921.63479565054;51035.74482127566;51039.489605103474;68066.9789953161;71092.64453677699;71106.57786844131;71478;71574;7533.171351151259;7648.73229436967;7664.923350766421;7698.5765782880235;7700.807479813049;7226.494145409771;9944.751381215527;9967.451790151612;11385.430728463709;12155;8088.959555202422;10087.949560252151;10169.9491502542;10217;10539.63111291101;9952.900470995488;10308.433036183082;10321.48392580353;10407.219458540489;10433.739156520844;7338.559686418618;8530.317574593893;10033.749156271151;10382.117520010883;10473.790524189626;7283.526570772883;7557.886631700419;7569.545827250162;7620.657070431733;7683.807904802425;9698.448248280241;9752.268579856398;10066;10506.947465262625;10685.8931410688 04:51:47 INFO - PROCESS | 1691 | |3;mootools.html;1404.0873432269018;1516.491975188312;1547.2206961993709;1783.589774351899;1938.1181562389115;7840.2551757583005;8027.83944321114;8526.271593090205;8721.5639218039;8745.08176641453;8496.065432802387;8617.612207450664;8714.869276960835;8715.651373945051;8735.694250701226;1934.7907557776389;2171.6851056596784;2477.3435039714445;2507.034791605236;2508.4606809535944;2261.2198791416936;2415.830891837572;2491.0533997081175;2497.825152239344;2499.6250562415694;2423.3699238198105;2451.889664965081;2466.5683505386487;2472.7527247275307;2473.109680515013;2438.4635380216323;2458.4960083182905;2471.9011239550396;2473.5423946569854;2479.3181874984343;2433.513297340521;2456.5086982603552;2457.8402403843693;2459.139301244568;2483.8758062097004;8766.430182038148;8811.427257228259;8815.51514666693;8824.294056475466;8824.955875220647;5303.310569625924;5443.700596467233;5449.427810079964;5479.561635069185;5496.367917689437;3620.094976255936;3681.889543313705;3763.5671897731563;3766.0961369271454;3767.4537192107264;876.8294327073364;1030.4075156784804;1049.3441599000626;1071.8285074388061;1072.7639919217759;11847.170698051139;11860.52557897683;11874.346910919896;11884.286942783374;11886.227395219283;4151.46031015966;4885.706857588556;4893.4617192108835;4928.679635823732;4982.501749824988;10120.342177758423;10133.240006999504;10148.391096534231;10159.847602285972;10159.847602285972;5438.048341540215;5447.428020057837;5454.181872719045;5472.699001554873;5488.7530061147345;4924.507549245119;4963.379577552806;4975.203967365276;4977.9751101244265;4989.451160372356;3557.8043207623828;3627.510286111394;3628.872989445357;3740.887773366749;3847.2690188864026;1185.063799598325;1189.4052973513244;1195.1952551647075;1196.1029228078942;1198.974876480614;1285.0490636928791;1292.3086148910477;1311.114997376767;1311.5934060441293;1340.8726171013739;8059.314958228616;8077.313428358655;8313.625886834985;8346.8330633387;8351.8329633407;1177.6408195500283;1187.2223693480785;1197.0423661071109;1198.1433275208267;1211.5517258614368;6219.191505104308;6248.843778905563;6324.462420694293;6326.4622507087415;6335.936640633627;10092.545835437277;10525.473726313654;10541;10574.312669676447;10710.143188544898;10070.69787906364;10451.268411211142;10454.163666906628;10471;10595.205359598061;8120.878186827203;8356.832863342699;8358.707445239508;8358.832823343499;8366.456180348257;7863.155741181409;8019.318357939641;8023.879641805261;8072.112067672669;8100.392470564613;9420.670276540288;9421.246300296098;9476.47879366614;9518.762030949281;9668.613255469703;9336.206422454168;9467.715968520955;9641.614335426504;9948.005199479994;9972.700818975442;7334.633268336668;7366.152892417226;7472.663730132048;7493.925060749323;7511.924880751122;7070.292970702889;7252.202257751748;7836.92163078362;7904.802379940547;7924.524528528307;6845.281245469154;7367.26327367259;7389.298016688406;7510;7560.206178351414;7135.892961605477;7183.964080179566;7326;7407.111146662435;7419.591922444318;7599.430042746705;7644.12092609357;7655.387568994356;7655.808604784925;7668.424868135024;6721.462283017249;6889.827754306182;6893.0694356261265;6894.896576551456;6901.171859376706;6961.860762784817;6996.475264355092;7017.824554386181;7094.4679149062995;7107.111611048619 04:51:47 INFO - PROCESS | 1691 | |4;prototype.html;286.5973307502959;319.79213511217705;325.85336598530665;331.3158328052571;337.0317346695299;6439.613623182612;6454.548181627288;6637.070810086586;6646.202455705322;6663.233728121268;6372;6498.740050397979;6501.447376972963;6557;6563.442107420863;4854.8300809471675;4888.291197776321;4902.828401005965;4916.901661966758;4926.950730492694;4683.859484215462;4806.687565308262;4808.158572249842;4812.855614331575;4884.120858245515;4515.390422292981;4833.154198015351;4848.5151484851585;4853.733044682541;4871.439784424783;4845.466998630148;4859;4869.220924652039;4873.999999999983;4877.975610121926;3608.350496910555;3943.4873466449176;4146.170765846812;4153.563875793058;4153.605407486284;5971.671558064305;6261.78083767066;6274.403931626488;6279.434850863398;6299.905501417483;5711.314642242916;5727.770889164429;5735.11105778605;5741.909037282903;5768.826935191951;6999.19509256437;7022.157341119098;7026.086608740831;7031.19141298752;7044.964775176142;4281.529031806499;4553.2714765637675;4692.8122875084955;4700.177468942956;4704.64715146362;7294.598797066159;7382.409407247461;7382.852342953111;7384.409247260206;7399.667014984285;4524.660650451164;4661.510541393172;4765.571098601074;4792.376990991149;4806.759662016885;4182.435371224846;4490.348899409632;4698.412698412699;4717.245240761462;4723.669343146015;5633.521150702236;5700.486956173964;5743.827685169368;5744.569157313218;5762.049261871744;6901.275366086589;7065.752698655625;7068.646567671596;7098.36114749675;7117.3238542338395;1677.9161041948098;1706.0275642883685;1707.044055328995;1709.6751617192695;1719.8882072665238;1095.8082335591398;1100.664297389304;1110.5335758981248;1124.4321617583068;1126.0597401170114;5363.731813409314;5981.611195272293;6114.510839132859;6621.801345959629;6629.966850165815;7294.562326260335;7320.414366850639;7323.194448610649;7335.193128755833;7345.595992220479;6332.398422149889;6577.572457790228;6584.275729669733;6600.60396376219;6611.900821487681;3270.7546933980047;3810.9237815244096;3830.8467661293794;3876.6317199865966;3887.611238876146;7590;7618.428617853572;7619.695212191561;7621.733239336597;7643.159252482223;6033.939660603425;7218.8917166242545;7468.477206595595;7509.136449308399;7529.73645922401;6150.661713605705;7574.924250757532;7601;7623.313901748869;7640.0067991160795;7341.522801017917;7361.447891408059;7368.410527157922;7381.9630901847295;7392.260773922565;6959.338862808025;7220.783376498714;7234.5659260444545;7242.89135662955;7257.2742725727;7630.313271805342;7646.885296720665;7657.770266892002;7663.808404789925;7698.499597526143;4319.676024298253;4393.780310984502;4404.955950440454;4486.7083639563325;4622.098690755271;7168.17565979919;7222.652637892601;7223.855522889407;7229.710811567478;7253.347198752138;5618.353889302783;6972.651367431709;6982.860342793218;6986.6855991481525;6988.301169882971;5696.629719068413;5766.913496297475;7041.5775053496955;7097.858042839218;7103.289671032855;6904.551204171713;6907.965460172667;6918.896216556655;6928.688209030706;6930.826729331807;6809.591424514545;7065.823354415975;7074.327938845801;7086;7087.468439866928;6934.306569343025;6942.375186233061;6945.548539344926;6950.270221626859;6952.30476952321 04:51:47 INFO - PROCESS | 1691 | |5;yui.html;693.4002088193714;701.5089437393823;707.7063018847177;723.7792473295646;731.1956847467784;14539;14705.411783528672;14734.484293049758;14741.041832280907;14807.25963701816;13005.024623153278;13094.803577946339;13102.606921792338;13118;13162.407691653874;673.2426020726682;695.3463744080548;822.596927505521;851.706161374328;853.91887770662;838.9119142490042;848.6859861851093;849.7110982266029;850.7447765670305;852.4757274276307;709.9006139140524;726.3245181980756;899.4468401932797;905.4431524612381;906.419891269588;889.3774357949429;905.4974489158515;905.6105874473974;905.6513242401656;905.9682911098113;662.7282814046266;665.8501837086665;667.7395815631908;669.6383952665554;669.7187181383782;14332.42670293187;14382.35279412429;14386.712265754626;14389.920755943345;14402.927985360006;12638.55765048219;12752.426140823685;12775.23348599087;12784.680382990407;12891.935540322238;9187.954060229657;10012.649557265533;10035.448050357227;10294.91903350145;10371.066604005675;3580.695640870529;3595.6404359563835;3627.419612861956;3634.036980200249;3634.56385233771;78230;79409;79683.40633187362;80562;81655;8843.51360675169;8946.910530894607;9082.228010619172;9164.8625270621;9508.001659825619;19237;19275.132619032178;19324.03379831003;19341;19341.903290483457;7329.926700733031;7337.046183996046;7507.1366792818435;7631.961840190764;7765.53406795594;4023.436718859362;4090.7341022834016;4112.629863312316;4148.522919864255;4269.978650106792;3475.826208689555;3503.421935380634;3509.9821051895174;3513.0690367052753;3514.7188224941942;644.3588629313768;651.4560342114388;658.5982550644103;661.1141070964931;668.8796016717038;498.576210221309;513.3608657221782;525.542777783331;562.3954249182145;606.2845841906504;8461.915380846236;8812.515311657791;9054.773630659287;9089.954550227207;9125.45247285165;586.3227971692702;601.8174287525035;602.6474512410201;607.7933502609134;635.8442181665429;4054.8378064877666;4278.957210427918;4325.9134817303475;4340.739555626673;4377.4444279419895;88471;88859;89339;89471.55264223638;89472.5526372377;69583.65208173927;69778.60442791115;69911.65044174848;69929.65035174791;74528;55601.721991390594;59395.65439110501;66293;66903.66548167227;67497.66251168713;8710.303175746052;8758.518281494578;8806.85510883581;8826.5586720665;8983.685571004984;47295.52704472911;47808;47978.520214797405;48376.27435588399;48859.26711099407;47248.2912756302;66253.006204906;66288.33711662822;66749;67636.323636763;10763.192760543147;10806.891931080903;10895.509702063584;10934.070603998749;11177.385243811668;11785.469653865768;11930.22453540517;12235.69410764738;12259.570915017932;12514.499420023461;8976.326775491734;10990.780184396108;11219.990200881959;11469.942650286695;11571.884281157081;11115.555377785122;11294.096472282034;11408.714782130513;11660.30038197711;11713.824292635447;11130.944345278222;11155.55377784912;11301.378424186749;11334.716632083933;12098.153129280865;8990.595423205841;8995.28037756991;9076.546172691471;9355.298352623444;9476.573554190216;8873.334499912662;9085;9640.75898102553;9652.710418687451;9656.565454554702 04:51:47 INFO - PROCESS | 1691 | __end_tp_report 04:51:47 INFO - PROCESS | 1691 | __start_cc_report 04:51:47 INFO - PROCESS | 1691 | _x_x_mozilla_cycle_collect,1097 04:51:47 INFO - PROCESS | 1691 | __end_cc_report 04:51:47 INFO - PROCESS | 1691 | __startTimestamp1454763107170__endTimestamp 04:51:47 INFO - PROCESS | 1691 | 04:51:47 INFO - PROCESS | 1691 | ------- Summary: start ------- 04:51:47 INFO - PROCESS | 1691 | Number of tests: 6 04:51:47 INFO - PROCESS | 1691 | 04:51:47 INFO - PROCESS | 1691 | [#0] dojo.html Cycles:165 Average:5750.82 Median:6005.10 stddev:633.89 (10.6%) stddev-sans-first:609.68 04:51:47 INFO - PROCESS | 1691 | Values: 3453.7 3489.9 3496.4 3526.0 3560.1 5630.9 5685.8 5687.1 5714.8 5771.4 5644.7 5707.2 5709.1 5714.4 5721.8 5148.0 5214.3 5243.7 5244.7 5302.5 5309.5 5318.9 5320.5 5321.3 5321.4 5285.2 5288.2 5297.4 5298.1 5306.6 5265.1 5290.7 5294.1 5299.2 5300.5 5208.0 5209.8 5302.7 5304.7 5317.2 5603.2 5654.4 5663.5 5692.2 5704.9 6237.5 6261.3 6264.0 6270.1 6289.8 6152.4 6163.7 6200.2 6290.7 6333.9 5775.8 5779.2 5785.1 5797.0 5850.9 6280.4 6321.5 6329.9 6343.2 6343.5 6038.0 6062.1 6108.1 6115.7 6115.9 6173.6 6198.2 6222.4 6236.4 6323.8 6190.2 6213.6 6220.6 6237.8 6250.0 6253.9 6265.7 6288.9 6293.3 6298.8 4840.8 4883.3 4917.6 4925.6 4956.9 4333.1 4374.2 4378.8 4395.9 4407.9 5705.6 5715.8 5728.1 5733.1 5737.3 6154.1 6247.9 6263.8 6277.2 6290.0 5719.3 5747.9 5766.3 5794.3 5819.8 4461.6 5349.2 5352.5 5356.8 5357.5 6215.3 6311.7 6334.1 6336.9 6343.9 6201.8 6220.9 6320.9 6334.4 6350.7 6232.9 6293.0 6307.5 6321.0 6336.3 4967.5 6193.3 6218.1 6224.2 6225.8 6214.2 6217.0 6226.7 6332.6 6336.1 5361.5 5415.3 6121.0 6126.6 6134.0 6110.7 6119.9 6122.4 6126.2 6127.4 5785.1 5916.2 5952.3 5960.0 6046.2 6089.7 6141.2 6156.8 6157.3 6166.7 6005.1 6009.4 6023.2 6028.5 6052.1 04:51:47 INFO - PROCESS | 1691 | 04:51:47 INFO - PROCESS | 1691 | [#1] ext.html Cycles:180 Average:64844.90 Median:34927.33 stddev:141511.47 (405.2%) stddev-sans-first:141825.84 04:51:47 INFO - PROCESS | 1691 | Values: 447.0 518.9 579.2 582.5 603.9 29041.9 29371.7 29401.3 29408.6 29451.4 30037.0 30412.2 37948.1 38477.6 38537.0 9406.6 9559.9 9579.3 9584.1 9595.8 9380.6 9502.0 9508.9 9513.6 9542.7 9507.5 9552.9 9555.0 9562.5 9562.9 9582.9 9648.2 9659.7 9669.5 9673.4 9437.4 9557.4 9573.9 9575.0 9589.5 38653.8 38903.0 38942.4 39050.5 39086.6 3101.4 3108.5 3117.7 3156.3 3309.5 27304.3 27508.7 27893.6 27958.2 28872.6 2714.5 2753.5 2778.4 2903.7 2945.6 482712.0 482768.0 483982.0 484061.2 484311.6 51562.2 52424.7 52444.7 58444.1 58732.7 62664.0 63598.4 63599.7 63652.7 63958.0 15405.4 15835.8 15837.7 15846.4 15894.9 11337.6 11487.8 11495.9 12296.0 12344.6 18410.7 18648.3 18649.2 18693.4 18820.3 7515.7 7863.4 8105.6 8383.8 8438.4 936.6 1040.7 1129.4 1134.6 1185.3 28633.3 28725.3 28820.4 28975.1 29182.7 1066.3 1093.5 1174.6 1204.7 1235.9 14572.9 14783.3 14800.6 14929.8 15098.8 497428.0 506378.0 506765.9 507452.0 507780.0 55505.7 55791.9 55815.7 55962.2 56067.4 1309.8 1331.1 1441.5 1466.9 1568.2 25289.5 27824.4 28104.2 28266.0 28371.1 44291.3 44560.6 44614.6 44630.3 44810.8 491110.0 501637.0 648657.0 649033.0 652918.0 29110.7 29119.7 29396.0 29472.7 29482.7 40449.6 40876.2 40916.2 40936.3 41259.6 33912.7 34377.8 34923.8 35229.6 35264.5 34642.0 34741.7 34930.8 34949.3 35177.3 33183.3 33245.8 33518.5 33603.7 33661.5 28355.7 29381.9 29612.0 29919.0 29986.0 18014.3 18304.6 22151.0 22626.9 23454.3 04:51:47 INFO - PROCESS | 1691 | 04:51:47 INFO - PROCESS | 1691 | [#2] jquery.html Cycles:180 Average:37082.44 Median:367.64 stddev:121357.53 (33009.8%) stddev-sans-first:121666.64 04:51:47 INFO - PROCESS | 1691 | Values: 361.4 367.1 368.2 370.5 374.8 12764.5 13994.9 18683.8 19189.3 19975.5 11640.0 12023.8 12027.6 12030.9 20180.8 4628.3 6317.0 6517.7 6521.3 6527.1 4745.3 4789.5 4789.8 7049.6 7387.0 7193.5 7372.6 7466.7 7467.8 7495.3 7250.2 7294.3 7300.4 7355.9 7369.4 6459.0 6835.1 7170.1 7181.4 7217.6 26214.7 26302.6 26996.5 27086.2 27806.7 2367.7 2416.9 2427.5 2477.4 2812.4 15077.6 15097.1 15348.8 15596.0 15739.9 1800.4 1814.5 1872.7 1883.3 1913.6 95087.0 97046.0 97290.5 97774.0 99040.0 10791.2 11124.5 11128.3 11139.7 11243.1 11023.9 13195.7 13265.0 13304.1 13312.2 8527.7 8531.0 8557.3 8632.7 8642.7 8663.9 8677.0 8685.0 8739.3 8769.6 3531.5 4035.6 4199.6 4207.1 4425.5 1470.3 1794.8 1798.5 1804.9 1817.8 796.9 903.6 904.9 1027.0 1052.6 15537.0 18610.5 18679.9 19594.9 20167.0 891.3 931.7 968.9 989.5 1028.2 10206.1 10547.5 10873.2 10898.3 11375.3 728063.0 733427.0 741601.0 742457.0 745761.3 100954.0 102492.5 107195.0 107594.0 109097.0 978.7 1088.2 1122.3 1139.3 1139.4 15972.9 17656.7 17869.0 17926.9 17975.5 49918.3 50089.2 50921.6 51035.7 51039.5 68067.0 71092.6 71106.6 71478.0 71574.0 7533.2 7648.7 7664.9 7698.6 7700.8 7226.5 9944.8 9967.5 11385.4 12155.0 8089.0 10087.9 10169.9 10217.0 10539.6 9952.9 10308.4 10321.5 10407.2 10433.7 7338.6 8530.3 10033.7 10382.1 10473.8 7283.5 7557.9 7569.5 7620.7 7683.8 9698.4 9752.3 10066.0 10506.9 10685.9 04:51:47 INFO - PROCESS | 1691 | 04:51:47 INFO - PROCESS | 1691 | [#3] mootools.html Cycles:180 Average:6013.64 Median:5440.87 stddev:3149.19 (57.9%) stddev-sans-first:3138.96 04:51:47 INFO - PROCESS | 1691 | Values: 1404.1 1516.5 1547.2 1783.6 1938.1 7840.3 8027.8 8526.3 8721.6 8745.1 8496.1 8617.6 8714.9 8715.7 8735.7 1934.8 2171.7 2477.3 2507.0 2508.5 2261.2 2415.8 2491.1 2497.8 2499.6 2423.4 2451.9 2466.6 2472.8 2473.1 2438.5 2458.5 2471.9 2473.5 2479.3 2433.5 2456.5 2457.8 2459.1 2483.9 8766.4 8811.4 8815.5 8824.3 8825.0 5303.3 5443.7 5449.4 5479.6 5496.4 3620.1 3681.9 3763.6 3766.1 3767.5 876.8 1030.4 1049.3 1071.8 1072.8 11847.2 11860.5 11874.3 11884.3 11886.2 4151.5 4885.7 4893.5 4928.7 4982.5 10120.3 10133.2 10148.4 10159.8 10159.8 5438.0 5447.4 5454.2 5472.7 5488.8 4924.5 4963.4 4975.2 4978.0 4989.5 3557.8 3627.5 3628.9 3740.9 3847.3 1185.1 1189.4 1195.2 1196.1 1199.0 1285.0 1292.3 1311.1 1311.6 1340.9 8059.3 8077.3 8313.6 8346.8 8351.8 1177.6 1187.2 1197.0 1198.1 1211.6 6219.2 6248.8 6324.5 6326.5 6335.9 10092.5 10525.5 10541.0 10574.3 10710.1 10070.7 10451.3 10454.2 10471.0 10595.2 8120.9 8356.8 8358.7 8358.8 8366.5 7863.2 8019.3 8023.9 8072.1 8100.4 9420.7 9421.2 9476.5 9518.8 9668.6 9336.2 9467.7 9641.6 9948.0 9972.7 7334.6 7366.2 7472.7 7493.9 7511.9 7070.3 7252.2 7836.9 7904.8 7924.5 6845.3 7367.3 7389.3 7510.0 7560.2 7135.9 7184.0 7326.0 7407.1 7419.6 7599.4 7644.1 7655.4 7655.8 7668.4 6721.5 6889.8 6893.1 6894.9 6901.2 6961.9 6996.5 7017.8 7094.5 7107.1 04:51:47 INFO - PROCESS | 1691 | 04:51:47 INFO - PROCESS | 1691 | [#4] prototype.html Cycles:180 Average:5732.53 Median:6447.08 stddev:1833.02 (28.4%) stddev-sans-first:1792.00 04:51:47 INFO - PROCESS | 1691 | Values: 286.6 319.8 325.9 331.3 337.0 6439.6 6454.5 6637.1 6646.2 6663.2 6372.0 6498.7 6501.4 6557.0 6563.4 4854.8 4888.3 4902.8 4916.9 4927.0 4683.9 4806.7 4808.2 4812.9 4884.1 4515.4 4833.2 4848.5 4853.7 4871.4 4845.5 4859.0 4869.2 4874.0 4878.0 3608.4 3943.5 4146.2 4153.6 4153.6 5971.7 6261.8 6274.4 6279.4 6299.9 5711.3 5727.8 5735.1 5741.9 5768.8 6999.2 7022.2 7026.1 7031.2 7045.0 4281.5 4553.3 4692.8 4700.2 4704.6 7294.6 7382.4 7382.9 7384.4 7399.7 4524.7 4661.5 4765.6 4792.4 4806.8 4182.4 4490.3 4698.4 4717.2 4723.7 5633.5 5700.5 5743.8 5744.6 5762.0 6901.3 7065.8 7068.6 7098.4 7117.3 1677.9 1706.0 1707.0 1709.7 1719.9 1095.8 1100.7 1110.5 1124.4 1126.1 5363.7 5981.6 6114.5 6621.8 6630.0 7294.6 7320.4 7323.2 7335.2 7345.6 6332.4 6577.6 6584.3 6600.6 6611.9 3270.8 3810.9 3830.8 3876.6 3887.6 7590.0 7618.4 7619.7 7621.7 7643.2 6033.9 7218.9 7468.5 7509.1 7529.7 6150.7 7574.9 7601.0 7623.3 7640.0 7341.5 7361.4 7368.4 7382.0 7392.3 6959.3 7220.8 7234.6 7242.9 7257.3 7630.3 7646.9 7657.8 7663.8 7698.5 4319.7 4393.8 4405.0 4486.7 4622.1 7168.2 7222.7 7223.9 7229.7 7253.3 5618.4 6972.7 6982.9 6986.7 6988.3 5696.6 5766.9 7041.6 7097.9 7103.3 6904.6 6908.0 6918.9 6928.7 6930.8 6809.6 7065.8 7074.3 7086.0 7087.5 6934.3 6942.4 6945.5 6950.3 6952.3 04:51:47 INFO - PROCESS | 1691 | 04:51:47 INFO - PROCESS | 1691 | [#5] yui.html Cycles:180 Average:17493.66 Median:640.10 stddev:24254.87 (3789.2%) stddev-sans-first:24290.11 04:51:47 INFO - PROCESS | 1691 | Values: 693.4 701.5 707.7 723.8 731.2 14539.0 14705.4 14734.5 14741.0 14807.3 13005.0 13094.8 13102.6 13118.0 13162.4 673.2 695.3 822.6 851.7 853.9 838.9 848.7 849.7 850.7 852.5 709.9 726.3 899.4 905.4 906.4 889.4 905.5 905.6 905.7 906.0 662.7 665.9 667.7 669.6 669.7 14332.4 14382.4 14386.7 14389.9 14402.9 12638.6 12752.4 12775.2 12784.7 12891.9 9188.0 10012.6 10035.4 10294.9 10371.1 3580.7 3595.6 3627.4 3634.0 3634.6 78230.0 79409.0 79683.4 80562.0 81655.0 8843.5 8946.9 9082.2 9164.9 9508.0 19237.0 19275.1 19324.0 19341.0 19341.9 7329.9 7337.0 7507.1 7632.0 7765.5 4023.4 4090.7 4112.6 4148.5 4270.0 3475.8 3503.4 3510.0 3513.1 3514.7 644.4 651.5 658.6 661.1 668.9 498.6 513.4 525.5 562.4 606.3 8461.9 8812.5 9054.8 9090.0 9125.5 586.3 601.8 602.6 607.8 635.8 4054.8 4279.0 4325.9 4340.7 4377.4 88471.0 88859.0 89339.0 89471.6 89472.6 69583.7 69778.6 69911.7 69929.7 74528.0 55601.7 59395.7 66293.0 66903.7 67497.7 8710.3 8758.5 8806.9 8826.6 8983.7 47295.5 47808.0 47978.5 48376.3 48859.3 47248.3 66253.0 66288.3 66749.0 67636.3 10763.2 10806.9 10895.5 10934.1 11177.4 11785.5 11930.2 12235.7 12259.6 12514.5 8976.3 10990.8 11220.0 11469.9 11571.9 11115.6 11294.1 11408.7 11660.3 11713.8 11130.9 11155.6 11301.4 11334.7 12098.2 8990.6 8995.3 9076.5 9355.3 9476.6 8873.3 9085.0 9640.8 9652.7 9656.6 04:51:47 INFO - PROCESS | 1691 | -------- Summary: end -------- 04:51:47 INFO - PROCESS | 1691 | 04:51:47 INFO - TEST-INFO | 1691: exit 0 04:51:47 INFO - TEST-OK | dromaeo_css | took 1115061ms 04:51:47 INFO - TEST-START | kraken 04:51:47 INFO - operating with platform_type : mac_ 04:51:47 INFO - Initialising browser for kraken test... 04:51:47 INFO - TEST-INFO | started process 1698 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmpbZ38yG/profile http://localhost:49282/getInfo.html) 04:51:47 INFO - PROCESS | 1698 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:51:49 INFO - PROCESS | 1698 | __metrics Screen width/height:1600/1200 04:51:49 INFO - PROCESS | 1698 | colorDepth:24 04:51:49 INFO - PROCESS | 1698 | Browser inner width/height: 1024/689 04:51:49 INFO - PROCESS | 1698 | __metrics 04:51:49 INFO - PROCESS | 1698 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:51:49 INFO - PROCESS | 1698 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:51:50 INFO - TEST-INFO | 1698: exit 0 04:51:50 INFO - Browser initialized. 04:51:50 INFO - Running cycle 1/1 for kraken test... 04:51:50 INFO - TEST-INFO | started process 1700 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmpbZ38yG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:52:02 INFO - PROCESS | 1700 | RSS: Main: 243679232 04:52:02 INFO - PROCESS | 1700 | 04:52:05 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection) 04:52:05 INFO - PROCESS | 1700 | RSS: Main: 292048896 04:52:05 INFO - PROCESS | 1700 | 04:52:08 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-dft) 04:52:08 INFO - PROCESS | 1700 | RSS: Main: 301584384 04:52:08 INFO - PROCESS | 1700 | 04:52:12 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-fft) 04:52:12 INFO - PROCESS | 1700 | RSS: Main: 287776768 04:52:12 INFO - PROCESS | 1700 | 04:52:14 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator) 04:52:15 INFO - PROCESS | 1700 | RSS: Main: 289333248 04:52:15 INFO - PROCESS | 1700 | 04:52:17 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:52:17 INFO - PROCESS | 1700 | RSS: Main: 290312192 04:52:17 INFO - PROCESS | 1700 | 04:52:20 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom) 04:52:21 INFO - PROCESS | 1700 | RSS: Main: 291631104 04:52:21 INFO - PROCESS | 1700 | 04:52:24 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate) 04:52:24 INFO - PROCESS | 1700 | RSS: Main: 290172928 04:52:24 INFO - PROCESS | 1700 | 04:52:27 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial) 04:52:28 INFO - PROCESS | 1700 | RSS: Main: 292274176 04:52:28 INFO - PROCESS | 1700 | 04:52:29 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:52:30 INFO - PROCESS | 1700 | RSS: Main: 326586368 04:52:30 INFO - PROCESS | 1700 | 04:52:32 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:52:33 INFO - PROCESS | 1700 | RSS: Main: 325603328 04:52:33 INFO - PROCESS | 1700 | 04:52:35 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:52:35 INFO - PROCESS | 1700 | RSS: Main: 334233600 04:52:35 INFO - PROCESS | 1700 | 04:52:38 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:52:38 INFO - PROCESS | 1700 | RSS: Main: 334807040 04:52:38 INFO - PROCESS | 1700 | 04:52:41 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:52:41 INFO - PROCESS | 1700 | RSS: Main: 333996032 04:52:41 INFO - PROCESS | 1700 | 04:52:43 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49282/tests/kraken/driver.html?testName=ai-astar) 04:52:43 INFO - PROCESS | 1700 | RSS: Main: 394981376 04:52:43 INFO - PROCESS | 1700 | 04:52:43 INFO - PROCESS | 1700 | __start_tp_report 04:52:44 INFO - PROCESS | 1700 | _x_x_mozilla_page_load 04:52:44 INFO - PROCESS | 1700 | _x_x_mozilla_page_load_details 04:52:44 INFO - PROCESS | 1700 | |i|pagename|runs| 04:52:44 INFO - PROCESS | 1700 | |0;ai-astar;108;107;110;110;109;110;114;110;110;109 04:52:44 INFO - PROCESS | 1700 | |1;audio-beat-detection;156;127;146;180;152;162;138;121;143;132 04:52:44 INFO - PROCESS | 1700 | |2;audio-dft;186;183;183;185;185;185;187;186;182;181 04:52:44 INFO - PROCESS | 1700 | |3;audio-fft;76;71;87;78;56;56;58;79;76;55 04:52:44 INFO - PROCESS | 1700 | |4;audio-oscillator;93;95;129;79;79;83;110;76;80;105 04:52:44 INFO - PROCESS | 1700 | |5;imaging-gaussian-blur;86;92;86;92;86;92;86;91;86;93 04:52:44 INFO - PROCESS | 1700 | |6;imaging-darkroom;95;96;95;94;95;95;94;94;112;150 04:52:44 INFO - PROCESS | 1700 | |7;imaging-desaturate;119;117;84;99;137;142;86;106;133;134 04:52:44 INFO - PROCESS | 1700 | |8;json-parse-financial;54;55;53;52;51;54;52;63;51;52 04:52:44 INFO - PROCESS | 1700 | |9;json-stringify-tinderbox;64;69;66;70;70;70;65;66;66;69 04:52:44 INFO - PROCESS | 1700 | |10;stanford-crypto-aes;83;83;82;83;82;81;81;82;84;83 04:52:44 INFO - PROCESS | 1700 | |11;stanford-crypto-ccm;127;129;120;125;121;124;119;119;124;133 04:52:44 INFO - PROCESS | 1700 | |12;stanford-crypto-pbkdf2;138;128;137;136;137;125;140;136;167;158 04:52:44 INFO - PROCESS | 1700 | |13;stanford-crypto-sha256-iterative;67;66;67;72;93;93;93;77;66;64 04:52:44 INFO - PROCESS | 1700 | __end_tp_report 04:52:44 INFO - PROCESS | 1700 | __start_cc_report 04:52:44 INFO - PROCESS | 1700 | _x_x_mozilla_cycle_collect,1147 04:52:44 INFO - PROCESS | 1700 | __end_cc_report 04:52:44 INFO - PROCESS | 1700 | __startTimestamp1454763163993__endTimestamp 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | ------- Summary: start ------- 04:52:44 INFO - PROCESS | 1700 | Number of tests: 14 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:1.83 (1.7%) stddev-sans-first:1.83 04:52:44 INFO - PROCESS | 1700 | Values: 108.0 107.0 110.0 110.0 109.0 110.0 114.0 110.0 110.0 109.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:149.00 stddev:17.64 (11.8%) stddev-sans-first:18.32 04:52:44 INFO - PROCESS | 1700 | Values: 156.0 127.0 146.0 180.0 152.0 162.0 138.0 121.0 143.0 132.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.00 stddev:1.95 (1.1%) stddev-sans-first:1.96 04:52:44 INFO - PROCESS | 1700 | Values: 186.0 183.0 183.0 185.0 185.0 185.0 187.0 186.0 182.0 181.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#3] audio-fft Cycles:10 Average:69.20 Median:76.00 stddev:11.84 (15.6%) stddev-sans-first:12.30 04:52:44 INFO - PROCESS | 1700 | Values: 76.0 71.0 87.0 78.0 56.0 56.0 58.0 79.0 76.0 55.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:79.50 stddev:17.27 (21.7%) stddev-sans-first:18.31 04:52:44 INFO - PROCESS | 1700 | Values: 93.0 95.0 129.0 79.0 79.0 83.0 110.0 76.0 80.0 105.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:91.50 stddev:3.20 (3.5%) stddev-sans-first:3.20 04:52:44 INFO - PROCESS | 1700 | Values: 86.0 92.0 86.0 92.0 86.0 92.0 86.0 91.0 86.0 93.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#6] imaging-darkroom Cycles:10 Average:102.00 Median:95.00 stddev:17.73 (18.7%) stddev-sans-first:18.62 04:52:44 INFO - PROCESS | 1700 | Values: 95.0 96.0 95.0 94.0 95.0 95.0 94.0 94.0 112.0 150.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#7] imaging-desaturate Cycles:10 Average:115.70 Median:139.50 stddev:21.22 (15.2%) stddev-sans-first:22.47 04:52:44 INFO - PROCESS | 1700 | Values: 119.0 117.0 84.0 99.0 137.0 142.0 86.0 106.0 133.0 134.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.50 stddev:3.53 (6.6%) stddev-sans-first:3.74 04:52:44 INFO - PROCESS | 1700 | Values: 54.0 55.0 53.0 52.0 51.0 54.0 52.0 63.0 51.0 52.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:69.00 stddev:2.32 (3.4%) stddev-sans-first:2.09 04:52:44 INFO - PROCESS | 1700 | Values: 64.0 69.0 66.0 70.0 70.0 70.0 65.0 66.0 66.0 69.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:0.97 (1.2%) stddev-sans-first:1.00 04:52:44 INFO - PROCESS | 1700 | Values: 83.0 83.0 82.0 83.0 82.0 81.0 81.0 82.0 84.0 83.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:124.50 stddev:4.61 (3.7%) stddev-sans-first:4.76 04:52:44 INFO - PROCESS | 1700 | Values: 127.0 129.0 120.0 125.0 121.0 124.0 119.0 119.0 124.0 133.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.20 Median:137.50 stddev:12.80 (9.3%) stddev-sans-first:13.56 04:52:44 INFO - PROCESS | 1700 | Values: 138.0 128.0 137.0 136.0 137.0 125.0 140.0 136.0 167.0 158.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.80 Median:74.50 stddev:12.43 (16.7%) stddev-sans-first:12.76 04:52:44 INFO - PROCESS | 1700 | Values: 67.0 66.0 67.0 72.0 93.0 93.0 93.0 77.0 66.0 64.0 04:52:44 INFO - PROCESS | 1700 | -------- Summary: end -------- 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - TEST-INFO | 1700: exit 0 04:52:44 INFO - TEST-OK | kraken | took 57027ms 04:52:44 INFO - SUITE-END | took 1172s 04:52:45 INFO - Completed test suite (00:19:32) 04:52:45 INFO - Working with test: dromaeo_css 04:52:45 INFO - Generating results file: dromaeo_css 04:52:45 INFO - Working with test: kraken 04:52:45 INFO - Generating results file: kraken 04:52:45 INFO - javascript benchmark 04:52:45 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:52:45 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 04:52:45 INFO - process_Request line: dromaeo_css 7450.17 graph.html#tests=[[72,64,59]] 04:52:45 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:52:45 INFO - process_Request line: kraken 1452.20 graph.html#tests=[[232,64,59]] 04:52:45 INFO - RETURN: dromaeo_css: 7450.17 04:52:45 INFO - RETURN: kraken: 1452.20 04:52:45 INFO - javascript benchmark 04:52:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3453.671901169389, 3489.947650785237, 3496.37065328241, 3525.995091398951, 3560.0921764949935, 5630.887382252353, 5685.829425117248, 5687.061634830248, 5714.828555143342, 5771.394003629622, 5644.689542075184, 5707.229524014268, 5709.086546152616, 5714.3999880012625, 5721.7711291548285, 5148.021875843597, 5214.348206474191, 5243.68537887728, 5244.659097158691, 5302.522772950434, 5309.522143007129, 5318.893622127555, 5320.494553017476, 5321.281626980366, 5321.361436627591, 5285.154375299952, 5288.15389537674, 5297.364316282052, 5298.09932311508, 5306.575473962093, 5265.104932161542, 5290.65610735301, 5294.073537131006, 5299.1786273127345, 5300.522952934216, 5208.0, 5209.843704688866, 5302.734863256822, 5304.708241046741, 5317.229001794718, 5603.215549823028, 5654.37801841797, 5663.5186009189265, 5692.174634677948, 5704.857378565527, 6237.469815065725, 6261.27995280544, 6264.0, 6270.122182894398, 6289.811305660792, 6152.354002829683, 6163.691815409256, 6200.193974783249, 6290.685465726741, 6333.936660633427, 5775.768969241268, 5779.162021506858, 5785.074388097884, 5797.01450753373, 5850.9414905851245, 6280.403361680633, 6321.462675672619, 6329.905051424233, 6343.238811342669, 6343.492520598341, 6038.0, 6062.090686397076, 6108.053251745987, 6115.694215289218, 6115.877682446326, 6173.56785025044, 6198.163247961557, 6222.408871157233, 6236.438720515175, 6323.810285691437, 6190.164327815687, 6213.565050446426, 6220.564560480813, 6237.812865614039, 6249.96875015622, 6253.906191407133, 6265.749370025239, 6288.874222515616, 6293.3391993840905, 6298.811035668938, 4840.806367745251, 4883.267509873547, 4917.631177661689, 4925.581325587365, 4956.925646115311, 4333.133373325348, 4374.168907907488, 4378.846740364072, 4395.934060989088, 4407.867763967086, 5705.6291341063525, 5715.828525144252, 5728.112142617901, 5733.082706766981, 5737.282839645044, 6154.076888466676, 6247.9062814057825, 6263.78076767311, 6277.1525844011385, 6289.968550157311, 5719.28508936383, 5747.942520574825, 5766.336871259775, 5794.333651630032, 5819.82540523785, 4461.598456138963, 5349.22436246742, 5352.545033672103, 5356.812511562077, 5357.5446087082255, 6215.316315205233, 6311.715972781236, 6334.144890439732, 6336.873262534724, 6343.873122537616, 6201.782937597162, 6220.906686399617, 6320.905186422116, 6334.3665633436285, 6350.650714210763, 6232.937670623236, 6293.0, 6307.526935479766, 6320.968395158179, 6336.3030066693545, 4967.478414766398, 6193.318734939063, 6218.129461875251, 6224.190855188796, 6225.782097626561, 6214.161088253028, 6216.968915155395, 6226.719797609027, 6332.588381755171, 6336.1446204763615, 5361.517463428154, 5415.296011518478, 6120.990036643904, 6126.632402055891, 6134.04922237054, 6110.694465276807, 6119.877602448015, 6122.448979591858, 6126.23422072241, 6127.417895299939, 5785.103308987113, 5916.171735957056, 5952.255968003999, 5960.046392577166, 6046.153538504701, 6089.6925282777975, 6141.232345956755, 6156.846078848064, 6157.291911430243, 6166.691665416801, 6005.099235114593, 6009.369016253405, 6023.216981792339, 6028.457438830526, 6052.122442245762], "unit": "score", "name": "dojo.html", "value": 5711.838084275154}, {"lowerIsBetter": false, "replicates": [447.0165635601673, 518.9429162792094, 579.2440864671604, 582.4670426559699, 603.9184710064143, 29041.854790726044, 29371.706282937164, 29401.264968375803, 29408.558871616944, 29451.410971780577, 30037.0, 30412.239694007607, 37948.051298717546, 38477.61522384775, 38537.0, 9406.623735050589, 9559.904400955971, 9579.281553883451, 9584.137427631511, 9595.80808383832, 9380.577873995653, 9502.0, 9508.857367139499, 9513.571889265, 9542.713718588453, 9507.524623768819, 9552.904470955305, 9554.996725343843, 9562.521873906277, 9562.856557151614, 9582.856257156149, 9648.179904708108, 9659.71020869375, 9669.468179250138, 9673.419594824332, 9437.433753974783, 9557.378770379903, 9573.90426095744, 9575.0, 9589.472579008152, 38653.80673096645, 38903.0, 38942.415863762064, 39050.50919144307, 39086.60913390858, 3101.379724055198, 3108.5026395776795, 3117.7194052535156, 3156.321390900944, 3309.520119582647, 27304.317392065157, 27508.724912751015, 27893.58159627607, 27958.161255162173, 28872.566911496346, 2714.4571085782923, 2753.5318995770767, 2778.4165325281715, 2903.651561812575, 2945.5581662750546, 482712.0, 482768.0, 483982.0, 484061.15938840515, 484311.57844210905, 51562.22656660078, 52424.68938276498, 52444.737776310874, 58444.12333814996, 58732.7063364689, 62664.0, 63598.36401636017, 63599.682001589696, 63652.68173659195, 63958.0, 15405.38378464849, 15835.762463563056, 15837.68324633501, 15846.366145354057, 15894.92052539753, 11337.60318388869, 11487.770244595229, 11495.942520287512, 12296.0, 12344.62966111018, 18410.723839142425, 18648.34730784416, 18649.160787764584, 18693.439196823845, 18820.341288054853, 7515.722327204388, 7863.37093032556, 8105.635246413925, 8383.832323353621, 8438.36712246584, 936.6440752514137, 1040.69819752271, 1129.4352823588206, 1134.6142311614092, 1185.3184418959133, 28633.28416789597, 28725.317761246697, 28820.42359152805, 28975.13074607723, 29182.708172918425, 1066.3495267886583, 1093.4642025407493, 1174.6123779152858, 1204.692803335144, 1235.8640549539543, 14572.854271457361, 14783.265095957282, 14800.629984250265, 14929.776053359208, 15098.797679101983, 497428.0, 506378.0, 506765.9323406792, 507452.0, 507780.0, 55505.72247138739, 55791.88416231653, 55815.720921395136, 55962.16056759152, 56067.43932560704, 1309.796981467874, 1331.1214598365227, 1441.502681574876, 1466.8973171878079, 1568.1767072287141, 25289.49421011533, 27824.44351113007, 28104.156875293775, 28266.010689625764, 28371.148865534065, 44291.33562996493, 44560.55439445564, 44614.55385446234, 44630.3305450412, 44810.77594612006, 491110.0, 501637.0, 648657.0, 649033.0, 652918.0, 29110.690018949623, 29119.7088029117, 29396.0, 29472.705272946994, 29482.705172947997, 40449.595504044584, 40876.1824763509, 40916.18167636571, 40936.27030165329, 41259.587404126774, 33912.660873391935, 34377.828110859286, 34923.825380872935, 35229.647703522634, 35264.47103293504, 34641.960741177805, 34741.65258347384, 34930.825345874124, 34949.30101397907, 35177.296454071286, 33183.336333273684, 33245.83377083196, 33518.497222542166, 33603.66396336005, 33661.49507757435, 28355.716442835306, 29381.85309073441, 29611.96358127455, 29918.952836650613, 29985.950491732685, 18014.2794288227, 18304.633907322044, 22151.0, 22626.868656566778, 23454.296371108892], "unit": "score", "name": "ext.html", "value": 18932.20643181762}, {"lowerIsBetter": false, "replicates": [361.36039210597244, 367.08778684967865, 368.193655893593, 370.54793152354137, 374.7844989131247, 12764.489420423195, 13994.930025349884, 18683.813161868376, 19189.32837350693, 19975.500612484695, 11640.0, 12023.819642705366, 12027.579034733786, 12030.879691203085, 20180.798192018112, 4628.259478483444, 6316.968415157918, 6517.67411629419, 6521.3478652134645, 6527.053577231299, 4745.335653008581, 4789.497102804207, 4789.832355867546, 7049.647517624124, 7386.963065184666, 7193.496455248135, 7372.631368431584, 7466.738664146756, 7467.813304667399, 7495.287947644965, 7250.202477727472, 7294.27057294269, 7300.379467745248, 7355.852882942365, 7369.410447164214, 6459.0, 6835.14560679915, 7170.067891174166, 7181.425485961111, 7217.566945983258, 26214.73785262142, 26302.6054609181, 26996.460070798475, 27086.1874143776, 27806.721932780816, 2367.739548649647, 2416.891239894209, 2427.478092210183, 2477.393038705529, 2812.437512497488, 15077.623059423602, 15097.094174349575, 15348.762937014177, 15596.0, 15739.92130039354, 1800.4148651688254, 1814.5372929902921, 1872.7284543741082, 1883.340830709241, 1913.5885784556249, 95087.0, 97046.0, 97290.54064189043, 97774.0222597765, 99040.0095999038, 10791.244612877023, 11124.49939752713, 11128.332300062022, 11139.721506962229, 11243.100551955824, 11023.944880275707, 13195.73608527824, 13265.0, 13304.13523120994, 13312.201267923956, 8527.74416767498, 8530.957345213359, 8557.27263182624, 8632.741017769476, 8642.654293828302, 8663.913360866436, 8677.002144753435, 8684.956575217084, 8739.344549158839, 8769.605367758466, 3531.5232443619784, 4035.5762644922447, 4199.559046300155, 4207.137536804948, 4425.491068527161, 1470.2501724120775, 1794.8474379677612, 1798.4874310821615, 1804.9368272110414, 1817.7727784026997, 796.9203079691985, 903.6114470777628, 904.9321300902459, 1026.9691909242736, 1052.6421016854306, 15537.0, 18610.534736631693, 18679.90660046691, 19594.90202548978, 20167.0, 891.251348866942, 931.7204838548544, 968.8982656821073, 989.4904124375952, 1028.2082796246848, 10206.132478739242, 10547.525361358757, 10873.184511161695, 10898.346099234072, 11375.326798202415, 728063.0, 733427.0, 741601.0, 742457.0, 745761.2711936514, 100954.0, 102492.48753756333, 107195.0, 107594.0, 109097.0, 978.6819283732815, 1088.1621151713296, 1122.2705241592867, 1139.2537887683582, 1139.3790384240608, 15972.920135399248, 17656.73514897303, 17869.0, 17926.91036544809, 17975.460736177934, 49918.251226232365, 50089.24866126938, 50921.63479565054, 51035.74482127566, 51039.489605103474, 68066.9789953161, 71092.64453677699, 71106.57786844131, 71478.0, 71574.0, 7533.171351151259, 7648.73229436967, 7664.923350766421, 7698.5765782880235, 7700.807479813049, 7226.494145409771, 9944.751381215527, 9967.451790151612, 11385.430728463709, 12155.0, 8088.959555202422, 10087.949560252151, 10169.9491502542, 10217.0, 10539.63111291101, 9952.900470995488, 10308.433036183082, 10321.48392580353, 10407.219458540489, 10433.739156520844, 7338.559686418618, 8530.317574593893, 10033.749156271151, 10382.117520010883, 10473.790524189626, 7283.526570772883, 7557.886631700419, 7569.545827250162, 7620.657070431733, 7683.807904802425, 9698.448248280241, 9752.268579856398, 10066.0, 10506.947465262625, 10685.8931410688], "unit": "score", "name": "jquery.html", "value": 9338.025097219734}, {"lowerIsBetter": false, "replicates": [1404.0873432269018, 1516.491975188312, 1547.2206961993709, 1783.589774351899, 1938.1181562389115, 7840.2551757583005, 8027.83944321114, 8526.271593090205, 8721.5639218039, 8745.08176641453, 8496.065432802387, 8617.612207450664, 8714.869276960835, 8715.651373945051, 8735.694250701226, 1934.7907557776389, 2171.6851056596784, 2477.3435039714445, 2507.034791605236, 2508.4606809535944, 2261.2198791416936, 2415.830891837572, 2491.0533997081175, 2497.825152239344, 2499.6250562415694, 2423.3699238198105, 2451.889664965081, 2466.5683505386487, 2472.7527247275307, 2473.109680515013, 2438.4635380216323, 2458.4960083182905, 2471.9011239550396, 2473.5423946569854, 2479.3181874984343, 2433.513297340521, 2456.5086982603552, 2457.8402403843693, 2459.139301244568, 2483.8758062097004, 8766.430182038148, 8811.427257228259, 8815.51514666693, 8824.294056475466, 8824.955875220647, 5303.310569625924, 5443.700596467233, 5449.427810079964, 5479.561635069185, 5496.367917689437, 3620.094976255936, 3681.889543313705, 3763.5671897731563, 3766.0961369271454, 3767.4537192107264, 876.8294327073364, 1030.4075156784804, 1049.3441599000626, 1071.8285074388061, 1072.7639919217759, 11847.170698051139, 11860.52557897683, 11874.346910919896, 11884.286942783374, 11886.227395219283, 4151.46031015966, 4885.706857588556, 4893.4617192108835, 4928.679635823732, 4982.501749824988, 10120.342177758423, 10133.240006999504, 10148.391096534231, 10159.847602285972, 10159.847602285972, 5438.048341540215, 5447.428020057837, 5454.181872719045, 5472.699001554873, 5488.7530061147345, 4924.507549245119, 4963.379577552806, 4975.203967365276, 4977.9751101244265, 4989.451160372356, 3557.8043207623828, 3627.510286111394, 3628.872989445357, 3740.887773366749, 3847.2690188864026, 1185.063799598325, 1189.4052973513244, 1195.1952551647075, 1196.1029228078942, 1198.974876480614, 1285.0490636928791, 1292.3086148910477, 1311.114997376767, 1311.5934060441293, 1340.8726171013739, 8059.314958228616, 8077.313428358655, 8313.625886834985, 8346.8330633387, 8351.8329633407, 1177.6408195500283, 1187.2223693480785, 1197.0423661071109, 1198.1433275208267, 1211.5517258614368, 6219.191505104308, 6248.843778905563, 6324.462420694293, 6326.4622507087415, 6335.936640633627, 10092.545835437277, 10525.473726313654, 10541.0, 10574.312669676447, 10710.143188544898, 10070.69787906364, 10451.268411211142, 10454.163666906628, 10471.0, 10595.205359598061, 8120.878186827203, 8356.832863342699, 8358.707445239508, 8358.832823343499, 8366.456180348257, 7863.155741181409, 8019.318357939641, 8023.879641805261, 8072.112067672669, 8100.392470564613, 9420.670276540288, 9421.246300296098, 9476.47879366614, 9518.762030949281, 9668.613255469703, 9336.206422454168, 9467.715968520955, 9641.614335426504, 9948.005199479994, 9972.700818975442, 7334.633268336668, 7366.152892417226, 7472.663730132048, 7493.925060749323, 7511.924880751122, 7070.292970702889, 7252.202257751748, 7836.92163078362, 7904.802379940547, 7924.524528528307, 6845.281245469154, 7367.26327367259, 7389.298016688406, 7510.0, 7560.206178351414, 7135.892961605477, 7183.964080179566, 7326.0, 7407.111146662435, 7419.591922444318, 7599.430042746705, 7644.12092609357, 7655.387568994356, 7655.808604784925, 7668.424868135024, 6721.462283017249, 6889.827754306182, 6893.0694356261265, 6894.896576551456, 6901.171859376706, 6961.860762784817, 6996.475264355092, 7017.824554386181, 7094.4679149062995, 7107.111611048619], "unit": "score", "name": "mootools.html", "value": 4908.590443498874}, {"lowerIsBetter": false, "replicates": [286.5973307502959, 319.79213511217705, 325.85336598530665, 331.3158328052571, 337.0317346695299, 6439.613623182612, 6454.548181627288, 6637.070810086586, 6646.202455705322, 6663.233728121268, 6372.0, 6498.740050397979, 6501.447376972963, 6557.0, 6563.442107420863, 4854.8300809471675, 4888.291197776321, 4902.828401005965, 4916.901661966758, 4926.950730492694, 4683.859484215462, 4806.687565308262, 4808.158572249842, 4812.855614331575, 4884.120858245515, 4515.390422292981, 4833.154198015351, 4848.5151484851585, 4853.733044682541, 4871.439784424783, 4845.466998630148, 4859.0, 4869.220924652039, 4873.999999999983, 4877.975610121926, 3608.350496910555, 3943.4873466449176, 4146.170765846812, 4153.563875793058, 4153.605407486284, 5971.671558064305, 6261.78083767066, 6274.403931626488, 6279.434850863398, 6299.905501417483, 5711.314642242916, 5727.770889164429, 5735.11105778605, 5741.909037282903, 5768.826935191951, 6999.19509256437, 7022.157341119098, 7026.086608740831, 7031.19141298752, 7044.964775176142, 4281.529031806499, 4553.2714765637675, 4692.8122875084955, 4700.177468942956, 4704.64715146362, 7294.598797066159, 7382.409407247461, 7382.852342953111, 7384.409247260206, 7399.667014984285, 4524.660650451164, 4661.510541393172, 4765.571098601074, 4792.376990991149, 4806.759662016885, 4182.435371224846, 4490.348899409632, 4698.412698412699, 4717.245240761462, 4723.669343146015, 5633.521150702236, 5700.486956173964, 5743.827685169368, 5744.569157313218, 5762.049261871744, 6901.275366086589, 7065.752698655625, 7068.646567671596, 7098.36114749675, 7117.3238542338395, 1677.9161041948098, 1706.0275642883685, 1707.044055328995, 1709.6751617192695, 1719.8882072665238, 1095.8082335591398, 1100.664297389304, 1110.5335758981248, 1124.4321617583068, 1126.0597401170114, 5363.731813409314, 5981.611195272293, 6114.510839132859, 6621.801345959629, 6629.966850165815, 7294.562326260335, 7320.414366850639, 7323.194448610649, 7335.193128755833, 7345.595992220479, 6332.398422149889, 6577.572457790228, 6584.275729669733, 6600.60396376219, 6611.900821487681, 3270.7546933980047, 3810.9237815244096, 3830.8467661293794, 3876.6317199865966, 3887.611238876146, 7590.0, 7618.428617853572, 7619.695212191561, 7621.733239336597, 7643.159252482223, 6033.939660603425, 7218.8917166242545, 7468.477206595595, 7509.136449308399, 7529.73645922401, 6150.661713605705, 7574.924250757532, 7601.0, 7623.313901748869, 7640.0067991160795, 7341.522801017917, 7361.447891408059, 7368.410527157922, 7381.9630901847295, 7392.260773922565, 6959.338862808025, 7220.783376498714, 7234.5659260444545, 7242.89135662955, 7257.2742725727, 7630.313271805342, 7646.885296720665, 7657.770266892002, 7663.808404789925, 7698.499597526143, 4319.676024298253, 4393.780310984502, 4404.955950440454, 4486.7083639563325, 4622.098690755271, 7168.17565979919, 7222.652637892601, 7223.855522889407, 7229.710811567478, 7253.347198752138, 5618.353889302783, 6972.651367431709, 6982.860342793218, 6986.6855991481525, 6988.301169882971, 5696.629719068413, 5766.913496297475, 7041.5775053496955, 7097.858042839218, 7103.289671032855, 6904.551204171713, 6907.965460172667, 6918.896216556655, 6928.688209030706, 6930.826729331807, 6809.591424514545, 7065.823354415975, 7074.327938845801, 7086.0, 7087.468439866928, 6934.306569343025, 6942.375186233061, 6945.548539344926, 6950.270221626859, 6952.30476952321], "unit": "score", "name": "prototype.html", "value": 5124.282272468346}, {"lowerIsBetter": false, "replicates": [693.4002088193714, 701.5089437393823, 707.7063018847177, 723.7792473295646, 731.1956847467784, 14539.0, 14705.411783528672, 14734.484293049758, 14741.041832280907, 14807.25963701816, 13005.024623153278, 13094.803577946339, 13102.606921792338, 13118.0, 13162.407691653874, 673.2426020726682, 695.3463744080548, 822.596927505521, 851.706161374328, 853.91887770662, 838.9119142490042, 848.6859861851093, 849.7110982266029, 850.7447765670305, 852.4757274276307, 709.9006139140524, 726.3245181980756, 899.4468401932797, 905.4431524612381, 906.419891269588, 889.3774357949429, 905.4974489158515, 905.6105874473974, 905.6513242401656, 905.9682911098113, 662.7282814046266, 665.8501837086665, 667.7395815631908, 669.6383952665554, 669.7187181383782, 14332.42670293187, 14382.35279412429, 14386.712265754626, 14389.920755943345, 14402.927985360006, 12638.55765048219, 12752.426140823685, 12775.23348599087, 12784.680382990407, 12891.935540322238, 9187.954060229657, 10012.649557265533, 10035.448050357227, 10294.91903350145, 10371.066604005675, 3580.695640870529, 3595.6404359563835, 3627.419612861956, 3634.036980200249, 3634.56385233771, 78230.0, 79409.0, 79683.40633187362, 80562.0, 81655.0, 8843.51360675169, 8946.910530894607, 9082.228010619172, 9164.8625270621, 9508.001659825619, 19237.0, 19275.132619032178, 19324.03379831003, 19341.0, 19341.903290483457, 7329.926700733031, 7337.046183996046, 7507.1366792818435, 7631.961840190764, 7765.53406795594, 4023.436718859362, 4090.7341022834016, 4112.629863312316, 4148.522919864255, 4269.978650106792, 3475.826208689555, 3503.421935380634, 3509.9821051895174, 3513.0690367052753, 3514.7188224941942, 644.3588629313768, 651.4560342114388, 658.5982550644103, 661.1141070964931, 668.8796016717038, 498.576210221309, 513.3608657221782, 525.542777783331, 562.3954249182145, 606.2845841906504, 8461.915380846236, 8812.515311657791, 9054.773630659287, 9089.954550227207, 9125.45247285165, 586.3227971692702, 601.8174287525035, 602.6474512410201, 607.7933502609134, 635.8442181665429, 4054.8378064877666, 4278.957210427918, 4325.9134817303475, 4340.739555626673, 4377.4444279419895, 88471.0, 88859.0, 89339.0, 89471.55264223638, 89472.5526372377, 69583.65208173927, 69778.60442791115, 69911.65044174848, 69929.65035174791, 74528.0, 55601.721991390594, 59395.65439110501, 66293.0, 66903.66548167227, 67497.66251168713, 8710.303175746052, 8758.518281494578, 8806.85510883581, 8826.5586720665, 8983.685571004984, 47295.52704472911, 47808.0, 47978.520214797405, 48376.27435588399, 48859.26711099407, 47248.2912756302, 66253.006204906, 66288.33711662822, 66749.0, 67636.323636763, 10763.192760543147, 10806.891931080903, 10895.509702063584, 10934.070603998749, 11177.385243811668, 11785.469653865768, 11930.22453540517, 12235.69410764738, 12259.570915017932, 12514.499420023461, 8976.326775491734, 10990.780184396108, 11219.990200881959, 11469.942650286695, 11571.884281157081, 11115.555377785122, 11294.096472282034, 11408.714782130513, 11660.30038197711, 11713.824292635447, 11130.944345278222, 11155.55377784912, 11301.378424186749, 11334.716632083933, 12098.153129280865, 8990.595423205841, 8995.28037756991, 9076.546172691471, 9355.298352623444, 9476.573554190216, 8873.334499912662, 9085.0, 9640.75898102553, 9652.710418687451, 9656.565454554702], "unit": "score", "name": "yui.html", "value": 6731.981554123475}], "name": "dromaeo_css", "value": 7450.173643669107}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 107.0, 110.0, 110.0, 109.0, 110.0, 114.0, 110.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [156.0, 127.0, 146.0, 180.0, 152.0, 162.0, 138.0, 121.0, 143.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [186.0, 183.0, 183.0, 185.0, 185.0, 185.0, 187.0, 186.0, 182.0, 181.0], "unit": "score", "name": "audio-dft", "value": 184.3}, {"lowerIsBetter": true, "replicates": [76.0, 71.0, 87.0, 78.0, 56.0, 56.0, 58.0, 79.0, 76.0, 55.0], "unit": "score", "name": "audio-fft", "value": 69.2}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 129.0, 79.0, 79.0, 83.0, 110.0, 76.0, 80.0, 105.0], "unit": "score", "name": "audio-oscillator", "value": 92.9}, {"lowerIsBetter": true, "replicates": [86.0, 92.0, 86.0, 92.0, 86.0, 92.0, 86.0, 91.0, 86.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 112.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 102.0}, {"lowerIsBetter": true, "replicates": [119.0, 117.0, 84.0, 99.0, 137.0, 142.0, 86.0, 106.0, 133.0, 134.0], "unit": "score", "name": "imaging-desaturate", "value": 115.7}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 53.0, 52.0, 51.0, 54.0, 52.0, 63.0, 51.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 53.7}, {"lowerIsBetter": true, "replicates": [64.0, 69.0, 66.0, 70.0, 70.0, 70.0, 65.0, 66.0, 66.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 82.0, 83.0, 82.0, 81.0, 81.0, 82.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [127.0, 129.0, 120.0, 125.0, 121.0, 124.0, 119.0, 119.0, 124.0, 133.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [138.0, 128.0, 137.0, 136.0, 137.0, 125.0, 140.0, 136.0, 167.0, 158.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.2}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 72.0, 93.0, 93.0, 93.0, 77.0, 66.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.8}], "name": "kraken", "value": 1452.2}]} 04:52:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1452.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7450.17"}}} 04:52:45 INFO - Return code: 0 04:52:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:52:45 INFO - # TBPL SUCCESS # 04:52:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:52:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:52:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:52:45 INFO - 2016-02-06 04:52:45.712 screenresolution[1704:10721] starting screenresolution argv=screenresolution get 04:52:45 INFO - 2016-02-06 04:52:45.714 screenresolution[1704:10721] Display 0: 1600x1200x32@60 04:52:45 INFO - 2016-02-06 04:52:45.720 screenresolution[1705:10724] starting screenresolution argv=screenresolution list 04:52:45 INFO - Available Modes on Display 0 04:52:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:52:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:52:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:52:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:52:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:52:45 INFO - Intel Iris: 04:52:45 INFO - Chipset Model: Intel Iris 04:52:45 INFO - Type: GPU 04:52:45 INFO - Bus: Built-In 04:52:45 INFO - VRAM (Dynamic, Max): 1536 MB 04:52:45 INFO - Vendor: Intel (0x8086) 04:52:45 INFO - Device ID: 0x0a2e 04:52:45 INFO - Revision ID: 0x0009 04:52:45 INFO - Displays: 04:52:45 INFO - Display: 04:52:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:52:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:52:45 INFO - Display Serial Number: 1600x1200 60 04:52:45 INFO - Main Display: Yes 04:52:45 INFO - Mirror: Off 04:52:45 INFO - Online: Yes 04:52:45 INFO - Rotation: Supported 04:52:45 INFO - Return code: 0 04:52:45 INFO - Running post-action listener: _resource_record_post_action 04:52:45 INFO - Running post-run listener: _resource_record_post_run 04:52:47 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 33885696; Write bytes: 709876224; Read time: 352; Write time: 2262 04:52:47 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 397193728; Write bytes: 392013312; Read time: 30082; Write time: 854 04:52:47 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 32103936; Write bytes: 302134272; Read time: 334; Write time: 1368 04:52:47 INFO - Running post-run listener: _upload_blobber_files 04:52:47 INFO - Blob upload gear active. 04:52:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:52:47 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:52:47 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:52:47 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:52:47 INFO - (blobuploader) - INFO - Open directory for files ... 04:52:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:52:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:52:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:48 INFO - (blobuploader) - INFO - Done attempting. 04:52:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:52:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:52:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:49 INFO - (blobuploader) - INFO - Done attempting. 04:52:49 INFO - (blobuploader) - INFO - Iteration through files over. 04:52:49 INFO - Return code: 0 04:52:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:52:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:52:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/775e4a2830183900bbd7ccfb79ca87acd0ed6f1844354f1d23645837620779805d55a390dc248023dee026e564505dd0294cb0db91e753cd4dca6f515ed8d336", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba0742905321de97893cb38a407bc6146d38c9a62b76113b54eb5c52c18ebeecf1c1fbe91d1c75c085338f76dfdcd7ca9228879f1ac7866c846aabb119ec7ee4"} 04:52:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:52:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:52:49 INFO - Contents: 04:52:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/775e4a2830183900bbd7ccfb79ca87acd0ed6f1844354f1d23645837620779805d55a390dc248023dee026e564505dd0294cb0db91e753cd4dca6f515ed8d336", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba0742905321de97893cb38a407bc6146d38c9a62b76113b54eb5c52c18ebeecf1c1fbe91d1c75c085338f76dfdcd7ca9228879f1ac7866c846aabb119ec7ee4"} 04:52:49 INFO - Running post-run listener: copy_logs_to_upload_dir 04:52:49 INFO - Copying logs to upload dir... 04:52:49 INFO - mkdir: /builds/slave/test/build/upload/logs 04:52:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.417752 ========= master_lag: 10.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-06 04:52:59.602833) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 10 secs) (at 2016-02-06 04:52:59.606301) ========= 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.u7qZXGcZbs/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.yneuf9Xgzq/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/775e4a2830183900bbd7ccfb79ca87acd0ed6f1844354f1d23645837620779805d55a390dc248023dee026e564505dd0294cb0db91e753cd4dca6f515ed8d336", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba0742905321de97893cb38a407bc6146d38c9a62b76113b54eb5c52c18ebeecf1c1fbe91d1c75c085338f76dfdcd7ca9228879f1ac7866c846aabb119ec7ee4"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010862 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/775e4a2830183900bbd7ccfb79ca87acd0ed6f1844354f1d23645837620779805d55a390dc248023dee026e564505dd0294cb0db91e753cd4dca6f515ed8d336", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba0742905321de97893cb38a407bc6146d38c9a62b76113b54eb5c52c18ebeecf1c1fbe91d1c75c085338f76dfdcd7ca9228879f1ac7866c846aabb119ec7ee4"}' ========= master_lag: 10.31 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 10 secs) (at 2016-02-06 04:53:09.922586) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2016-02-06 04:53:09.922892) ========= 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.u7qZXGcZbs/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.yneuf9Xgzq/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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.005138 ========= master_lag: 8.52 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2016-02-06 04:53:18.443287) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 04:53:18.444016) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 04:53:18.639219) ========= ========= Total master_lag: 34.61 =========