builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0070 starttime: 1454762323.66 results: success (0) buildid: 20160206043839 builduid: 1d9e29e633f349838ab51624232a8817 revision: 46d6d868ba0f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.663812) ========= 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.664282) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.664628) ========= 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.0PvNBml8te/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.f0VXl45Fsm/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.005742 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.739935) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.740266) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.797535) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.797816) ========= 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.0PvNBml8te/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.f0VXl45Fsm/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.005675 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.861598) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.861892) ========= 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.862248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.862565) ========= 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.0PvNBml8te/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.f0VXl45Fsm/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.0M=0.001s 2016-02-06 04:38:44 (20.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.205066 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:44.094767) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:44.095696) ========= 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.0PvNBml8te/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.f0VXl45Fsm/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.027215 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:44.150480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-06 04:38:44.151289) ========= 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.0PvNBml8te/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.f0VXl45Fsm/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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,218 Setting DEBUG logging. 2016-02-06 04:38:44,219 attempt 1/10 2016-02-06 04:38:44,219 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/46d6d868ba0f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-06 04:38:45,211 unpacking tar archive at: fx-team-46d6d868ba0f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.230274 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-06 04:38:45.400889) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:45.401270) ========= 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.0PvNBml8te/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.f0VXl45Fsm/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.005503 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:45.452069) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:45.452386) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:45.465015) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-02-06 04:38:45.465348) ========= /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.0PvNBml8te/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.f0VXl45Fsm/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:38:45 INFO - MultiFileLogger online at 20160206 04:38:45 in /builds/slave/test 04:38:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:38:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:38:45 INFO - {'append_to_log': False, 04:38:45 INFO - 'base_work_dir': '/builds/slave/test', 04:38:45 INFO - 'blob_upload_branch': 'Fx-Team', 04:38:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:38:45 INFO - 'branch': 'Fx-Team', 04:38:45 INFO - 'buildbot_json_path': 'buildprops.json', 04:38:45 INFO - 'config_files': ('talos/mac_config.py',), 04:38:45 INFO - 'default_actions': ('clobber', 04:38:45 INFO - 'read-buildbot-config', 04:38:45 INFO - 'download-and-extract', 04:38:45 INFO - 'populate-webroot', 04:38:45 INFO - 'create-virtualenv', 04:38:45 INFO - 'install', 04:38:45 INFO - 'run-tests'), 04:38:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:38:45 INFO - 'download_minidump_stackwalk': True, 04:38:45 INFO - 'download_symbols': 'ondemand', 04:38:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:38:45 INFO - 'tooltool.py': '/tools/tooltool.py', 04:38:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:38:45 INFO - '/tools/misc-python/virtualenv.py')}, 04:38:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:38:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:38:45 INFO - 'installer_path': 'installer.exe', 04:38:45 INFO - 'log_level': 'info', 04:38:45 INFO - 'log_name': 'talos', 04:38:45 INFO - 'log_to_console': True, 04:38:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:38:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:38:45 INFO - 'opt_config_files': (), 04:38:45 INFO - 'pip_index': False, 04:38:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:38:45 INFO - 'cmd': ('bash', 04:38:45 INFO - '-c', 04:38:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:38:45 INFO - 'enabled': True, 04:38:45 INFO - 'halt_on_failure': False, 04:38:45 INFO - 'name': 'check_screen_resolution'},), 04:38:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:38:45 INFO - 'cmd': ('bash', 04:38:45 INFO - '-c', 04:38:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:38:45 INFO - 'enabled': True, 04:38:45 INFO - 'halt_on_failure': False, 04:38:45 INFO - 'name': 'check_screen_resolution'},), 04:38:45 INFO - 'run_cmd_checks_enabled': True, 04:38:45 INFO - 'sps_profile': False, 04:38:45 INFO - 'sps_profile_interval': 0, 04:38:45 INFO - 'suite': 'dromaeojs', 04:38:45 INFO - 'system_bits': '32', 04:38:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:38:45 INFO - 'title': 't-yosemite-r7-0070', 04:38:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:38:45 INFO - 'use_talos_json': True, 04:38:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:38:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:38:45 INFO - 'work_dir': 'build'} 04:38:45 INFO - ##### 04:38:45 INFO - ##### Running clobber step. 04:38:45 INFO - ##### 04:38:45 INFO - Running pre-action listener: _resource_record_pre_action 04:38:45 INFO - Running main action method: clobber 04:38:45 INFO - rmtree: /builds/slave/test/build 04:38:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:38:47 INFO - Running post-action listener: _resource_record_post_action 04:38:47 INFO - ##### 04:38:47 INFO - ##### Running read-buildbot-config step. 04:38:47 INFO - ##### 04:38:47 INFO - Running pre-action listener: _resource_record_pre_action 04:38:47 INFO - Running main action method: read_buildbot_config 04:38:47 INFO - Using buildbot properties: 04:38:47 INFO - { 04:38:47 INFO - "project": "", 04:38:47 INFO - "product": "firefox", 04:38:47 INFO - "script_repo_revision": "production", 04:38:47 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:38:47 INFO - "repository": "", 04:38:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:38:47 INFO - "buildid": "20160206043839", 04:38:47 INFO - "stage_platform": "macosx64", 04:38:47 INFO - "basedir": "/builds/slave/test", 04:38:47 INFO - "buildnumber": 302, 04:38:47 INFO - "platform": "yosemite_r7", 04:38:47 INFO - "mozci_request": { 04:38:47 INFO - "priority": -1, 04:38:47 INFO - "type": "trigger_all_talos_jobs", 04:38:47 INFO - "times": 6 04:38:47 INFO - }, 04:38:47 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:38:47 INFO - "slavebuilddir": "test", 04:38:47 INFO - "branch": "fx-team", 04:38:47 INFO - "revision": "46d6d868ba0f", 04:38:47 INFO - "slavename": "t-yosemite-r7-0070", 04:38:47 INFO - "builduid": "1d9e29e633f349838ab51624232a8817", 04:38:47 INFO - "repo_path": "integration/fx-team" 04:38:47 INFO - } 04:38:47 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg. 04:38:47 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/test_packages.json. 04:38:47 INFO - Running post-action listener: _resource_record_post_action 04:38:47 INFO - ##### 04:38:47 INFO - ##### Running download-and-extract step. 04:38:47 INFO - ##### 04:38:47 INFO - Running pre-action listener: _resource_record_pre_action 04:38:47 INFO - Running main action method: download_and_extract 04:38:47 INFO - mkdir: /builds/slave/test/build/tests 04:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:47 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/test_packages.json 04:38:47 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/test_packages.json to /builds/slave/test/build/test_packages.json 04:38:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:38:47 INFO - Downloaded 1277 bytes. 04:38:47 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:38:47 INFO - Using the following test package requirements: 04:38:47 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:38:47 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:47 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:38:47 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:47 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:38:47 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:47 INFO - u'jsshell-mac.zip'], 04:38:47 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:47 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:38:47 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:38:47 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:47 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:38:47 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:47 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:38:47 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:47 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:38:47 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:38:47 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:47 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:38:47 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:47 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip 04:38:47 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:38:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:38:50 INFO - Downloaded 17118689 bytes. 04:38:50 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:50 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:53 INFO - Return code: 0 04:38:53 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:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:53 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip 04:38:53 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:53 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:53 INFO - Downloaded 17118689 bytes. 04:38:53 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:53 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:57 INFO - Return code: 0 04:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:57 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:57 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:57 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:57 INFO - Downloaded 10706582 bytes. 04:38:57 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:57 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:57 INFO - Return code: 0 04:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:57 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg 04:38:57 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:57 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:07 INFO - Downloaded 111104284 bytes. 04:39:07 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:07 INFO - mkdir: /builds/slave/test/properties 04:39:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:39:07 INFO - Writing to file /builds/slave/test/properties/build_url 04:39:07 INFO - Contents: 04:39:07 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg 04:39:07 INFO - Running post-action listener: _resource_record_post_action 04:39:07 INFO - Running post-action listener: set_extra_try_arguments 04:39:07 INFO - ##### 04:39:07 INFO - ##### Running populate-webroot step. 04:39:07 INFO - ##### 04:39:07 INFO - Running pre-action listener: _resource_record_pre_action 04:39:07 INFO - Running main action method: populate_webroot 04:39:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:39:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:39:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:39:07 INFO - '--tppagecycles', 04:39:07 INFO - '7'], 04:39:07 INFO - 'tests': ['tsvgm']}}, 04:39:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:39:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:39:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:39:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:39:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:39:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:39:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:07 INFO - 'talos_options': ['--e10s'], 04:39:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:07 INFO - 'tests': ['damp', 'tps']}, 04:39:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:07 INFO - 'talos_options': ['--e10s'], 04:39:07 INFO - 'tests': ['damp', 'tps']}, 04:39:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:39:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:39:07 INFO - 'other': {'tests': ['a11yr', 04:39:07 INFO - 'ts_paint', 04:39:07 INFO - 'tpaint', 04:39:07 INFO - 'sessionrestore', 04:39:07 INFO - 'sessionrestore_no_auto_restore']}, 04:39:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:39:07 INFO - 'tests': ['a11yr', 04:39:07 INFO - 'ts_paint', 04:39:07 INFO - 'tpaint', 04:39:07 INFO - 'sessionrestore', 04:39:07 INFO - 'sessionrestore_no_auto_restore']}, 04:39:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:39:07 INFO - 'tests': ['a11yr', 04:39:07 INFO - 'ts_paint', 04:39:07 INFO - 'tpaint', 04:39:07 INFO - 'sessionrestore', 04:39:07 INFO - 'sessionrestore_no_auto_restore']}, 04:39:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:39:07 INFO - 'tests': ['a11yr', 04:39:07 INFO - 'ts_paint', 04:39:07 INFO - 'tpaint', 04:39:07 INFO - 'sessionrestore', 04:39:07 INFO - 'sessionrestore_no_auto_restore']}, 04:39:07 INFO - 'other_l64': {'tests': ['a11yr', 04:39:07 INFO - 'ts_paint', 04:39:07 INFO - 'tpaint', 04:39:07 INFO - 'sessionrestore', 04:39:07 INFO - 'sessionrestore_no_auto_restore']}, 04:39:07 INFO - 'other_nol64': {'tests': ['a11yr', 04:39:07 INFO - 'ts_paint', 04:39:07 INFO - 'tpaint', 04:39:07 INFO - 'sessionrestore', 04:39:07 INFO - 'sessionrestore_no_auto_restore']}, 04:39:07 INFO - 'svgr': {'tests': ['tsvgx', 04:39:07 INFO - 'tsvgr_opacity', 04:39:07 INFO - 'tart', 04:39:07 INFO - 'tscrollx', 04:39:07 INFO - 'cart']}, 04:39:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:39:07 INFO - 'tests': ['tsvgx', 04:39:07 INFO - 'tsvgr_opacity', 04:39:07 INFO - 'tart', 04:39:07 INFO - 'tscrollx', 04:39:07 INFO - 'cart']}, 04:39:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:07 INFO - 'tests': ['tp5o']}, 04:39:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:07 INFO - 'talos_options': ['--e10s'], 04:39:07 INFO - 'tests': ['tp5o']}, 04:39:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:07 INFO - 'talos_options': ['--xperf_path', 04:39:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:07 INFO - 'tests': ['tp5n']}, 04:39:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:07 INFO - 'talos_options': ['--e10s', 04:39:07 INFO - '--xperf_path', 04:39:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:07 INFO - 'tests': ['tp5n']}}, 04:39:07 INFO - 'talos.zip': {'path': '', 04:39:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:39:07 INFO - Running post-action listener: _resource_record_post_action 04:39:07 INFO - ##### 04:39:07 INFO - ##### Running create-virtualenv step. 04:39:07 INFO - ##### 04:39:07 INFO - Running pre-action listener: _resource_record_pre_action 04:39:07 INFO - Running main action method: create_virtualenv 04:39:07 INFO - Creating virtualenv /builds/slave/test/build/venv 04:39:07 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:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:39:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:39:07 INFO - Using real prefix '/tools/python27' 04:39:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:39:08 INFO - Installing distribute.............................................................................................................................................................................................done. 04:39:10 INFO - Installing pip.................done. 04:39:10 INFO - Return code: 0 04:39:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:10 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 0x1026c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1ebd6cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102565d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10255bb20>, '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.0PvNBml8te/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.f0VXl45Fsm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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:10 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:10 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:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0PvNBml8te/Render', 04:39:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:10 INFO - 'HOME': '/Users/cltbld', 04:39:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:10 INFO - 'LOGNAME': 'cltbld', 04:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:10 INFO - 'MOZ_NO_REMOTE': '1', 04:39:10 INFO - 'NO_EM_RESTART': '1', 04:39:10 INFO - 'PAGER': '/bin/cat', 04:39:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:10 INFO - 'PWD': '/builds/slave/test', 04:39:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:10 INFO - 'SHELL': '/bin/bash', 04:39:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f0VXl45Fsm/Listeners', 04:39:10 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 04:39:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:10 INFO - 'USER': 'cltbld', 04:39:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:10 INFO - 'XPC_FLAGS': '0x0', 04:39:10 INFO - 'XPC_SERVICE_NAME': '0', 04:39:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:11 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:11 INFO - Cleaning up... 04:39:11 INFO - Return code: 0 04:39:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1026c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1ebd6cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102565d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10255bb20>, '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.0PvNBml8te/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.f0VXl45Fsm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:39:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0PvNBml8te/Render', 04:39:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:11 INFO - 'HOME': '/Users/cltbld', 04:39:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:11 INFO - 'LOGNAME': 'cltbld', 04:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:11 INFO - 'MOZ_NO_REMOTE': '1', 04:39:11 INFO - 'NO_EM_RESTART': '1', 04:39:11 INFO - 'PAGER': '/bin/cat', 04:39:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:11 INFO - 'PWD': '/builds/slave/test', 04:39:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:11 INFO - 'SHELL': '/bin/bash', 04:39:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f0VXl45Fsm/Listeners', 04:39:11 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 04:39:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:11 INFO - 'USER': 'cltbld', 04:39:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:11 INFO - 'XPC_FLAGS': '0x0', 04:39:11 INFO - 'XPC_SERVICE_NAME': '0', 04:39:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:11 INFO - Downloading/unpacking psutil>=0.7.1 04:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:39:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:14 INFO - Installing collected packages: psutil 04:39:14 INFO - Running setup.py install for psutil 04:39:14 INFO - building 'psutil._psutil_osx' extension 04:39:14 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:15 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:15 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:15 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:15 INFO - building 'psutil._psutil_posix' extension 04:39:15 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:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:39:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:39:15 INFO - ^ 04:39:15 INFO - 1 warning generated. 04:39:15 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:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:16 INFO - Successfully installed psutil 04:39:16 INFO - Cleaning up... 04:39:16 INFO - Return code: 0 04:39:16 INFO - Installing mozsystemmonitor==0.0.0 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', '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 0x1026c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1ebd6cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102565d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10255bb20>, '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.0PvNBml8te/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.f0VXl45Fsm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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', 'mozsystemmonitor==0.0.0'] 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 mozsystemmonitor==0.0.0 04:39:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0PvNBml8te/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.f0VXl45Fsm/Listeners', 04:39:16 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 04:39:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:16 INFO - 'USER': 'cltbld', 04:39:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:16 INFO - 'XPC_FLAGS': '0x0', 04:39:16 INFO - 'XPC_SERVICE_NAME': '0', 04:39:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:39:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:39:18 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:18 INFO - Installing collected packages: mozsystemmonitor 04:39:18 INFO - Running setup.py install for mozsystemmonitor 04:39:18 INFO - Successfully installed mozsystemmonitor 04:39:18 INFO - Cleaning up... 04:39:18 INFO - Return code: 0 04:39:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:18 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 0x1026c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1ebd6cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102565d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10255bb20>, '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.0PvNBml8te/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.f0VXl45Fsm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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:18 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:18 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:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0PvNBml8te/Render', 04:39:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:18 INFO - 'HOME': '/Users/cltbld', 04:39:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:18 INFO - 'LOGNAME': 'cltbld', 04:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:18 INFO - 'MOZ_NO_REMOTE': '1', 04:39:18 INFO - 'NO_EM_RESTART': '1', 04:39:18 INFO - 'PAGER': '/bin/cat', 04:39:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:18 INFO - 'PWD': '/builds/slave/test', 04:39:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:18 INFO - 'SHELL': '/bin/bash', 04:39:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f0VXl45Fsm/Listeners', 04:39:18 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 04:39:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:18 INFO - 'USER': 'cltbld', 04:39:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:18 INFO - 'XPC_FLAGS': '0x0', 04:39:18 INFO - 'XPC_SERVICE_NAME': '0', 04:39:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:19 INFO - Downloading/unpacking 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:21 INFO - Downloading blobuploader-1.2.4.tar.gz 04:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:39:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:39:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:39:22 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:22 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:22 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:22 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:22 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:22 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:22 INFO - Downloading docopt-0.6.1.tar.gz 04:39:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:39:22 INFO - Installing collected packages: blobuploader, requests, docopt 04:39:22 INFO - Running setup.py install for blobuploader 04:39:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:39:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:39:22 INFO - Running setup.py install for requests 04:39:23 INFO - Running setup.py install for docopt 04:39:23 INFO - Successfully installed blobuploader requests docopt 04:39:23 INFO - Cleaning up... 04:39:23 INFO - Return code: 0 04:39:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:23 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 0x1026c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1ebd6cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102565d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10255bb20>, '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.0PvNBml8te/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.f0VXl45Fsm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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:23 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:23 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:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0PvNBml8te/Render', 04:39:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:23 INFO - 'HOME': '/Users/cltbld', 04:39:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:23 INFO - 'LOGNAME': 'cltbld', 04:39:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:23 INFO - 'MOZ_NO_REMOTE': '1', 04:39:23 INFO - 'NO_EM_RESTART': '1', 04:39:23 INFO - 'PAGER': '/bin/cat', 04:39:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:23 INFO - 'PWD': '/builds/slave/test', 04:39:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:23 INFO - 'SHELL': '/bin/bash', 04:39:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f0VXl45Fsm/Listeners', 04:39:23 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 04:39:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:23 INFO - 'USER': 'cltbld', 04:39:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:23 INFO - 'XPC_FLAGS': '0x0', 04:39:23 INFO - 'XPC_SERVICE_NAME': '0', 04:39:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:23 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-MNXk7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:23 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-B3paKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:24 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-xTo9AB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:24 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-VhLJrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:24 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-T2K2G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:24 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-lL6AUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:24 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-yjEUv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:24 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-AKY1Xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:24 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-mIkPja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:24 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-5590CQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:24 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-yilAs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:25 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-BsxFTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:25 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-Pwn_az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:25 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-8M87j5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:25 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-02fUID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:25 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-Ll739I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:25 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-XJNQpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:39:25 INFO - Running setup.py install for manifestparser 04:39:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:39:25 INFO - Running setup.py install for mozcrash 04:39:25 INFO - Running setup.py install for mozdebug 04:39:26 INFO - Running setup.py install for mozdevice 04:39:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Running setup.py install for mozfile 04:39:26 INFO - Running setup.py install for mozhttpd 04:39:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Running setup.py install for mozinfo 04:39:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Running setup.py install for mozInstall 04:39:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Running setup.py install for mozleak 04:39:26 INFO - Running setup.py install for mozlog 04:39:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Running setup.py install for moznetwork 04:39:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Running setup.py install for mozprocess 04:39:27 INFO - Running setup.py install for mozprofile 04:39:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Running setup.py install for mozrunner 04:39:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Running setup.py install for mozscreenshot 04:39:27 INFO - Running setup.py install for moztest 04:39:28 INFO - Running setup.py install for mozversion 04:39:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:39:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:39:28 INFO - Cleaning up... 04:39:28 INFO - Return code: 0 04:39:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:28 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 0x1026c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1ebd6cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102565d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10255bb20>, '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.0PvNBml8te/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.f0VXl45Fsm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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:28 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:28 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:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0PvNBml8te/Render', 04:39:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:28 INFO - 'HOME': '/Users/cltbld', 04:39:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:28 INFO - 'LOGNAME': 'cltbld', 04:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:28 INFO - 'MOZ_NO_REMOTE': '1', 04:39:28 INFO - 'NO_EM_RESTART': '1', 04:39:28 INFO - 'PAGER': '/bin/cat', 04:39:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:28 INFO - 'PWD': '/builds/slave/test', 04:39:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:28 INFO - 'SHELL': '/bin/bash', 04:39:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f0VXl45Fsm/Listeners', 04:39:28 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 04:39:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:28 INFO - 'USER': 'cltbld', 04:39:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:28 INFO - 'XPC_FLAGS': '0x0', 04:39:28 INFO - 'XPC_SERVICE_NAME': '0', 04:39:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:28 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-QxPE23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:28 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-6bI_8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:28 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-C4QjYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:28 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-rOAP4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:28 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-S51dgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:29 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-47qeUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:29 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-jqYdj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:29 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-RASZ7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:29 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-qc1_lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:29 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-bOWhrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:29 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-hQyzgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:29 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-1OlEx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:29 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-jfyfPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:29 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-bC_Lcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:29 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-Dpu_v3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:30 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-ZxdKHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:30 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-BL_Bpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:30 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:30 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:30 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:30 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:30 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:30 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:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:32 INFO - Downloading blessings-1.6.tar.gz 04:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:39:32 INFO - Installing collected packages: blessings 04:39:32 INFO - Running setup.py install for blessings 04:39:32 INFO - Successfully installed blessings 04:39:32 INFO - Cleaning up... 04:39:32 INFO - Return code: 0 04:39:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:39:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:33 INFO - Reading from file tmpfile_stdout 04:39:33 INFO - Current package versions: 04:39:33 INFO - blessings == 1.6 04:39:33 INFO - blobuploader == 1.2.4 04:39:33 INFO - docopt == 0.6.1 04:39:33 INFO - manifestparser == 1.1 04:39:33 INFO - mozInstall == 1.12 04:39:33 INFO - mozcrash == 0.16 04:39:33 INFO - mozdebug == 0.1 04:39:33 INFO - mozdevice == 0.48 04:39:33 INFO - mozfile == 1.2 04:39:33 INFO - mozhttpd == 0.7 04:39:33 INFO - mozinfo == 0.9 04:39:33 INFO - mozleak == 0.1 04:39:33 INFO - mozlog == 3.1 04:39:33 INFO - moznetwork == 0.27 04:39:33 INFO - mozprocess == 0.22 04:39:33 INFO - mozprofile == 0.28 04:39:33 INFO - mozrunner == 6.11 04:39:33 INFO - mozscreenshot == 0.1 04:39:33 INFO - mozsystemmonitor == 0.0 04:39:33 INFO - moztest == 0.7 04:39:33 INFO - mozversion == 1.4 04:39:33 INFO - psutil == 3.1.1 04:39:33 INFO - requests == 1.2.3 04:39:33 INFO - wsgiref == 0.1.2 04:39:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-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 0x1026c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1ebd6cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102565d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10255bb20>, '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.0PvNBml8te/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.f0VXl45Fsm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-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:33 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:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0PvNBml8te/Render', 04:39:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:33 INFO - 'HOME': '/Users/cltbld', 04:39:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:33 INFO - 'LOGNAME': 'cltbld', 04:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:33 INFO - 'MOZ_NO_REMOTE': '1', 04:39:33 INFO - 'NO_EM_RESTART': '1', 04:39:33 INFO - 'PAGER': '/bin/cat', 04:39:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:33 INFO - 'PWD': '/builds/slave/test', 04:39:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:33 INFO - 'SHELL': '/bin/bash', 04:39:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f0VXl45Fsm/Listeners', 04:39:33 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 04:39:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:33 INFO - 'USER': 'cltbld', 04:39:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:33 INFO - 'XPC_FLAGS': '0x0', 04:39:33 INFO - 'XPC_SERVICE_NAME': '0', 04:39:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:33 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:33 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:33 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:33 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:33 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:33 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:33 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:33 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:33 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:33 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:33 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:33 INFO - Cleaning up... 04:39:33 INFO - Return code: 0 04:39:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1ebd6cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102565d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10255bb20>, '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.0PvNBml8te/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.f0VXl45Fsm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:39:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0PvNBml8te/Render', 04:39:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:33 INFO - 'HOME': '/Users/cltbld', 04:39:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:33 INFO - 'LOGNAME': 'cltbld', 04:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:33 INFO - 'MOZ_NO_REMOTE': '1', 04:39:33 INFO - 'NO_EM_RESTART': '1', 04:39:33 INFO - 'PAGER': '/bin/cat', 04:39:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:33 INFO - 'PWD': '/builds/slave/test', 04:39:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:33 INFO - 'SHELL': '/bin/bash', 04:39:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f0VXl45Fsm/Listeners', 04:39:33 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 04:39:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:33 INFO - 'USER': 'cltbld', 04:39:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:33 INFO - 'XPC_FLAGS': '0x0', 04:39:33 INFO - 'XPC_SERVICE_NAME': '0', 04:39:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:33 INFO - Downloading/unpacking jsonschema 04:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:39:35 INFO - Downloading/unpacking functools32 (from jsonschema) 04:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:36 INFO - Downloading functools32-3.2.3-2.tar.gz 04:39:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:39:36 INFO - warning: no files found matching '*.txt' 04:39:36 INFO - no previously-included directories found matching 'build' 04:39:36 INFO - no previously-included directories found matching 'dist' 04:39:36 INFO - no previously-included directories found matching '.git*' 04:39:36 INFO - Installing collected packages: jsonschema, functools32 04:39:36 INFO - Running setup.py install for functools32 04:39:36 INFO - warning: no files found matching '*.txt' 04:39:36 INFO - no previously-included directories found matching 'build' 04:39:36 INFO - no previously-included directories found matching 'dist' 04:39:36 INFO - no previously-included directories found matching '.git*' 04:39:36 INFO - Successfully installed jsonschema functools32 04:39:36 INFO - Cleaning up... 04:39:36 INFO - Return code: 0 04:39:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1026c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026c74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1ebd6cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102565d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10255bb20>, '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.0PvNBml8te/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.f0VXl45Fsm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:39:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:39:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0PvNBml8te/Render', 04:39:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:36 INFO - 'HOME': '/Users/cltbld', 04:39:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:36 INFO - 'LOGNAME': 'cltbld', 04:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:36 INFO - 'MOZ_NO_REMOTE': '1', 04:39:36 INFO - 'NO_EM_RESTART': '1', 04:39:36 INFO - 'PAGER': '/bin/cat', 04:39:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:36 INFO - 'PWD': '/builds/slave/test', 04:39:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:36 INFO - 'SHELL': '/bin/bash', 04:39:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f0VXl45Fsm/Listeners', 04:39:36 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 04:39:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:36 INFO - 'USER': 'cltbld', 04:39:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:36 INFO - 'XPC_FLAGS': '0x0', 04:39:36 INFO - 'XPC_SERVICE_NAME': '0', 04:39:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:36 INFO - Downloading/unpacking flake8 04:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:39:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:39:39 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:39 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:39 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:39 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:39 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:39 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:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:39:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:39:39 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:39 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:39 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:39 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:39 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:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:39:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:40 INFO - no previously-included directories found matching 'docs/_build' 04:39:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:39:40 INFO - Running setup.py install for pep8 04:39:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:40 INFO - no previously-included directories found matching 'docs/_build' 04:39:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:39:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:39:40 INFO - Cleaning up... 04:39:40 INFO - Return code: 0 04:39:40 INFO - Running post-action listener: _resource_record_post_action 04:39:40 INFO - Running post-action listener: _start_resource_monitoring 04:39:40 INFO - Starting resource monitoring. 04:39:40 INFO - ##### 04:39:40 INFO - ##### Running install step. 04:39:40 INFO - ##### 04:39:40 INFO - Running pre-action listener: _resource_record_pre_action 04:39:40 INFO - Running main action method: install 04:39:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:41 INFO - Reading from file tmpfile_stdout 04:39:41 INFO - Detecting whether we're running mozinstall >=1.0... 04:39:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:39:41 INFO - Reading from file tmpfile_stdout 04:39:41 INFO - Output received: 04:39:41 INFO - Usage: mozinstall [options] installer 04:39:41 INFO - Options: 04:39:41 INFO - -h, --help show this help message and exit 04:39:41 INFO - -d DEST, --destination=DEST 04:39:41 INFO - Directory to install application into. [default: 04:39:41 INFO - "/builds/slave/test"] 04:39:41 INFO - --app=APP Application being installed. [default: firefox] 04:39:41 INFO - mkdir: /builds/slave/test/build/application 04:39:41 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:41 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:15 INFO - Reading from file tmpfile_stdout 04:40:15 INFO - Output received: 04:40:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:40:15 INFO - Running post-action listener: _resource_record_post_action 04:40:15 INFO - ##### 04:40:15 INFO - ##### Running run-tests step. 04:40:15 INFO - ##### 04:40:15 INFO - Running pre-action listener: _resource_record_pre_action 04:40:15 INFO - Running main action method: run_tests 04:40:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:40:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:40:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:40:15 INFO - 2016-02-06 04:40:15.506 screenresolution[1758:14216] starting screenresolution argv=screenresolution get 04:40:15 INFO - 2016-02-06 04:40:15.509 screenresolution[1758:14216] Display 0: 1600x1200x32@60 04:40:15 INFO - 2016-02-06 04:40:15.515 screenresolution[1759:14219] starting screenresolution argv=screenresolution list 04:40:15 INFO - Available Modes on Display 0 04:40:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:40:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:40:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:40:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:40:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:40:15 INFO - Intel Iris: 04:40:15 INFO - Chipset Model: Intel Iris 04:40:15 INFO - Type: GPU 04:40:15 INFO - Bus: Built-In 04:40:15 INFO - VRAM (Dynamic, Max): 1536 MB 04:40:15 INFO - Vendor: Intel (0x8086) 04:40:15 INFO - Device ID: 0x0a2e 04:40:15 INFO - Revision ID: 0x0009 04:40:15 INFO - Displays: 04:40:15 INFO - Display: 04:40:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:40:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:40:15 INFO - Display Serial Number: 1600x1200 60 04:40:15 INFO - Main Display: Yes 04:40:15 INFO - Mirror: Off 04:40:15 INFO - Online: Yes 04:40:15 INFO - Rotation: Supported 04:40:15 INFO - Return code: 0 04:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:40:15 INFO - Python 2.7.3 04:40:15 INFO - Return code: 0 04:40:15 INFO - grabbing minidump binary from tooltool 04:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:15 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 0x102565d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10255bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:40:15 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:15 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:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:40:15 INFO - Return code: 0 04:40:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:40:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:40:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:40:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:40:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:40:17 INFO - Return code: 0 04:40:17 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-0070', '--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:17 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-0070 --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:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0PvNBml8te/Render', 04:40:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:17 INFO - 'HOME': '/Users/cltbld', 04:40:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:17 INFO - 'LOGNAME': 'cltbld', 04:40:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:40:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:17 INFO - 'MOZ_NO_REMOTE': '1', 04:40:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:40:17 INFO - 'NO_EM_RESTART': '1', 04:40:17 INFO - 'PAGER': '/bin/cat', 04:40:17 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:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:17 INFO - 'PWD': '/builds/slave/test', 04:40:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:40:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:17 INFO - 'SHELL': '/bin/bash', 04:40:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f0VXl45Fsm/Listeners', 04:40:17 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 04:40:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:17 INFO - 'USER': 'cltbld', 04:40:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:17 INFO - 'XPC_FLAGS': '0x0', 04:40:17 INFO - 'XPC_SERVICE_NAME': '0', 04:40:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:17 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-0070', '--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:17 INFO - mozversion application_buildid: 20160203075343 04:40:17 INFO - mozversion application_changeset: 46d6d868ba0f8ae089da8882b594fe359eba2978 04:40:17 INFO - mozversion application_display_name: Nightly 04:40:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:40:17 INFO - mozversion application_name: Firefox 04:40:17 INFO - mozversion application_remotingname: firefox 04:40:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:40:17 INFO - mozversion application_vendor: Mozilla 04:40:17 INFO - mozversion application_version: 47.0a1 04:40:17 INFO - mozversion platform_buildid: 20160203075343 04:40:17 INFO - mozversion platform_changeset: 46d6d868ba0f8ae089da8882b594fe359eba2978 04:40:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:40:17 INFO - mozversion platform_version: 47.0a1 04:40:17 INFO - using testdate: 1454762417 04:40:17 INFO - actual date: 1454762417 04:40:17 INFO - starting webserver on 'localhost:49273' 04:40:17 INFO - SUITE-START | Running 2 tests 04:40:17 INFO - TEST-START | dromaeo_css 04:40:17 INFO - operating with platform_type : mac_ 04:40:17 INFO - Initialising browser for dromaeo_css test... 04:40:17 INFO - TEST-INFO | started process 1777 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpJdvH5v/profile http://localhost:49273/getInfo.html) 04:40:18 INFO - PROCESS | 1777 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:40:20 INFO - PROCESS | 1777 | __metrics Screen width/height:1600/1200 04:40:20 INFO - PROCESS | 1777 | colorDepth:24 04:40:20 INFO - PROCESS | 1777 | Browser inner width/height: 1024/689 04:40:20 INFO - PROCESS | 1777 | __metrics 04:40:20 INFO - PROCESS | 1777 | 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:20 INFO - PROCESS | 1777 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:40:20 INFO - TEST-INFO | 1777: exit 0 04:40:20 INFO - Browser initialized. 04:40:20 INFO - Running cycle 1/1 for dromaeo_css test... 04:40:20 INFO - TEST-INFO | started process 1781 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpJdvH5v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:32 INFO - PROCESS | 1781 | RSS: Main: 242667520 04:40:32 INFO - PROCESS | 1781 | 04:41:24 INFO - PROCESS | 1781 | 1454762484627 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:33 INFO - PROCESS | 1781 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 04:43:35 INFO - PROCESS | 1781 | RSS: Main: 348393472 04:43:35 INFO - PROCESS | 1781 | 04:46:38 INFO - PROCESS | 1781 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 04:46:38 INFO - PROCESS | 1781 | RSS: Main: 376950784 04:46:38 INFO - PROCESS | 1781 | 04:49:40 INFO - PROCESS | 1781 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 04:49:41 INFO - PROCESS | 1781 | RSS: Main: 378171392 04:49:41 INFO - PROCESS | 1781 | 04:52:43 INFO - PROCESS | 1781 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 04:52:44 INFO - PROCESS | 1781 | RSS: Main: 370798592 04:52:44 INFO - PROCESS | 1781 | 04:55:47 INFO - PROCESS | 1781 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 04:55:47 INFO - PROCESS | 1781 | RSS: Main: 340692992 04:55:47 INFO - PROCESS | 1781 | 04:58:50 INFO - PROCESS | 1781 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 04:58:51 INFO - PROCESS | 1781 | RSS: Main: 386449408 04:58:51 INFO - PROCESS | 1781 | 04:58:51 INFO - PROCESS | 1781 | __start_tp_report 04:58:51 INFO - PROCESS | 1781 | _x_x_mozilla_page_load 04:58:51 INFO - PROCESS | 1781 | _x_x_mozilla_page_load_details 04:58:51 INFO - PROCESS | 1781 | |i|pagename|runs| 04:58:51 INFO - PROCESS | 1781 | |0;dojo.html;3445.9483107753385;3489.616142224353;3499.230169362741;3522.9295414091725;3556.6976806971406;5577.107662773957;5676.886462270752;5694.715264236792;5699.202111704365;5722.37053924068;5610.410906854782;5676.602637815345;5740;5827.475527202551;5843.298804143498;5154.974225128869;5158.896822063566;5169.793208271664;5181.0933086709865;5224.686518808865;5279.340082489689;5307.73461326934;5310.097283461801;5311.203319502067;5347.679139251657;5138.922916156261;5208.5572726318305;5232.555232805216;5243.475652434745;5252.65857719247;5212.50481204285;5240.4497527759795;5240.52835244826;5244.763985620656;5247;5126.897462050775;5204.193350030751;5205.037068142406;5205.219217117425;5209.984053109645;5458.972705136489;5526.806561770319;5530.751116199781;5544.528715059225;5545.140503222007;6205.87588248237;6260.561760676755;6262.185915830958;6266;6280.214973128359;6128;6202.751889924398;6312.747490100391;6325.304216536223;6336.46140078094;5666.951613951433;5740.339860916007;5758.049921762904;5802.1296805479515;5804.88390232193;6273.059041143773;6274.121622972787;6295.496360291166;6301.905471417932;6314.8421289467215;5972.5520585955355;6177.320494745574;6183.196184495987;6188.164597779332;6189.195404597373;6175.907361389583;6191.628502289877;6223.62658240498;6274.309825919146;6299.023651334051;6189;6196.659183744938;6198.504119670415;6221.160143380676;6231.4391704746795;6054.424829641177;6208.441240288395;6212.968935155295;6222.502199824004;6225.408586184305;4849.975750121227;4868.464468908417;4870.975645121752;4940.604751619861;4969.776360063805;3690.261947610435;4296.634786043159;4340.652747780233;4354.891127721832;4355.499117601516;5673.858153546194;5717.571182161355;5720.628159169641;5731.541476681856;5779.566532510079;6120.050983828535;6229.003359462555;6244.843878903063;6246.6876656167005;6334.208223972004;5696.3164420269;5699.515541178963;5709.8287051388525;5712.885742285131;5741.942580574141;5300.257963885059;5332.626716129834;5336.279602253646;5340.546053585489;5346.625736198506;6227.750889964532;6236.532260080512;6282.717277722422;6286.528510361742;6292.087647291209;6266.592671476339;6274.623522588659;6309.652969086745;6313.936860631335;6318.399752023551;6276.466500347522;6294.339094395205;6295.874082518416;6301.527385446201;6307.432331090224;5001.774920128676;6028.698565071817;6121.816345509642;6132.448079672851;6188.907166392598;5138.5375316220225;6192.876142477216;6204.224471941007;6210.5652604317265;6238.189035425366;5137.383513978347;5479.232907392889;6096.695165241809;6105.914670190187;6125.84596676928;6050.878982420415;6084.361142080018;6115.296740874856;6122.142899994094;6124.846878828065;5748.942510575008;5885.764569417175;5937.317208520903;5939.138824870456;5964.493018093511;5999.070144127667;6044.758209671564;6087.878242435215;6100.054491553817;6128.693565321805;5939.910901336397;5942.762289508544;5959.106134079922;5975.521958243417;5978.388360659864 04:58:51 INFO - PROCESS | 1781 | |1;ext.html;453.40377403714115;468.60168856472;573.2948473377745;579.9594028418011;592.0202065581465;34936.12659683506;37392;37500;37575.62424375756;37598.43602345964;31388.68611313886;39202.82391528252;39223.607763922424;39239;39279.41080883782;9337.626494940194;9576.569054392568;9578.090081442288;9583.472908990037;9587;9535.189508891752;9683.564239609235;9686.66096686616;9686.951565242163;9698.369605975624;9649;9728.270379721514;9735.902640973605;9738.123568878835;9741.90258097417;9606.663766768164;9662.806743865154;9692.75768105796;9701.854472182922;9712.417254964725;9444.819397575304;9594.568244429018;9601.47191904445;9607.13535781783;9608.423494590346;37797.24405511875;38163.23673526542;38186.618133818585;38210.617893820985;38263.234735305414;3109.4247564200696;3209.7753157279;3212.5921696169266;3215.983920080408;3231.1437469070715;27947.441051178863;28011.439771204667;29444.70555294441;29525.852370738008;31076.115485564304;2736.53478908586;2763.1710486853863;2768.9723102768917;2790.9023184188454;2802.173358859121;485503.5724821389;489451;489740;489752;490252;57648.423515764305;58702.412975869694;58798.11802822961;67694.66152669206;68237.97643035358;71922.64038679774;72951;73091.53816923632;73217;73288.26711732814;16430.342786288413;16895;16930.915345423193;16965.491035268962;16970.896891702;11348.432578371048;11715;11726.120540959462;12810.615681529569;12896.097273190786;18047.54881127956;18317.81682183188;18340;20886.58226835485;21588.028538715796;7406.407487401103;7591.089069311718;8364.58177091143;8834.602442890086;8911.064338244521;927.5825878354767;977.8386566216636;1057.4078516030893;1083.4636854756945;1112.238116889933;31671.891483798416;32619.67380326214;32715.50926736101;33301.50047749286;33339;1071.507106730897;1098.9450527473755;1149.8850114988602;1156.0000599481557;1194.3073017649915;15295.61760955985;15440.073595584301;15535.223238838013;16040.358385664442;16520.917395412947;529441;534793;534799;535293;537032;59884;60807.695961520796;60899;60984;61003.38996609977;1234.8703386144325;1435.8205224346957;1457.3441951121827;1457.6501639606417;1470.6838029823639;30225;30336.84831575828;30457.54313685341;31041.8447907759;31125.066248012597;50695;51415.22877156771;51419.971600568526;51615.48384516257;51635.741821290656;465431;465595;465867;466905;467466;28002.719972800012;32019.839900800347;32393.676063239065;32712.509312359856;33010.504842427865;35300.117497062776;37290.62709372872;43066.56933430626;43185;43278.783606081764;35015.9495215144;35755.821220893726;35809.82095089508;35966;36127.63872361243;33381.831635892624;34742;35584.46623300704;35708;35771.82114089413;31198.22004449816;31768.841155794074;31776.8411157952;32425;35567.46648800322;25978.870105649352;30908.227294316923;30915;31665;32137.517937231427;23518.647220292052;24127.51744965126;24329.391765205302;24668.753312467365;25319 04:58:51 INFO - PROCESS | 1781 | |2;jquery.html;359.7517712778183;361.0432354261206;367.10609665464597;367.89882782234884;369.88903329001295;14968.700625987474;15113.319900604472;18914.716279255805;19974.50063748407;21023.05396257168;16005;18971.81028189718;19503;20173.899130504327;20218.696719549218;5088.313077734514;5584.357798853143;5611.635243709166;5858.941410585903;5875.970620146893;4132.152908653718;4312.719673221231;4839.612830973531;5114.923276150861;5751.741171647286;6006.609570377933;6282.057691346312;6291.496680265568;6297.929352010146;6299.33856945021;6361.4274715275615;6363.013732871413;6366.554341196118;6377.489800815923;6387.808365749035;5344.545713614348;5448.536874365684;5494.725263736837;5499.285092937893;5526.06056970316;21364.038618262217;21691.783082169135;24349.26952191437;24528.877355613287;24715.62926556103;2356.2577787996897;2374.952500949971;2376.6435034744754;2707.241972247774;2716;13935.790963135561;13941.163530188222;14030.368633411521;14616.853831461656;14643.48747793822;1689.6029433083338;1720.053970316321;1728.032301910934;1736.1232577548383;1771.7430972509044;96005;98165;98168.50915745446;99260;99522.004779952;9876.160526355197;10431.68704938853;10757.30077544957;10783.78432431347;10905.454727263605;13252.73494530104;13310.534131305552;13373.598792036255;13385.996050296071;13415.0609457339;8368.874466883002;8373.204545568162;8392;8430.662773489114;8465.534395608178;8488.320934325362;8488.533130677872;8512.319014478951;8580.528070956032;8598.656053757779;3583.9104022399647;4300.505441874162;4358.8038538265855;4383.430154079949;4422.358757980139;1437.6405898525368;1780.6349698311815;1792.8476079533125;1793.2199493220492;1836.3480964257762;852.8678054901376;895.6909866096187;952.514217748953;1029.9330543514648;1060.3107979813028;18629.813701862808;19257.8074219256;19439.433537045436;19470.902645486964;19761.703574446394;806.3549160671439;928.6146249306597;945.3193700535603;967.2842096848282;994.5275993902839;8461.746147615582;9336.87957445111;10047.748806279902;10314.793704125876;10463.68608941733;541929;586396;702704;715823;738710;85846;103175.48412258041;104106;104618;114978;491.037566369919;505.8356034288871;506.18756895183435;510.3034358101165;510.5150107397987;8222.506649601042;9793.069658382443;10464.63373781914;10744.4090575016;11452.94273528627;48273.2762757957;49877.75061124671;50006.749966251395;50446.49553504418;51915.6254843434;71942;72666.63666681632;73412.898806519;73893.630531847;74118.25881741113;7442.330190282684;7583.2416758325935;7590;7689;7695;9177.862332064891;11526.308421494738;11737.471813768572;11829.52681892749;12104.515819367127;9876.40741555509;9920.107190352903;9976;10124.898751012395;10214.029667181605;9820.312578119463;9898.010198980044;9932.0067993203;10153.238507111848;10173.898261017295;8860.601272942862;10281.752909135925;10524.842127367943;10723.89276107229;10773.569057237622;7623.542587444771;7790.649420775965;7805.102413222325;7807.414443916842;7811.609419529114;9801.110912022776;10503.842442363524;10666.253362264568;10730.463476825971;10765.523929496416 04:58:51 INFO - PROCESS | 1781 | |3;mootools.html;1194.9424759088206;1352.4725357110735;1469.9853001469985;1676.2540669402113;1929.7780755213155;7935.285824275814;8121.796955076126;8663.78340541486;8846.380753347268;8853.026167121612;8647.481151130936;8771.210591046805;8820.073892241318;8831.116888311166;8848.77878053049;2129.265403435812;2215.202527090254;2480.5364834747497;2497;2505.5865782145925;2229.7547269800307;2458.041363868093;2503.173952595639;2505.9373515662073;2512.6231065340253;2436.135172013936;2444.6455263986713;2465.593177125772;2467.8889449974795;2472.307753828931;2428.720697119836;2449.987750061256;2461.655368248447;2466.802655787542;2476.7770900618852;2080.3030984620173;2403.567357875582;2447.984086604057;2458.262521243638;2466.1121996081397;8862.911370886273;8863.601137948808;8915.37592368528;8918.464892106495;8922.68770593026;5452.073147564924;5553.305836770403;5576.247206627094;5588.832335029955;5596.496315331639;3628.2743451309843;3702.4631428442726;3738.102855314732;3739.046543131511;3784.7539909906045;1049.4857519815312;1064.3241541621048;1068.834330678746;1095.3482677806771;1098.3794156301744;12280.078994075391;12300.692482687915;12313.75372492554;12325.815112773316;12332.876671233353;4908.913711672525;4935.728534930613;4938;4975.8507244781995;5009.549140577293;10351.689449316533;10369.792604148026;10380.117689996436;10381.740456488647;10438.791224175626;5553.611247212737;5580.888382232332;5586.16207568868;5589.972050139723;5591.440855914376;4220.662347012231;5012.273220383024;5064.392272927199;5082.415522214918;5145.974270128625;3673.045008297808;3725.18046029873;3725.6646901778972;3950.20995800841;3952.8418863245724;1213.5327898759042;1230.7200511468152;1296.695276609996;1318.3803612302395;1326.2042774335514;1077.8922107789315;1115.9609413670482;1122.5622007417114;1173.6185739634652;1288.5812111063942;7973.561454120079;8079.353651707849;8085.948826652498;8138.674453021813;8150.470219435836;1003.8243307421172;1185.7154282972024;1193.1886317304143;1197.22180582622;1212.4543955220186;6178.62928224308;6259.0924315973925;6266.279377871603;6266.498680105672;6276.905846412307;10038;10630.20273479492;10693.732656683645;10737.087347575543;10740.516676749565;10274.845877311845;10541.051305382553;10554.683359499228;10572.629957951434;10625.787484250272;8224.095349511548;8321.791955201168;8384.748457546284;8393;8394.160583941557;7722.227777222233;7823.982882225274;7864.646090926037;7895.447318687637;7997.440179187401;9086.681966131153;9139.268858491438;9227.630894764134;9380.108889655472;9476.810463790824;9528.475933823705;9806.85289720669;9809.803803923738;9941.453220072675;10017.449040302854;7341.412686985135;7368.889466658112;7473.850522989618;7491.288327608869;7497.137829149499;7221.67502462401;7393.297636724503;7405.9629701851145;8010.078840933134;8104.716334928249;7409.518381305198;7474.364679002346;7495.400367970658;7637.923620763721;7653.655585498777;7282.2353652867805;7384.593847338448;7444.553326800409;7476.25237476248;7556.508826926232;7555.320021197898;7610.9238907610215;7666.4633475656165;7676.6545505453505;7679.385649147943;6967.407770339578;6991.056207411934;7017.3684368407085;7022;7028.824279393056;7074.646267686698;7102.183248926233;7117.964410178123;7124.287571242834;7133.037039999534 04:58:51 INFO - PROCESS | 1781 | |4;prototype.html;318.6494855658775;322.0900954802683;328.37444667907647;329.6703296703297;333.47144775530785;6285.42864283929;6415.166028416305;6477.773277935274;6482.773102941398;6503.869922601545;6351.7459301628;6372.362763723625;6373.9362606373925;6375.107484952099;6378.649174295412;4676.228422310314;4718.079974404993;4719.150552900476;4729.881752956169;4749.8337558185385;4730.361401210827;4737.881552961187;4751.16854550454;4757.690750101249;4772.761361931907;4611.700239484439;4761.547652972962;4776.785044672998;4784.712917224961;4823.879403014935;4759.071980963713;4773.140834649762;4779.737114458703;4789.521047895182;4796.088743138793;4107.938380924288;4112.547619761824;4116.176764647053;4116.876493705194;4118.402831589433;5802.100674395476;5972.70136493178;5995.980683283852;6004.819855404345;6005.579609427342;4508.729476231437;4666.603338716213;5391.865203369908;5523.834284971457;5531.363893152299;6701.29636388182;6702.966485167592;6710.899336509956;6712.395884370381;6714.19429668438;3498.6326435724136;4292.79801655537;4392.1874453226255;4538.251188553884;4539.024109816405;5824.621399609055;6527;6970.128733908262;6976;6989.475789315872;4652.464966528825;4664.137134630104;4666.440027196691;4670.136024835417;4671.929921051187;4758.143534163814;4758.500357462486;4762.690425122356;4766.070616229802;4785.832495862628;5585.3297604287745;5586.301712285965;5600.635958662674;5605.075162598126;5615.18579805934;5527.778888844482;6658.3341665834;6815.829604259834;6848.760293389708;6851.835188018049;1549.6745683406386;1584.4771225495558;1588.2693960778172;1590.3559058581293;1615.3700056977789;1037.749511838233;1053.9683809485728;1083.869935607732;1084.6366467233408;1089.4389389464432;5068.68214264294;5611.7755289788765;6340.556161068773;6343.746250150035;6364.91796394614;6933.410660093848;6964.129483814523;6964.303569642995;6969.630325689189;6986.510944233854;6355.046742988497;6361.236651601745;6364.077208804697;6368;6372.458341041063;3619.2037751694584;3746.83139258734;3759.4172903200047;3765.3410653135593;3766.2844059628583;7367;7379.188289288174;7396.667149978264;7461.403087752967;7535.8116047099265;6402.679866006681;6956.5478243913985;7132.750353737594;7412.369948554326;7432.9256707433315;7472.103347598431;7475;7475.028246327943;7481.102267727908;7496.8500629986;5788.421157884178;7094.822629434306;7109.537880037781;7120.394766444703;7121.038659780863;6141.8944589974235;6182.350853160533;6944.201416837129;6972.267911869383;7038.260982596754;7487.588182650006;7515.661795219337;7519.43604229674;7521.887171692539;7527.8118047049265;4515.819367225275;4553.9316910247035;4559.156556037144;4566.292224705176;4568.8857778554475;6838.281980391987;7088.929110709033;7108.147022357351;7118.501704880816;7131.0729605151;6503.577267477599;6620.205575330799;6633.767818126343;6687.364700353459;6935;6869.793906182823;6877.621730804653;6887.345702158287;6902.965485172542;6907.274736152833;6542.313057128933;6724.4284235840505;6728.091707619605;6735.831604209738;6743.696533656095;6904.378605925491;6905.274946130584;6907.240203577703;6913.481488888253;6915.755164070516;5447.564194864481;6725.495587830835;6754.425873800782;6773.390394864486;6780.796576102724 04:58:51 INFO - PROCESS | 1781 | |5;yui.html;614.6926536731634;617.2931992868166;718.8490417012428;747.7767791973071;763.5151678684038;14727.190004549746;14909.403623855047;14939;14970.92514537427;15014.399424023026;13387.263700496469;13413.798793018113;15240.923795381008;15631.062136271832;15637.92181039096;692.2108795972596;705.2136867392845;848.5757121439281;864.5245115186653;866.9913300867005;708.9361957423831;709.7019251914182;709.7977076533189;710;711.8825393810015;894.7181637784109;897.1701176411825;908.504864848659;909.4679612426738;909.6043221198767;897.8821367397599;898.0032164297625;898.1243287794414;898.7393655839799;903.7559858838109;535.7963973690012;546.2270886695321;546.6392181160455;659.3933581105347;666.4468491152332;12307.138500304982;14878.404863805543;14931.25343732809;14942.701145977127;14970.251487425694;12117.030637548974;12176.695582610506;12314.753704925852;12409.62771116868;12641.557545485864;9813.705588832347;9934.751631209205;9970.202383809277;10101.494925253708;10628.627998020032;3444.3627928832993;3476.5480487536456;3500.4924285978645;3504.526888869995;3550.946735798965;83749.16250837475;84275.3144937104;86159.13840861636;86363.13636863614;86382.84042898915;9302.209312208539;9413.294002949806;9474.85787713171;9550.570224339921;9875.555599998017;20583.38249852507;20680.793192068188;20914.47713807167;20920.686189707165;20921.163153473994;7421.962890185622;7487;7497.475176737576;7529.774106776806;7635.503692259986;4182.226288136704;4188.329867221291;4201.894952626209;4208.011117387473;4217.91564168721;3491.8079505626924;3544.8936531904083;3547.8048707321345;3548.8935331940083;3554.484599733076;654.8166513376262;656.2158220925947;657.2277573850706;657.9440747536513;659.0509666080924;474.80295677294225;570.5920267009026;620.9130721698966;632.3170975346615;636.4971672378862;6921.792346229621;8488.151184881586;8498.235158835734;8625.051244363114;8690.435121717068;519.231537324754;540.103428309013;597.1252115650593;600.1283856745539;617.6964081547794;3908.843646254175;4020.537638171648;4087.452471482838;4122.628963393309;4150.045489537423;74396;93734;95906;96815;96908.51545742367;80345.79481307785;80883;81011.18988810154;82689;83757.58121209354;62590.0611490828;65294.67352663206;67905.66047169732;69388.999999999;70008.29991700017;7953.2842044216295;7977.122516523062;8130.918690813016;8214.680691731206;8250.422470427013;48213;49222;49240.01519969652;49605.751971239915;50335.98656053717;62114.68942655258;63763.768268112246;64766.35233647603;69071.3092869085;69579;8540.786480337792;9864.802703946025;9960.900390996287;10061.89938100639;10562.31344962575;10689.412082335546;10803.189760768131;10892.7276818077;10932;10986.780264394507;9876.654317098866;10233.283670143019;10259.538320775733;10267.897321026694;11023.889761102286;11430.1998860079;11445.885541144482;11475.081993440672;11546.480408381474;12181.634550963485;9099.54502274897;10653.201009924132;10677.359358438518;11182.993530582287;11305.26515776472;9044.63821447161;9057.501837399006;9067.863982040142;9458.243340532603;9569.138777510057;9202.033786452326;9544.284178686488;9582.137607615348;9702.223822094074;9948.204143668634 04:58:51 INFO - PROCESS | 1781 | __end_tp_report 04:58:51 INFO - PROCESS | 1781 | __start_cc_report 04:58:51 INFO - PROCESS | 1781 | _x_x_mozilla_cycle_collect,1459 04:58:51 INFO - PROCESS | 1781 | __end_cc_report 04:58:51 INFO - PROCESS | 1781 | __startTimestamp1454763531032__endTimestamp 04:58:51 INFO - PROCESS | 1781 | 04:58:51 INFO - PROCESS | 1781 | ------- Summary: start ------- 04:58:51 INFO - PROCESS | 1781 | Number of tests: 6 04:58:51 INFO - PROCESS | 1781 | 04:58:51 INFO - PROCESS | 1781 | [#0] dojo.html Cycles:165 Average:5714.33 Median:5939.14 stddev:640.88 (10.8%) stddev-sans-first:617.65 04:58:51 INFO - PROCESS | 1781 | Values: 3445.9 3489.6 3499.2 3522.9 3556.7 5577.1 5676.9 5694.7 5699.2 5722.4 5610.4 5676.6 5740.0 5827.5 5843.3 5155.0 5158.9 5169.8 5181.1 5224.7 5279.3 5307.7 5310.1 5311.2 5347.7 5138.9 5208.6 5232.6 5243.5 5252.7 5212.5 5240.4 5240.5 5244.8 5247.0 5126.9 5204.2 5205.0 5205.2 5210.0 5459.0 5526.8 5530.8 5544.5 5545.1 6205.9 6260.6 6262.2 6266.0 6280.2 6128.0 6202.8 6312.7 6325.3 6336.5 5667.0 5740.3 5758.0 5802.1 5804.9 6273.1 6274.1 6295.5 6301.9 6314.8 5972.6 6177.3 6183.2 6188.2 6189.2 6175.9 6191.6 6223.6 6274.3 6299.0 6189.0 6196.7 6198.5 6221.2 6231.4 6054.4 6208.4 6213.0 6222.5 6225.4 4850.0 4868.5 4871.0 4940.6 4969.8 3690.3 4296.6 4340.7 4354.9 4355.5 5673.9 5717.6 5720.6 5731.5 5779.6 6120.1 6229.0 6244.8 6246.7 6334.2 5696.3 5699.5 5709.8 5712.9 5741.9 5300.3 5332.6 5336.3 5340.5 5346.6 6227.8 6236.5 6282.7 6286.5 6292.1 6266.6 6274.6 6309.7 6313.9 6318.4 6276.5 6294.3 6295.9 6301.5 6307.4 5001.8 6028.7 6121.8 6132.4 6188.9 5138.5 6192.9 6204.2 6210.6 6238.2 5137.4 5479.2 6096.7 6105.9 6125.8 6050.9 6084.4 6115.3 6122.1 6124.8 5748.9 5885.8 5937.3 5939.1 5964.5 5999.1 6044.8 6087.9 6100.1 6128.7 5939.9 5942.8 5959.1 5975.5 5978.4 04:58:51 INFO - PROCESS | 1781 | 04:58:51 INFO - PROCESS | 1781 | [#1] ext.html Cycles:180 Average:63963.55 Median:36709.13 stddev:132300.21 (360.4%) stddev-sans-first:132585.41 04:58:51 INFO - PROCESS | 1781 | Values: 453.4 468.6 573.3 580.0 592.0 34936.1 37392.0 37500.0 37575.6 37598.4 31388.7 39202.8 39223.6 39239.0 39279.4 9337.6 9576.6 9578.1 9583.5 9587.0 9535.2 9683.6 9686.7 9687.0 9698.4 9649.0 9728.3 9735.9 9738.1 9741.9 9606.7 9662.8 9692.8 9701.9 9712.4 9444.8 9594.6 9601.5 9607.1 9608.4 37797.2 38163.2 38186.6 38210.6 38263.2 3109.4 3209.8 3212.6 3216.0 3231.1 27947.4 28011.4 29444.7 29525.9 31076.1 2736.5 2763.2 2769.0 2790.9 2802.2 485503.6 489451.0 489740.0 489752.0 490252.0 57648.4 58702.4 58798.1 67694.7 68238.0 71922.6 72951.0 73091.5 73217.0 73288.3 16430.3 16895.0 16930.9 16965.5 16970.9 11348.4 11715.0 11726.1 12810.6 12896.1 18047.5 18317.8 18340.0 20886.6 21588.0 7406.4 7591.1 8364.6 8834.6 8911.1 927.6 977.8 1057.4 1083.5 1112.2 31671.9 32619.7 32715.5 33301.5 33339.0 1071.5 1098.9 1149.9 1156.0 1194.3 15295.6 15440.1 15535.2 16040.4 16520.9 529441.0 534793.0 534799.0 535293.0 537032.0 59884.0 60807.7 60899.0 60984.0 61003.4 1234.9 1435.8 1457.3 1457.7 1470.7 30225.0 30336.8 30457.5 31041.8 31125.1 50695.0 51415.2 51420.0 51615.5 51635.7 465431.0 465595.0 465867.0 466905.0 467466.0 28002.7 32019.8 32393.7 32712.5 33010.5 35300.1 37290.6 43066.6 43185.0 43278.8 35015.9 35755.8 35809.8 35966.0 36127.6 33381.8 34742.0 35584.5 35708.0 35771.8 31198.2 31768.8 31776.8 32425.0 35567.5 25978.9 30908.2 30915.0 31665.0 32137.5 23518.6 24127.5 24329.4 24668.8 25319.0 04:58:51 INFO - PROCESS | 1781 | 04:58:51 INFO - PROCESS | 1781 | [#2] jquery.html Cycles:180 Average:34571.10 Median:2665.33 stddev:109121.95 (4094.1%) stddev-sans-first:109397.83 04:58:51 INFO - PROCESS | 1781 | Values: 359.8 361.0 367.1 367.9 369.9 14968.7 15113.3 18914.7 19974.5 21023.1 16005.0 18971.8 19503.0 20173.9 20218.7 5088.3 5584.4 5611.6 5858.9 5876.0 4132.2 4312.7 4839.6 5114.9 5751.7 6006.6 6282.1 6291.5 6297.9 6299.3 6361.4 6363.0 6366.6 6377.5 6387.8 5344.5 5448.5 5494.7 5499.3 5526.1 21364.0 21691.8 24349.3 24528.9 24715.6 2356.3 2375.0 2376.6 2707.2 2716.0 13935.8 13941.2 14030.4 14616.9 14643.5 1689.6 1720.1 1728.0 1736.1 1771.7 96005.0 98165.0 98168.5 99260.0 99522.0 9876.2 10431.7 10757.3 10783.8 10905.5 13252.7 13310.5 13373.6 13386.0 13415.1 8368.9 8373.2 8392.0 8430.7 8465.5 8488.3 8488.5 8512.3 8580.5 8598.7 3583.9 4300.5 4358.8 4383.4 4422.4 1437.6 1780.6 1792.8 1793.2 1836.3 852.9 895.7 952.5 1029.9 1060.3 18629.8 19257.8 19439.4 19470.9 19761.7 806.4 928.6 945.3 967.3 994.5 8461.7 9336.9 10047.7 10314.8 10463.7 541929.0 586396.0 702704.0 715823.0 738710.0 85846.0 103175.5 104106.0 104618.0 114978.0 491.0 505.8 506.2 510.3 510.5 8222.5 9793.1 10464.6 10744.4 11452.9 48273.3 49877.8 50006.7 50446.5 51915.6 71942.0 72666.6 73412.9 73893.6 74118.3 7442.3 7583.2 7590.0 7689.0 7695.0 9177.9 11526.3 11737.5 11829.5 12104.5 9876.4 9920.1 9976.0 10124.9 10214.0 9820.3 9898.0 9932.0 10153.2 10173.9 8860.6 10281.8 10524.8 10723.9 10773.6 7623.5 7790.6 7805.1 7807.4 7811.6 9801.1 10503.8 10666.3 10730.5 10765.5 04:58:51 INFO - PROCESS | 1781 | 04:58:51 INFO - PROCESS | 1781 | [#3] mootools.html Cycles:180 Average:6059.50 Median:5299.02 stddev:3198.16 (60.4%) stddev-sans-first:3186.22 04:58:51 INFO - PROCESS | 1781 | Values: 1194.9 1352.5 1470.0 1676.3 1929.8 7935.3 8121.8 8663.8 8846.4 8853.0 8647.5 8771.2 8820.1 8831.1 8848.8 2129.3 2215.2 2480.5 2497.0 2505.6 2229.8 2458.0 2503.2 2505.9 2512.6 2436.1 2444.6 2465.6 2467.9 2472.3 2428.7 2450.0 2461.7 2466.8 2476.8 2080.3 2403.6 2448.0 2458.3 2466.1 8862.9 8863.6 8915.4 8918.5 8922.7 5452.1 5553.3 5576.2 5588.8 5596.5 3628.3 3702.5 3738.1 3739.0 3784.8 1049.5 1064.3 1068.8 1095.3 1098.4 12280.1 12300.7 12313.8 12325.8 12332.9 4908.9 4935.7 4938.0 4975.9 5009.5 10351.7 10369.8 10380.1 10381.7 10438.8 5553.6 5580.9 5586.2 5590.0 5591.4 4220.7 5012.3 5064.4 5082.4 5146.0 3673.0 3725.2 3725.7 3950.2 3952.8 1213.5 1230.7 1296.7 1318.4 1326.2 1077.9 1116.0 1122.6 1173.6 1288.6 7973.6 8079.4 8085.9 8138.7 8150.5 1003.8 1185.7 1193.2 1197.2 1212.5 6178.6 6259.1 6266.3 6266.5 6276.9 10038.0 10630.2 10693.7 10737.1 10740.5 10274.8 10541.1 10554.7 10572.6 10625.8 8224.1 8321.8 8384.7 8393.0 8394.2 7722.2 7824.0 7864.6 7895.4 7997.4 9086.7 9139.3 9227.6 9380.1 9476.8 9528.5 9806.9 9809.8 9941.5 10017.4 7341.4 7368.9 7473.9 7491.3 7497.1 7221.7 7393.3 7406.0 8010.1 8104.7 7409.5 7474.4 7495.4 7637.9 7653.7 7282.2 7384.6 7444.6 7476.3 7556.5 7555.3 7610.9 7666.5 7676.7 7679.4 6967.4 6991.1 7017.4 7022.0 7028.8 7074.6 7102.2 7118.0 7124.3 7133.0 04:58:51 INFO - PROCESS | 1781 | 04:58:51 INFO - PROCESS | 1781 | [#4] prototype.html Cycles:180 Average:5567.82 Median:6347.75 stddev:1760.49 (27.7%) stddev-sans-first:1720.77 04:58:51 INFO - PROCESS | 1781 | Values: 318.6 322.1 328.4 329.7 333.5 6285.4 6415.2 6477.8 6482.8 6503.9 6351.7 6372.4 6373.9 6375.1 6378.6 4676.2 4718.1 4719.2 4729.9 4749.8 4730.4 4737.9 4751.2 4757.7 4772.8 4611.7 4761.5 4776.8 4784.7 4823.9 4759.1 4773.1 4779.7 4789.5 4796.1 4107.9 4112.5 4116.2 4116.9 4118.4 5802.1 5972.7 5996.0 6004.8 6005.6 4508.7 4666.6 5391.9 5523.8 5531.4 6701.3 6703.0 6710.9 6712.4 6714.2 3498.6 4292.8 4392.2 4538.3 4539.0 5824.6 6527.0 6970.1 6976.0 6989.5 4652.5 4664.1 4666.4 4670.1 4671.9 4758.1 4758.5 4762.7 4766.1 4785.8 5585.3 5586.3 5600.6 5605.1 5615.2 5527.8 6658.3 6815.8 6848.8 6851.8 1549.7 1584.5 1588.3 1590.4 1615.4 1037.7 1054.0 1083.9 1084.6 1089.4 5068.7 5611.8 6340.6 6343.7 6364.9 6933.4 6964.1 6964.3 6969.6 6986.5 6355.0 6361.2 6364.1 6368.0 6372.5 3619.2 3746.8 3759.4 3765.3 3766.3 7367.0 7379.2 7396.7 7461.4 7535.8 6402.7 6956.5 7132.8 7412.4 7432.9 7472.1 7475.0 7475.0 7481.1 7496.9 5788.4 7094.8 7109.5 7120.4 7121.0 6141.9 6182.4 6944.2 6972.3 7038.3 7487.6 7515.7 7519.4 7521.9 7527.8 4515.8 4553.9 4559.2 4566.3 4568.9 6838.3 7088.9 7108.1 7118.5 7131.1 6503.6 6620.2 6633.8 6687.4 6935.0 6869.8 6877.6 6887.3 6903.0 6907.3 6542.3 6724.4 6728.1 6735.8 6743.7 6904.4 6905.3 6907.2 6913.5 6915.8 5447.6 6725.5 6754.4 6773.4 6780.8 04:58:51 INFO - PROCESS | 1781 | 04:58:51 INFO - PROCESS | 1781 | [#5] yui.html Cycles:180 Average:18200.45 Median:65030.51 stddev:26006.25 (40.0%) stddev-sans-first:26045.68 04:58:51 INFO - PROCESS | 1781 | Values: 614.7 617.3 718.8 747.8 763.5 14727.2 14909.4 14939.0 14970.9 15014.4 13387.3 13413.8 15240.9 15631.1 15637.9 692.2 705.2 848.6 864.5 867.0 708.9 709.7 709.8 710.0 711.9 894.7 897.2 908.5 909.5 909.6 897.9 898.0 898.1 898.7 903.8 535.8 546.2 546.6 659.4 666.4 12307.1 14878.4 14931.3 14942.7 14970.3 12117.0 12176.7 12314.8 12409.6 12641.6 9813.7 9934.8 9970.2 10101.5 10628.6 3444.4 3476.5 3500.5 3504.5 3550.9 83749.2 84275.3 86159.1 86363.1 86382.8 9302.2 9413.3 9474.9 9550.6 9875.6 20583.4 20680.8 20914.5 20920.7 20921.2 7422.0 7487.0 7497.5 7529.8 7635.5 4182.2 4188.3 4201.9 4208.0 4217.9 3491.8 3544.9 3547.8 3548.9 3554.5 654.8 656.2 657.2 657.9 659.1 474.8 570.6 620.9 632.3 636.5 6921.8 8488.2 8498.2 8625.1 8690.4 519.2 540.1 597.1 600.1 617.7 3908.8 4020.5 4087.5 4122.6 4150.0 74396.0 93734.0 95906.0 96815.0 96908.5 80345.8 80883.0 81011.2 82689.0 83757.6 62590.1 65294.7 67905.7 69389.0 70008.3 7953.3 7977.1 8130.9 8214.7 8250.4 48213.0 49222.0 49240.0 49605.8 50336.0 62114.7 63763.8 64766.4 69071.3 69579.0 8540.8 9864.8 9960.9 10061.9 10562.3 10689.4 10803.2 10892.7 10932.0 10986.8 9876.7 10233.3 10259.5 10267.9 11023.9 11430.2 11445.9 11475.1 11546.5 12181.6 9099.5 10653.2 10677.4 11183.0 11305.3 9044.6 9057.5 9067.9 9458.2 9569.1 9202.0 9544.3 9582.1 9702.2 9948.2 04:58:51 INFO - PROCESS | 1781 | -------- Summary: end -------- 04:58:51 INFO - PROCESS | 1781 | 04:58:51 INFO - TEST-INFO | 1781: exit 0 04:58:51 INFO - TEST-OK | dromaeo_css | took 1113736ms 04:58:51 INFO - TEST-START | kraken 04:58:51 INFO - operating with platform_type : mac_ 04:58:51 INFO - Initialising browser for kraken test... 04:58:51 INFO - TEST-INFO | started process 1787 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpEZ5FgT/profile http://localhost:49273/getInfo.html) 04:58:51 INFO - PROCESS | 1787 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:58:53 INFO - PROCESS | 1787 | __metrics Screen width/height:1600/1200 04:58:53 INFO - PROCESS | 1787 | colorDepth:24 04:58:53 INFO - PROCESS | 1787 | Browser inner width/height: 1024/689 04:58:53 INFO - PROCESS | 1787 | __metrics 04:58:53 INFO - PROCESS | 1787 | 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:53 INFO - PROCESS | 1787 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:58:54 INFO - TEST-INFO | 1787: exit 0 04:58:54 INFO - Browser initialized. 04:58:54 INFO - Running cycle 1/1 for kraken test... 04:58:54 INFO - TEST-INFO | started process 1789 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpEZ5FgT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:59:06 INFO - PROCESS | 1789 | RSS: Main: 241369088 04:59:06 INFO - PROCESS | 1789 | 04:59:08 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 04:59:09 INFO - PROCESS | 1789 | RSS: Main: 290955264 04:59:09 INFO - PROCESS | 1789 | 04:59:12 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 04:59:12 INFO - PROCESS | 1789 | RSS: Main: 301367296 04:59:12 INFO - PROCESS | 1789 | 04:59:16 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 04:59:16 INFO - PROCESS | 1789 | RSS: Main: 288141312 04:59:16 INFO - PROCESS | 1789 | 04:59:18 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 04:59:19 INFO - PROCESS | 1789 | RSS: Main: 290009088 04:59:19 INFO - PROCESS | 1789 | 04:59:21 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:59:22 INFO - PROCESS | 1789 | RSS: Main: 291835904 04:59:22 INFO - PROCESS | 1789 | 04:59:24 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 04:59:25 INFO - PROCESS | 1789 | RSS: Main: 292880384 04:59:25 INFO - PROCESS | 1789 | 04:59:28 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 04:59:28 INFO - PROCESS | 1789 | RSS: Main: 291631104 04:59:28 INFO - PROCESS | 1789 | 04:59:31 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 04:59:32 INFO - PROCESS | 1789 | RSS: Main: 292442112 04:59:32 INFO - PROCESS | 1789 | 04:59:33 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:59:34 INFO - PROCESS | 1789 | RSS: Main: 326000640 04:59:34 INFO - PROCESS | 1789 | 04:59:36 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:59:36 INFO - PROCESS | 1789 | RSS: Main: 324972544 04:59:36 INFO - PROCESS | 1789 | 04:59:38 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:59:39 INFO - PROCESS | 1789 | RSS: Main: 333422592 04:59:39 INFO - PROCESS | 1789 | 04:59:42 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:59:42 INFO - PROCESS | 1789 | RSS: Main: 335278080 04:59:42 INFO - PROCESS | 1789 | 04:59:45 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:59:45 INFO - PROCESS | 1789 | RSS: Main: 334172160 04:59:45 INFO - PROCESS | 1789 | 04:59:47 INFO - PROCESS | 1789 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 04:59:47 INFO - PROCESS | 1789 | RSS: Main: 394145792 04:59:47 INFO - PROCESS | 1789 | 04:59:47 INFO - PROCESS | 1789 | __start_tp_report 04:59:47 INFO - PROCESS | 1789 | _x_x_mozilla_page_load 04:59:47 INFO - PROCESS | 1789 | _x_x_mozilla_page_load_details 04:59:47 INFO - PROCESS | 1789 | |i|pagename|runs| 04:59:47 INFO - PROCESS | 1789 | |0;ai-astar;111;108;110;110;111;113;114;110;110;112 04:59:47 INFO - PROCESS | 1789 | |1;audio-beat-detection;159;119;142;157;126;129;159;142;193;150 04:59:47 INFO - PROCESS | 1789 | |2;audio-dft;188;185;190;188;184;184;183;181;184;182 04:59:47 INFO - PROCESS | 1789 | |3;audio-fft;75;72;95;106;80;56;67;73;75;55 04:59:47 INFO - PROCESS | 1789 | |4;audio-oscillator;91;95;124;78;79;83;114;83;114;150 04:59:47 INFO - PROCESS | 1789 | |5;imaging-gaussian-blur;85;90;85;94;86;90;83;90;105;117 04:59:47 INFO - PROCESS | 1789 | |6;imaging-darkroom;95;95;94;94;107;124;94;95;93;94 04:59:47 INFO - PROCESS | 1789 | |7;imaging-desaturate;86;86;88;88;101;136;136;87;84;85 04:59:47 INFO - PROCESS | 1789 | |8;json-parse-financial;52;52;53;53;52;52;53;62;51;52 04:59:47 INFO - PROCESS | 1789 | |9;json-stringify-tinderbox;62;63;73;77;71;69;67;69;68;69 04:59:47 INFO - PROCESS | 1789 | |10;stanford-crypto-aes;82;82;80;83;82;83;82;82;85;79 04:59:47 INFO - PROCESS | 1789 | |11;stanford-crypto-ccm;133;110;130;126;107;129;126;126;122;119 04:59:47 INFO - PROCESS | 1789 | |12;stanford-crypto-pbkdf2;138;126;136;136;134;126;137;135;135;137 04:59:47 INFO - PROCESS | 1789 | |13;stanford-crypto-sha256-iterative;68;66;66;66;66;67;67;67;67;66 04:59:47 INFO - PROCESS | 1789 | __end_tp_report 04:59:47 INFO - PROCESS | 1789 | __start_cc_report 04:59:47 INFO - PROCESS | 1789 | _x_x_mozilla_cycle_collect,1162 04:59:47 INFO - PROCESS | 1789 | __end_cc_report 04:59:47 INFO - PROCESS | 1789 | __startTimestamp1454763587714__endTimestamp 04:59:47 INFO - PROCESS | 1789 | 04:59:47 INFO - PROCESS | 1789 | ------- Summary: start ------- 04:59:47 INFO - PROCESS | 1789 | Number of tests: 14 04:59:47 INFO - PROCESS | 1789 | 04:59:47 INFO - PROCESS | 1789 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:1.73 (1.6%) stddev-sans-first:1.83 04:59:47 INFO - PROCESS | 1789 | Values: 111.0 108.0 110.0 110.0 111.0 113.0 114.0 110.0 110.0 112.0 04:59:47 INFO - PROCESS | 1789 | 04:59:47 INFO - PROCESS | 1789 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:153.50 stddev:21.37 (13.9%) stddev-sans-first:22.26 04:59:47 INFO - PROCESS | 1789 | Values: 159.0 119.0 142.0 157.0 126.0 129.0 159.0 142.0 193.0 150.0 04:59:47 INFO - PROCESS | 1789 | 04:59:47 INFO - PROCESS | 1789 | [#2] audio-dft Cycles:10 Average:184.90 Median:184.50 stddev:2.88 (1.6%) stddev-sans-first:2.83 04:59:47 INFO - PROCESS | 1789 | Values: 188.0 185.0 190.0 188.0 184.0 184.0 183.0 181.0 184.0 182.0 04:59:47 INFO - PROCESS | 1789 | 04:59:47 INFO - PROCESS | 1789 | [#3] audio-fft Cycles:10 Average:75.40 Median:74.00 stddev:15.71 (21.2%) stddev-sans-first:16.67 04:59:47 INFO - PROCESS | 1789 | Values: 75.0 72.0 95.0 106.0 80.0 56.0 67.0 73.0 75.0 55.0 04:59:47 INFO - PROCESS | 1789 | 04:59:47 INFO - PROCESS | 1789 | [#4] audio-oscillator Cycles:10 Average:101.10 Median:81.00 stddev:23.72 (29.3%) stddev-sans-first:24.88 04:59:47 INFO - PROCESS | 1789 | Values: 91.0 95.0 124.0 78.0 79.0 83.0 114.0 83.0 114.0 150.0 04:59:47 INFO - PROCESS | 1789 | 04:59:47 INFO - PROCESS | 1789 | [#5] imaging-gaussian-blur Cycles:10 Average:92.50 Median:88.00 stddev:10.66 (12.1%) stddev-sans-first:10.95 04:59:47 INFO - PROCESS | 1789 | Values: 85.0 90.0 85.0 94.0 86.0 90.0 83.0 90.0 105.0 117.0 04:59:47 INFO - PROCESS | 1789 | 04:59:47 INFO - PROCESS | 1789 | [#6] imaging-darkroom Cycles:10 Average:98.50 Median:94.00 stddev:9.83 (10.5%) stddev-sans-first:10.35 04:59:47 INFO - PROCESS | 1789 | Values: 95.0 95.0 94.0 94.0 107.0 124.0 94.0 95.0 93.0 94.0 04:59:47 INFO - PROCESS | 1789 | 04:59:47 INFO - PROCESS | 1789 | [#7] imaging-desaturate Cycles:10 Average:97.70 Median:86.00 stddev:20.74 (24.1%) stddev-sans-first:21.56 04:59:47 INFO - PROCESS | 1789 | Values: 86.0 86.0 88.0 88.0 101.0 136.0 136.0 87.0 84.0 85.0 04:59:47 INFO - PROCESS | 1789 | 04:59:47 INFO - PROCESS | 1789 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:52.50 stddev:3.16 (6.0%) stddev-sans-first:3.32 04:59:47 INFO - PROCESS | 1789 | Values: 52.0 52.0 53.0 53.0 52.0 52.0 53.0 62.0 51.0 52.0 04:59:47 INFO - PROCESS | 1789 | 04:59:47 INFO - PROCESS | 1789 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:4.39 (6.4%) stddev-sans-first:3.91 04:59:47 INFO - PROCESS | 1789 | Values: 62.0 63.0 73.0 77.0 71.0 69.0 67.0 69.0 68.0 69.0 04:59:47 INFO - PROCESS | 1789 | 04:59:47 INFO - PROCESS | 1789 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:1.63 (2.0%) stddev-sans-first:1.73 04:59:47 INFO - PROCESS | 1789 | Values: 82.0 82.0 80.0 83.0 82.0 83.0 82.0 82.0 85.0 79.0 04:59:47 INFO - PROCESS | 1789 | 04:59:47 INFO - PROCESS | 1789 | [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:126.00 stddev:8.52 (6.8%) stddev-sans-first:8.20 04:59:47 INFO - PROCESS | 1789 | Values: 133.0 110.0 130.0 126.0 107.0 129.0 126.0 126.0 122.0 119.0 04:59:47 INFO - PROCESS | 1789 | 04:59:47 INFO - PROCESS | 1789 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.00 Median:136.00 stddev:4.37 (3.2%) stddev-sans-first:4.39 04:59:47 INFO - PROCESS | 1789 | Values: 138.0 126.0 136.0 136.0 134.0 126.0 137.0 135.0 135.0 137.0 04:59:47 INFO - PROCESS | 1789 | 04:59:47 INFO - PROCESS | 1789 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.53 04:59:47 INFO - PROCESS | 1789 | Values: 68.0 66.0 66.0 66.0 66.0 67.0 67.0 67.0 67.0 66.0 04:59:47 INFO - PROCESS | 1789 | -------- Summary: end -------- 04:59:47 INFO - PROCESS | 1789 | 04:59:48 INFO - TEST-INFO | 1789: exit 0 04:59:48 INFO - TEST-OK | kraken | took 56953ms 04:59:48 INFO - SUITE-END | took 1170s 04:59:48 INFO - Completed test suite (00:19:31) 04:59:48 INFO - Working with test: dromaeo_css 04:59:48 INFO - Generating results file: dromaeo_css 04:59:48 INFO - Working with test: kraken 04:59:48 INFO - Generating results file: kraken 04:59:48 INFO - javascript benchmark 04:59:48 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:59:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 04:59:48 INFO - process_Request line: dromaeo_css 7384.30 graph.html#tests=[[72,64,59]] 04:59:48 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:59:48 INFO - process_Request line: kraken 1436.00 graph.html#tests=[[232,64,59]] 04:59:48 INFO - RETURN: dromaeo_css: 7384.30 04:59:48 INFO - RETURN: kraken: 1436.00 04:59:48 INFO - javascript benchmark 04:59:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3445.9483107753385, 3489.616142224353, 3499.230169362741, 3522.9295414091725, 3556.6976806971406, 5577.107662773957, 5676.886462270752, 5694.715264236792, 5699.202111704365, 5722.37053924068, 5610.410906854782, 5676.602637815345, 5740.0, 5827.475527202551, 5843.298804143498, 5154.974225128869, 5158.896822063566, 5169.793208271664, 5181.0933086709865, 5224.686518808865, 5279.340082489689, 5307.73461326934, 5310.097283461801, 5311.203319502067, 5347.679139251657, 5138.922916156261, 5208.5572726318305, 5232.555232805216, 5243.475652434745, 5252.65857719247, 5212.50481204285, 5240.4497527759795, 5240.52835244826, 5244.763985620656, 5247.0, 5126.897462050775, 5204.193350030751, 5205.037068142406, 5205.219217117425, 5209.984053109645, 5458.972705136489, 5526.806561770319, 5530.751116199781, 5544.528715059225, 5545.140503222007, 6205.87588248237, 6260.561760676755, 6262.185915830958, 6266.0, 6280.214973128359, 6128.0, 6202.751889924398, 6312.747490100391, 6325.304216536223, 6336.46140078094, 5666.951613951433, 5740.339860916007, 5758.049921762904, 5802.1296805479515, 5804.88390232193, 6273.059041143773, 6274.121622972787, 6295.496360291166, 6301.905471417932, 6314.8421289467215, 5972.5520585955355, 6177.320494745574, 6183.196184495987, 6188.164597779332, 6189.195404597373, 6175.907361389583, 6191.628502289877, 6223.62658240498, 6274.309825919146, 6299.023651334051, 6189.0, 6196.659183744938, 6198.504119670415, 6221.160143380676, 6231.4391704746795, 6054.424829641177, 6208.441240288395, 6212.968935155295, 6222.502199824004, 6225.408586184305, 4849.975750121227, 4868.464468908417, 4870.975645121752, 4940.604751619861, 4969.776360063805, 3690.261947610435, 4296.634786043159, 4340.652747780233, 4354.891127721832, 4355.499117601516, 5673.858153546194, 5717.571182161355, 5720.628159169641, 5731.541476681856, 5779.566532510079, 6120.050983828535, 6229.003359462555, 6244.843878903063, 6246.6876656167005, 6334.208223972004, 5696.3164420269, 5699.515541178963, 5709.8287051388525, 5712.885742285131, 5741.942580574141, 5300.257963885059, 5332.626716129834, 5336.279602253646, 5340.546053585489, 5346.625736198506, 6227.750889964532, 6236.532260080512, 6282.717277722422, 6286.528510361742, 6292.087647291209, 6266.592671476339, 6274.623522588659, 6309.652969086745, 6313.936860631335, 6318.399752023551, 6276.466500347522, 6294.339094395205, 6295.874082518416, 6301.527385446201, 6307.432331090224, 5001.774920128676, 6028.698565071817, 6121.816345509642, 6132.448079672851, 6188.907166392598, 5138.5375316220225, 6192.876142477216, 6204.224471941007, 6210.5652604317265, 6238.189035425366, 5137.383513978347, 5479.232907392889, 6096.695165241809, 6105.914670190187, 6125.84596676928, 6050.878982420415, 6084.361142080018, 6115.296740874856, 6122.142899994094, 6124.846878828065, 5748.942510575008, 5885.764569417175, 5937.317208520903, 5939.138824870456, 5964.493018093511, 5999.070144127667, 6044.758209671564, 6087.878242435215, 6100.054491553817, 6128.693565321805, 5939.910901336397, 5942.762289508544, 5959.106134079922, 5975.521958243417, 5978.388360659864], "unit": "score", "name": "dojo.html", "value": 5674.5847177202495}, {"lowerIsBetter": false, "replicates": [453.40377403714115, 468.60168856472, 573.2948473377745, 579.9594028418011, 592.0202065581465, 34936.12659683506, 37392.0, 37500.0, 37575.62424375756, 37598.43602345964, 31388.68611313886, 39202.82391528252, 39223.607763922424, 39239.0, 39279.41080883782, 9337.626494940194, 9576.569054392568, 9578.090081442288, 9583.472908990037, 9587.0, 9535.189508891752, 9683.564239609235, 9686.66096686616, 9686.951565242163, 9698.369605975624, 9649.0, 9728.270379721514, 9735.902640973605, 9738.123568878835, 9741.90258097417, 9606.663766768164, 9662.806743865154, 9692.75768105796, 9701.854472182922, 9712.417254964725, 9444.819397575304, 9594.568244429018, 9601.47191904445, 9607.13535781783, 9608.423494590346, 37797.24405511875, 38163.23673526542, 38186.618133818585, 38210.617893820985, 38263.234735305414, 3109.4247564200696, 3209.7753157279, 3212.5921696169266, 3215.983920080408, 3231.1437469070715, 27947.441051178863, 28011.439771204667, 29444.70555294441, 29525.852370738008, 31076.115485564304, 2736.53478908586, 2763.1710486853863, 2768.9723102768917, 2790.9023184188454, 2802.173358859121, 485503.5724821389, 489451.0, 489740.0, 489752.0, 490252.0, 57648.423515764305, 58702.412975869694, 58798.11802822961, 67694.66152669206, 68237.97643035358, 71922.64038679774, 72951.0, 73091.53816923632, 73217.0, 73288.26711732814, 16430.342786288413, 16895.0, 16930.915345423193, 16965.491035268962, 16970.896891702, 11348.432578371048, 11715.0, 11726.120540959462, 12810.615681529569, 12896.097273190786, 18047.54881127956, 18317.81682183188, 18340.0, 20886.58226835485, 21588.028538715796, 7406.407487401103, 7591.089069311718, 8364.58177091143, 8834.602442890086, 8911.064338244521, 927.5825878354767, 977.8386566216636, 1057.4078516030893, 1083.4636854756945, 1112.238116889933, 31671.891483798416, 32619.67380326214, 32715.50926736101, 33301.50047749286, 33339.0, 1071.507106730897, 1098.9450527473755, 1149.8850114988602, 1156.0000599481557, 1194.3073017649915, 15295.61760955985, 15440.073595584301, 15535.223238838013, 16040.358385664442, 16520.917395412947, 529441.0, 534793.0, 534799.0, 535293.0, 537032.0, 59884.0, 60807.695961520796, 60899.0, 60984.0, 61003.38996609977, 1234.8703386144325, 1435.8205224346957, 1457.3441951121827, 1457.6501639606417, 1470.6838029823639, 30225.0, 30336.84831575828, 30457.54313685341, 31041.8447907759, 31125.066248012597, 50695.0, 51415.22877156771, 51419.971600568526, 51615.48384516257, 51635.741821290656, 465431.0, 465595.0, 465867.0, 466905.0, 467466.0, 28002.719972800012, 32019.839900800347, 32393.676063239065, 32712.509312359856, 33010.504842427865, 35300.117497062776, 37290.62709372872, 43066.56933430626, 43185.0, 43278.783606081764, 35015.9495215144, 35755.821220893726, 35809.82095089508, 35966.0, 36127.63872361243, 33381.831635892624, 34742.0, 35584.46623300704, 35708.0, 35771.82114089413, 31198.22004449816, 31768.841155794074, 31776.8411157952, 32425.0, 35567.46648800322, 25978.870105649352, 30908.227294316923, 30915.0, 31665.0, 32137.517937231427, 23518.647220292052, 24127.51744965126, 24329.391765205302, 24668.753312467365, 25319.0], "unit": "score", "name": "ext.html", "value": 19619.80212047872}, {"lowerIsBetter": false, "replicates": [359.7517712778183, 361.0432354261206, 367.10609665464597, 367.89882782234884, 369.88903329001295, 14968.700625987474, 15113.319900604472, 18914.716279255805, 19974.50063748407, 21023.05396257168, 16005.0, 18971.81028189718, 19503.0, 20173.899130504327, 20218.696719549218, 5088.313077734514, 5584.357798853143, 5611.635243709166, 5858.941410585903, 5875.970620146893, 4132.152908653718, 4312.719673221231, 4839.612830973531, 5114.923276150861, 5751.741171647286, 6006.609570377933, 6282.057691346312, 6291.496680265568, 6297.929352010146, 6299.33856945021, 6361.4274715275615, 6363.013732871413, 6366.554341196118, 6377.489800815923, 6387.808365749035, 5344.545713614348, 5448.536874365684, 5494.725263736837, 5499.285092937893, 5526.06056970316, 21364.038618262217, 21691.783082169135, 24349.26952191437, 24528.877355613287, 24715.62926556103, 2356.2577787996897, 2374.952500949971, 2376.6435034744754, 2707.241972247774, 2716.0, 13935.790963135561, 13941.163530188222, 14030.368633411521, 14616.853831461656, 14643.48747793822, 1689.6029433083338, 1720.053970316321, 1728.032301910934, 1736.1232577548383, 1771.7430972509044, 96005.0, 98165.0, 98168.50915745446, 99260.0, 99522.004779952, 9876.160526355197, 10431.68704938853, 10757.30077544957, 10783.78432431347, 10905.454727263605, 13252.73494530104, 13310.534131305552, 13373.598792036255, 13385.996050296071, 13415.0609457339, 8368.874466883002, 8373.204545568162, 8392.0, 8430.662773489114, 8465.534395608178, 8488.320934325362, 8488.533130677872, 8512.319014478951, 8580.528070956032, 8598.656053757779, 3583.9104022399647, 4300.505441874162, 4358.8038538265855, 4383.430154079949, 4422.358757980139, 1437.6405898525368, 1780.6349698311815, 1792.8476079533125, 1793.2199493220492, 1836.3480964257762, 852.8678054901376, 895.6909866096187, 952.514217748953, 1029.9330543514648, 1060.3107979813028, 18629.813701862808, 19257.8074219256, 19439.433537045436, 19470.902645486964, 19761.703574446394, 806.3549160671439, 928.6146249306597, 945.3193700535603, 967.2842096848282, 994.5275993902839, 8461.746147615582, 9336.87957445111, 10047.748806279902, 10314.793704125876, 10463.68608941733, 541929.0, 586396.0, 702704.0, 715823.0, 738710.0, 85846.0, 103175.48412258041, 104106.0, 104618.0, 114978.0, 491.037566369919, 505.8356034288871, 506.18756895183435, 510.3034358101165, 510.5150107397987, 8222.506649601042, 9793.069658382443, 10464.63373781914, 10744.4090575016, 11452.94273528627, 48273.2762757957, 49877.75061124671, 50006.749966251395, 50446.49553504418, 51915.6254843434, 71942.0, 72666.63666681632, 73412.898806519, 73893.630531847, 74118.25881741113, 7442.330190282684, 7583.2416758325935, 7590.0, 7689.0, 7695.0, 9177.862332064891, 11526.308421494738, 11737.471813768572, 11829.52681892749, 12104.515819367127, 9876.40741555509, 9920.107190352903, 9976.0, 10124.898751012395, 10214.029667181605, 9820.312578119463, 9898.010198980044, 9932.0067993203, 10153.238507111848, 10173.898261017295, 8860.601272942862, 10281.752909135925, 10524.842127367943, 10723.89276107229, 10773.569057237622, 7623.542587444771, 7790.649420775965, 7805.102413222325, 7807.414443916842, 7811.609419529114, 9801.110912022776, 10503.842442363524, 10666.253362264568, 10730.463476825971, 10765.523929496416], "unit": "score", "name": "jquery.html", "value": 8835.449983676795}, {"lowerIsBetter": false, "replicates": [1194.9424759088206, 1352.4725357110735, 1469.9853001469985, 1676.2540669402113, 1929.7780755213155, 7935.285824275814, 8121.796955076126, 8663.78340541486, 8846.380753347268, 8853.026167121612, 8647.481151130936, 8771.210591046805, 8820.073892241318, 8831.116888311166, 8848.77878053049, 2129.265403435812, 2215.202527090254, 2480.5364834747497, 2497.0, 2505.5865782145925, 2229.7547269800307, 2458.041363868093, 2503.173952595639, 2505.9373515662073, 2512.6231065340253, 2436.135172013936, 2444.6455263986713, 2465.593177125772, 2467.8889449974795, 2472.307753828931, 2428.720697119836, 2449.987750061256, 2461.655368248447, 2466.802655787542, 2476.7770900618852, 2080.3030984620173, 2403.567357875582, 2447.984086604057, 2458.262521243638, 2466.1121996081397, 8862.911370886273, 8863.601137948808, 8915.37592368528, 8918.464892106495, 8922.68770593026, 5452.073147564924, 5553.305836770403, 5576.247206627094, 5588.832335029955, 5596.496315331639, 3628.2743451309843, 3702.4631428442726, 3738.102855314732, 3739.046543131511, 3784.7539909906045, 1049.4857519815312, 1064.3241541621048, 1068.834330678746, 1095.3482677806771, 1098.3794156301744, 12280.078994075391, 12300.692482687915, 12313.75372492554, 12325.815112773316, 12332.876671233353, 4908.913711672525, 4935.728534930613, 4938.0, 4975.8507244781995, 5009.549140577293, 10351.689449316533, 10369.792604148026, 10380.117689996436, 10381.740456488647, 10438.791224175626, 5553.611247212737, 5580.888382232332, 5586.16207568868, 5589.972050139723, 5591.440855914376, 4220.662347012231, 5012.273220383024, 5064.392272927199, 5082.415522214918, 5145.974270128625, 3673.045008297808, 3725.18046029873, 3725.6646901778972, 3950.20995800841, 3952.8418863245724, 1213.5327898759042, 1230.7200511468152, 1296.695276609996, 1318.3803612302395, 1326.2042774335514, 1077.8922107789315, 1115.9609413670482, 1122.5622007417114, 1173.6185739634652, 1288.5812111063942, 7973.561454120079, 8079.353651707849, 8085.948826652498, 8138.674453021813, 8150.470219435836, 1003.8243307421172, 1185.7154282972024, 1193.1886317304143, 1197.22180582622, 1212.4543955220186, 6178.62928224308, 6259.0924315973925, 6266.279377871603, 6266.498680105672, 6276.905846412307, 10038.0, 10630.20273479492, 10693.732656683645, 10737.087347575543, 10740.516676749565, 10274.845877311845, 10541.051305382553, 10554.683359499228, 10572.629957951434, 10625.787484250272, 8224.095349511548, 8321.791955201168, 8384.748457546284, 8393.0, 8394.160583941557, 7722.227777222233, 7823.982882225274, 7864.646090926037, 7895.447318687637, 7997.440179187401, 9086.681966131153, 9139.268858491438, 9227.630894764134, 9380.108889655472, 9476.810463790824, 9528.475933823705, 9806.85289720669, 9809.803803923738, 9941.453220072675, 10017.449040302854, 7341.412686985135, 7368.889466658112, 7473.850522989618, 7491.288327608869, 7497.137829149499, 7221.67502462401, 7393.297636724503, 7405.9629701851145, 8010.078840933134, 8104.716334928249, 7409.518381305198, 7474.364679002346, 7495.400367970658, 7637.923620763721, 7653.655585498777, 7282.2353652867805, 7384.593847338448, 7444.553326800409, 7476.25237476248, 7556.508826926232, 7555.320021197898, 7610.9238907610215, 7666.4633475656165, 7676.6545505453505, 7679.385649147943, 6967.407770339578, 6991.056207411934, 7017.3684368407085, 7022.0, 7028.824279393056, 7074.646267686698, 7102.183248926233, 7117.964410178123, 7124.287571242834, 7133.037039999534], "unit": "score", "name": "mootools.html", "value": 4925.689601042586}, {"lowerIsBetter": false, "replicates": [318.6494855658775, 322.0900954802683, 328.37444667907647, 329.6703296703297, 333.47144775530785, 6285.42864283929, 6415.166028416305, 6477.773277935274, 6482.773102941398, 6503.869922601545, 6351.7459301628, 6372.362763723625, 6373.9362606373925, 6375.107484952099, 6378.649174295412, 4676.228422310314, 4718.079974404993, 4719.150552900476, 4729.881752956169, 4749.8337558185385, 4730.361401210827, 4737.881552961187, 4751.16854550454, 4757.690750101249, 4772.761361931907, 4611.700239484439, 4761.547652972962, 4776.785044672998, 4784.712917224961, 4823.879403014935, 4759.071980963713, 4773.140834649762, 4779.737114458703, 4789.521047895182, 4796.088743138793, 4107.938380924288, 4112.547619761824, 4116.176764647053, 4116.876493705194, 4118.402831589433, 5802.100674395476, 5972.70136493178, 5995.980683283852, 6004.819855404345, 6005.579609427342, 4508.729476231437, 4666.603338716213, 5391.865203369908, 5523.834284971457, 5531.363893152299, 6701.29636388182, 6702.966485167592, 6710.899336509956, 6712.395884370381, 6714.19429668438, 3498.6326435724136, 4292.79801655537, 4392.1874453226255, 4538.251188553884, 4539.024109816405, 5824.621399609055, 6527.0, 6970.128733908262, 6976.0, 6989.475789315872, 4652.464966528825, 4664.137134630104, 4666.440027196691, 4670.136024835417, 4671.929921051187, 4758.143534163814, 4758.500357462486, 4762.690425122356, 4766.070616229802, 4785.832495862628, 5585.3297604287745, 5586.301712285965, 5600.635958662674, 5605.075162598126, 5615.18579805934, 5527.778888844482, 6658.3341665834, 6815.829604259834, 6848.760293389708, 6851.835188018049, 1549.6745683406386, 1584.4771225495558, 1588.2693960778172, 1590.3559058581293, 1615.3700056977789, 1037.749511838233, 1053.9683809485728, 1083.869935607732, 1084.6366467233408, 1089.4389389464432, 5068.68214264294, 5611.7755289788765, 6340.556161068773, 6343.746250150035, 6364.91796394614, 6933.410660093848, 6964.129483814523, 6964.303569642995, 6969.630325689189, 6986.510944233854, 6355.046742988497, 6361.236651601745, 6364.077208804697, 6368.0, 6372.458341041063, 3619.2037751694584, 3746.83139258734, 3759.4172903200047, 3765.3410653135593, 3766.2844059628583, 7367.0, 7379.188289288174, 7396.667149978264, 7461.403087752967, 7535.8116047099265, 6402.679866006681, 6956.5478243913985, 7132.750353737594, 7412.369948554326, 7432.9256707433315, 7472.103347598431, 7475.0, 7475.028246327943, 7481.102267727908, 7496.8500629986, 5788.421157884178, 7094.822629434306, 7109.537880037781, 7120.394766444703, 7121.038659780863, 6141.8944589974235, 6182.350853160533, 6944.201416837129, 6972.267911869383, 7038.260982596754, 7487.588182650006, 7515.661795219337, 7519.43604229674, 7521.887171692539, 7527.8118047049265, 4515.819367225275, 4553.9316910247035, 4559.156556037144, 4566.292224705176, 4568.8857778554475, 6838.281980391987, 7088.929110709033, 7108.147022357351, 7118.501704880816, 7131.0729605151, 6503.577267477599, 6620.205575330799, 6633.767818126343, 6687.364700353459, 6935.0, 6869.793906182823, 6877.621730804653, 6887.345702158287, 6902.965485172542, 6907.274736152833, 6542.313057128933, 6724.4284235840505, 6728.091707619605, 6735.831604209738, 6743.696533656095, 6904.378605925491, 6905.274946130584, 6907.240203577703, 6913.481488888253, 6915.755164070516, 5447.564194864481, 6725.495587830835, 6754.425873800782, 6773.390394864486, 6780.796576102724], "unit": "score", "name": "prototype.html", "value": 4986.592886656309}, {"lowerIsBetter": false, "replicates": [614.6926536731634, 617.2931992868166, 718.8490417012428, 747.7767791973071, 763.5151678684038, 14727.190004549746, 14909.403623855047, 14939.0, 14970.92514537427, 15014.399424023026, 13387.263700496469, 13413.798793018113, 15240.923795381008, 15631.062136271832, 15637.92181039096, 692.2108795972596, 705.2136867392845, 848.5757121439281, 864.5245115186653, 866.9913300867005, 708.9361957423831, 709.7019251914182, 709.7977076533189, 710.0, 711.8825393810015, 894.7181637784109, 897.1701176411825, 908.504864848659, 909.4679612426738, 909.6043221198767, 897.8821367397599, 898.0032164297625, 898.1243287794414, 898.7393655839799, 903.7559858838109, 535.7963973690012, 546.2270886695321, 546.6392181160455, 659.3933581105347, 666.4468491152332, 12307.138500304982, 14878.404863805543, 14931.25343732809, 14942.701145977127, 14970.251487425694, 12117.030637548974, 12176.695582610506, 12314.753704925852, 12409.62771116868, 12641.557545485864, 9813.705588832347, 9934.751631209205, 9970.202383809277, 10101.494925253708, 10628.627998020032, 3444.3627928832993, 3476.5480487536456, 3500.4924285978645, 3504.526888869995, 3550.946735798965, 83749.16250837475, 84275.3144937104, 86159.13840861636, 86363.13636863614, 86382.84042898915, 9302.209312208539, 9413.294002949806, 9474.85787713171, 9550.570224339921, 9875.555599998017, 20583.38249852507, 20680.793192068188, 20914.47713807167, 20920.686189707165, 20921.163153473994, 7421.962890185622, 7487.0, 7497.475176737576, 7529.774106776806, 7635.503692259986, 4182.226288136704, 4188.329867221291, 4201.894952626209, 4208.011117387473, 4217.91564168721, 3491.8079505626924, 3544.8936531904083, 3547.8048707321345, 3548.8935331940083, 3554.484599733076, 654.8166513376262, 656.2158220925947, 657.2277573850706, 657.9440747536513, 659.0509666080924, 474.80295677294225, 570.5920267009026, 620.9130721698966, 632.3170975346615, 636.4971672378862, 6921.792346229621, 8488.151184881586, 8498.235158835734, 8625.051244363114, 8690.435121717068, 519.231537324754, 540.103428309013, 597.1252115650593, 600.1283856745539, 617.6964081547794, 3908.843646254175, 4020.537638171648, 4087.452471482838, 4122.628963393309, 4150.045489537423, 74396.0, 93734.0, 95906.0, 96815.0, 96908.51545742367, 80345.79481307785, 80883.0, 81011.18988810154, 82689.0, 83757.58121209354, 62590.0611490828, 65294.67352663206, 67905.66047169732, 69388.999999999, 70008.29991700017, 7953.2842044216295, 7977.122516523062, 8130.918690813016, 8214.680691731206, 8250.422470427013, 48213.0, 49222.0, 49240.01519969652, 49605.751971239915, 50335.98656053717, 62114.68942655258, 63763.768268112246, 64766.35233647603, 69071.3092869085, 69579.0, 8540.786480337792, 9864.802703946025, 9960.900390996287, 10061.89938100639, 10562.31344962575, 10689.412082335546, 10803.189760768131, 10892.7276818077, 10932.0, 10986.780264394507, 9876.654317098866, 10233.283670143019, 10259.538320775733, 10267.897321026694, 11023.889761102286, 11430.1998860079, 11445.885541144482, 11475.081993440672, 11546.480408381474, 12181.634550963485, 9099.54502274897, 10653.201009924132, 10677.359358438518, 11182.993530582287, 11305.26515776472, 9044.63821447161, 9057.501837399006, 9067.863982040142, 9458.243340532603, 9569.138777510057, 9202.033786452326, 9544.284178686488, 9582.137607615348, 9702.223822094074, 9948.204143668634], "unit": "score", "name": "yui.html", "value": 6709.5309744667575}], "name": "dromaeo_css", "value": 7384.29837263711}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 110.0, 110.0, 111.0, 113.0, 114.0, 110.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [159.0, 119.0, 142.0, 157.0, 126.0, 129.0, 159.0, 142.0, 193.0, 150.0], "unit": "score", "name": "audio-beat-detection", "value": 147.6}, {"lowerIsBetter": true, "replicates": [188.0, 185.0, 190.0, 188.0, 184.0, 184.0, 183.0, 181.0, 184.0, 182.0], "unit": "score", "name": "audio-dft", "value": 184.9}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 95.0, 106.0, 80.0, 56.0, 67.0, 73.0, 75.0, 55.0], "unit": "score", "name": "audio-fft", "value": 75.4}, {"lowerIsBetter": true, "replicates": [91.0, 95.0, 124.0, 78.0, 79.0, 83.0, 114.0, 83.0, 114.0, 150.0], "unit": "score", "name": "audio-oscillator", "value": 101.1}, {"lowerIsBetter": true, "replicates": [85.0, 90.0, 85.0, 94.0, 86.0, 90.0, 83.0, 90.0, 105.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 94.0, 94.0, 107.0, 124.0, 94.0, 95.0, 93.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 98.5}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 88.0, 88.0, 101.0, 136.0, 136.0, 87.0, 84.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 97.7}, {"lowerIsBetter": true, "replicates": [52.0, 52.0, 53.0, 53.0, 52.0, 52.0, 53.0, 62.0, 51.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 53.2}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 73.0, 77.0, 71.0, 69.0, 67.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 80.0, 83.0, 82.0, 83.0, 82.0, 82.0, 85.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.0}, {"lowerIsBetter": true, "replicates": [133.0, 110.0, 130.0, 126.0, 107.0, 129.0, 126.0, 126.0, 122.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.8}, {"lowerIsBetter": true, "replicates": [138.0, 126.0, 136.0, 136.0, 134.0, 126.0, 137.0, 135.0, 135.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.0}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1436.0}]} 04:59:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1436.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7384.30"}}} 04:59:49 INFO - Return code: 0 04:59:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:59:49 INFO - # TBPL SUCCESS # 04:59:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:59:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:59:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:59:49 INFO - 2016-02-06 04:59:49.129 screenresolution[1793:16211] starting screenresolution argv=screenresolution get 04:59:49 INFO - 2016-02-06 04:59:49.132 screenresolution[1793:16211] Display 0: 1600x1200x32@60 04:59:49 INFO - 2016-02-06 04:59:49.138 screenresolution[1794:16214] starting screenresolution argv=screenresolution list 04:59:49 INFO - Available Modes on Display 0 04:59:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:59:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:59:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:59:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:59:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:59:49 INFO - Intel Iris: 04:59:49 INFO - Chipset Model: Intel Iris 04:59:49 INFO - Type: GPU 04:59:49 INFO - Bus: Built-In 04:59:49 INFO - VRAM (Dynamic, Max): 1536 MB 04:59:49 INFO - Vendor: Intel (0x8086) 04:59:49 INFO - Device ID: 0x0a2e 04:59:49 INFO - Revision ID: 0x0009 04:59:49 INFO - Displays: 04:59:49 INFO - Display: 04:59:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:59:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:59:49 INFO - Display Serial Number: 1600x1200 60 04:59:49 INFO - Main Display: Yes 04:59:49 INFO - Mirror: Off 04:59:49 INFO - Online: Yes 04:59:49 INFO - Rotation: Supported 04:59:49 INFO - Return code: 0 04:59:49 INFO - Running post-action listener: _resource_record_post_action 04:59:49 INFO - Running post-run listener: _resource_record_post_run 04:59:50 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 33934848; Write bytes: 708941824; Read time: 351; Write time: 2213 04:59:50 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 393007616; Write bytes: 387601920; Read time: 29870; Write time: 722 04:59:50 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 32161280; Write bytes: 301416960; Read time: 333; Write time: 1430 04:59:50 INFO - Running post-run listener: _upload_blobber_files 04:59:50 INFO - Blob upload gear active. 04:59:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:59:50 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:50 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:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:59:50 INFO - (blobuploader) - INFO - Open directory for files ... 04:59:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:59:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:59:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:51 INFO - (blobuploader) - INFO - Done attempting. 04:59:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:59:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:59:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:52 INFO - (blobuploader) - INFO - Done attempting. 04:59:52 INFO - (blobuploader) - INFO - Iteration through files over. 04:59:52 INFO - Return code: 0 04:59:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:59:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:59:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a69de8a02cf6672c32c0cea749584cae22b1a3f74f53d2c0a66103bd662877cbcc50845f4289054eb5669a3022341d9ad9cc610f6baeaa0cf1682d2b437aa595", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/320c12e48f90d012f9984107f35d3ce555a4f5d25ce7b8b3906124dd7efd8cda71228f3410a326e4324dfc80b3ee6bbb9bea15460abe4cb87397c38321b25dd8"} 04:59:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:59:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:59:52 INFO - Contents: 04:59:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a69de8a02cf6672c32c0cea749584cae22b1a3f74f53d2c0a66103bd662877cbcc50845f4289054eb5669a3022341d9ad9cc610f6baeaa0cf1682d2b437aa595", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/320c12e48f90d012f9984107f35d3ce555a4f5d25ce7b8b3906124dd7efd8cda71228f3410a326e4324dfc80b3ee6bbb9bea15460abe4cb87397c38321b25dd8"} 04:59:52 INFO - Running post-run listener: copy_logs_to_upload_dir 04:59:52 INFO - Copying logs to upload dir... 04:59:52 INFO - mkdir: /builds/slave/test/build/upload/logs 04:59:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.563017 ========= master_lag: 22.50 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-02-06 05:00:15.524565) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 9 secs) (at 2016-02-06 05:00:15.531942) ========= 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.0PvNBml8te/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.f0VXl45Fsm/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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/a69de8a02cf6672c32c0cea749584cae22b1a3f74f53d2c0a66103bd662877cbcc50845f4289054eb5669a3022341d9ad9cc610f6baeaa0cf1682d2b437aa595", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/320c12e48f90d012f9984107f35d3ce555a4f5d25ce7b8b3906124dd7efd8cda71228f3410a326e4324dfc80b3ee6bbb9bea15460abe4cb87397c38321b25dd8"} 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.011143 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/a69de8a02cf6672c32c0cea749584cae22b1a3f74f53d2c0a66103bd662877cbcc50845f4289054eb5669a3022341d9ad9cc610f6baeaa0cf1682d2b437aa595", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/320c12e48f90d012f9984107f35d3ce555a4f5d25ce7b8b3906124dd7efd8cda71228f3410a326e4324dfc80b3ee6bbb9bea15460abe4cb87397c38321b25dd8"}' ========= master_lag: 8.99 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 9 secs) (at 2016-02-06 05:00:24.535594) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:00:24.535951) ========= 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.0PvNBml8te/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.f0VXl45Fsm/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.005354 ========= master_lag: 0.61 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:00:25.152769) ========= ========= Started reboot skipped (results: 3, elapsed: 16 secs) (at 2016-02-06 05:00:25.153236) ========= ========= Finished reboot skipped (results: 3, elapsed: 16 secs) (at 2016-02-06 05:00:41.938499) ========= ========= Total master_lag: 32.35 =========