builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0129 starttime: 1454762323.67 results: success (0) buildid: 20160206043837 builduid: 20d1c7e73f9049a79dd4581c742dcfe6 revision: 46d6d868ba0f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.672565) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.672977) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.673293) ========= 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.sy3bz8CSEB/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.OScLpcq5MU/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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.005161 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.742820) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.743134) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.790852) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.791158) ========= 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.sy3bz8CSEB/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.OScLpcq5MU/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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.005628 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.844127) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.844893) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.845829) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.846714) ========= 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.sy3bz8CSEB/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.OScLpcq5MU/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-06 04:38:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 175M=0s 2016-02-06 04:38:44 (175 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.611386 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:44.478435) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:44.478747) ========= 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.sy3bz8CSEB/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.OScLpcq5MU/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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.026824 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:44.527121) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-06 04:38:44.527495) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 46d6d868ba0f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 46d6d868ba0f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sy3bz8CSEB/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.OScLpcq5MU/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-06 04:38:44,594 Setting DEBUG logging. 2016-02-06 04:38:44,594 attempt 1/10 2016-02-06 04:38:44,594 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/46d6d868ba0f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-06 04:38:46,502 unpacking tar archive at: fx-team-46d6d868ba0f/testing/mozharness/ program finished with exit code 0 elapsedTime=2.145253 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-06 04:38:46.688359) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:46.688787) ========= echo 46d6d868ba0f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'46d6d868ba0f'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sy3bz8CSEB/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.OScLpcq5MU/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 46d6d868ba0f program finished with exit code 0 elapsedTime=0.005431 script_repo_revision: '46d6d868ba0f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:46.747813) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:46.748181) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:46.762781) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2016-02-06 04:38:46.763190) ========= /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.sy3bz8CSEB/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.OScLpcq5MU/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:38:46 INFO - MultiFileLogger online at 20160206 04:38:46 in /builds/slave/test 04:38:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:38:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:38:46 INFO - {'append_to_log': False, 04:38:46 INFO - 'base_work_dir': '/builds/slave/test', 04:38:46 INFO - 'blob_upload_branch': 'Fx-Team', 04:38:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:38:46 INFO - 'branch': 'Fx-Team', 04:38:46 INFO - 'buildbot_json_path': 'buildprops.json', 04:38:46 INFO - 'config_files': ('talos/mac_config.py',), 04:38:46 INFO - 'default_actions': ('clobber', 04:38:46 INFO - 'read-buildbot-config', 04:38:46 INFO - 'download-and-extract', 04:38:46 INFO - 'populate-webroot', 04:38:46 INFO - 'create-virtualenv', 04:38:46 INFO - 'install', 04:38:46 INFO - 'run-tests'), 04:38:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:38:46 INFO - 'download_minidump_stackwalk': True, 04:38:46 INFO - 'download_symbols': 'ondemand', 04:38:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:38:46 INFO - 'tooltool.py': '/tools/tooltool.py', 04:38:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:38:46 INFO - '/tools/misc-python/virtualenv.py')}, 04:38:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:38:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:38:46 INFO - 'installer_path': 'installer.exe', 04:38:46 INFO - 'log_level': 'info', 04:38:46 INFO - 'log_name': 'talos', 04:38:46 INFO - 'log_to_console': True, 04:38:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:38:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:38:46 INFO - 'opt_config_files': (), 04:38:46 INFO - 'pip_index': False, 04:38:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:38:46 INFO - 'cmd': ('bash', 04:38:46 INFO - '-c', 04:38:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:38:46 INFO - 'enabled': True, 04:38:46 INFO - 'halt_on_failure': False, 04:38:46 INFO - 'name': 'check_screen_resolution'},), 04:38:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:38:46 INFO - 'cmd': ('bash', 04:38:46 INFO - '-c', 04:38:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:38:46 INFO - 'enabled': True, 04:38:46 INFO - 'halt_on_failure': False, 04:38:46 INFO - 'name': 'check_screen_resolution'},), 04:38:46 INFO - 'run_cmd_checks_enabled': True, 04:38:46 INFO - 'sps_profile': False, 04:38:46 INFO - 'sps_profile_interval': 0, 04:38:46 INFO - 'suite': 'dromaeojs', 04:38:46 INFO - 'system_bits': '32', 04:38:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:38:46 INFO - 'title': 't-yosemite-r7-0129', 04:38:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:38:46 INFO - 'use_talos_json': True, 04:38:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:38:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:38:46 INFO - 'work_dir': 'build'} 04:38:46 INFO - ##### 04:38:46 INFO - ##### Running clobber step. 04:38:46 INFO - ##### 04:38:46 INFO - Running pre-action listener: _resource_record_pre_action 04:38:46 INFO - Running main action method: clobber 04:38:46 INFO - rmtree: /builds/slave/test/build 04:38:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:38:48 INFO - Running post-action listener: _resource_record_post_action 04:38:48 INFO - ##### 04:38:48 INFO - ##### Running read-buildbot-config step. 04:38:48 INFO - ##### 04:38:48 INFO - Running pre-action listener: _resource_record_pre_action 04:38:48 INFO - Running main action method: read_buildbot_config 04:38:48 INFO - Using buildbot properties: 04:38:48 INFO - { 04:38:48 INFO - "project": "", 04:38:48 INFO - "product": "firefox", 04:38:48 INFO - "script_repo_revision": "production", 04:38:48 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:38:48 INFO - "repository": "", 04:38:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:38:48 INFO - "buildid": "20160206043837", 04:38:48 INFO - "stage_platform": "macosx64", 04:38:48 INFO - "basedir": "/builds/slave/test", 04:38:48 INFO - "buildnumber": 303, 04:38:48 INFO - "platform": "yosemite_r7", 04:38:48 INFO - "mozci_request": { 04:38:48 INFO - "priority": -1, 04:38:48 INFO - "type": "trigger_all_talos_jobs", 04:38:48 INFO - "times": 6 04:38:48 INFO - }, 04:38:48 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:38:48 INFO - "slavebuilddir": "test", 04:38:48 INFO - "branch": "fx-team", 04:38:48 INFO - "revision": "46d6d868ba0f", 04:38:48 INFO - "slavename": "t-yosemite-r7-0129", 04:38:48 INFO - "builduid": "20d1c7e73f9049a79dd4581c742dcfe6", 04:38:48 INFO - "repo_path": "integration/fx-team" 04:38:48 INFO - } 04:38:48 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg. 04:38:48 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/test_packages.json. 04:38:48 INFO - Running post-action listener: _resource_record_post_action 04:38:48 INFO - ##### 04:38:48 INFO - ##### Running download-and-extract step. 04:38:48 INFO - ##### 04:38:48 INFO - Running pre-action listener: _resource_record_pre_action 04:38:48 INFO - Running main action method: download_and_extract 04:38:48 INFO - mkdir: /builds/slave/test/build/tests 04:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:48 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/test_packages.json 04:38:48 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/test_packages.json to /builds/slave/test/build/test_packages.json 04:38:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:38:49 INFO - Downloaded 1277 bytes. 04:38:49 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:38:49 INFO - Using the following test package requirements: 04:38:49 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:38:49 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:49 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:38:49 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:49 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:38:49 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:49 INFO - u'jsshell-mac.zip'], 04:38:49 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:49 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:38:49 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:38:49 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:49 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:38:49 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:49 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:38:49 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:49 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:38:49 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:38:49 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:49 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:38:49 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:49 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip 04:38:49 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:38:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:38:49 INFO - Downloaded 17118689 bytes. 04:38:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:38:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:38:52 INFO - Return code: 0 04:38:52 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:52 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip 04:38:52 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:38:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:38:52 INFO - Downloaded 17118689 bytes. 04:38:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:38:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:38:55 INFO - Return code: 0 04:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:55 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.talos.tests.zip 04:38:55 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:38:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:38:56 INFO - Downloaded 10706582 bytes. 04:38:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:38:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:38:56 INFO - Return code: 0 04:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:56 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg 04:38:56 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:38:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 04:39:05 INFO - Downloaded 111104284 bytes. 04:39:05 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg 04:39:05 INFO - mkdir: /builds/slave/test/properties 04:39:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:39:05 INFO - Writing to file /builds/slave/test/properties/build_url 04:39:05 INFO - Contents: 04:39:05 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg 04:39:05 INFO - Running post-action listener: _resource_record_post_action 04:39:05 INFO - Running post-action listener: set_extra_try_arguments 04:39:05 INFO - ##### 04:39:05 INFO - ##### Running populate-webroot step. 04:39:05 INFO - ##### 04:39:05 INFO - Running pre-action listener: _resource_record_pre_action 04:39:05 INFO - Running main action method: populate_webroot 04:39:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:39:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:39:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:39:05 INFO - '--tppagecycles', 04:39:05 INFO - '7'], 04:39:05 INFO - 'tests': ['tsvgm']}}, 04:39:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:39:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:39:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:39:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:39:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:39:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:39:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:05 INFO - 'talos_options': ['--e10s'], 04:39:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:05 INFO - 'tests': ['damp', 'tps']}, 04:39:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:05 INFO - 'talos_options': ['--e10s'], 04:39:05 INFO - 'tests': ['damp', 'tps']}, 04:39:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:39:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:39:05 INFO - 'other': {'tests': ['a11yr', 04:39:05 INFO - 'ts_paint', 04:39:05 INFO - 'tpaint', 04:39:05 INFO - 'sessionrestore', 04:39:05 INFO - 'sessionrestore_no_auto_restore']}, 04:39:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:39:05 INFO - 'tests': ['a11yr', 04:39:05 INFO - 'ts_paint', 04:39:05 INFO - 'tpaint', 04:39:05 INFO - 'sessionrestore', 04:39:05 INFO - 'sessionrestore_no_auto_restore']}, 04:39:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:39:05 INFO - 'tests': ['a11yr', 04:39:05 INFO - 'ts_paint', 04:39:05 INFO - 'tpaint', 04:39:05 INFO - 'sessionrestore', 04:39:05 INFO - 'sessionrestore_no_auto_restore']}, 04:39:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:39:05 INFO - 'tests': ['a11yr', 04:39:05 INFO - 'ts_paint', 04:39:05 INFO - 'tpaint', 04:39:05 INFO - 'sessionrestore', 04:39:05 INFO - 'sessionrestore_no_auto_restore']}, 04:39:05 INFO - 'other_l64': {'tests': ['a11yr', 04:39:05 INFO - 'ts_paint', 04:39:05 INFO - 'tpaint', 04:39:05 INFO - 'sessionrestore', 04:39:05 INFO - 'sessionrestore_no_auto_restore']}, 04:39:05 INFO - 'other_nol64': {'tests': ['a11yr', 04:39:05 INFO - 'ts_paint', 04:39:05 INFO - 'tpaint', 04:39:05 INFO - 'sessionrestore', 04:39:05 INFO - 'sessionrestore_no_auto_restore']}, 04:39:05 INFO - 'svgr': {'tests': ['tsvgx', 04:39:05 INFO - 'tsvgr_opacity', 04:39:05 INFO - 'tart', 04:39:05 INFO - 'tscrollx', 04:39:05 INFO - 'cart']}, 04:39:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:39:05 INFO - 'tests': ['tsvgx', 04:39:05 INFO - 'tsvgr_opacity', 04:39:05 INFO - 'tart', 04:39:05 INFO - 'tscrollx', 04:39:05 INFO - 'cart']}, 04:39:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:05 INFO - 'tests': ['tp5o']}, 04:39:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:05 INFO - 'talos_options': ['--e10s'], 04:39:05 INFO - 'tests': ['tp5o']}, 04:39:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:05 INFO - 'talos_options': ['--xperf_path', 04:39:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:05 INFO - 'tests': ['tp5n']}, 04:39:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:05 INFO - 'talos_options': ['--e10s', 04:39:05 INFO - '--xperf_path', 04:39:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:05 INFO - 'tests': ['tp5n']}}, 04:39:05 INFO - 'talos.zip': {'path': '', 04:39:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:39:05 INFO - Running post-action listener: _resource_record_post_action 04:39:05 INFO - ##### 04:39:05 INFO - ##### Running create-virtualenv step. 04:39:05 INFO - ##### 04:39:05 INFO - Running pre-action listener: _resource_record_pre_action 04:39:05 INFO - Running main action method: create_virtualenv 04:39:05 INFO - Creating virtualenv /builds/slave/test/build/venv 04:39:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:39:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:39:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:39:05 INFO - Using real prefix '/tools/python27' 04:39:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:39:06 INFO - Installing distribute.............................................................................................................................................................................................done. 04:39:09 INFO - Installing pip.................done. 04:39:09 INFO - Return code: 0 04:39:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:09 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 0x10e6c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf3945ae90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56ed30>, '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 0x10e391db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e564b20>, '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.sy3bz8CSEB/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.OScLpcq5MU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:39:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:39:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sy3bz8CSEB/Render', 04:39:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:09 INFO - 'HOME': '/Users/cltbld', 04:39:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:09 INFO - 'LOGNAME': 'cltbld', 04:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:09 INFO - 'MOZ_NO_REMOTE': '1', 04:39:09 INFO - 'NO_EM_RESTART': '1', 04:39:09 INFO - 'PAGER': '/bin/cat', 04:39:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:09 INFO - 'PWD': '/builds/slave/test', 04:39:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:09 INFO - 'SHELL': '/bin/bash', 04:39:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OScLpcq5MU/Listeners', 04:39:09 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:39:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:09 INFO - 'USER': 'cltbld', 04:39:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:09 INFO - 'XPC_FLAGS': '0x0', 04:39:09 INFO - 'XPC_SERVICE_NAME': '0', 04:39:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:39:09 INFO - Cleaning up... 04:39:09 INFO - Return code: 0 04:39:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:09 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 0x10e6c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf3945ae90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56ed30>, '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 0x10e391db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e564b20>, '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.sy3bz8CSEB/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.OScLpcq5MU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:39:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:39:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sy3bz8CSEB/Render', 04:39:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:09 INFO - 'HOME': '/Users/cltbld', 04:39:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:09 INFO - 'LOGNAME': 'cltbld', 04:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:09 INFO - 'MOZ_NO_REMOTE': '1', 04:39:09 INFO - 'NO_EM_RESTART': '1', 04:39:09 INFO - 'PAGER': '/bin/cat', 04:39:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:09 INFO - 'PWD': '/builds/slave/test', 04:39:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:09 INFO - 'SHELL': '/bin/bash', 04:39:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OScLpcq5MU/Listeners', 04:39:09 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:39:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:09 INFO - 'USER': 'cltbld', 04:39:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:09 INFO - 'XPC_FLAGS': '0x0', 04:39:09 INFO - 'XPC_SERVICE_NAME': '0', 04:39:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:09 INFO - Downloading/unpacking psutil>=0.7.1 04:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:39:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:12 INFO - Installing collected packages: psutil 04:39:12 INFO - Running setup.py install for psutil 04:39:12 INFO - building 'psutil._psutil_osx' extension 04:39:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:39:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:39:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:39:13 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:39:13 INFO - building 'psutil._psutil_posix' extension 04:39:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:39:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:39:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:39:13 INFO - ^ 04:39:13 INFO - 1 warning generated. 04:39:13 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:39:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:14 INFO - Successfully installed psutil 04:39:14 INFO - Cleaning up... 04:39:14 INFO - Return code: 0 04:39:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:39: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:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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', '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 0x10e6c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf3945ae90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56ed30>, '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 0x10e391db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e564b20>, '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.sy3bz8CSEB/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.OScLpcq5MU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:39: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 mozsystemmonitor==0.0.0 04:39:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sy3bz8CSEB/Render', 04:39:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:14 INFO - 'HOME': '/Users/cltbld', 04:39:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:14 INFO - 'LOGNAME': 'cltbld', 04:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:14 INFO - 'MOZ_NO_REMOTE': '1', 04:39:14 INFO - 'NO_EM_RESTART': '1', 04:39:14 INFO - 'PAGER': '/bin/cat', 04:39:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:14 INFO - 'PWD': '/builds/slave/test', 04:39:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:14 INFO - 'SHELL': '/bin/bash', 04:39:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OScLpcq5MU/Listeners', 04:39:14 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:39:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:14 INFO - 'USER': 'cltbld', 04:39:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:14 INFO - 'XPC_FLAGS': '0x0', 04:39:14 INFO - 'XPC_SERVICE_NAME': '0', 04:39:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:39: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:39: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:39: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:39: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:39: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:39: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:39:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:39:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:39:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:39:16 INFO - Installing collected packages: mozsystemmonitor 04:39:16 INFO - Running setup.py install for mozsystemmonitor 04:39:16 INFO - Successfully installed mozsystemmonitor 04:39:16 INFO - Cleaning up... 04:39:16 INFO - Return code: 0 04:39:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e6c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf3945ae90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56ed30>, '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 0x10e391db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e564b20>, '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.sy3bz8CSEB/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.OScLpcq5MU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:39:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sy3bz8CSEB/Render', 04:39:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:16 INFO - 'HOME': '/Users/cltbld', 04:39:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:16 INFO - 'LOGNAME': 'cltbld', 04:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:16 INFO - 'MOZ_NO_REMOTE': '1', 04:39:16 INFO - 'NO_EM_RESTART': '1', 04:39:16 INFO - 'PAGER': '/bin/cat', 04:39:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:16 INFO - 'PWD': '/builds/slave/test', 04:39:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:16 INFO - 'SHELL': '/bin/bash', 04:39:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OScLpcq5MU/Listeners', 04:39:16 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:39:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:16 INFO - 'USER': 'cltbld', 04:39:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:16 INFO - 'XPC_FLAGS': '0x0', 04:39:16 INFO - 'XPC_SERVICE_NAME': '0', 04:39:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:17 INFO - Downloading/unpacking blobuploader==1.2.4 04:39: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:39: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:39: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:39: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:39: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:39: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:39:19 INFO - Downloading blobuploader-1.2.4.tar.gz 04:39:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:39:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:39:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:20 INFO - Downloading docopt-0.6.1.tar.gz 04:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:39:20 INFO - Installing collected packages: blobuploader, requests, docopt 04:39:20 INFO - Running setup.py install for blobuploader 04:39:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:39:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:39:20 INFO - Running setup.py install for requests 04:39:21 INFO - Running setup.py install for docopt 04:39:21 INFO - Successfully installed blobuploader requests docopt 04:39:21 INFO - Cleaning up... 04:39:21 INFO - Return code: 0 04:39:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:21 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 0x10e6c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf3945ae90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56ed30>, '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 0x10e391db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e564b20>, '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.sy3bz8CSEB/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.OScLpcq5MU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:39:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sy3bz8CSEB/Render', 04:39:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:21 INFO - 'HOME': '/Users/cltbld', 04:39:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:21 INFO - 'LOGNAME': 'cltbld', 04:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:21 INFO - 'MOZ_NO_REMOTE': '1', 04:39:21 INFO - 'NO_EM_RESTART': '1', 04:39:21 INFO - 'PAGER': '/bin/cat', 04:39:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:21 INFO - 'PWD': '/builds/slave/test', 04:39:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:21 INFO - 'SHELL': '/bin/bash', 04:39:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OScLpcq5MU/Listeners', 04:39:21 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:39:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:21 INFO - 'USER': 'cltbld', 04:39:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:21 INFO - 'XPC_FLAGS': '0x0', 04:39:21 INFO - 'XPC_SERVICE_NAME': '0', 04:39:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:21 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-b2RXWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:21 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-zYgnr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:22 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-AjG8ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:22 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-x5Moow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:22 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-s8riKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:22 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-VksmCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:22 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-Ns5qOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:22 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-1dIEhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:22 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-4hhLnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:22 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-eJak_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:22 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-nOiuGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:22 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-ItyTJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:23 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-MCU6BG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:23 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-OPlxQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:23 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-q5ZRfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:23 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-QXIRFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:23 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-EwCEBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:39:23 INFO - Running setup.py install for manifestparser 04:39:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:39:23 INFO - Running setup.py install for mozcrash 04:39:23 INFO - Running setup.py install for mozdebug 04:39:24 INFO - Running setup.py install for mozdevice 04:39:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Running setup.py install for mozfile 04:39:24 INFO - Running setup.py install for mozhttpd 04:39:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Running setup.py install for mozinfo 04:39:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Running setup.py install for mozInstall 04:39:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Running setup.py install for mozleak 04:39:24 INFO - Running setup.py install for mozlog 04:39:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:39:25 INFO - Running setup.py install for moznetwork 04:39:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:39:25 INFO - Running setup.py install for mozprocess 04:39:25 INFO - Running setup.py install for mozprofile 04:39:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:39:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:39:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:39:25 INFO - Running setup.py install for mozrunner 04:39:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:39:25 INFO - Running setup.py install for mozscreenshot 04:39:25 INFO - Running setup.py install for moztest 04:39:25 INFO - Running setup.py install for mozversion 04:39:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:39:26 INFO - Cleaning up... 04:39:26 INFO - Return code: 0 04:39:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:26 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 0x10e6c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf3945ae90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56ed30>, '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 0x10e391db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e564b20>, '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.sy3bz8CSEB/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.OScLpcq5MU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:39:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:39:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sy3bz8CSEB/Render', 04:39:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:26 INFO - 'HOME': '/Users/cltbld', 04:39:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:26 INFO - 'LOGNAME': 'cltbld', 04:39:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:26 INFO - 'MOZ_NO_REMOTE': '1', 04:39:26 INFO - 'NO_EM_RESTART': '1', 04:39:26 INFO - 'PAGER': '/bin/cat', 04:39:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:26 INFO - 'PWD': '/builds/slave/test', 04:39:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:26 INFO - 'SHELL': '/bin/bash', 04:39:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OScLpcq5MU/Listeners', 04:39:26 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:39:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:26 INFO - 'USER': 'cltbld', 04:39:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:26 INFO - 'XPC_FLAGS': '0x0', 04:39:26 INFO - 'XPC_SERVICE_NAME': '0', 04:39:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:26 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-kOYfTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:26 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-hcd6Vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:26 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-Rib3Pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:26 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-z_nWGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:26 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-obiMLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:26 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-8jzya9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:27 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-Y9ax3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:27 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-gxxsin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:27 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-q4NEVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:27 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-QN9gPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:27 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-qOO6qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:27 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-gFgRC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:27 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-HfJqQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:27 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-szcO5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:27 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-InMtnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:28 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-Bu9c5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:28 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-9AwcKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:39:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39: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:39: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:39: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:39: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:39: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:39: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:39:30 INFO - Downloading blessings-1.6.tar.gz 04:39:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:39:30 INFO - Installing collected packages: blessings 04:39:30 INFO - Running setup.py install for blessings 04:39:30 INFO - Successfully installed blessings 04:39:30 INFO - Cleaning up... 04:39:30 INFO - Return code: 0 04:39:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:39:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:31 INFO - Reading from file tmpfile_stdout 04:39:31 INFO - Current package versions: 04:39:31 INFO - blessings == 1.6 04:39:31 INFO - blobuploader == 1.2.4 04:39:31 INFO - docopt == 0.6.1 04:39:31 INFO - manifestparser == 1.1 04:39:31 INFO - mozInstall == 1.12 04:39:31 INFO - mozcrash == 0.16 04:39:31 INFO - mozdebug == 0.1 04:39:31 INFO - mozdevice == 0.48 04:39:31 INFO - mozfile == 1.2 04:39:31 INFO - mozhttpd == 0.7 04:39:31 INFO - mozinfo == 0.9 04:39:31 INFO - mozleak == 0.1 04:39:31 INFO - mozlog == 3.1 04:39:31 INFO - moznetwork == 0.27 04:39:31 INFO - mozprocess == 0.22 04:39:31 INFO - mozprofile == 0.28 04:39:31 INFO - mozrunner == 6.11 04:39:31 INFO - mozscreenshot == 0.1 04:39:31 INFO - mozsystemmonitor == 0.0 04:39:31 INFO - moztest == 0.7 04:39:31 INFO - mozversion == 1.4 04:39:31 INFO - psutil == 3.1.1 04:39:31 INFO - requests == 1.2.3 04:39:31 INFO - wsgiref == 0.1.2 04:39:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39: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:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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:39:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:31 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 0x10e6c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf3945ae90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56ed30>, '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 0x10e391db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e564b20>, '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.sy3bz8CSEB/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.OScLpcq5MU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:39:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:39:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sy3bz8CSEB/Render', 04:39:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:31 INFO - 'HOME': '/Users/cltbld', 04:39:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:31 INFO - 'LOGNAME': 'cltbld', 04:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:31 INFO - 'MOZ_NO_REMOTE': '1', 04:39:31 INFO - 'NO_EM_RESTART': '1', 04:39:31 INFO - 'PAGER': '/bin/cat', 04:39:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:31 INFO - 'PWD': '/builds/slave/test', 04:39:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:31 INFO - 'SHELL': '/bin/bash', 04:39:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OScLpcq5MU/Listeners', 04:39:31 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:39:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:31 INFO - 'USER': 'cltbld', 04:39:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:31 INFO - 'XPC_FLAGS': '0x0', 04:39:31 INFO - 'XPC_SERVICE_NAME': '0', 04:39:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:39:31 INFO - Cleaning up... 04:39:31 INFO - Return code: 0 04:39:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:39: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:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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:39:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e6c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf3945ae90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56ed30>, '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 0x10e391db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e564b20>, '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.sy3bz8CSEB/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.OScLpcq5MU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39: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', 'jsonschema'] in /builds/slave/test/build 04:39: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 jsonschema 04:39:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sy3bz8CSEB/Render', 04:39:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:31 INFO - 'HOME': '/Users/cltbld', 04:39:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:31 INFO - 'LOGNAME': 'cltbld', 04:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:31 INFO - 'MOZ_NO_REMOTE': '1', 04:39:31 INFO - 'NO_EM_RESTART': '1', 04:39:31 INFO - 'PAGER': '/bin/cat', 04:39:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:31 INFO - 'PWD': '/builds/slave/test', 04:39:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:31 INFO - 'SHELL': '/bin/bash', 04:39:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OScLpcq5MU/Listeners', 04:39:31 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:39:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:31 INFO - 'USER': 'cltbld', 04:39:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:31 INFO - 'XPC_FLAGS': '0x0', 04:39:31 INFO - 'XPC_SERVICE_NAME': '0', 04:39:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:31 INFO - Downloading/unpacking jsonschema 04:39: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:39: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:39: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:39: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:39: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:39: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:39:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:39:34 INFO - Downloading/unpacking functools32 (from jsonschema) 04:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:34 INFO - Downloading functools32-3.2.3-2.tar.gz 04:39:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:39:34 INFO - warning: no files found matching '*.txt' 04:39:34 INFO - no previously-included directories found matching 'build' 04:39:34 INFO - no previously-included directories found matching 'dist' 04:39:34 INFO - no previously-included directories found matching '.git*' 04:39:34 INFO - Installing collected packages: jsonschema, functools32 04:39:34 INFO - Running setup.py install for functools32 04:39:34 INFO - warning: no files found matching '*.txt' 04:39:34 INFO - no previously-included directories found matching 'build' 04:39:34 INFO - no previously-included directories found matching 'dist' 04:39:34 INFO - no previously-included directories found matching '.git*' 04:39:34 INFO - Successfully installed jsonschema functools32 04:39:34 INFO - Cleaning up... 04:39:34 INFO - Return code: 0 04:39:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x10e6c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf3945ae90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56ed30>, '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 0x10e391db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e564b20>, '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.sy3bz8CSEB/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.OScLpcq5MU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:39:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sy3bz8CSEB/Render', 04:39:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:34 INFO - 'HOME': '/Users/cltbld', 04:39:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:34 INFO - 'LOGNAME': 'cltbld', 04:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:34 INFO - 'MOZ_NO_REMOTE': '1', 04:39:34 INFO - 'NO_EM_RESTART': '1', 04:39:34 INFO - 'PAGER': '/bin/cat', 04:39:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:34 INFO - 'PWD': '/builds/slave/test', 04:39:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:34 INFO - 'SHELL': '/bin/bash', 04:39:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OScLpcq5MU/Listeners', 04:39:34 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:39:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:34 INFO - 'USER': 'cltbld', 04:39:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:34 INFO - 'XPC_FLAGS': '0x0', 04:39:34 INFO - 'XPC_SERVICE_NAME': '0', 04:39:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:35 INFO - Downloading/unpacking flake8 04:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:39:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:39:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:39:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:38 INFO - no previously-included directories found matching 'docs/_build' 04:39:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:39:38 INFO - Running setup.py install for pep8 04:39:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:38 INFO - no previously-included directories found matching 'docs/_build' 04:39:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:39:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:39:38 INFO - Cleaning up... 04:39:38 INFO - Return code: 0 04:39:38 INFO - Running post-action listener: _resource_record_post_action 04:39:38 INFO - Running post-action listener: _start_resource_monitoring 04:39:38 INFO - Starting resource monitoring. 04:39:38 INFO - ##### 04:39:38 INFO - ##### Running install step. 04:39:38 INFO - ##### 04:39:38 INFO - Running pre-action listener: _resource_record_pre_action 04:39:38 INFO - Running main action method: install 04:39:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:39 INFO - Reading from file tmpfile_stdout 04:39:39 INFO - Detecting whether we're running mozinstall >=1.0... 04:39:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:39:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:39:39 INFO - Reading from file tmpfile_stdout 04:39:39 INFO - Output received: 04:39:39 INFO - Usage: mozinstall [options] installer 04:39:39 INFO - Options: 04:39:39 INFO - -h, --help show this help message and exit 04:39:39 INFO - -d DEST, --destination=DEST 04:39:39 INFO - Directory to install application into. [default: 04:39:39 INFO - "/builds/slave/test"] 04:39:39 INFO - --app=APP Application being installed. [default: firefox] 04:39:39 INFO - mkdir: /builds/slave/test/build/application 04:39:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:39:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:40:12 INFO - Reading from file tmpfile_stdout 04:40:12 INFO - Output received: 04:40:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:40:12 INFO - Running post-action listener: _resource_record_post_action 04:40:12 INFO - ##### 04:40:12 INFO - ##### Running run-tests step. 04:40:12 INFO - ##### 04:40:12 INFO - Running pre-action listener: _resource_record_pre_action 04:40:12 INFO - Running main action method: run_tests 04:40:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:40:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:40:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:40:12 INFO - 2016-02-06 04:40:12.825 screenresolution[1699:14123] starting screenresolution argv=screenresolution get 04:40:12 INFO - 2016-02-06 04:40:12.828 screenresolution[1699:14123] Display 0: 1600x1200x32@60 04:40:12 INFO - 2016-02-06 04:40:12.833 screenresolution[1700:14125] starting screenresolution argv=screenresolution list 04:40:12 INFO - Available Modes on Display 0 04:40:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:40:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:40:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:40:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:40:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:40:13 INFO - Intel Iris: 04:40:13 INFO - Chipset Model: Intel Iris 04:40:13 INFO - Type: GPU 04:40:13 INFO - Bus: Built-In 04:40:13 INFO - VRAM (Dynamic, Max): 1536 MB 04:40:13 INFO - Vendor: Intel (0x8086) 04:40:13 INFO - Device ID: 0x0a2e 04:40:13 INFO - Revision ID: 0x0009 04:40:13 INFO - Displays: 04:40:13 INFO - Display: 04:40:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:40:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:40:13 INFO - Display Serial Number: 1600x1200 60 04:40:13 INFO - Main Display: Yes 04:40:13 INFO - Mirror: Off 04:40:13 INFO - Online: Yes 04:40:13 INFO - Rotation: Supported 04:40:13 INFO - Return code: 0 04:40:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:40:13 INFO - Python 2.7.3 04:40:13 INFO - Return code: 0 04:40:13 INFO - grabbing minidump binary from tooltool 04:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:13 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 0x10e56ed30>, '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 0x10e391db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e564b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:40:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:40:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:40:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:40:13 INFO - Return code: 0 04:40:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:40:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:40:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:40:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:40:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:40:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:40:14 INFO - Return code: 0 04:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0129', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0129 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:40:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sy3bz8CSEB/Render', 04:40:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:14 INFO - 'HOME': '/Users/cltbld', 04:40:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:14 INFO - 'LOGNAME': 'cltbld', 04:40:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:40:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:14 INFO - 'MOZ_NO_REMOTE': '1', 04:40:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:40:14 INFO - 'NO_EM_RESTART': '1', 04:40:14 INFO - 'PAGER': '/bin/cat', 04:40:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:14 INFO - 'PWD': '/builds/slave/test', 04:40:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:40:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:14 INFO - 'SHELL': '/bin/bash', 04:40:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OScLpcq5MU/Listeners', 04:40:14 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 04:40:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:14 INFO - 'USER': 'cltbld', 04:40:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:14 INFO - 'XPC_FLAGS': '0x0', 04:40:14 INFO - 'XPC_SERVICE_NAME': '0', 04:40:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0129', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:40:14 INFO - mozversion application_buildid: 20160203075343 04:40:14 INFO - mozversion application_changeset: 46d6d868ba0f8ae089da8882b594fe359eba2978 04:40:14 INFO - mozversion application_display_name: Nightly 04:40:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:40:14 INFO - mozversion application_name: Firefox 04:40:14 INFO - mozversion application_remotingname: firefox 04:40:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:40:14 INFO - mozversion application_vendor: Mozilla 04:40:14 INFO - mozversion application_version: 47.0a1 04:40:14 INFO - mozversion platform_buildid: 20160203075343 04:40:14 INFO - mozversion platform_changeset: 46d6d868ba0f8ae089da8882b594fe359eba2978 04:40:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:40:14 INFO - mozversion platform_version: 47.0a1 04:40:14 INFO - using testdate: 1454762414 04:40:14 INFO - actual date: 1454762414 04:40:14 INFO - starting webserver on 'localhost:49268' 04:40:14 INFO - SUITE-START | Running 2 tests 04:40:14 INFO - TEST-START | dromaeo_css 04:40:14 INFO - operating with platform_type : mac_ 04:40:14 INFO - Initialising browser for dromaeo_css test... 04:40:14 INFO - TEST-INFO | started process 1718 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmpZiwXfg/profile http://localhost:49268/getInfo.html) 04:40:14 INFO - PROCESS | 1718 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:40:16 INFO - PROCESS | 1718 | __metrics Screen width/height:1600/1200 04:40:16 INFO - PROCESS | 1718 | colorDepth:24 04:40:16 INFO - PROCESS | 1718 | Browser inner width/height: 1024/689 04:40:16 INFO - PROCESS | 1718 | __metrics 04:40:17 INFO - PROCESS | 1718 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:40:17 INFO - PROCESS | 1718 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:40:17 INFO - TEST-INFO | 1718: exit 0 04:40:17 INFO - Browser initialized. 04:40:17 INFO - Running cycle 1/1 for dromaeo_css test... 04:40:17 INFO - TEST-INFO | started process 1722 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmpZiwXfg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:29 INFO - PROCESS | 1722 | RSS: Main: 242802688 04:40:29 INFO - PROCESS | 1722 | 04:41:20 INFO - PROCESS | 1722 | 1454762480604 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:43:31 INFO - PROCESS | 1722 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 04:43:32 INFO - PROCESS | 1722 | RSS: Main: 388268032 04:43:32 INFO - PROCESS | 1722 | 04:46:35 INFO - PROCESS | 1722 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 04:46:36 INFO - PROCESS | 1722 | RSS: Main: 377786368 04:46:36 INFO - PROCESS | 1722 | 04:49:38 INFO - PROCESS | 1722 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 04:49:38 INFO - PROCESS | 1722 | RSS: Main: 379461632 04:49:38 INFO - PROCESS | 1722 | 04:52:41 INFO - PROCESS | 1722 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 04:52:41 INFO - PROCESS | 1722 | RSS: Main: 340779008 04:52:41 INFO - PROCESS | 1722 | 04:55:44 INFO - PROCESS | 1722 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 04:55:45 INFO - PROCESS | 1722 | RSS: Main: 338477056 04:55:45 INFO - PROCESS | 1722 | 04:58:48 INFO - PROCESS | 1722 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 04:58:48 INFO - PROCESS | 1722 | RSS: Main: 424411136 04:58:48 INFO - PROCESS | 1722 | 04:58:48 INFO - PROCESS | 1722 | __start_tp_report 04:58:48 INFO - PROCESS | 1722 | _x_x_mozilla_page_load 04:58:48 INFO - PROCESS | 1722 | _x_x_mozilla_page_load_details 04:58:48 INFO - PROCESS | 1722 | |i|pagename|runs| 04:58:48 INFO - PROCESS | 1722 | |0;dojo.html;3408.6591340865907;3462.4979377990176;3492.63327350628;3502.509648649189;3531.240783231605;5544.750486228119;5635.971820140899;5662.943370566293;5668.716564171796;5673.858153546158;5578.776848926038;5634.830955071344;5642.15367694846;5643;5643.661380317184;5116.999999999991;5140;5166.018456493254;5188.247704082905;5232.947670523303;5258.815941442051;5258.973705131469;5261.631685781997;5264.684118952856;5279.5512381447625;5219.973900130494;5225.451327610604;5225.921611175835;5235.319408476893;5243.580513558925;5201.2458193561915;5224.529792318691;5224.52979231871;5239.73801309933;5251;4276.31578947367;5131.794728210867;5236.24074509194;5247.895042099137;5269.86825329366;5599.832005039855;5641.323041235037;5652.34997975234;5656.8020119295625;5659.405762394971;6148.907766383508;6160.0759886017;6177.66022868742;6180.752769889199;6185.876282474325;6138.263408390977;6150.446459818638;6201.87596248077;6207.162033125515;6303.590266632654;5745.827625171251;5754.510866576305;5764.855878603026;5771.105478650816;5786.971065144648;6296.811095667045;6312.116303717483;6324.810255692337;6334.144890439824;6337.302896681362;6018.398160183947;6092.603980741238;6108.908366374508;6122.602030867979;6168.290646575611;6251.593646412968;6275.02737075754;6281.246250449975;6294.307626161119;6299.716512756937;6123.663198524124;6220.222472190976;6229.4393504584805;6230.906536401958;6231;5394.298741163623;6101.420365065312;6155.938440615537;6159.137720719103;6274.1843560337775;4840.951590484121;4884.633652476078;4892.706437613754;4894.632902532253;4929.802807887716;4364.323529852878;4366.3013917773005;4381.058072514425;4391.626711729475;4420.513743488214;5598.552115830806;5682.516986056232;5695.914561281584;5701.743421546041;5785.479306862402;6243.500519958392;6277.7175027123885;6281.842953926097;6296.118543403927;6300.59046161998;5749.223854779635;5753.913691294634;5756.992526307879;5760.884782304331;5785.363610002896;5218.399884013387;5242.318498595235;5282.445343238982;5303.549198318186;5376.166694162411;5257.474252574789;6278.623282603058;6282.434580887651;6285.905711414424;6312.084747711556;6264.59280146789;6269.247690277196;6276.435120839146;6284.748610055546;6285.905711414241;6213.440790328892;6237.625742455467;6259.624422534663;6304.085907543289;6312.495000399865;6154.753809847556;6157.907631385622;6165.106059621419;6168.9691551541955;6184.567080304516;6209.099680546386;6217.626942383471;6254.28075771274;6285.560010799383;6291.307956124731;5801.535877129735;5933.792317268875;6004.489618382312;6076.361981991828;6093.634381937098;6052.636841789506;6053.909191362045;6077.118817771487;6086.239220097488;6090.969545152246;5842.824715258549;5865.882682346414;5871.295444546682;5875.059990401515;5879.94120058811;5945.494632956247;6014.188084608521;6035.668038257762;6057.4851137653795;6068.059450785136;5839.35767065614;5890.410958904246;5903.940960590339;5909.674967876808;5949.315828679757 04:58:48 INFO - PROCESS | 1722 | |1;ext.html;490.8846421091045;525.8720045502397;550.7989583801913;579.2759051186017;659.3241927024801;29816;38129;38472.23055538887;38495;38560.80719596405;40695.38956915648;41000.769976900665;41063.973400664996;41075;41107.38338924918;9478.336516443835;9665.4200747955;9672.70981870545;9688.224942004657;9689.90310096897;9407;9558.426494410323;9565.808683826353;9608.135267825894;9684.854727179098;9610.90389096107;9691.370060946016;9711;9714.319997600136;9729;9571.138597526222;9643.27675424339;9651.613935442574;9655.420674759467;9662.275329350257;9583.424994500352;9754.0733630305;9760.365576237522;9773.902260977371;9791.118799308097;38928;39231.80384098061;39324.41013384802;39326.410103848466;39354.40968385476;3155.2269693924904;3200.423923693734;3293.127321259868;3392.372411103929;3514.9297014059575;27916.720832791616;28267.293317667016;28652.283692907637;28653.570196447068;28932.42135157285;2753.160286112735;2768.792340574465;2829.7028811974856;2857.4713677969435;2954.6158999330164;476643;479861;480204;480240;480361;52875.47124528782;53571.732141339045;53728.194077088876;58013.70993145092;61847;59571.702141489885;59862.401375986556;60146.39853601495;60165.69917150386;60179.39820601738;15873.603159920864;16016.519504414886;16085.678286434206;16099.919500402422;16105.114218717848;11460.484278207501;11654.53381864733;11683.182177247681;12476.937615311865;12731.93634031824;18679.346222882134;18767.624647507248;18776.906115469334;18801.905990470234;18827.15277812502;6520.510961677893;6639.502037347122;7266.781996540112;7995.68017279314;8178.754637360769;938.4932136646271;978.5303054533864;1020.3316827478013;1097.155190503308;1120.9271397359146;28859.567106493418;28916.855415723207;29358.706412935597;29529.85235073811;29547.965821196154;1106.286445242814;1140.6692059302875;1151.861776586815;1171.2679575265458;1172.2731906218028;14724.969252152461;14743.483978060716;14981.70036599262;15063;15118.017328873588;494710;499117;499642;501106.3838296926;501761;55834.720826395605;55891.72054139703;55964;56064.878702425725;56268;1379.8551152128882;1393.686420555367;1409.457358916804;1416.624594482463;1417.1284659934067;25219;28454.715452846034;28700.282492937844;29378.853105734335;29742.553861692526;47781.76109119432;49164.262536062706;49180.75409622929;49184.50815491942;49190.508094918594;461639;465533.344666549;499394;509849;632063;29607;29640.258993525335;29728.554071688508;29863.85068074646;29874;41372.1725565493;41902;41966.370504441846;42243.94390140271;43194.70415887528;35102;35504.82247588849;35730.64269357273;36067;36078;34797.47803782894;35475.11312217215;35651.82174089113;35697.82151089228;35821.641783582876;34635.307293853475;35352.762653307014;35524.64475355317;35619;35712.464313035845;25090.240073591525;31157.68842311548;31294.843525782224;31316.217094571908;31716.524252135776;19817.81093134359;23832.642510362704;24219.03123875096;24363.75636243615;24988.75011249864 04:58:48 INFO - PROCESS | 1722 | |2;jquery.html;296.5862621642808;364.2496457297968;365.3715609152258;366.57843479998;371.392772816445;14876.702465950675;15194.088354698726;18643.533911652215;19426.1258243379;19963.10166042528;15794.684106317867;18694;19252.614947701037;20051.799482005175;20104.69842952357;5616.85957851055;5649.519790817785;5795.420457954213;5827.912581311284;5844.853878653025;4148.087420767426;4348.260795664744;4359.2589259825745;5758.510526605243;5846.181534585162;6025.668588227646;6067.787627433041;6312.558120931513;6321.0834429008;6325.5255855810765;6317.368263173692;6332.986722124461;6378.681065946684;6417.294097649255;6428.967855160741;5502.614816962814;5553.888922221573;5561.165825126223;5567.47109024642;5570.777168913239;23314.950827212815;23844.64233036506;24255.514889702106;24480;24612.630810537856;1949.892755898425;2096.842736794731;2248.4940888300166;2445.168642661504;2903.941921161586;9560.952195238979;9634.662786802428;9812.116909478109;9893.060159284856;9901.752456188653;1672.4230140601474;1704.582377317565;1743;1774.1661419133115;1781.118346418531;84793.57603212007;86484.56757716234;86604.56697716533;88095;88178.67731984025;10322.741931451774;10602.522886470128;10721.195910306758;10726.785464290826;10773.946130269298;12727.427265773062;12814.231146131262;12848.678783030498;12851.742965140646;12858.871411285767;8197.877031844528;8207.343412526983;8215.34277257818;8287.585620718939;8287.62705678246;8373.49759014461;8411.53736544496;8449.746507604781;8486.236238738544;8511.702090426805;4302.118065796567;4411.7573533455325;4418.0059486615255;4420.31485119807;4470.530594287618;1411.5200831717266;1643.0716645095483;1731.2901710298718;1826.4794533558138;1871.223442271442;811.9350451963828;832.937529685276;917.9941827107791;976.1739763385102;998.7453199434098;18931.716024259647;19048.619027619647;19063.332783352515;19261.22955081809;19587.706184407245;693.8334799648048;741.610654406441;861.5562985062572;887.7381172554112;960.0831206198064;10158.441285729208;10197.13324367437;10250.897491024994;10262.640807571848;10311.278210525192;725921;734597;743670;746054;755379;112445;112485;112689.87310126793;114618.4269078666;117250.41374793243;1126.6000569797768;1180.221054104287;1187.7268228307537;1190.3215167354697;1192.284629222477;17185.484435466955;17449.476515704548;17517.299308028047;17865.73201401954;18069.096545172426;48994.755026224644;49856.50143498664;50091.49908500868;50387.49612503975;50560.28108344174;66258;68793.65603171953;69833;70415.64792176211;70672;5879.7060146993335;7501.962490187514;7658.885116723142;7670.463067585216;7875.094364147967;10559.472026398496;11614.361210133186;11923.224990375598;11969.64091077269;12172.45223964906;9202.447853128833;9981.800363992825;10008.799824003625;10211.540480678535;10405.219608529542;7123.7889558774095;9995.70012899614;10177.592896284066;10251.794964100825;10321.948390258001;7798.805029874298;9810.773653293338;10121.69634910954;10262.794744105226;10426.843597345895;7522.134954480305;7612.162662107275;7612.733554325793;7636.656350464132;7651.693932242648;8401.873971890303;10265.332753371007;10389.84415233757;10428.322159059637;10433.426161561187 04:58:48 INFO - PROCESS | 1722 | |3;mootools.html;1403.9929800350997;1531.9923400382997;1556.2607761313375;1783.9108044597767;1934.8935808530525;7996.480228785133;8204.015518137825;8606.61270242839;8767.912320876789;8768.473891566511;8603.139686031394;8639.308855291578;8766.780830479242;8771.605277762501;8772.254358379545;2185.3771675072608;2234.7988681018705;2492.5887228607257;2525.1793167220635;2537.847729136258;2260.8982595783227;2275.943101422469;2278.6695929090274;2473.3445636906145;2534.8605826679527;2458.5820410530164;2485.763852434016;2488.464980029293;2489.614109812982;2493.1523282084086;2493.3891196656755;2520.4329025969196;2521.319243804181;2521.911733089333;2523.2430270918835;1918.414883460544;2193.649016157407;2252.7747225277503;2456.361346050022;2532.556802559545;8600;8688.131186881325;8694.826103477959;8702.129787021311;8702.825943481159;5304.124819404794;5436.075867102562;5440.619156659035;5464.590155738336;5474.945250547484;3620.674139327447;3675.2833197526493;3729.8881033569037;3757.436384542313;3769.4722738816586;1036.6734478639205;1051.332403923514;1057.6245432871297;1082.6319051522441;1088.1240601315938;12208.450619722134;12280.631581052583;12287.56993505232;12298.877011229952;12310.13829031968;4855.465898751135;4960.925586116211;5053.69677819332;5055.368078990126;5062.012907483079;10323.432211228455;10347.482625868677;10358.912314207051;10362.533685984148;10364.792704145875;5549.417311182348;5570.97214513933;5578.553715702734;5584.246126772915;5585.078462053797;4947.455779864212;5034.295198672189;5034.8237811677145;5045.823396181116;5077.847664570068;3326.6673332667024;3965.7025723070883;3974.28462876685;4002.1595464952684;4032.7781971991235;1309.1163464661315;1314.4413624209672;1322;1327.0710502648185;1328.7209685965863;1231.3658465890073;1291.180100636084;1293.5213970830853;1334.5862782537445;1361.857005014479;7982.560959147187;8063.516189028677;8186.2632363087605;8221.17788221173;8253.628586713612;511.60606333123286;518.2226660009985;526.5287567627029;526.6418835192029;527.4725274725274;6012.729427175787;6082.543809214327;6131.172291740647;6232.626042437469;6263.154474146023;9691.612335506641;10568.682939511827;10658.253922225369;10659.040686338112;10666.14670826332;10082.848757268646;10477.31897426665;10525.631602893862;10530.473476326306;10536.473176341306;8041.919580804117;8161.277175263666;8231.753047408587;8255.009398872053;8263.669453221804;8095;8214.58927053633;8215.671373145007;8219.83560328802;8228.753137405887;9550.856737149088;9572.90427095748;9722.125008749246;9926.404415735078;9927.702168934655;9318.72043838686;9991.550380232762;10062;10223.897761022592;10242.334248273839;6677.632730199885;7614.428917831074;7619.314261716472;7620.80947976305;7635.503692259986;8104.959475202586;8173.427860049739;8212.671493140208;8262.545559994018;8272.793180170544;7761.495502792301;7809.882851757115;7822.217778222132;7894.802629934297;7932.484388514728;7671.616419178907;7698.92301076982;7708.614569271626;7813.10149332834;7817.804554886174;7558.773236802905;7573.583452910143;7637.389008879388;7666.041744781903;7672.424568157299;7081.18566364854;7114.1463024435325;7159.534630249017;7163.570185788869;7168.928310717035;6884.793456196322;7134.643267836691;7147.571145731273;7160.997460355658;7214.71141154348 04:58:48 INFO - PROCESS | 1722 | |4;prototype.html;319.47924882441623;325.094611506953;332.1530098249465;333.34165024077436;336.32231054425324;6612.504062195337;6629.701663425145;6687.49843761718;6761.2224594171685;6787.966060169692;6636.303188165233;6642.368974947372;6660.333966603337;6664.2002959644915;6672.299408562104;4275.700700950934;4783.536478713465;4833.25084611884;4981.576565991895;4994.950050499503;3990.4014397840265;4937.259411088329;4958.727270000149;4993.600511959053;5005.124103281929;4887.560119589236;4898.7305698186765;4911.238757992499;4927.556519913207;4934.777934992934;4653.185692503798;4733.786979585927;4749.168895443318;4928.383952005999;4934.9013019739405;4040.4747382840337;4051.311277082903;4062.939055914164;4064.3700226464944;4067.5118985721606;5007.4992500749995;6292.748290068392;6332.271788744308;6333;6347.714352854086;5529.170624406331;5666.603337766358;5673.801416950387;5679.886402271932;5687.943120568824;5438.619296649236;5987.311459182162;6329.607486352995;6798.762043328509;6930.27232140623;4603.10239503297;4705.505921878188;4709.952900470986;4718.4809670936165;4720.57514823664;7443.2556744325675;7482.064741907262;7482.139553951365;7485.1017877854465;7491.175970643225;4649.69776964503;4773.713577185311;4791.401074865642;4793.376861008116;4827.686200396963;4884.438289596671;4899.1426500362295;4899.926501102486;4906.779194936236;4909.901801963941;5748.080307150836;5763.250777398911;5765.4811067004175;5767.509761670305;5774.48029677331;6862.553933994374;7092.751753688596;7096.219415864251;7105.396041336544;7114.181869085121;1632.795900512436;1634.6076941534184;1634.8882759723501;1635.1088656682136;1642.3758971590958;1098.6154845803906;1099.1591432554103;1113.6547670222258;1124.8875112488686;1125.707316097804;6725.159355080615;6726.562773419712;6734.0572319875255;6740.528163028639;6797.694103765342;5959.851003724855;7297.306755858185;7348;7356.595387253646;7359;5727.76852976612;6441.3880681335195;6496.577722448026;6657.700403481855;6679;3176.09481297829;3863.0149311925843;3892.727509074394;3894.201688653819;3906.7655940643654;6114.419130182626;7663.157052724196;7671.53970761756;7673.693052277847;7702.845943081107;7325.194228634846;7529.058867641545;7540.9622951884885;7559.924400755922;7574.962125189339;6060.636361818305;7374.2994415529365;7644.732434364771;7650.38796896247;7662.387009039375;7204.423646108194;7337.669804858688;7367.115946086504;7392.002079719169;7402.33378995893;7004.894926576004;7224.602646854473;7280.1991780903;7282.890756638761;7295.744648937261;6275.96862015687;7457.440691948017;7698.153203147761;7723.845523089619;7731.92268077312;4803.927941080957;4822.7829747660735;4829.13075646387;4833.516648335139;4834.661573689808;7306.196318405077;7317.0487836580905;7323.63381830917;7323.8535229296185;7335.889961650686;6849.8972515411315;7135.821604459722;7161.319674630901;7181.640917954186;7196.712131514891;7163.997040414451;7168.319009694071;7171.569705817667;7172.856542869218;7180.748673796392;6688.264290928091;6968.895466567904;6970.954356846513;6975.895361569682;6997.7200911962955;7054.294570542905;7054.6472676367;7061.329173728487;7080.858382832417;7132.821679458055;6961.025456436002;6967.059446974797;6974.7210111597;6990.126234220723;6995.230524642387 04:58:48 INFO - PROCESS | 1722 | |5;yui.html;681.7988693335466;696.4579285607532;703.4477934821164;725.1624373848207;757.1103952855393;14961.625959351008;15115.093094414315;15153.772693409608;15165.620859478518;15167;13562.45750169992;15241.161736104537;15578.987365821215;15596.454124105658;15644.921775391107;705.14677240539;710.2400431538256;838.3586556284447;869.8216865542548;877.7586163804941;702.3257672634252;854.5599016506504;884.8628462588309;886.175856453498;887.5473508510673;902.9954850225739;922.0042354257386;922.7646950027734;922.8108237811266;925.9537023148849;739;749.4528993834476;751.4138971602159;906.8141031088611;918.4994178172911;669.6785542939416;677.9830504237384;678.3589507915023;678.7556479667315;680.2721088435376;14973.326200321011;15038.097714137077;15046.473373431878;15053.623659408493;15057.924710376488;10137.594496220143;12782.360881955958;12935.87064129356;13214.66963325915;13425.127366721132;10366.585336586528;11127.33236005834;11150.832737508943;11280.041196498307;12036;3141.3246152077186;3616.8914932552066;3698;3718.0890681782867;3732.1789206374556;74519;75091.99999999945;75128.62435687786;75197.6240118796;75245.62377188134;9322.1610055094;9478.763030924281;9526.99966503521;9768.755781105387;9974.40153590787;21676;21844.126234950425;21850.781492185193;21852.125914963224;21866.562668746537;7354.154272258652;7385.8153546161775;7389.371903388164;7512.060992375953;7583.886241706379;4066.512018557792;4091.5499295077516;4107.260693075275;4120.278951183531;4123.628873401408;3561.198730285665;3642.4900513928073;3644.3804553226014;3645.2709458108484;3647.908802279964;589.9292084949748;683.2962049089446;690.0373978300244;717.4511498703496;718.2745427118543;546.9507744303032;566.396787421395;629.3580547841268;632.2581288550015;632.5666918161074;8335.541545215072;8364.121767214476;8479.236868681848;8651.95674021626;8695.043545210021;541.196323459662;550.5705549671263;606.805822136912;610.2432983101012;622.822495588755;3300;3732.088970602934;4224.471941007374;4289.091354347348;4311.223979683625;88229.67655485173;89178.55410723035;89702;90093;91077;75674.86487702689;76295.23704762882;76382.61808691033;76856;78069.2193078062;67064.69240610542;67702.3229767696;68154.65922670453;68357.31642683609;69208;7755.883661745192;8832.470051796912;8870.512121833102;8902.109789021046;8930.821383572422;47099.29351059805;47338.28992565183;47353.52646473629;48000.27999579939;48526.51473485361;65501;65824;66511.33488665051;66524.66737666281;67900.6604966972;10966.342019478856;11186.384748838893;11253.381064041556;11271.830922536332;11654.242474239147;12104.688120778845;12149.967252783612;12188.390580470763;12214.26714397139;12874.420651070912;11523.942380288381;11552.59565915189;11678.124140689313;11974.22167559106;12312.630621081382;10496.895031049897;11196.496157672762;11767.352795596324;11849;11851.703707407383;10597.62908298206;10672.359658420519;11070.612528561784;11389.829152562552;11619.01238394746;9441.669541566012;9657.236940577814;9673.226141908772;9690.806183876142;9831.655892043744;7073.434125270069;8343.249107580346;8930;9014.459132452073;9409.858852117086 04:58:48 INFO - PROCESS | 1722 | __end_tp_report 04:58:48 INFO - PROCESS | 1722 | __start_cc_report 04:58:48 INFO - PROCESS | 1722 | _x_x_mozilla_cycle_collect,1352 04:58:48 INFO - PROCESS | 1722 | __end_cc_report 04:58:48 INFO - PROCESS | 1722 | __startTimestamp1454763528349__endTimestamp 04:58:48 INFO - PROCESS | 1722 | 04:58:48 INFO - PROCESS | 1722 | ------- Summary: start ------- 04:58:48 INFO - PROCESS | 1722 | Number of tests: 6 04:58:48 INFO - PROCESS | 1722 | 04:58:48 INFO - PROCESS | 1722 | [#0] dojo.html Cycles:165 Average:5713.73 Median:5875.06 stddev:631.60 (10.8%) stddev-sans-first:607.10 04:58:48 INFO - PROCESS | 1722 | Values: 3408.7 3462.5 3492.6 3502.5 3531.2 5544.8 5636.0 5662.9 5668.7 5673.9 5578.8 5634.8 5642.2 5643.0 5643.7 5117.0 5140.0 5166.0 5188.2 5232.9 5258.8 5259.0 5261.6 5264.7 5279.6 5220.0 5225.5 5225.9 5235.3 5243.6 5201.2 5224.5 5224.5 5239.7 5251.0 4276.3 5131.8 5236.2 5247.9 5269.9 5599.8 5641.3 5652.3 5656.8 5659.4 6148.9 6160.1 6177.7 6180.8 6185.9 6138.3 6150.4 6201.9 6207.2 6303.6 5745.8 5754.5 5764.9 5771.1 5787.0 6296.8 6312.1 6324.8 6334.1 6337.3 6018.4 6092.6 6108.9 6122.6 6168.3 6251.6 6275.0 6281.2 6294.3 6299.7 6123.7 6220.2 6229.4 6230.9 6231.0 5394.3 6101.4 6155.9 6159.1 6274.2 4841.0 4884.6 4892.7 4894.6 4929.8 4364.3 4366.3 4381.1 4391.6 4420.5 5598.6 5682.5 5695.9 5701.7 5785.5 6243.5 6277.7 6281.8 6296.1 6300.6 5749.2 5753.9 5757.0 5760.9 5785.4 5218.4 5242.3 5282.4 5303.5 5376.2 5257.5 6278.6 6282.4 6285.9 6312.1 6264.6 6269.2 6276.4 6284.7 6285.9 6213.4 6237.6 6259.6 6304.1 6312.5 6154.8 6157.9 6165.1 6169.0 6184.6 6209.1 6217.6 6254.3 6285.6 6291.3 5801.5 5933.8 6004.5 6076.4 6093.6 6052.6 6053.9 6077.1 6086.2 6091.0 5842.8 5865.9 5871.3 5875.1 5879.9 5945.5 6014.2 6035.7 6057.5 6068.1 5839.4 5890.4 5903.9 5909.7 5949.3 04:58:48 INFO - PROCESS | 1722 | 04:58:48 INFO - PROCESS | 1722 | [#1] ext.html Cycles:180 Average:63218.44 Median:38483.62 stddev:132843.11 (345.2%) stddev-sans-first:133132.29 04:58:48 INFO - PROCESS | 1722 | Values: 490.9 525.9 550.8 579.3 659.3 29816.0 38129.0 38472.2 38495.0 38560.8 40695.4 41000.8 41064.0 41075.0 41107.4 9478.3 9665.4 9672.7 9688.2 9689.9 9407.0 9558.4 9565.8 9608.1 9684.9 9610.9 9691.4 9711.0 9714.3 9729.0 9571.1 9643.3 9651.6 9655.4 9662.3 9583.4 9754.1 9760.4 9773.9 9791.1 38928.0 39231.8 39324.4 39326.4 39354.4 3155.2 3200.4 3293.1 3392.4 3514.9 27916.7 28267.3 28652.3 28653.6 28932.4 2753.2 2768.8 2829.7 2857.5 2954.6 476643.0 479861.0 480204.0 480240.0 480361.0 52875.5 53571.7 53728.2 58013.7 61847.0 59571.7 59862.4 60146.4 60165.7 60179.4 15873.6 16016.5 16085.7 16099.9 16105.1 11460.5 11654.5 11683.2 12476.9 12731.9 18679.3 18767.6 18776.9 18801.9 18827.2 6520.5 6639.5 7266.8 7995.7 8178.8 938.5 978.5 1020.3 1097.2 1120.9 28859.6 28916.9 29358.7 29529.9 29548.0 1106.3 1140.7 1151.9 1171.3 1172.3 14725.0 14743.5 14981.7 15063.0 15118.0 494710.0 499117.0 499642.0 501106.4 501761.0 55834.7 55891.7 55964.0 56064.9 56268.0 1379.9 1393.7 1409.5 1416.6 1417.1 25219.0 28454.7 28700.3 29378.9 29742.6 47781.8 49164.3 49180.8 49184.5 49190.5 461639.0 465533.3 499394.0 509849.0 632063.0 29607.0 29640.3 29728.6 29863.9 29874.0 41372.2 41902.0 41966.4 42243.9 43194.7 35102.0 35504.8 35730.6 36067.0 36078.0 34797.5 35475.1 35651.8 35697.8 35821.6 34635.3 35352.8 35524.6 35619.0 35712.5 25090.2 31157.7 31294.8 31316.2 31716.5 19817.8 23832.6 24219.0 24363.8 24988.8 04:58:48 INFO - PROCESS | 1722 | 04:58:48 INFO - PROCESS | 1722 | [#2] jquery.html Cycles:180 Average:36845.48 Median:4353.76 stddev:121866.62 (2799.1%) stddev-sans-first:122177.59 04:58:48 INFO - PROCESS | 1722 | Values: 296.6 364.2 365.4 366.6 371.4 14876.7 15194.1 18643.5 19426.1 19963.1 15794.7 18694.0 19252.6 20051.8 20104.7 5616.9 5649.5 5795.4 5827.9 5844.9 4148.1 4348.3 4359.3 5758.5 5846.2 6025.7 6067.8 6312.6 6321.1 6325.5 6317.4 6333.0 6378.7 6417.3 6429.0 5502.6 5553.9 5561.2 5567.5 5570.8 23315.0 23844.6 24255.5 24480.0 24612.6 1949.9 2096.8 2248.5 2445.2 2903.9 9561.0 9634.7 9812.1 9893.1 9901.8 1672.4 1704.6 1743.0 1774.2 1781.1 84793.6 86484.6 86604.6 88095.0 88178.7 10322.7 10602.5 10721.2 10726.8 10773.9 12727.4 12814.2 12848.7 12851.7 12858.9 8197.9 8207.3 8215.3 8287.6 8287.6 8373.5 8411.5 8449.7 8486.2 8511.7 4302.1 4411.8 4418.0 4420.3 4470.5 1411.5 1643.1 1731.3 1826.5 1871.2 811.9 832.9 918.0 976.2 998.7 18931.7 19048.6 19063.3 19261.2 19587.7 693.8 741.6 861.6 887.7 960.1 10158.4 10197.1 10250.9 10262.6 10311.3 725921.0 734597.0 743670.0 746054.0 755379.0 112445.0 112485.0 112689.9 114618.4 117250.4 1126.6 1180.2 1187.7 1190.3 1192.3 17185.5 17449.5 17517.3 17865.7 18069.1 48994.8 49856.5 50091.5 50387.5 50560.3 66258.0 68793.7 69833.0 70415.6 70672.0 5879.7 7502.0 7658.9 7670.5 7875.1 10559.5 11614.4 11923.2 11969.6 12172.5 9202.4 9981.8 10008.8 10211.5 10405.2 7123.8 9995.7 10177.6 10251.8 10321.9 7798.8 9810.8 10121.7 10262.8 10426.8 7522.1 7612.2 7612.7 7636.7 7651.7 8401.9 10265.3 10389.8 10428.3 10433.4 04:58:48 INFO - PROCESS | 1722 | 04:58:48 INFO - PROCESS | 1722 | [#3] mootools.html Cycles:180 Average:6091.97 Median:527.06 stddev:3239.07 (614.6%) stddev-sans-first:3228.99 04:58:48 INFO - PROCESS | 1722 | Values: 1404.0 1532.0 1556.3 1783.9 1934.9 7996.5 8204.0 8606.6 8767.9 8768.5 8603.1 8639.3 8766.8 8771.6 8772.3 2185.4 2234.8 2492.6 2525.2 2537.8 2260.9 2275.9 2278.7 2473.3 2534.9 2458.6 2485.8 2488.5 2489.6 2493.2 2493.4 2520.4 2521.3 2521.9 2523.2 1918.4 2193.6 2252.8 2456.4 2532.6 8600.0 8688.1 8694.8 8702.1 8702.8 5304.1 5436.1 5440.6 5464.6 5474.9 3620.7 3675.3 3729.9 3757.4 3769.5 1036.7 1051.3 1057.6 1082.6 1088.1 12208.5 12280.6 12287.6 12298.9 12310.1 4855.5 4960.9 5053.7 5055.4 5062.0 10323.4 10347.5 10358.9 10362.5 10364.8 5549.4 5571.0 5578.6 5584.2 5585.1 4947.5 5034.3 5034.8 5045.8 5077.8 3326.7 3965.7 3974.3 4002.2 4032.8 1309.1 1314.4 1322.0 1327.1 1328.7 1231.4 1291.2 1293.5 1334.6 1361.9 7982.6 8063.5 8186.3 8221.2 8253.6 511.6 518.2 526.5 526.6 527.5 6012.7 6082.5 6131.2 6232.6 6263.2 9691.6 10568.7 10658.3 10659.0 10666.1 10082.8 10477.3 10525.6 10530.5 10536.5 8041.9 8161.3 8231.8 8255.0 8263.7 8095.0 8214.6 8215.7 8219.8 8228.8 9550.9 9572.9 9722.1 9926.4 9927.7 9318.7 9991.6 10062.0 10223.9 10242.3 6677.6 7614.4 7619.3 7620.8 7635.5 8105.0 8173.4 8212.7 8262.5 8272.8 7761.5 7809.9 7822.2 7894.8 7932.5 7671.6 7698.9 7708.6 7813.1 7817.8 7558.8 7573.6 7637.4 7666.0 7672.4 7081.2 7114.1 7159.5 7163.6 7168.9 6884.8 7134.6 7147.6 7161.0 7214.7 04:58:48 INFO - PROCESS | 1722 | 04:58:48 INFO - PROCESS | 1722 | [#4] prototype.html Cycles:180 Average:5773.56 Median:6621.10 stddev:1835.44 (27.7%) stddev-sans-first:1794.36 04:58:48 INFO - PROCESS | 1722 | Values: 319.5 325.1 332.2 333.3 336.3 6612.5 6629.7 6687.5 6761.2 6788.0 6636.3 6642.4 6660.3 6664.2 6672.3 4275.7 4783.5 4833.3 4981.6 4995.0 3990.4 4937.3 4958.7 4993.6 5005.1 4887.6 4898.7 4911.2 4927.6 4934.8 4653.2 4733.8 4749.2 4928.4 4934.9 4040.5 4051.3 4062.9 4064.4 4067.5 5007.5 6292.7 6332.3 6333.0 6347.7 5529.2 5666.6 5673.8 5679.9 5687.9 5438.6 5987.3 6329.6 6798.8 6930.3 4603.1 4705.5 4710.0 4718.5 4720.6 7443.3 7482.1 7482.1 7485.1 7491.2 4649.7 4773.7 4791.4 4793.4 4827.7 4884.4 4899.1 4899.9 4906.8 4909.9 5748.1 5763.3 5765.5 5767.5 5774.5 6862.6 7092.8 7096.2 7105.4 7114.2 1632.8 1634.6 1634.9 1635.1 1642.4 1098.6 1099.2 1113.7 1124.9 1125.7 6725.2 6726.6 6734.1 6740.5 6797.7 5959.9 7297.3 7348.0 7356.6 7359.0 5727.8 6441.4 6496.6 6657.7 6679.0 3176.1 3863.0 3892.7 3894.2 3906.8 6114.4 7663.2 7671.5 7673.7 7702.8 7325.2 7529.1 7541.0 7559.9 7575.0 6060.6 7374.3 7644.7 7650.4 7662.4 7204.4 7337.7 7367.1 7392.0 7402.3 7004.9 7224.6 7280.2 7282.9 7295.7 6276.0 7457.4 7698.2 7723.8 7731.9 4803.9 4822.8 4829.1 4833.5 4834.7 7306.2 7317.0 7323.6 7323.9 7335.9 6849.9 7135.8 7161.3 7181.6 7196.7 7164.0 7168.3 7171.6 7172.9 7180.7 6688.3 6968.9 6971.0 6975.9 6997.7 7054.3 7054.6 7061.3 7080.9 7132.8 6961.0 6967.1 6974.7 6990.1 6995.2 04:58:48 INFO - PROCESS | 1722 | 04:58:48 INFO - PROCESS | 1722 | [#5] yui.html Cycles:180 Average:17960.48 Median:33066.78 stddev:24733.87 (74.8%) stddev-sans-first:24769.23 04:58:48 INFO - PROCESS | 1722 | Values: 681.8 696.5 703.4 725.2 757.1 14961.6 15115.1 15153.8 15165.6 15167.0 13562.5 15241.2 15579.0 15596.5 15644.9 705.1 710.2 838.4 869.8 877.8 702.3 854.6 884.9 886.2 887.5 903.0 922.0 922.8 922.8 926.0 739.0 749.5 751.4 906.8 918.5 669.7 678.0 678.4 678.8 680.3 14973.3 15038.1 15046.5 15053.6 15057.9 10137.6 12782.4 12935.9 13214.7 13425.1 10366.6 11127.3 11150.8 11280.0 12036.0 3141.3 3616.9 3698.0 3718.1 3732.2 74519.0 75092.0 75128.6 75197.6 75245.6 9322.2 9478.8 9527.0 9768.8 9974.4 21676.0 21844.1 21850.8 21852.1 21866.6 7354.2 7385.8 7389.4 7512.1 7583.9 4066.5 4091.5 4107.3 4120.3 4123.6 3561.2 3642.5 3644.4 3645.3 3647.9 589.9 683.3 690.0 717.5 718.3 547.0 566.4 629.4 632.3 632.6 8335.5 8364.1 8479.2 8652.0 8695.0 541.2 550.6 606.8 610.2 622.8 3300.0 3732.1 4224.5 4289.1 4311.2 88229.7 89178.6 89702.0 90093.0 91077.0 75674.9 76295.2 76382.6 76856.0 78069.2 67064.7 67702.3 68154.7 68357.3 69208.0 7755.9 8832.5 8870.5 8902.1 8930.8 47099.3 47338.3 47353.5 48000.3 48526.5 65501.0 65824.0 66511.3 66524.7 67900.7 10966.3 11186.4 11253.4 11271.8 11654.2 12104.7 12150.0 12188.4 12214.3 12874.4 11523.9 11552.6 11678.1 11974.2 12312.6 10496.9 11196.5 11767.4 11849.0 11851.7 10597.6 10672.4 11070.6 11389.8 11619.0 9441.7 9657.2 9673.2 9690.8 9831.7 7073.4 8343.2 8930.0 9014.5 9409.9 04:58:48 INFO - PROCESS | 1722 | -------- Summary: end -------- 04:58:48 INFO - PROCESS | 1722 | 04:58:48 INFO - TEST-INFO | 1722: exit 0 04:58:48 INFO - TEST-OK | dromaeo_css | took 1114150ms 04:58:48 INFO - TEST-START | kraken 04:58:48 INFO - operating with platform_type : mac_ 04:58:48 INFO - Initialising browser for kraken test... 04:58:48 INFO - TEST-INFO | started process 1727 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmp_UPsbF/profile http://localhost:49268/getInfo.html) 04:58:49 INFO - PROCESS | 1727 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:58:51 INFO - PROCESS | 1727 | __metrics Screen width/height:1600/1200 04:58:51 INFO - PROCESS | 1727 | colorDepth:24 04:58:51 INFO - PROCESS | 1727 | Browser inner width/height: 1024/689 04:58:51 INFO - PROCESS | 1727 | __metrics 04:58:51 INFO - PROCESS | 1727 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:58:51 INFO - PROCESS | 1727 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:58:51 INFO - TEST-INFO | 1727: exit 0 04:58:51 INFO - Browser initialized. 04:58:51 INFO - Running cycle 1/1 for kraken test... 04:58:51 INFO - TEST-INFO | started process 1729 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmp_UPsbF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:59:03 INFO - PROCESS | 1729 | RSS: Main: 242503680 04:59:03 INFO - PROCESS | 1729 | 04:59:06 INFO - PROCESS | 1729 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 04:59:06 INFO - PROCESS | 1729 | RSS: Main: 291258368 04:59:06 INFO - PROCESS | 1729 | 04:59:09 INFO - PROCESS | 1729 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 04:59:09 INFO - PROCESS | 1729 | RSS: Main: 300425216 04:59:09 INFO - PROCESS | 1729 | 04:59:13 INFO - PROCESS | 1729 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 04:59:13 INFO - PROCESS | 1729 | RSS: Main: 286810112 04:59:13 INFO - PROCESS | 1729 | 04:59:15 INFO - PROCESS | 1729 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 04:59:16 INFO - PROCESS | 1729 | RSS: Main: 289042432 04:59:16 INFO - PROCESS | 1729 | 04:59:18 INFO - PROCESS | 1729 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:59:18 INFO - PROCESS | 1729 | RSS: Main: 289812480 04:59:18 INFO - PROCESS | 1729 | 04:59:21 INFO - PROCESS | 1729 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 04:59:22 INFO - PROCESS | 1729 | RSS: Main: 290910208 04:59:22 INFO - PROCESS | 1729 | 04:59:25 INFO - PROCESS | 1729 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 04:59:25 INFO - PROCESS | 1729 | RSS: Main: 290426880 04:59:25 INFO - PROCESS | 1729 | 04:59:28 INFO - PROCESS | 1729 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 04:59:28 INFO - PROCESS | 1729 | RSS: Main: 290942976 04:59:28 INFO - PROCESS | 1729 | 04:59:30 INFO - PROCESS | 1729 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:59:31 INFO - PROCESS | 1729 | RSS: Main: 325558272 04:59:31 INFO - PROCESS | 1729 | 04:59:32 INFO - PROCESS | 1729 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:59:33 INFO - PROCESS | 1729 | RSS: Main: 324075520 04:59:33 INFO - PROCESS | 1729 | 04:59:35 INFO - PROCESS | 1729 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:59:36 INFO - PROCESS | 1729 | RSS: Main: 332726272 04:59:36 INFO - PROCESS | 1729 | 04:59:38 INFO - PROCESS | 1729 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:59:39 INFO - PROCESS | 1729 | RSS: Main: 335187968 04:59:39 INFO - PROCESS | 1729 | 04:59:41 INFO - PROCESS | 1729 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:59:42 INFO - PROCESS | 1729 | RSS: Main: 334594048 04:59:42 INFO - PROCESS | 1729 | 04:59:44 INFO - PROCESS | 1729 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 04:59:44 INFO - PROCESS | 1729 | RSS: Main: 393904128 04:59:44 INFO - PROCESS | 1729 | 04:59:44 INFO - PROCESS | 1729 | __start_tp_report 04:59:44 INFO - PROCESS | 1729 | _x_x_mozilla_page_load 04:59:44 INFO - PROCESS | 1729 | _x_x_mozilla_page_load_details 04:59:44 INFO - PROCESS | 1729 | |i|pagename|runs| 04:59:44 INFO - PROCESS | 1729 | |0;ai-astar;111;107;110;111;111;110;116;111;110;112 04:59:44 INFO - PROCESS | 1729 | |1;audio-beat-detection;157;124;144;158;133;142;138;120;155;116 04:59:44 INFO - PROCESS | 1729 | |2;audio-dft;188;182;188;185;189;184;185;182;181;180 04:59:44 INFO - PROCESS | 1729 | |3;audio-fft;77;89;107;100;46;69;88;111;104;74 04:59:44 INFO - PROCESS | 1729 | |4;audio-oscillator;94;97;127;78;79;81;115;76;77;116 04:59:44 INFO - PROCESS | 1729 | |5;imaging-gaussian-blur;86;91;86;91;85;89;85;91;86;92 04:59:44 INFO - PROCESS | 1729 | |6;imaging-darkroom;94;94;94;94;94;94;94;94;95;94 04:59:44 INFO - PROCESS | 1729 | |7;imaging-desaturate;85;86;86;87;87;86;87;84;91;86 04:59:44 INFO - PROCESS | 1729 | |8;json-parse-financial;55;53;54;53;55;52;55;62;51;52 04:59:44 INFO - PROCESS | 1729 | |9;json-stringify-tinderbox;64;72;71;72;69;69;67;67;68;67 04:59:44 INFO - PROCESS | 1729 | |10;stanford-crypto-aes;83;83;82;83;83;81;81;82;83;83 04:59:44 INFO - PROCESS | 1729 | |11;stanford-crypto-ccm;122;123;118;122;125;125;121;124;123;126 04:59:44 INFO - PROCESS | 1729 | |12;stanford-crypto-pbkdf2;136;136;138;137;137;125;137;137;138;138 04:59:44 INFO - PROCESS | 1729 | |13;stanford-crypto-sha256-iterative;68;74;95;95;95;94;66;65;65;66 04:59:44 INFO - PROCESS | 1729 | __end_tp_report 04:59:44 INFO - PROCESS | 1729 | __start_cc_report 04:59:44 INFO - PROCESS | 1729 | _x_x_mozilla_cycle_collect,1109 04:59:44 INFO - PROCESS | 1729 | __end_cc_report 04:59:44 INFO - PROCESS | 1729 | __startTimestamp1454763584332__endTimestamp 04:59:44 INFO - PROCESS | 1729 | 04:59:44 INFO - PROCESS | 1729 | ------- Summary: start ------- 04:59:44 INFO - PROCESS | 1729 | Number of tests: 14 04:59:44 INFO - PROCESS | 1729 | 04:59:44 INFO - PROCESS | 1729 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:2.23 (2.0%) stddev-sans-first:2.37 04:59:44 INFO - PROCESS | 1729 | Values: 111.0 107.0 110.0 111.0 111.0 110.0 116.0 111.0 110.0 112.0 04:59:44 INFO - PROCESS | 1729 | 04:59:44 INFO - PROCESS | 1729 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:143.00 stddev:15.37 (10.7%) stddev-sans-first:14.81 04:59:44 INFO - PROCESS | 1729 | Values: 157.0 124.0 144.0 158.0 133.0 142.0 138.0 120.0 155.0 116.0 04:59:44 INFO - PROCESS | 1729 | 04:59:44 INFO - PROCESS | 1729 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.00 stddev:3.17 (1.7%) stddev-sans-first:3.08 04:59:44 INFO - PROCESS | 1729 | Values: 188.0 182.0 188.0 185.0 189.0 184.0 185.0 182.0 181.0 180.0 04:59:44 INFO - PROCESS | 1729 | 04:59:44 INFO - PROCESS | 1729 | [#3] audio-fft Cycles:10 Average:86.50 Median:71.50 stddev:20.30 (28.4%) stddev-sans-first:21.24 04:59:44 INFO - PROCESS | 1729 | Values: 77.0 89.0 107.0 100.0 46.0 69.0 88.0 111.0 104.0 74.0 04:59:44 INFO - PROCESS | 1729 | 04:59:44 INFO - PROCESS | 1729 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:78.50 stddev:19.11 (24.3%) stddev-sans-first:20.27 04:59:44 INFO - PROCESS | 1729 | Values: 94.0 97.0 127.0 78.0 79.0 81.0 115.0 76.0 77.0 116.0 04:59:44 INFO - PROCESS | 1729 | 04:59:44 INFO - PROCESS | 1729 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:90.00 stddev:2.86 (3.2%) stddev-sans-first:2.92 04:59:44 INFO - PROCESS | 1729 | Values: 86.0 91.0 86.0 91.0 85.0 89.0 85.0 91.0 86.0 92.0 04:59:44 INFO - PROCESS | 1729 | 04:59:44 INFO - PROCESS | 1729 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:59:44 INFO - PROCESS | 1729 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 04:59:44 INFO - PROCESS | 1729 | 04:59:44 INFO - PROCESS | 1729 | [#7] imaging-desaturate Cycles:10 Average:86.50 Median:86.50 stddev:1.84 (2.1%) stddev-sans-first:1.87 04:59:44 INFO - PROCESS | 1729 | Values: 85.0 86.0 86.0 87.0 87.0 86.0 87.0 84.0 91.0 86.0 04:59:44 INFO - PROCESS | 1729 | 04:59:44 INFO - PROCESS | 1729 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:3.08 (5.7%) stddev-sans-first:3.26 04:59:44 INFO - PROCESS | 1729 | Values: 55.0 53.0 54.0 53.0 55.0 52.0 55.0 62.0 51.0 52.0 04:59:44 INFO - PROCESS | 1729 | 04:59:44 INFO - PROCESS | 1729 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:2.55 (3.7%) stddev-sans-first:2.09 04:59:44 INFO - PROCESS | 1729 | Values: 64.0 72.0 71.0 72.0 69.0 69.0 67.0 67.0 68.0 67.0 04:59:44 INFO - PROCESS | 1729 | 04:59:44 INFO - PROCESS | 1729 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:0.84 (1.0%) stddev-sans-first:0.87 04:59:44 INFO - PROCESS | 1729 | Values: 83.0 83.0 82.0 83.0 83.0 81.0 81.0 82.0 83.0 83.0 04:59:44 INFO - PROCESS | 1729 | 04:59:44 INFO - PROCESS | 1729 | [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:123.50 stddev:2.33 (1.9%) stddev-sans-first:2.45 04:59:44 INFO - PROCESS | 1729 | Values: 122.0 123.0 118.0 122.0 125.0 125.0 121.0 124.0 123.0 126.0 04:59:44 INFO - PROCESS | 1729 | 04:59:44 INFO - PROCESS | 1729 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.90 Median:137.00 stddev:3.90 (2.8%) stddev-sans-first:4.14 04:59:44 INFO - PROCESS | 1729 | Values: 136.0 136.0 138.0 137.0 137.0 125.0 137.0 137.0 138.0 138.0 04:59:44 INFO - PROCESS | 1729 | 04:59:44 INFO - PROCESS | 1729 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.30 Median:84.00 stddev:14.39 (17.1%) stddev-sans-first:14.77 04:59:44 INFO - PROCESS | 1729 | Values: 68.0 74.0 95.0 95.0 95.0 94.0 66.0 65.0 65.0 66.0 04:59:44 INFO - PROCESS | 1729 | -------- Summary: end -------- 04:59:44 INFO - PROCESS | 1729 | 04:59:45 INFO - TEST-INFO | 1729: exit 0 04:59:45 INFO - TEST-OK | kraken | took 56289ms 04:59:45 INFO - SUITE-END | took 1170s 04:59:45 INFO - Completed test suite (00:19:30) 04:59:45 INFO - Working with test: dromaeo_css 04:59:45 INFO - Generating results file: dromaeo_css 04:59:45 INFO - Working with test: kraken 04:59:45 INFO - Generating results file: kraken 04:59:45 INFO - javascript benchmark 04:59:45 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:59:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 04:59:46 INFO - process_Request line: dromaeo_css 7442.96 graph.html#tests=[[72,64,59]] 04:59:46 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:59:46 INFO - process_Request line: kraken 1425.60 graph.html#tests=[[232,64,59]] 04:59:46 INFO - RETURN: dromaeo_css: 7442.96 04:59:46 INFO - RETURN: kraken: 1425.60 04:59:46 INFO - javascript benchmark 04:59:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3408.6591340865907, 3462.4979377990176, 3492.63327350628, 3502.509648649189, 3531.240783231605, 5544.750486228119, 5635.971820140899, 5662.943370566293, 5668.716564171796, 5673.858153546158, 5578.776848926038, 5634.830955071344, 5642.15367694846, 5643.0, 5643.661380317184, 5116.999999999991, 5140.0, 5166.018456493254, 5188.247704082905, 5232.947670523303, 5258.815941442051, 5258.973705131469, 5261.631685781997, 5264.684118952856, 5279.5512381447625, 5219.973900130494, 5225.451327610604, 5225.921611175835, 5235.319408476893, 5243.580513558925, 5201.2458193561915, 5224.529792318691, 5224.52979231871, 5239.73801309933, 5251.0, 4276.31578947367, 5131.794728210867, 5236.24074509194, 5247.895042099137, 5269.86825329366, 5599.832005039855, 5641.323041235037, 5652.34997975234, 5656.8020119295625, 5659.405762394971, 6148.907766383508, 6160.0759886017, 6177.66022868742, 6180.752769889199, 6185.876282474325, 6138.263408390977, 6150.446459818638, 6201.87596248077, 6207.162033125515, 6303.590266632654, 5745.827625171251, 5754.510866576305, 5764.855878603026, 5771.105478650816, 5786.971065144648, 6296.811095667045, 6312.116303717483, 6324.810255692337, 6334.144890439824, 6337.302896681362, 6018.398160183947, 6092.603980741238, 6108.908366374508, 6122.602030867979, 6168.290646575611, 6251.593646412968, 6275.02737075754, 6281.246250449975, 6294.307626161119, 6299.716512756937, 6123.663198524124, 6220.222472190976, 6229.4393504584805, 6230.906536401958, 6231.0, 5394.298741163623, 6101.420365065312, 6155.938440615537, 6159.137720719103, 6274.1843560337775, 4840.951590484121, 4884.633652476078, 4892.706437613754, 4894.632902532253, 4929.802807887716, 4364.323529852878, 4366.3013917773005, 4381.058072514425, 4391.626711729475, 4420.513743488214, 5598.552115830806, 5682.516986056232, 5695.914561281584, 5701.743421546041, 5785.479306862402, 6243.500519958392, 6277.7175027123885, 6281.842953926097, 6296.118543403927, 6300.59046161998, 5749.223854779635, 5753.913691294634, 5756.992526307879, 5760.884782304331, 5785.363610002896, 5218.399884013387, 5242.318498595235, 5282.445343238982, 5303.549198318186, 5376.166694162411, 5257.474252574789, 6278.623282603058, 6282.434580887651, 6285.905711414424, 6312.084747711556, 6264.59280146789, 6269.247690277196, 6276.435120839146, 6284.748610055546, 6285.905711414241, 6213.440790328892, 6237.625742455467, 6259.624422534663, 6304.085907543289, 6312.495000399865, 6154.753809847556, 6157.907631385622, 6165.106059621419, 6168.9691551541955, 6184.567080304516, 6209.099680546386, 6217.626942383471, 6254.28075771274, 6285.560010799383, 6291.307956124731, 5801.535877129735, 5933.792317268875, 6004.489618382312, 6076.361981991828, 6093.634381937098, 6052.636841789506, 6053.909191362045, 6077.118817771487, 6086.239220097488, 6090.969545152246, 5842.824715258549, 5865.882682346414, 5871.295444546682, 5875.059990401515, 5879.94120058811, 5945.494632956247, 6014.188084608521, 6035.668038257762, 6057.4851137653795, 6068.059450785136, 5839.35767065614, 5890.410958904246, 5903.940960590339, 5909.674967876808, 5949.315828679757], "unit": "score", "name": "dojo.html", "value": 5674.596612685912}, {"lowerIsBetter": false, "replicates": [490.8846421091045, 525.8720045502397, 550.7989583801913, 579.2759051186017, 659.3241927024801, 29816.0, 38129.0, 38472.23055538887, 38495.0, 38560.80719596405, 40695.38956915648, 41000.769976900665, 41063.973400664996, 41075.0, 41107.38338924918, 9478.336516443835, 9665.4200747955, 9672.70981870545, 9688.224942004657, 9689.90310096897, 9407.0, 9558.426494410323, 9565.808683826353, 9608.135267825894, 9684.854727179098, 9610.90389096107, 9691.370060946016, 9711.0, 9714.319997600136, 9729.0, 9571.138597526222, 9643.27675424339, 9651.613935442574, 9655.420674759467, 9662.275329350257, 9583.424994500352, 9754.0733630305, 9760.365576237522, 9773.902260977371, 9791.118799308097, 38928.0, 39231.80384098061, 39324.41013384802, 39326.410103848466, 39354.40968385476, 3155.2269693924904, 3200.423923693734, 3293.127321259868, 3392.372411103929, 3514.9297014059575, 27916.720832791616, 28267.293317667016, 28652.283692907637, 28653.570196447068, 28932.42135157285, 2753.160286112735, 2768.792340574465, 2829.7028811974856, 2857.4713677969435, 2954.6158999330164, 476643.0, 479861.0, 480204.0, 480240.0, 480361.0, 52875.47124528782, 53571.732141339045, 53728.194077088876, 58013.70993145092, 61847.0, 59571.702141489885, 59862.401375986556, 60146.39853601495, 60165.69917150386, 60179.39820601738, 15873.603159920864, 16016.519504414886, 16085.678286434206, 16099.919500402422, 16105.114218717848, 11460.484278207501, 11654.53381864733, 11683.182177247681, 12476.937615311865, 12731.93634031824, 18679.346222882134, 18767.624647507248, 18776.906115469334, 18801.905990470234, 18827.15277812502, 6520.510961677893, 6639.502037347122, 7266.781996540112, 7995.68017279314, 8178.754637360769, 938.4932136646271, 978.5303054533864, 1020.3316827478013, 1097.155190503308, 1120.9271397359146, 28859.567106493418, 28916.855415723207, 29358.706412935597, 29529.85235073811, 29547.965821196154, 1106.286445242814, 1140.6692059302875, 1151.861776586815, 1171.2679575265458, 1172.2731906218028, 14724.969252152461, 14743.483978060716, 14981.70036599262, 15063.0, 15118.017328873588, 494710.0, 499117.0, 499642.0, 501106.3838296926, 501761.0, 55834.720826395605, 55891.72054139703, 55964.0, 56064.878702425725, 56268.0, 1379.8551152128882, 1393.686420555367, 1409.457358916804, 1416.624594482463, 1417.1284659934067, 25219.0, 28454.715452846034, 28700.282492937844, 29378.853105734335, 29742.553861692526, 47781.76109119432, 49164.262536062706, 49180.75409622929, 49184.50815491942, 49190.508094918594, 461639.0, 465533.344666549, 499394.0, 509849.0, 632063.0, 29607.0, 29640.258993525335, 29728.554071688508, 29863.85068074646, 29874.0, 41372.1725565493, 41902.0, 41966.370504441846, 42243.94390140271, 43194.70415887528, 35102.0, 35504.82247588849, 35730.64269357273, 36067.0, 36078.0, 34797.47803782894, 35475.11312217215, 35651.82174089113, 35697.82151089228, 35821.641783582876, 34635.307293853475, 35352.762653307014, 35524.64475355317, 35619.0, 35712.464313035845, 25090.240073591525, 31157.68842311548, 31294.843525782224, 31316.217094571908, 31716.524252135776, 19817.81093134359, 23832.642510362704, 24219.03123875096, 24363.75636243615, 24988.75011249864], "unit": "score", "name": "ext.html", "value": 19273.446472340824}, {"lowerIsBetter": false, "replicates": [296.5862621642808, 364.2496457297968, 365.3715609152258, 366.57843479998, 371.392772816445, 14876.702465950675, 15194.088354698726, 18643.533911652215, 19426.1258243379, 19963.10166042528, 15794.684106317867, 18694.0, 19252.614947701037, 20051.799482005175, 20104.69842952357, 5616.85957851055, 5649.519790817785, 5795.420457954213, 5827.912581311284, 5844.853878653025, 4148.087420767426, 4348.260795664744, 4359.2589259825745, 5758.510526605243, 5846.181534585162, 6025.668588227646, 6067.787627433041, 6312.558120931513, 6321.0834429008, 6325.5255855810765, 6317.368263173692, 6332.986722124461, 6378.681065946684, 6417.294097649255, 6428.967855160741, 5502.614816962814, 5553.888922221573, 5561.165825126223, 5567.47109024642, 5570.777168913239, 23314.950827212815, 23844.64233036506, 24255.514889702106, 24480.0, 24612.630810537856, 1949.892755898425, 2096.842736794731, 2248.4940888300166, 2445.168642661504, 2903.941921161586, 9560.952195238979, 9634.662786802428, 9812.116909478109, 9893.060159284856, 9901.752456188653, 1672.4230140601474, 1704.582377317565, 1743.0, 1774.1661419133115, 1781.118346418531, 84793.57603212007, 86484.56757716234, 86604.56697716533, 88095.0, 88178.67731984025, 10322.741931451774, 10602.522886470128, 10721.195910306758, 10726.785464290826, 10773.946130269298, 12727.427265773062, 12814.231146131262, 12848.678783030498, 12851.742965140646, 12858.871411285767, 8197.877031844528, 8207.343412526983, 8215.34277257818, 8287.585620718939, 8287.62705678246, 8373.49759014461, 8411.53736544496, 8449.746507604781, 8486.236238738544, 8511.702090426805, 4302.118065796567, 4411.7573533455325, 4418.0059486615255, 4420.31485119807, 4470.530594287618, 1411.5200831717266, 1643.0716645095483, 1731.2901710298718, 1826.4794533558138, 1871.223442271442, 811.9350451963828, 832.937529685276, 917.9941827107791, 976.1739763385102, 998.7453199434098, 18931.716024259647, 19048.619027619647, 19063.332783352515, 19261.22955081809, 19587.706184407245, 693.8334799648048, 741.610654406441, 861.5562985062572, 887.7381172554112, 960.0831206198064, 10158.441285729208, 10197.13324367437, 10250.897491024994, 10262.640807571848, 10311.278210525192, 725921.0, 734597.0, 743670.0, 746054.0, 755379.0, 112445.0, 112485.0, 112689.87310126793, 114618.4269078666, 117250.41374793243, 1126.6000569797768, 1180.221054104287, 1187.7268228307537, 1190.3215167354697, 1192.284629222477, 17185.484435466955, 17449.476515704548, 17517.299308028047, 17865.73201401954, 18069.096545172426, 48994.755026224644, 49856.50143498664, 50091.49908500868, 50387.49612503975, 50560.28108344174, 66258.0, 68793.65603171953, 69833.0, 70415.64792176211, 70672.0, 5879.7060146993335, 7501.962490187514, 7658.885116723142, 7670.463067585216, 7875.094364147967, 10559.472026398496, 11614.361210133186, 11923.224990375598, 11969.64091077269, 12172.45223964906, 9202.447853128833, 9981.800363992825, 10008.799824003625, 10211.540480678535, 10405.219608529542, 7123.7889558774095, 9995.70012899614, 10177.592896284066, 10251.794964100825, 10321.948390258001, 7798.805029874298, 9810.773653293338, 10121.69634910954, 10262.794744105226, 10426.843597345895, 7522.134954480305, 7612.162662107275, 7612.733554325793, 7636.656350464132, 7651.693932242648, 8401.873971890303, 10265.332753371007, 10389.84415233757, 10428.322159059637, 10433.426161561187], "unit": "score", "name": "jquery.html", "value": 9001.578327378707}, {"lowerIsBetter": false, "replicates": [1403.9929800350997, 1531.9923400382997, 1556.2607761313375, 1783.9108044597767, 1934.8935808530525, 7996.480228785133, 8204.015518137825, 8606.61270242839, 8767.912320876789, 8768.473891566511, 8603.139686031394, 8639.308855291578, 8766.780830479242, 8771.605277762501, 8772.254358379545, 2185.3771675072608, 2234.7988681018705, 2492.5887228607257, 2525.1793167220635, 2537.847729136258, 2260.8982595783227, 2275.943101422469, 2278.6695929090274, 2473.3445636906145, 2534.8605826679527, 2458.5820410530164, 2485.763852434016, 2488.464980029293, 2489.614109812982, 2493.1523282084086, 2493.3891196656755, 2520.4329025969196, 2521.319243804181, 2521.911733089333, 2523.2430270918835, 1918.414883460544, 2193.649016157407, 2252.7747225277503, 2456.361346050022, 2532.556802559545, 8600.0, 8688.131186881325, 8694.826103477959, 8702.129787021311, 8702.825943481159, 5304.124819404794, 5436.075867102562, 5440.619156659035, 5464.590155738336, 5474.945250547484, 3620.674139327447, 3675.2833197526493, 3729.8881033569037, 3757.436384542313, 3769.4722738816586, 1036.6734478639205, 1051.332403923514, 1057.6245432871297, 1082.6319051522441, 1088.1240601315938, 12208.450619722134, 12280.631581052583, 12287.56993505232, 12298.877011229952, 12310.13829031968, 4855.465898751135, 4960.925586116211, 5053.69677819332, 5055.368078990126, 5062.012907483079, 10323.432211228455, 10347.482625868677, 10358.912314207051, 10362.533685984148, 10364.792704145875, 5549.417311182348, 5570.97214513933, 5578.553715702734, 5584.246126772915, 5585.078462053797, 4947.455779864212, 5034.295198672189, 5034.8237811677145, 5045.823396181116, 5077.847664570068, 3326.6673332667024, 3965.7025723070883, 3974.28462876685, 4002.1595464952684, 4032.7781971991235, 1309.1163464661315, 1314.4413624209672, 1322.0, 1327.0710502648185, 1328.7209685965863, 1231.3658465890073, 1291.180100636084, 1293.5213970830853, 1334.5862782537445, 1361.857005014479, 7982.560959147187, 8063.516189028677, 8186.2632363087605, 8221.17788221173, 8253.628586713612, 511.60606333123286, 518.2226660009985, 526.5287567627029, 526.6418835192029, 527.4725274725274, 6012.729427175787, 6082.543809214327, 6131.172291740647, 6232.626042437469, 6263.154474146023, 9691.612335506641, 10568.682939511827, 10658.253922225369, 10659.040686338112, 10666.14670826332, 10082.848757268646, 10477.31897426665, 10525.631602893862, 10530.473476326306, 10536.473176341306, 8041.919580804117, 8161.277175263666, 8231.753047408587, 8255.009398872053, 8263.669453221804, 8095.0, 8214.58927053633, 8215.671373145007, 8219.83560328802, 8228.753137405887, 9550.856737149088, 9572.90427095748, 9722.125008749246, 9926.404415735078, 9927.702168934655, 9318.72043838686, 9991.550380232762, 10062.0, 10223.897761022592, 10242.334248273839, 6677.632730199885, 7614.428917831074, 7619.314261716472, 7620.80947976305, 7635.503692259986, 8104.959475202586, 8173.427860049739, 8212.671493140208, 8262.545559994018, 8272.793180170544, 7761.495502792301, 7809.882851757115, 7822.217778222132, 7894.802629934297, 7932.484388514728, 7671.616419178907, 7698.92301076982, 7708.614569271626, 7813.10149332834, 7817.804554886174, 7558.773236802905, 7573.583452910143, 7637.389008879388, 7666.041744781903, 7672.424568157299, 7081.18566364854, 7114.1463024435325, 7159.534630249017, 7163.570185788869, 7168.928310717035, 6884.793456196322, 7134.643267836691, 7147.571145731273, 7160.997460355658, 7214.71141154348], "unit": "score", "name": "mootools.html", "value": 4871.356069224129}, {"lowerIsBetter": false, "replicates": [319.47924882441623, 325.094611506953, 332.1530098249465, 333.34165024077436, 336.32231054425324, 6612.504062195337, 6629.701663425145, 6687.49843761718, 6761.2224594171685, 6787.966060169692, 6636.303188165233, 6642.368974947372, 6660.333966603337, 6664.2002959644915, 6672.299408562104, 4275.700700950934, 4783.536478713465, 4833.25084611884, 4981.576565991895, 4994.950050499503, 3990.4014397840265, 4937.259411088329, 4958.727270000149, 4993.600511959053, 5005.124103281929, 4887.560119589236, 4898.7305698186765, 4911.238757992499, 4927.556519913207, 4934.777934992934, 4653.185692503798, 4733.786979585927, 4749.168895443318, 4928.383952005999, 4934.9013019739405, 4040.4747382840337, 4051.311277082903, 4062.939055914164, 4064.3700226464944, 4067.5118985721606, 5007.4992500749995, 6292.748290068392, 6332.271788744308, 6333.0, 6347.714352854086, 5529.170624406331, 5666.603337766358, 5673.801416950387, 5679.886402271932, 5687.943120568824, 5438.619296649236, 5987.311459182162, 6329.607486352995, 6798.762043328509, 6930.27232140623, 4603.10239503297, 4705.505921878188, 4709.952900470986, 4718.4809670936165, 4720.57514823664, 7443.2556744325675, 7482.064741907262, 7482.139553951365, 7485.1017877854465, 7491.175970643225, 4649.69776964503, 4773.713577185311, 4791.401074865642, 4793.376861008116, 4827.686200396963, 4884.438289596671, 4899.1426500362295, 4899.926501102486, 4906.779194936236, 4909.901801963941, 5748.080307150836, 5763.250777398911, 5765.4811067004175, 5767.509761670305, 5774.48029677331, 6862.553933994374, 7092.751753688596, 7096.219415864251, 7105.396041336544, 7114.181869085121, 1632.795900512436, 1634.6076941534184, 1634.8882759723501, 1635.1088656682136, 1642.3758971590958, 1098.6154845803906, 1099.1591432554103, 1113.6547670222258, 1124.8875112488686, 1125.707316097804, 6725.159355080615, 6726.562773419712, 6734.0572319875255, 6740.528163028639, 6797.694103765342, 5959.851003724855, 7297.306755858185, 7348.0, 7356.595387253646, 7359.0, 5727.76852976612, 6441.3880681335195, 6496.577722448026, 6657.700403481855, 6679.0, 3176.09481297829, 3863.0149311925843, 3892.727509074394, 3894.201688653819, 3906.7655940643654, 6114.419130182626, 7663.157052724196, 7671.53970761756, 7673.693052277847, 7702.845943081107, 7325.194228634846, 7529.058867641545, 7540.9622951884885, 7559.924400755922, 7574.962125189339, 6060.636361818305, 7374.2994415529365, 7644.732434364771, 7650.38796896247, 7662.387009039375, 7204.423646108194, 7337.669804858688, 7367.115946086504, 7392.002079719169, 7402.33378995893, 7004.894926576004, 7224.602646854473, 7280.1991780903, 7282.890756638761, 7295.744648937261, 6275.96862015687, 7457.440691948017, 7698.153203147761, 7723.845523089619, 7731.92268077312, 4803.927941080957, 4822.7829747660735, 4829.13075646387, 4833.516648335139, 4834.661573689808, 7306.196318405077, 7317.0487836580905, 7323.63381830917, 7323.8535229296185, 7335.889961650686, 6849.8972515411315, 7135.821604459722, 7161.319674630901, 7181.640917954186, 7196.712131514891, 7163.997040414451, 7168.319009694071, 7171.569705817667, 7172.856542869218, 7180.748673796392, 6688.264290928091, 6968.895466567904, 6970.954356846513, 6975.895361569682, 6997.7200911962955, 7054.294570542905, 7054.6472676367, 7061.329173728487, 7080.858382832417, 7132.821679458055, 6961.025456436002, 6967.059446974797, 6974.7210111597, 6990.126234220723, 6995.230524642387], "unit": "score", "name": "prototype.html", "value": 5163.637161540451}, {"lowerIsBetter": false, "replicates": [681.7988693335466, 696.4579285607532, 703.4477934821164, 725.1624373848207, 757.1103952855393, 14961.625959351008, 15115.093094414315, 15153.772693409608, 15165.620859478518, 15167.0, 13562.45750169992, 15241.161736104537, 15578.987365821215, 15596.454124105658, 15644.921775391107, 705.14677240539, 710.2400431538256, 838.3586556284447, 869.8216865542548, 877.7586163804941, 702.3257672634252, 854.5599016506504, 884.8628462588309, 886.175856453498, 887.5473508510673, 902.9954850225739, 922.0042354257386, 922.7646950027734, 922.8108237811266, 925.9537023148849, 739.0, 749.4528993834476, 751.4138971602159, 906.8141031088611, 918.4994178172911, 669.6785542939416, 677.9830504237384, 678.3589507915023, 678.7556479667315, 680.2721088435376, 14973.326200321011, 15038.097714137077, 15046.473373431878, 15053.623659408493, 15057.924710376488, 10137.594496220143, 12782.360881955958, 12935.87064129356, 13214.66963325915, 13425.127366721132, 10366.585336586528, 11127.33236005834, 11150.832737508943, 11280.041196498307, 12036.0, 3141.3246152077186, 3616.8914932552066, 3698.0, 3718.0890681782867, 3732.1789206374556, 74519.0, 75091.99999999945, 75128.62435687786, 75197.6240118796, 75245.62377188134, 9322.1610055094, 9478.763030924281, 9526.99966503521, 9768.755781105387, 9974.40153590787, 21676.0, 21844.126234950425, 21850.781492185193, 21852.125914963224, 21866.562668746537, 7354.154272258652, 7385.8153546161775, 7389.371903388164, 7512.060992375953, 7583.886241706379, 4066.512018557792, 4091.5499295077516, 4107.260693075275, 4120.278951183531, 4123.628873401408, 3561.198730285665, 3642.4900513928073, 3644.3804553226014, 3645.2709458108484, 3647.908802279964, 589.9292084949748, 683.2962049089446, 690.0373978300244, 717.4511498703496, 718.2745427118543, 546.9507744303032, 566.396787421395, 629.3580547841268, 632.2581288550015, 632.5666918161074, 8335.541545215072, 8364.121767214476, 8479.236868681848, 8651.95674021626, 8695.043545210021, 541.196323459662, 550.5705549671263, 606.805822136912, 610.2432983101012, 622.822495588755, 3300.0, 3732.088970602934, 4224.471941007374, 4289.091354347348, 4311.223979683625, 88229.67655485173, 89178.55410723035, 89702.0, 90093.0, 91077.0, 75674.86487702689, 76295.23704762882, 76382.61808691033, 76856.0, 78069.2193078062, 67064.69240610542, 67702.3229767696, 68154.65922670453, 68357.31642683609, 69208.0, 7755.883661745192, 8832.470051796912, 8870.512121833102, 8902.109789021046, 8930.821383572422, 47099.29351059805, 47338.28992565183, 47353.52646473629, 48000.27999579939, 48526.51473485361, 65501.0, 65824.0, 66511.33488665051, 66524.66737666281, 67900.6604966972, 10966.342019478856, 11186.384748838893, 11253.381064041556, 11271.830922536332, 11654.242474239147, 12104.688120778845, 12149.967252783612, 12188.390580470763, 12214.26714397139, 12874.420651070912, 11523.942380288381, 11552.59565915189, 11678.124140689313, 11974.22167559106, 12312.630621081382, 10496.895031049897, 11196.496157672762, 11767.352795596324, 11849.0, 11851.703707407383, 10597.62908298206, 10672.359658420519, 11070.612528561784, 11389.829152562552, 11619.01238394746, 9441.669541566012, 9657.236940577814, 9673.226141908772, 9690.806183876142, 9831.655892043744, 7073.434125270069, 8343.249107580346, 8930.0, 9014.459132452073, 9409.858852117086], "unit": "score", "name": "yui.html", "value": 6864.655818448366}], "name": "dromaeo_css", "value": 7442.951493205552}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 110.0, 111.0, 111.0, 110.0, 116.0, 111.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [157.0, 124.0, 144.0, 158.0, 133.0, 142.0, 138.0, 120.0, 155.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 138.7}, {"lowerIsBetter": true, "replicates": [188.0, 182.0, 188.0, 185.0, 189.0, 184.0, 185.0, 182.0, 181.0, 180.0], "unit": "score", "name": "audio-dft", "value": 184.4}, {"lowerIsBetter": true, "replicates": [77.0, 89.0, 107.0, 100.0, 46.0, 69.0, 88.0, 111.0, 104.0, 74.0], "unit": "score", "name": "audio-fft", "value": 86.5}, {"lowerIsBetter": true, "replicates": [94.0, 97.0, 127.0, 78.0, 79.0, 81.0, 115.0, 76.0, 77.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 94.0}, {"lowerIsBetter": true, "replicates": [86.0, 91.0, 86.0, 91.0, 85.0, 89.0, 85.0, 91.0, 86.0, 92.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.2}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 94.1}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 86.0, 87.0, 87.0, 86.0, 87.0, 84.0, 91.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 86.5}, {"lowerIsBetter": true, "replicates": [55.0, 53.0, 54.0, 53.0, 55.0, 52.0, 55.0, 62.0, 51.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.2}, {"lowerIsBetter": true, "replicates": [64.0, 72.0, 71.0, 72.0, 69.0, 69.0, 67.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 82.0, 83.0, 83.0, 81.0, 81.0, 82.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [122.0, 123.0, 118.0, 122.0, 125.0, 125.0, 121.0, 124.0, 123.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [136.0, 136.0, 138.0, 137.0, 137.0, 125.0, 137.0, 137.0, 138.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.9}, {"lowerIsBetter": true, "replicates": [68.0, 74.0, 95.0, 95.0, 95.0, 94.0, 66.0, 65.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 78.3}], "name": "kraken", "value": 1425.6000000000004}]} 04:59:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1425.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7442.96"}}} 04:59:46 INFO - Return code: 0 04:59:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:59:46 INFO - # TBPL SUCCESS # 04:59:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:59:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:59:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:59:46 INFO - 2016-02-06 04:59:46.223 screenresolution[1733:16307] starting screenresolution argv=screenresolution get 04:59:46 INFO - 2016-02-06 04:59:46.225 screenresolution[1733:16307] Display 0: 1600x1200x32@60 04:59:46 INFO - 2016-02-06 04:59:46.231 screenresolution[1734:16310] starting screenresolution argv=screenresolution list 04:59:46 INFO - Available Modes on Display 0 04:59:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:59:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:59:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:59:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:59:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:59:46 INFO - Intel Iris: 04:59:46 INFO - Chipset Model: Intel Iris 04:59:46 INFO - Type: GPU 04:59:46 INFO - Bus: Built-In 04:59:46 INFO - VRAM (Dynamic, Max): 1536 MB 04:59:46 INFO - Vendor: Intel (0x8086) 04:59:46 INFO - Device ID: 0x0a2e 04:59:46 INFO - Revision ID: 0x0009 04:59:46 INFO - Displays: 04:59:46 INFO - Display: 04:59:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:59:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:59:46 INFO - Display Serial Number: 1600x1200 60 04:59:46 INFO - Main Display: Yes 04:59:46 INFO - Mirror: Off 04:59:46 INFO - Online: Yes 04:59:46 INFO - Rotation: Supported 04:59:46 INFO - Return code: 0 04:59:46 INFO - Running post-action listener: _resource_record_post_action 04:59:46 INFO - Running post-run listener: _resource_record_post_run 04:59:47 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 33885696; Write bytes: 708815360; Read time: 353; Write time: 1948 04:59:47 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 384602624; Write bytes: 378271232; Read time: 28718; Write time: 709 04:59:47 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 32960000; Write bytes: 303068160; Read time: 339; Write time: 1181 04:59:47 INFO - Running post-run listener: _upload_blobber_files 04:59:47 INFO - Blob upload gear active. 04:59:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:59: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:59: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:59: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:59:47 INFO - (blobuploader) - INFO - Open directory for files ... 04:59:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:59:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:59:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:49 INFO - (blobuploader) - INFO - Done attempting. 04:59:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:59:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:59:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:50 INFO - (blobuploader) - INFO - Done attempting. 04:59:50 INFO - (blobuploader) - INFO - Iteration through files over. 04:59:50 INFO - Return code: 0 04:59:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:59:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:59:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e24d4cac70e7a4cf2e717cf7b0c793a765ed68d0374427041399cd0e98540408dc126cea79d9780130a4a8d0073c23d622f63fdc3b3939e9d1e1e9ff122ee8bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b96a4c6c8d7094435646ad9c546ab1fd2c475749e5e35bba8f1679add9f68a8477cb19bfd9c3067007c582790ae64f75ef7df968407870e65cbeae0823417e2e"} 04:59:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:59:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:59:50 INFO - Contents: 04:59:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e24d4cac70e7a4cf2e717cf7b0c793a765ed68d0374427041399cd0e98540408dc126cea79d9780130a4a8d0073c23d622f63fdc3b3939e9d1e1e9ff122ee8bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b96a4c6c8d7094435646ad9c546ab1fd2c475749e5e35bba8f1679add9f68a8477cb19bfd9c3067007c582790ae64f75ef7df968407870e65cbeae0823417e2e"} 04:59:50 INFO - Running post-run listener: copy_logs_to_upload_dir 04:59:50 INFO - Copying logs to upload dir... 04:59:50 INFO - mkdir: /builds/slave/test/build/upload/logs 04:59:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.630087 ========= master_lag: 25.42 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2016-02-06 05:00:15.814107) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 8 secs) (at 2016-02-06 05:00:15.820903) ========= 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.sy3bz8CSEB/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.OScLpcq5MU/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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/e24d4cac70e7a4cf2e717cf7b0c793a765ed68d0374427041399cd0e98540408dc126cea79d9780130a4a8d0073c23d622f63fdc3b3939e9d1e1e9ff122ee8bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b96a4c6c8d7094435646ad9c546ab1fd2c475749e5e35bba8f1679add9f68a8477cb19bfd9c3067007c582790ae64f75ef7df968407870e65cbeae0823417e2e"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010819 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e24d4cac70e7a4cf2e717cf7b0c793a765ed68d0374427041399cd0e98540408dc126cea79d9780130a4a8d0073c23d622f63fdc3b3939e9d1e1e9ff122ee8bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b96a4c6c8d7094435646ad9c546ab1fd2c475749e5e35bba8f1679add9f68a8477cb19bfd9c3067007c582790ae64f75ef7df968407870e65cbeae0823417e2e"}' ========= master_lag: 8.74 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 8 secs) (at 2016-02-06 05:00:24.573991) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:00:24.574311) ========= 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.sy3bz8CSEB/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.OScLpcq5MU/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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.005582 ========= master_lag: 0.59 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:00:25.165714) ========= ========= Started reboot skipped (results: 3, elapsed: 40 secs) (at 2016-02-06 05:00:25.166170) ========= ========= Finished reboot skipped (results: 3, elapsed: 40 secs) (at 2016-02-06 05:01:05.945153) ========= ========= Total master_lag: 34.97 =========