builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0159 starttime: 1470953999.3 results: success (0) buildid: 20160811130435 builduid: 70e0739b3ec8487e810ac7c5345c6832 revision: 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 15:19:59.304984) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 15:19:59.305429) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 15:19:59.305711) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 15:19:59.419526) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 15:19:59.419925) ========= 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.NIOgcFUGd9/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.AiniTf8lVL/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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-08-11 15:19:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 168M=0s 2016-08-11 15:19:59 (168 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181761 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 15:19:59.628994) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 15:19:59.629736) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NIOgcFUGd9/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.AiniTf8lVL/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.037173 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 15:19:59.690573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 15:19:59.691428) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b --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 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NIOgcFUGd9/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.AiniTf8lVL/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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-08-11 15:19:59,770 truncating revision to first 12 chars 2016-08-11 15:19:59,770 Setting DEBUG logging. 2016-08-11 15:19:59,770 attempt 1/10 2016-08-11 15:19:59,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/61340bd78a4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 15:20:00,906 unpacking tar archive at: fx-team-61340bd78a4b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.414743 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 15:20:01.148518) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 15:20:01.148902) ========= script_repo_revision: 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 15:20:01.152397) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 15:20:01.152748) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 15:20:01.173856) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-11 15:20:01.174289) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NIOgcFUGd9/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.AiniTf8lVL/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 15:20:01 INFO - MultiFileLogger online at 20160811 15:20:01 in /builds/slave/test 15:20:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:20:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:20:01 INFO - {'append_to_log': False, 15:20:01 INFO - 'base_work_dir': '/builds/slave/test', 15:20:01 INFO - 'blob_upload_branch': 'Fx-Team', 15:20:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:20:01 INFO - 'branch': 'Fx-Team', 15:20:01 INFO - 'buildbot_json_path': 'buildprops.json', 15:20:01 INFO - 'config_files': ('talos/mac_config.py',), 15:20:01 INFO - 'default_actions': ('clobber', 15:20:01 INFO - 'read-buildbot-config', 15:20:01 INFO - 'download-and-extract', 15:20:01 INFO - 'populate-webroot', 15:20:01 INFO - 'create-virtualenv', 15:20:01 INFO - 'install', 15:20:01 INFO - 'run-tests'), 15:20:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:20:01 INFO - 'download_minidump_stackwalk': True, 15:20:01 INFO - 'download_symbols': 'ondemand', 15:20:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:20:01 INFO - 'tooltool.py': '/tools/tooltool.py', 15:20:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:20:01 INFO - '/tools/misc-python/virtualenv.py')}, 15:20:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:20:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:20:01 INFO - 'installer_path': 'installer.exe', 15:20:01 INFO - 'log_level': 'info', 15:20:01 INFO - 'log_name': 'talos', 15:20:01 INFO - 'log_to_console': True, 15:20:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:20:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:20:01 INFO - 'opt_config_files': (), 15:20:01 INFO - 'pip_index': False, 15:20:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:20:01 INFO - 'cmd': ('bash', 15:20:01 INFO - '-c', 15:20:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:20:01 INFO - 'enabled': True, 15:20:01 INFO - 'halt_on_failure': False, 15:20:01 INFO - 'name': 'check_screen_resolution'},), 15:20:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:20:01 INFO - 'cmd': ('bash', 15:20:01 INFO - '-c', 15:20:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:20:01 INFO - 'enabled': True, 15:20:01 INFO - 'halt_on_failure': False, 15:20:01 INFO - 'name': 'check_screen_resolution'},), 15:20:01 INFO - 'run_cmd_checks_enabled': True, 15:20:01 INFO - 'sps_profile': False, 15:20:01 INFO - 'sps_profile_interval': 0, 15:20:01 INFO - 'suite': 'dromaeojs-e10s', 15:20:01 INFO - 'system_bits': '32', 15:20:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:20:01 INFO - 'title': 't-yosemite-r7-0159', 15:20:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:20:01 INFO - 'use_talos_json': True, 15:20:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:20:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:20:01 INFO - 'work_dir': 'build'} 15:20:01 INFO - [mozharness: 2016-08-11 22:20:01.370896Z] Running clobber step. 15:20:01 INFO - Running pre-action listener: _resource_record_pre_action 15:20:01 INFO - Running main action method: clobber 15:20:01 INFO - rmtree: /builds/slave/test/build 15:20:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:20:03 INFO - Running post-action listener: _resource_record_post_action 15:20:03 INFO - [mozharness: 2016-08-11 22:20:03.187499Z] Finished clobber step (success) 15:20:03 INFO - [mozharness: 2016-08-11 22:20:03.187648Z] Running read-buildbot-config step. 15:20:03 INFO - Running pre-action listener: _resource_record_pre_action 15:20:03 INFO - Running main action method: read_buildbot_config 15:20:03 INFO - Using buildbot properties: 15:20:03 INFO - { 15:20:03 INFO - "project": "", 15:20:03 INFO - "product": "firefox", 15:20:03 INFO - "script_repo_revision": "production", 15:20:03 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 15:20:03 INFO - "repository": "", 15:20:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 15:20:03 INFO - "buildid": "20160811130435", 15:20:03 INFO - "pgo_build": "False", 15:20:03 INFO - "basedir": "/builds/slave/test", 15:20:03 INFO - "buildnumber": 77, 15:20:03 INFO - "slavename": "t-yosemite-r7-0159", 15:20:03 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 15:20:03 INFO - "platform": "yosemite_r7", 15:20:03 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 15:20:03 INFO - "branch": "fx-team", 15:20:03 INFO - "repo_path": "integration/fx-team", 15:20:03 INFO - "revision": "61340bd78a4bf05890f4b84a6ca57ba01c0ee29b", 15:20:03 INFO - "stage_platform": "macosx64", 15:20:03 INFO - "builduid": "70e0739b3ec8487e810ac7c5345c6832", 15:20:03 INFO - "slavebuilddir": "test" 15:20:03 INFO - } 15:20:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 15:20:03 INFO - Running post-action listener: _resource_record_post_action 15:20:03 INFO - [mozharness: 2016-08-11 22:20:03.190625Z] Finished read-buildbot-config step (success) 15:20:03 INFO - [mozharness: 2016-08-11 22:20:03.190726Z] Running download-and-extract step. 15:20:03 INFO - Running pre-action listener: _resource_record_pre_action 15:20:03 INFO - Running main action method: download_and_extract 15:20:03 INFO - mkdir: /builds/slave/test/build/tests 15:20:03 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:03 INFO - trying https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 15:20:03 INFO - Downloading https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 15:20:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 15:20:04 INFO - Downloaded 1199 bytes. 15:20:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 15:20:04 INFO - Using the following test package requirements: 15:20:04 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 15:20:04 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:20:04 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 15:20:04 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:20:04 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 15:20:04 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:20:04 INFO - u'jsshell-mac.zip'], 15:20:04 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:20:04 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 15:20:04 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 15:20:04 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:20:04 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 15:20:04 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:20:04 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 15:20:04 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:20:04 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 15:20:04 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:20:04 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 15:20:04 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:20:04 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:04 INFO - trying https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 15:20:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 15:20:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:20:07 INFO - Downloaded 16328279 bytes. 15:20:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:20:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:20:10 INFO - Return code: 0 15:20:10 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:10 INFO - trying https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 15:20:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 15:20:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:20:11 INFO - Downloaded 16328279 bytes. 15:20:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:20:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:20:14 INFO - Return code: 0 15:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:14 INFO - trying https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 15:20:14 INFO - Downloading https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 15:20:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:20:16 INFO - Downloaded 14413719 bytes. 15:20:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:20:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 15:20:17 INFO - Return code: 0 15:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:17 INFO - trying https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:20:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 15:20:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 15:20:20 INFO - Downloaded 110898889 bytes. 15:20:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:20:20 INFO - mkdir: /builds/slave/test/properties 15:20:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:20:20 INFO - Writing to file /builds/slave/test/properties/build_url 15:20:20 INFO - Contents: 15:20:20 INFO - build_url:https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:20:21 INFO - Running post-action listener: _resource_record_post_action 15:20:21 INFO - Running post-action listener: set_extra_try_arguments 15:20:21 INFO - [mozharness: 2016-08-11 22:20:21.511110Z] Finished download-and-extract step (success) 15:20:21 INFO - [mozharness: 2016-08-11 22:20:21.511267Z] Running populate-webroot step. 15:20:21 INFO - Running pre-action listener: _resource_record_pre_action 15:20:21 INFO - Running main action method: populate_webroot 15:20:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:20:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:20:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:20:21 INFO - '--tppagecycles', 15:20:21 INFO - '7'], 15:20:21 INFO - 'tests': ['tsvgm']}}, 15:20:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:20:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:20:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:20:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:20:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:20:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:20:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:21 INFO - 'talos_options': ['--disable-e10s'], 15:20:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:20:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:20:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:21 INFO - 'talos_options': ['--disable-e10s'], 15:20:21 INFO - 'tests': ['damp', 'tps']}, 15:20:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:21 INFO - 'tests': ['damp', 'tps']}, 15:20:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:20:21 INFO - 'tests': ['dromaeo_dom']}, 15:20:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:20:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:20:21 INFO - 'tests': ['basic_compositor_video']}, 15:20:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:20:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:20:21 INFO - 'tests': ['a11yr', 15:20:21 INFO - 'ts_paint', 15:20:21 INFO - 'tpaint', 15:20:21 INFO - 'sessionrestore', 15:20:21 INFO - 'sessionrestore_no_auto_restore', 15:20:21 INFO - 'tabpaint']}, 15:20:21 INFO - 'other-e10s': {'tests': ['a11yr', 15:20:21 INFO - 'ts_paint', 15:20:21 INFO - 'tpaint', 15:20:21 INFO - 'sessionrestore', 15:20:21 INFO - 'sessionrestore_no_auto_restore', 15:20:21 INFO - 'tabpaint']}, 15:20:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:20:21 INFO - 'ts_paint', 15:20:21 INFO - 'tpaint', 15:20:21 INFO - 'sessionrestore', 15:20:21 INFO - 'sessionrestore_no_auto_restore', 15:20:21 INFO - 'tabpaint']}, 15:20:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:20:21 INFO - 'ts_paint', 15:20:21 INFO - 'tpaint', 15:20:21 INFO - 'sessionrestore', 15:20:21 INFO - 'sessionrestore_no_auto_restore', 15:20:21 INFO - 'tabpaint']}, 15:20:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:20:21 INFO - 'tests': ['a11yr', 15:20:21 INFO - 'ts_paint', 15:20:21 INFO - 'tpaint', 15:20:21 INFO - 'sessionrestore', 15:20:21 INFO - 'sessionrestore_no_auto_restore', 15:20:21 INFO - 'tabpaint']}, 15:20:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:20:21 INFO - 'tests': ['a11yr', 15:20:21 INFO - 'ts_paint', 15:20:21 INFO - 'tpaint', 15:20:21 INFO - 'sessionrestore', 15:20:21 INFO - 'sessionrestore_no_auto_restore', 15:20:21 INFO - 'tabpaint']}, 15:20:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:20:21 INFO - 'tests': ['tsvgx', 15:20:21 INFO - 'tsvgr_opacity', 15:20:21 INFO - 'tart', 15:20:21 INFO - 'tscrollx', 15:20:21 INFO - 'cart']}, 15:20:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:20:21 INFO - 'tsvgr_opacity', 15:20:21 INFO - 'tart', 15:20:21 INFO - 'tscrollx', 15:20:21 INFO - 'cart']}, 15:20:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:21 INFO - 'talos_options': ['--disable-e10s'], 15:20:21 INFO - 'tests': ['tp5o']}, 15:20:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:21 INFO - 'tests': ['tp5o']}, 15:20:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:21 INFO - 'talos_options': ['--disable-e10s', 15:20:21 INFO - '--xperf_path', 15:20:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:20:21 INFO - 'tests': ['tp5n']}, 15:20:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:21 INFO - 'talos_options': ['--xperf_path', 15:20:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:20:21 INFO - 'tests': ['tp5n']}}, 15:20:21 INFO - 'talos.zip': {'path': '', 15:20:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:20:21 INFO - Running post-action listener: _resource_record_post_action 15:20:21 INFO - [mozharness: 2016-08-11 22:20:21.530432Z] Finished populate-webroot step (success) 15:20:21 INFO - [mozharness: 2016-08-11 22:20:21.530548Z] Running create-virtualenv step. 15:20:21 INFO - Running pre-action listener: _resource_record_pre_action 15:20:21 INFO - Running main action method: create_virtualenv 15:20:21 INFO - Creating virtualenv /builds/slave/test/build/venv 15:20:21 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 15:20:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:20:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:20:21 INFO - Using real prefix '/tools/python27' 15:20:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:20:22 INFO - Installing distribute.............................................................................................................................................................................................done. 15:20:25 INFO - Installing pip.................done. 15:20:25 INFO - Return code: 0 15:20:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:25 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 0x108e29a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ebe618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb378cd2ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d8dd30>, '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 0x108af2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d85b20>, '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.NIOgcFUGd9/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.AiniTf8lVL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 15:20:25 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 15:20:25 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 15:20:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIOgcFUGd9/Render', 15:20:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:20:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:20:25 INFO - 'HOME': '/Users/cltbld', 15:20:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:20:25 INFO - 'LOGNAME': 'cltbld', 15:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:25 INFO - 'MOZ_NO_REMOTE': '1', 15:20:25 INFO - 'NO_EM_RESTART': '1', 15:20:25 INFO - 'PAGER': '/bin/cat', 15:20:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:25 INFO - 'PWD': '/builds/slave/test', 15:20:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:20:25 INFO - 'SHELL': '/bin/bash', 15:20:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AiniTf8lVL/Listeners', 15:20:25 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 15:20:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:20:25 INFO - 'USER': 'cltbld', 15:20:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:20:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:25 INFO - 'XPC_FLAGS': '0x0', 15:20:25 INFO - 'XPC_SERVICE_NAME': '0', 15:20:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:25 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 15:20:25 INFO - Cleaning up... 15:20:25 INFO - Return code: 0 15:20:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:25 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108e29a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ebe618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb378cd2ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d8dd30>, '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 0x108af2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d85b20>, '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.NIOgcFUGd9/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.AiniTf8lVL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 15:20:25 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>=3.1.1'] in /builds/slave/test/build 15:20:25 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>=3.1.1 15:20:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIOgcFUGd9/Render', 15:20:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:20:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:20:25 INFO - 'HOME': '/Users/cltbld', 15:20:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:20:25 INFO - 'LOGNAME': 'cltbld', 15:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:25 INFO - 'MOZ_NO_REMOTE': '1', 15:20:25 INFO - 'NO_EM_RESTART': '1', 15:20:25 INFO - 'PAGER': '/bin/cat', 15:20:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:25 INFO - 'PWD': '/builds/slave/test', 15:20:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:20:25 INFO - 'SHELL': '/bin/bash', 15:20:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AiniTf8lVL/Listeners', 15:20:25 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 15:20:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:20:25 INFO - 'USER': 'cltbld', 15:20:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:20:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:25 INFO - 'XPC_FLAGS': '0x0', 15:20:25 INFO - 'XPC_SERVICE_NAME': '0', 15:20:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:25 INFO - Downloading/unpacking psutil>=3.1.1 15:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:20:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:20:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:20:29 INFO - Installing collected packages: psutil 15:20:29 INFO - Running setup.py install for psutil 15:20:29 INFO - building 'psutil._psutil_osx' extension 15:20:29 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 15:20:29 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 15:20:29 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 15:20:30 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 15:20:30 INFO - building 'psutil._psutil_posix' extension 15:20:30 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 15:20:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:20:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:20:30 INFO - ^ 15:20:30 INFO - 1 warning generated. 15:20:30 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 15:20:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:20:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:20:30 INFO - Successfully installed psutil 15:20:30 INFO - Cleaning up... 15:20:30 INFO - Return code: 0 15:20:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108e29a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ebe618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb378cd2ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d8dd30>, '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 0x108af2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d85b20>, '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.NIOgcFUGd9/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.AiniTf8lVL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 15:20:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:20:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIOgcFUGd9/Render', 15:20:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:20:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:20:30 INFO - 'HOME': '/Users/cltbld', 15:20:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:20:30 INFO - 'LOGNAME': 'cltbld', 15:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:30 INFO - 'MOZ_NO_REMOTE': '1', 15:20:30 INFO - 'NO_EM_RESTART': '1', 15:20:30 INFO - 'PAGER': '/bin/cat', 15:20:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:30 INFO - 'PWD': '/builds/slave/test', 15:20:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:20:30 INFO - 'SHELL': '/bin/bash', 15:20:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AiniTf8lVL/Listeners', 15:20:30 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 15:20:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:20:30 INFO - 'USER': 'cltbld', 15:20:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:20:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:30 INFO - 'XPC_FLAGS': '0x0', 15:20:30 INFO - 'XPC_SERVICE_NAME': '0', 15:20:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:20:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:20:33 INFO - Installing collected packages: mozsystemmonitor 15:20:33 INFO - Running setup.py install for mozsystemmonitor 15:20:33 INFO - Successfully installed mozsystemmonitor 15:20:33 INFO - Cleaning up... 15:20:33 INFO - Return code: 0 15:20:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108e29a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ebe618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb378cd2ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d8dd30>, '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 0x108af2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d85b20>, '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.NIOgcFUGd9/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.AiniTf8lVL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 15:20: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==2.5.1'] in /builds/slave/test/build 15:20: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==2.5.1 15:20:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIOgcFUGd9/Render', 15:20:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:20:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:20:33 INFO - 'HOME': '/Users/cltbld', 15:20:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:20:33 INFO - 'LOGNAME': 'cltbld', 15:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:33 INFO - 'MOZ_NO_REMOTE': '1', 15:20:33 INFO - 'NO_EM_RESTART': '1', 15:20:33 INFO - 'PAGER': '/bin/cat', 15:20:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:33 INFO - 'PWD': '/builds/slave/test', 15:20:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:20:33 INFO - 'SHELL': '/bin/bash', 15:20:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AiniTf8lVL/Listeners', 15:20:33 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 15:20:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:20:33 INFO - 'USER': 'cltbld', 15:20:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:20:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:33 INFO - 'XPC_FLAGS': '0x0', 15:20:33 INFO - 'XPC_SERVICE_NAME': '0', 15:20:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:33 INFO - Downloading/unpacking jsonschema==2.5.1 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:20:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20:36 INFO - Downloading functools32-3.2.3-2.tar.gz 15:20:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:20:36 INFO - warning: no files found matching '*.txt' 15:20:36 INFO - no previously-included directories found matching 'build' 15:20:36 INFO - no previously-included directories found matching 'dist' 15:20:36 INFO - no previously-included directories found matching '.git*' 15:20:36 INFO - Installing collected packages: jsonschema, functools32 15:20:36 INFO - Running setup.py install for functools32 15:20:36 INFO - warning: no files found matching '*.txt' 15:20:36 INFO - no previously-included directories found matching 'build' 15:20:36 INFO - no previously-included directories found matching 'dist' 15:20:36 INFO - no previously-included directories found matching '.git*' 15:20:36 INFO - Successfully installed jsonschema functools32 15:20:36 INFO - Cleaning up... 15:20:36 INFO - Return code: 0 15:20:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108e29a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ebe618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb378cd2ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d8dd30>, '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 0x108af2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d85b20>, '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.NIOgcFUGd9/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.AiniTf8lVL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 15:20: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:20: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 functools32==3.2.3-2 15:20:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIOgcFUGd9/Render', 15:20:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:20:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:20:36 INFO - 'HOME': '/Users/cltbld', 15:20:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:20:36 INFO - 'LOGNAME': 'cltbld', 15:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:36 INFO - 'MOZ_NO_REMOTE': '1', 15:20:36 INFO - 'NO_EM_RESTART': '1', 15:20:36 INFO - 'PAGER': '/bin/cat', 15:20:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:36 INFO - 'PWD': '/builds/slave/test', 15:20:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:20:36 INFO - 'SHELL': '/bin/bash', 15:20:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AiniTf8lVL/Listeners', 15:20:36 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 15:20:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:20:36 INFO - 'USER': 'cltbld', 15:20:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:20:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:36 INFO - 'XPC_FLAGS': '0x0', 15:20:36 INFO - 'XPC_SERVICE_NAME': '0', 15:20:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:20:37 INFO - Cleaning up... 15:20:37 INFO - Return code: 0 15:20:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:20:37 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:37 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:37 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 0x108e29a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ebe618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb378cd2ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d8dd30>, '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 0x108af2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d85b20>, '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.NIOgcFUGd9/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.AiniTf8lVL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 15:20:37 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 15:20:37 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 15:20:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIOgcFUGd9/Render', 15:20:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:20:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:20:37 INFO - 'HOME': '/Users/cltbld', 15:20:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:20:37 INFO - 'LOGNAME': 'cltbld', 15:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:37 INFO - 'MOZ_NO_REMOTE': '1', 15:20:37 INFO - 'NO_EM_RESTART': '1', 15:20:37 INFO - 'PAGER': '/bin/cat', 15:20:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:37 INFO - 'PWD': '/builds/slave/test', 15:20:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:20:37 INFO - 'SHELL': '/bin/bash', 15:20:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AiniTf8lVL/Listeners', 15:20:37 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 15:20:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:20:37 INFO - 'USER': 'cltbld', 15:20:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:20:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:37 INFO - 'XPC_FLAGS': '0x0', 15:20:37 INFO - 'XPC_SERVICE_NAME': '0', 15:20:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:37 INFO - Downloading/unpacking blobuploader==1.2.4 15:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:39 INFO - Downloading blobuploader-1.2.4.tar.gz 15:20:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:20:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:20:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20:40 INFO - Downloading docopt-0.6.1.tar.gz 15:20:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:20:41 INFO - Installing collected packages: blobuploader, requests, docopt 15:20:41 INFO - Running setup.py install for blobuploader 15:20:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:20:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:20:41 INFO - Running setup.py install for requests 15:20:41 INFO - Running setup.py install for docopt 15:20:41 INFO - Successfully installed blobuploader requests docopt 15:20:41 INFO - Cleaning up... 15:20:41 INFO - Return code: 0 15:20:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:20:41 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:41 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:41 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 0x108e29a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ebe618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb378cd2ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d8dd30>, '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 0x108af2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d85b20>, '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.NIOgcFUGd9/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.AiniTf8lVL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 15:20:41 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 15:20:41 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 15:20:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIOgcFUGd9/Render', 15:20:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:20:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:20:41 INFO - 'HOME': '/Users/cltbld', 15:20:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:20:41 INFO - 'LOGNAME': 'cltbld', 15:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:41 INFO - 'MOZ_NO_REMOTE': '1', 15:20:41 INFO - 'NO_EM_RESTART': '1', 15:20:41 INFO - 'PAGER': '/bin/cat', 15:20:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:41 INFO - 'PWD': '/builds/slave/test', 15:20:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:20:41 INFO - 'SHELL': '/bin/bash', 15:20:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AiniTf8lVL/Listeners', 15:20:41 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 15:20:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:20:41 INFO - 'USER': 'cltbld', 15:20:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:20:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:41 INFO - 'XPC_FLAGS': '0x0', 15:20:41 INFO - 'XPC_SERVICE_NAME': '0', 15:20:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:20:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:20:42 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-lriiOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:20:42 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-C5cr79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:20:42 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-0mDTzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:20:42 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-RyXlLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:20:42 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-NcCyT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:20:42 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-5fbpao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:20:42 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-j4cdoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:20:42 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-JDk1zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:20:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-xZsW7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:20:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-8tDIjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:20:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Fe955J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:20:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-uoKO_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:20:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-C2VAYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:20:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-nbeXe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-_wSdJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:20:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-jpx0CQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:20:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-N4oSsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:20:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:20:44 INFO - Running setup.py install for manifestparser 15:20:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:20:44 INFO - Running setup.py install for mozcrash 15:20:44 INFO - Running setup.py install for mozdebug 15:20:44 INFO - Running setup.py install for mozdevice 15:20:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:20:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:20:44 INFO - Running setup.py install for mozfile 15:20:44 INFO - Running setup.py install for mozhttpd 15:20:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:20:44 INFO - Running setup.py install for mozinfo 15:20:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:20:45 INFO - Running setup.py install for mozInstall 15:20:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:20:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:20:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:20:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:20:45 INFO - Running setup.py install for mozleak 15:20:45 INFO - Running setup.py install for mozlog 15:20:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:20:45 INFO - Running setup.py install for moznetwork 15:20:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:20:45 INFO - Running setup.py install for mozprocess 15:20:45 INFO - Running setup.py install for mozprofile 15:20:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:20:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:20:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:20:45 INFO - Running setup.py install for mozrunner 15:20:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:20:46 INFO - Running setup.py install for mozscreenshot 15:20:46 INFO - Running setup.py install for moztest 15:20:46 INFO - Running setup.py install for mozversion 15:20:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:20:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:20:46 INFO - Cleaning up... 15:20:46 INFO - Return code: 0 15:20:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:20:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:46 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 0x108e29a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ebe618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb378cd2ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d8dd30>, '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 0x108af2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d85b20>, '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.NIOgcFUGd9/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.AiniTf8lVL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 15:20:46 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 15:20:46 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 15:20:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIOgcFUGd9/Render', 15:20:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:20:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:20:46 INFO - 'HOME': '/Users/cltbld', 15:20:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:20:46 INFO - 'LOGNAME': 'cltbld', 15:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:46 INFO - 'MOZ_NO_REMOTE': '1', 15:20:46 INFO - 'NO_EM_RESTART': '1', 15:20:46 INFO - 'PAGER': '/bin/cat', 15:20:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:46 INFO - 'PWD': '/builds/slave/test', 15:20:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:20:46 INFO - 'SHELL': '/bin/bash', 15:20:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AiniTf8lVL/Listeners', 15:20:46 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 15:20:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:20:46 INFO - 'USER': 'cltbld', 15:20:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:20:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:46 INFO - 'XPC_FLAGS': '0x0', 15:20:46 INFO - 'XPC_SERVICE_NAME': '0', 15:20:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:20:46 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-9lpBki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:20:46 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)) 15:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:20:46 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-mMunXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:20:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 15:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:20:47 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-0iONh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:20:47 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)) 15:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:20:47 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-QNM_NR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:20:47 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)) 15:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:20:47 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-rgdMEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:20:47 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)) 15:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:20:47 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-oi7xFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:20:47 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)) 15:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:20:47 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-S69Z5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:20:47 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)) 15:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:20:47 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-kgd5n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:20:47 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)) 15:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:20:47 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-gjvLz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:20:47 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)) 15:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:20:47 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-fwAfgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:20:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 15:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:20:47 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-pSKcs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:20:48 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)) 15:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:20:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-_Ofd0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 15:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:20:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-vzF5VC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:20:48 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)) 15:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:20:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-XHCbhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 15:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-BctDGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:48 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)) 15:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:20:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-qmlVRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:20:48 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)) 15:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:20:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-lMO7Ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:20:48 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)) 15:20:48 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:20:48 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:20:48 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)) 15:20:48 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)) 15:20:48 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)) 15:20:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:20:48 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 15:20:48 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 15:20:48 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 15:20:48 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 15:20:48 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 15:20:48 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 15:20:51 INFO - Downloading blessings-1.6.tar.gz 15:20:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:20:51 INFO - Installing collected packages: blessings 15:20:51 INFO - Running setup.py install for blessings 15:20:51 INFO - Successfully installed blessings 15:20:51 INFO - Cleaning up... 15:20:51 INFO - Return code: 0 15:20:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:20:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:20:52 INFO - Reading from file tmpfile_stdout 15:20:52 INFO - Current package versions: 15:20:52 INFO - blessings == 1.6 15:20:52 INFO - blobuploader == 1.2.4 15:20:52 INFO - docopt == 0.6.1 15:20:52 INFO - functools32 == 3.2.3-2 15:20:52 INFO - jsonschema == 2.5.1 15:20:52 INFO - manifestparser == 1.1 15:20:52 INFO - mozInstall == 1.12 15:20:52 INFO - mozcrash == 0.17 15:20:52 INFO - mozdebug == 0.1 15:20:52 INFO - mozdevice == 0.48 15:20:52 INFO - mozfile == 1.2 15:20:52 INFO - mozhttpd == 0.7 15:20:52 INFO - mozinfo == 0.9 15:20:52 INFO - mozleak == 0.1 15:20:52 INFO - mozlog == 3.3 15:20:52 INFO - moznetwork == 0.27 15:20:52 INFO - mozprocess == 0.23 15:20:52 INFO - mozprofile == 0.28 15:20:52 INFO - mozrunner == 6.12 15:20:52 INFO - mozscreenshot == 0.1 15:20:52 INFO - mozsystemmonitor == 0.3 15:20:52 INFO - moztest == 0.7 15:20:52 INFO - mozversion == 1.4 15:20:52 INFO - psutil == 3.1.1 15:20:52 INFO - requests == 1.2.3 15:20:52 INFO - wsgiref == 0.1.2 15:20:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:52 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 0x108e29a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ebe618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb378cd2ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d8dd30>, '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 0x108af2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d85b20>, '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.NIOgcFUGd9/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.AiniTf8lVL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 15:20:52 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 15:20:52 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 15:20:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIOgcFUGd9/Render', 15:20:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:20:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:20:52 INFO - 'HOME': '/Users/cltbld', 15:20:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:20:52 INFO - 'LOGNAME': 'cltbld', 15:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:52 INFO - 'MOZ_NO_REMOTE': '1', 15:20:52 INFO - 'NO_EM_RESTART': '1', 15:20:52 INFO - 'PAGER': '/bin/cat', 15:20:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:52 INFO - 'PWD': '/builds/slave/test', 15:20:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:20:52 INFO - 'SHELL': '/bin/bash', 15:20:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AiniTf8lVL/Listeners', 15:20:52 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 15:20:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:20:52 INFO - 'USER': 'cltbld', 15:20:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:20:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:52 INFO - 'XPC_FLAGS': '0x0', 15:20:52 INFO - 'XPC_SERVICE_NAME': '0', 15:20:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:52 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)) 15:20:52 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)) 15:20:52 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)) 15:20:52 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)) 15:20:52 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)) 15:20:52 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)) 15:20:52 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)) 15:20:52 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)) 15:20:52 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)) 15:20:52 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)) 15:20:52 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)) 15:20:52 INFO - Cleaning up... 15:20:52 INFO - Return code: 0 15:20:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:52 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 0x108e29a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ebe618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb378cd2ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d8dd30>, '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 0x108af2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d85b20>, '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.NIOgcFUGd9/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.AiniTf8lVL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 15:20:52 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 15:20:52 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 15:20:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIOgcFUGd9/Render', 15:20:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:20:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:20:52 INFO - 'HOME': '/Users/cltbld', 15:20:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:20:52 INFO - 'LOGNAME': 'cltbld', 15:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:52 INFO - 'MOZ_NO_REMOTE': '1', 15:20:52 INFO - 'NO_EM_RESTART': '1', 15:20:52 INFO - 'PAGER': '/bin/cat', 15:20:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:52 INFO - 'PWD': '/builds/slave/test', 15:20:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:20:52 INFO - 'SHELL': '/bin/bash', 15:20:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AiniTf8lVL/Listeners', 15:20:52 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 15:20:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:20:52 INFO - 'USER': 'cltbld', 15:20:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:20:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:52 INFO - 'XPC_FLAGS': '0x0', 15:20:52 INFO - 'XPC_SERVICE_NAME': '0', 15:20:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:20:52 INFO - Cleaning up... 15:20:53 INFO - Return code: 0 15:20:53 INFO - Running post-action listener: _resource_record_post_action 15:20:53 INFO - Running post-action listener: _start_resource_monitoring 15:20:53 INFO - Starting resource monitoring. 15:20:53 INFO - [mozharness: 2016-08-11 22:20:53.026055Z] Finished create-virtualenv step (success) 15:20:53 INFO - [mozharness: 2016-08-11 22:20:53.026989Z] Running install step. 15:20:53 INFO - Running pre-action listener: _resource_record_pre_action 15:20:53 INFO - Running main action method: install 15:20:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:20:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:20:53 INFO - Reading from file tmpfile_stdout 15:20:53 INFO - Detecting whether we're running mozinstall >=1.0... 15:20:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:20:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:20:53 INFO - Reading from file tmpfile_stdout 15:20:53 INFO - Output received: 15:20:53 INFO - Usage: mozinstall [options] installer 15:20:53 INFO - Options: 15:20:53 INFO - -h, --help show this help message and exit 15:20:53 INFO - -d DEST, --destination=DEST 15:20:53 INFO - Directory to install application into. [default: 15:20:53 INFO - "/builds/slave/test"] 15:20:53 INFO - --app=APP Application being installed. [default: firefox] 15:20:53 INFO - mkdir: /builds/slave/test/build/application 15:20:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:20:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:21:27 INFO - Reading from file tmpfile_stdout 15:21:27 INFO - Output received: 15:21:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:21:27 INFO - Running post-action listener: _resource_record_post_action 15:21:27 INFO - [mozharness: 2016-08-11 22:21:27.471694Z] Finished install step (success) 15:21:27 INFO - [mozharness: 2016-08-11 22:21:27.471824Z] Running run-tests step. 15:21:27 INFO - Running pre-action listener: _resource_record_pre_action 15:21:27 INFO - Running main action method: run_tests 15:21:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:21:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:21:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:21:27 INFO - 2016-08-11 15:21:27.486 screenresolution[1647:7499] starting screenresolution argv=screenresolution get 15:21:27 INFO - 2016-08-11 15:21:27.488 screenresolution[1647:7499] Display 0: 1600x1200x32@60 15:21:27 INFO - 2016-08-11 15:21:27.495 screenresolution[1648:7501] starting screenresolution argv=screenresolution list 15:21:27 INFO - Available Modes on Display 0 15:21:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:21:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:21:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:21:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:21:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:21:27 INFO - Intel Iris: 15:21:27 INFO - Chipset Model: Intel Iris 15:21:27 INFO - Type: GPU 15:21:27 INFO - Bus: Built-In 15:21:27 INFO - VRAM (Dynamic, Max): 1536 MB 15:21:27 INFO - Vendor: Intel (0x8086) 15:21:27 INFO - Device ID: 0x0a2e 15:21:27 INFO - Revision ID: 0x0009 15:21:27 INFO - Displays: 15:21:27 INFO - Display: 15:21:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:21:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:21:27 INFO - Display Serial Number: 1600x1200 60 15:21:27 INFO - Main Display: Yes 15:21:27 INFO - Mirror: Off 15:21:27 INFO - Online: Yes 15:21:27 INFO - Rotation: Supported 15:21:27 INFO - Return code: 0 15:21:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:21:27 INFO - Python 2.7.3 15:21:27 INFO - Return code: 0 15:21:27 INFO - grabbing minidump binary from tooltool 15:21:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:27 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d8dd30>, '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 0x108af2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d85b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:21:27 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 15:21:27 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 15:21:27 INFO - Calling ['/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'] with output_timeout 600 15:21:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:21:27 INFO - Return code: 0 15:21:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:21:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:21:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:21:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:21:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:21:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0159 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:21:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NIOgcFUGd9/Render', 15:21:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:21:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:21:27 INFO - 'HOME': '/Users/cltbld', 15:21:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:21:27 INFO - 'LOGNAME': 'cltbld', 15:21:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:21:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:27 INFO - 'MOZ_NO_REMOTE': '1', 15:21:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:21:27 INFO - 'NO_EM_RESTART': '1', 15:21:27 INFO - 'PAGER': '/bin/cat', 15:21:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:27 INFO - 'PWD': '/builds/slave/test', 15:21:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:21:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:21:27 INFO - 'SHELL': '/bin/bash', 15:21:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AiniTf8lVL/Listeners', 15:21:27 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 15:21:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:21:27 INFO - 'USER': 'cltbld', 15:21:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:21:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:27 INFO - 'XPC_FLAGS': '0x0', 15:21:27 INFO - 'XPC_SERVICE_NAME': '0', 15:21:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:21:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:21:28 INFO - mozversion application_buildid: 20160811130435 15:21:28 INFO - mozversion application_changeset: 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b 15:21:28 INFO - mozversion application_display_name: Nightly 15:21:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:21:28 INFO - mozversion application_name: Firefox 15:21:28 INFO - mozversion application_remotingname: firefox 15:21:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:21:28 INFO - mozversion application_vendor: Mozilla 15:21:28 INFO - mozversion application_version: 51.0a1 15:21:28 INFO - mozversion platform_buildid: 20160811130435 15:21:28 INFO - mozversion platform_changeset: 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b 15:21:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:21:28 INFO - mozversion platform_version: 51.0a1 15:21:28 INFO - using testdate: 1470954088 15:21:28 INFO - actual date: 1470954088 15:21:28 INFO - starting webserver on 'localhost:49282' 15:21:28 INFO - SUITE-START | Running 2 tests 15:21:28 INFO - TEST-START | dromaeo_css 15:21:28 INFO - operating with platform_type : mac_ 15:21:28 INFO - Initialising browser for dromaeo_css test... 15:21:28 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpzOSbrm/profile http://localhost:49282/getInfo.html) 15:21:30 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 15:21:30 INFO - PROCESS | 1658 | colorDepth:24 15:21:30 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 15:21:30 INFO - PROCESS | 1658 | __metrics 15:21:31 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 15:21:31 INFO - TEST-INFO | 1658: exit 0 15:21:31 INFO - Browser initialized. 15:21:31 INFO - Running cycle 1/1 for dromaeo_css test... 15:21:31 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpzOSbrm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:21:43 INFO - PROCESS | 1661 | RSS: Main: 254959616 15:21:43 INFO - PROCESS | 1661 | 15:22:33 INFO - PROCESS | 1661 | 1470954153359 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] 15:24:45 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49282/tests/dromaeo/cssquery-ext.html) 15:24:46 INFO - PROCESS | 1661 | RSS: Main: 269041664 15:24:46 INFO - PROCESS | 1661 | 15:27:48 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-ext.html (next: http://localhost:49282/tests/dromaeo/cssquery-jquery.html) 15:27:49 INFO - PROCESS | 1661 | RSS: Main: 275976192 15:27:49 INFO - PROCESS | 1661 | 15:30:51 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49282/tests/dromaeo/cssquery-mootools.html) 15:30:52 INFO - PROCESS | 1661 | RSS: Main: 280702976 15:30:52 INFO - PROCESS | 1661 | 15:33:53 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49282/tests/dromaeo/cssquery-prototype.html) 15:33:54 INFO - PROCESS | 1661 | RSS: Main: 279093248 15:33:54 INFO - PROCESS | 1661 | 15:36:57 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49282/tests/dromaeo/cssquery-yui.html) 15:36:57 INFO - PROCESS | 1661 | RSS: Main: 283291648 15:36:57 INFO - PROCESS | 1661 | 15:40:00 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-yui.html (next: http://localhost:49282/tests/dromaeo/cssquery-dojo.html) 15:40:00 INFO - PROCESS | 1661 | RSS: Main: 284954624 15:40:00 INFO - PROCESS | 1661 | 15:40:00 INFO - PROCESS | 1661 | __start_tp_report 15:40:00 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 15:40:00 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 15:40:00 INFO - PROCESS | 1661 | |i|pagename|runs| 15:40:00 INFO - PROCESS | 1661 | |0;dojo.html;3411.8464669089904;3422.9999999999995;3432.5194472773833;3436.7250619950405;3464.549608550888;5553.750081246354;5638.267025286712;5692.402297758733;5734.340550836645;5750.252467179266;5608.971955140229;5618.410066942974;5623.128415095656;5731.828045158652;5743.9712801436035;5078.238264260353;5165.9225111623355;5210.739463026853;5246.580273578104;5276.657017293883;5101.260317253996;5201.661891977028;5205.973970130144;5299.284596579451;5318.946810531903;5129.871753206163;5135.768890399941;5136.332276803992;5142.845714628567;5209.6874187548865;5134.127198376285;5160.329157209576;5206;5225;5268.631195816294;4568.177728008957;5115.18157094863;5180.378354597435;5196.012757576086;5205.583553315726;5434.592405569598;5668.234788303567;5697.088465845486;5698.629589076697;5729.197912292282;5168;6200.162977998003;6201.844953876144;6209.534284928648;6304.306526282106;5348.839534813962;6098.1157732128595;6109.040306147788;6245.718942647592;6292.370762923717;4847.830325938575;5002.349694539723;5889.1755154278435;5899.233099697012;5905.852353691106;6285.622862628257;6315;6321.051842223611;6323.146375239284;6344.587601805868;5969.403059694083;6111.694415279218;6129.233845769279;6208.72060757267;6224.284207316216;5195.3246078009615;6248.0003199487865;6261.78083767066;6277.780277690259;6293.118963345135;6144.324124346318;6182.1345011698395;6206.317305096526;6244.4380005798785;6247;6034.607750496204;6091.51267898567;6148.661823599745;6252.187215661935;6292.559520833498;5035.395752509722;5045.990801839646;5057.14028615129;5069.645124841226;5101.464346243665;4432.867013989586;4479.61923236522;4479.731216127043;4490.461144662661;4508.211063063951;5603.663780173202;5646.096624540054;5688.11834165705;5724.713764311768;5725.456081672234;5227.503387178212;6271.153394291712;6304.148939893147;6321.936780632135;6323.146375239376;5758.510526605285;5774.566907481955;5777.30672319316;5779.566532510079;5792.82621521355;5366.8658283542445;5473.31583552056;5475.753591088331;5479.5342395896;5483.506484416422;6270.968645156745;6392.904106438407;6445.548811583238;6474.449671777952;6490.091387205795;5674;6259.186305780219;6263.843403914756;6276.811695649138;6282.371762823681;6167.6916154193;6302.653354065387;6332.715027823851;6412.647304398303;6417.454516366161;5546.833594992157;5830;6216.316205217513;6252.812415627538;6261.624302541862;6229.844253893689;6252.021234781737;6291.150694656163;6295.5907865988565;6307.842303942438;5435.619506634655;6087.371687753549;6144.38556144382;6168.25980882297;6169.81490555284;6155.199824022849;6189.381061893775;6203.751849926133;6204.193454850841;6204.689765511616;4825.879353016203;5882.499987500939;5957.195778570011;6049.576529642883;6079.635221886701;5805.274340707411;6059.0608455689435;6141.539384546266;6217.875642487034;6241.625502469867;5980.401959803985;6033.974224381954;6037.698115094316;6060.484858786876;6095.299040610386 15:40:00 INFO - PROCESS | 1661 | |1;ext.html;501.73909567025146;521.2467983763463;538.6041259674139;541.5478075806701;542.6743953627824;38682.80658596707;41771.58228417715;41897;41964.37053444201;42187.57812421879;39627.40558891619;42641.786791066;43268.56731432685;43307.3503897441;43336;9554.331196816243;9754.658586949457;9766.90233097667;9786.314957952945;9787.36382135159;9632.662856800014;9737.97751236117;9762.804743905117;9768.21854251658;9787.657431989881;9770.755731106743;9776.657816976407;9801.264905132144;9804.656837010705;9805.852912206323;9681.37071090377;9717;9755;9777.95111024444;9797.265205109645;9579.61681532738;9646.180074693659;9667.564959576835;9671.90328096717;9701.272404569685;40434.98912527181;40611;40742.79628601838;40859;41006.79496602498;3376.5104059911423;3407.863685452579;3441.5353927219753;3542.167590616203;4067.857624983141;32213.194670133198;32468;33349.6665033349;33386.165345866306;33416.16459588506;3215.614126304835;3358.966410335914;3359.9160020999425;3394.4908263760385;3401.710854577339;348341;462914;468720.65639671584;470669;473492;60530.697346513865;60677;60784.39215607876;61118;61273.08090378648;63457;63840.36159638344;63951.68024159849;63973.680131599045;64225.71548569002;15958.12230327343;15967.680646387007;15979.840201598068;16162.838371616133;16168.595785105466;12482.937585312015;12510.687232819071;12560.120791544687;12597.622071337875;12618.116731828868;16099.1145486997;16682.91561048528;16722.08028558441;16751.329946802234;16789.748153777702;3247.8700851966128;6067.848303792352;6808.3191680832515;7080.90246011869;7136.821579460555;823.9340852731887;887.587271918561;990.6483198464585;1029.1818004686293;1056.5140035583563;30086.699133008828;30577.38845223083;30746.923857664875;30900.69099309023;30927.226819329248;1044.4360045575456;1048.632978457549;1059.3167407022427;1079.6922876980022;1083.8374243863484;15946.681066378607;16018.439354622533;16025.958312709636;16066.38506336065;16299.837001630069;620377;628684;633157;633440;637208;59699;59701.70149149226;60090.39909600848;60185.39814601885;60429.79140417167;1360.2382665707235;1384.5915454940816;1431.8496557861274;1432.9355179016968;1433.104309806371;29599;29823.956161534243;30251.11991300104;30286.394272114874;30363;43369;50441.49558504368;51948.22077668762;52158.30575248246;52184.21723674224;463770;466843;468171.6591417021;545297;576360;25478.872605636854;25706.485870282115;26193;27429.45141097127;28209.858950705115;47730.28404574004;48360.75819620879;49854;50137.74931125321;50340.74148146326;32587.674123258465;39625.603743962194;39897.202055958136;41252;41637.79181104075;31892.68107318897;39918.2016359677;40699;41048.91930584087;41634.58365416307;38215.426768597936;39559;39695.816730078965;39726.60273397345;39859.80420587387;28052.896032797213;34431.655683443845;35151.47272790859;35372.82313588416;35438.82280588581;22238.332850014525;25678.486430270917;26137.477250454504;26142.73857261403;26259.21222363332 15:40:00 INFO - PROCESS | 1661 | |2;jquery.html;343.1917833502101;370.33524822942815;375.7351067497415;380.82101412336203;403.92325458162946;19738.506537336554;20346.491337716547;21198.89400552995;21806;22300.553988920252;11651.766964660701;11946.462409191585;12322.322272275022;12327.952124069465;12371.50513979442;5484.61607687461;5695.601307908448;5733.913991290113;5743.885122297552;5747.712614369265;3981.741186822862;5682.090865461527;5965.926133296027;6229.937700623003;6268.373162683741;6243.687815609224;6293.590916590407;6308.526860485459;6324.9051264231075;6337.809865704014;6260.40526150015;6288;6302.275238347603;6303.810885673437;6312.179416675849;6094.695265236721;6117.235345581802;6190.102435146879;6208.068789681539;6217.658028808413;13226.61920854246;13398.263095529743;13595.04834661574;25680;25764.067694922767;2078.158345869925;2170.4790850195996;2314.5833749925005;2335.8832058397184;2352.023910077316;10062.798744025078;10292.742681432948;10332.896671033268;10339.741506462324;10463.424511651856;1892.924283028677;1893.1670065171281;1900.790912999569;1929.1511734836627;2012.7584689837167;121788.39105804414;125174;126625.36687316504;127717;127941;8731.25784308341;11553.537858485566;11714.88285117155;11849.229800062969;11888.048956083492;14666.706665866623;14711.337989790485;14722.852771472148;14735.263236838115;14784.48254311094;6692.799216023527;7617.809554761176;7771.028621422322;8191.631376588068;8281.710140145065;8051.114377418479;8142.7557173284895;8149.877751833727;8174.836503269901;8316.584170791437;4541.341505481687;4554;4557.772111394417;4599.126166028444;4618.792154353062;1652.80997681669;1787.8390944814769;1841.2542920117373;1937.9748163169522;1947.3184385464974;891.2825175733597;926.3515539122641;992.5136683025265;997.2420960070399;1002.9899701003043;21760.455988600093;22178.778212217992;22249;22370.776292237195;22434.887825560767;962.0860182826343;980.4362491567377;991.0881988570388;1018.2821111116644;1031.4069410089228;10921.344719316867;11592.88407115935;11612.361320127475;11644.951954324151;11725.824112638316;609019;614490;618042;621805;625810;104744;121562;125076.49847003008;128001.71998280085;139733.30133349268;831.7504748575524;974.3325821812082;994.627014869424;996.4868092932146;997.8375192900335;16265.349386024427;18878.3392581259;19453.4163975081;19724.112414941075;19801.603967920848;49942.75028624834;52330.21504677357;53198;54963.90072198614;55412;56690;73983.63008184925;76486.61756691181;76634.6168269155;80170;7100.325469080429;7362.889556656547;7565.546067235983;7643.121041080347;7757;11313.20807543464;12952.870471295544;13438.664033398853;13842.792358114837;13845.376958037114;11014.339139651647;11620.825687614524;11726.765464690488;11732.530698772294;11757.706057348634;11158.330500170016;11586.073114151017;11603.12976526747;11819.290842549475;11819.822702659296;11602.825957610812;11649.184557080924;12063.638090857288;12117.394130293625;12201.20692155007;7108.360247577536;7373.483856130234;7536.962315188389;8239.752807415787;8591.484510929364;8404.453710508797;10572.524236409534;10896.618618348637;11437.08503319749;11718 15:40:00 INFO - PROCESS | 1661 | |3;mootools.html;1537.4926274329468;1576.0386164439694;1790.2212537546168;1875.118694213719;1883.1996401529348;7843.568603726792;7874.645640946157;8324;8884.955575222122;8915.331350148741;7277.818054548639;8671.30629549636;8732.432391894537;8734.956325218365;8737.60680769367;2284.3603790938564;2328.6972693549815;2333.556624241389;2336.404216924682;2340.134150364359;1965.3023176772253;2334.3697201755517;2372.620380739082;2374.7269064057596;2389.3668177932773;2356.4226764442737;2357.446000189954;2368.135630494874;2370.3600027992434;2374.8931298091543;2342.5197834443898;2343.238447504568;2350.341904266808;2350.96473552896;2361.456864921069;2319.095552734435;2341.9648705269433;2349.635806450003;2355.611324131516;2356.1871154451687;8690.304775617935;8716.738497845075;8737.825243495094;8825.691100811506;8838.07200243978;5138.075146473633;5221.582273418117;5247.816326428595;5293.470652934714;5311.920321195185;2848.4445533121047;3506.6493350664728;3552;3622;3660.2313514162056;1052.4476203421393;1084.4848696869003;1090.3457925244868;1092.2408925796574;1107.6431371569763;11368.261063030877;11491.310521368745;11511.194216404854;11582.47878845454;11611.303321800719;4507.954920450754;4660.277656963176;4735.928961065587;4764.761761911891;4769.928451073237;9592.136707696342;9764.609415623438;9776.804463910681;9787.706368808947;9798.853017204749;5239.607029472805;5274.551663108678;5289.074411977888;5289.761960711778;5299.072662284085;4364.127174565099;4613.238815595456;4806.2310030394965;4841.3222148899185;4849.4908034656555;3880.611938806097;3923.058465968147;3984.362501999666;4040.2727509048063;4075.8777236682945;1276.527684756646;1295.9352032398342;1296.1769276509485;1304.4390911907972;1306.8431788185478;807.4105902691068;868.9876294117408;892.2193081054078;948.0846397328106;966.4587830814767;5570.192322113352;5617.578681598897;5914.822555323347;5924;5929.555283353766;442.84721770989603;448.4752839178169;456.5731041476164;458.660591162544;463.3443677196796;3835.712321575837;4024.678025757932;4051.169510250392;4172.687048471377;4193.895152621209;10380.273380863418;10488.31825931312;10556.47217639115;10727.195460340507;10742.570297188182;10431.791364172674;10464.476776161162;10634.73413164677;10714;10740.087092597061;8013.719519816778;8028.638711258008;8133.837323253501;8140.87788683182;8144.511329320141;5191.247269145877;5448.918266226089;5927.2590926134235;6060.272767267779;6164.106204600218;9566.61733530651;9738.707838764849;9949.253805964438;9949.801003980025;9974.351667141613;10081.193504519768;10098;10132.64535741275;10134.442605656759;10172.847407289044;6931.549449285781;7249.927500725136;7414.147373052168;7468.402527797872;7551.320381165721;8139.267465928095;8239;8262.545559994258;8324.29243514284;8339.666413343399;7266.564006159648;7371.3734332582335;7409.555426674417;7494.475386722877;7511.9624401877645;6316.273628532777;7254.96372518134;7259.854802903807;7293.890591641236;7343.44924130703;6949;6996.160460744743;7050.612216328152;7054.541454805421;7075.327843854826;4703.482616912069;4755.476897541337;4947.010597880367;4985.351904252569;5089.262057001788;4201.642860356904;4942.5304596063315;5021.698698078127;5093.923591146062;5121.743912804271 15:40:00 INFO - PROCESS | 1661 | |4;prototype.html;303.6917528708361;309.87295208964326;315.23240908388067;317.2560345988659;318.7338572292136;5485.314335708036;5584.888302233953;5696.7721291148355;5749.425057494253;5768.653880767151;5634.943650563493;5676.3188417389865;5678.716064196784;5694.345150307716;5724.828255152342;4336.631386332166;4344.152890186415;4348.4999225089205;4354.346847972798;4357.7385356878685;3956.5054368203973;4231.513375961773;4278.165757677254;4359.564043595631;4395.582419670126;4197.517285512159;4217.915641687165;4228.118487273149;4243.448351714273;4252.362145678142;3539.4513850353237;4229.667654688778;4248.9575104249025;4270.7864606769535;4279.443672322609;3047.5123980163066;3532.205253817896;3648.1791596890753;3653.342398368293;3666.1934374437583;5461.290032295816;5462.808801691922;5508.521165475512;5528.640638358494;5538.723063846792;3904.160605469809;4715.622750179978;4817.975910120427;4828.420589529279;4889.975550122263;4597.747123908183;5449.346078470569;5666.453306340784;5973.729982606582;6026.578139530235;3514.3322768674125;3945.309570825094;3956.683465322796;3971.8808435746973;3985.481887354654;5217.686938783685;6193.411625895533;6243.625382477066;6321.304656487782;6325.715342809584;3402.625711171769;3644.344018076719;3865.1640470776156;3892.260470510594;4053.918921621551;3610.5667319921777;3905.92587038561;4089.44792453021;4104.958950410517;4107.815148318333;4844.563989240985;4866.391701037371;4872.171730805771;4873.463918968911;4878.219484882473;5204.9219261711105;5322.973385133049;6027.969860150672;6075.453209211104;6109.59479319759;1170.414792603698;1312.3569450968957;1378.6553361659585;1382.3364784903304;1392.6448755567264;702.7997020849034;762.1768490030754;850.4217132350061;860.6385318166385;861.1646702698373;4257.616814486649;4334.9783251083545;4442.73343599385;4662.7202367858035;4728.621710263171;4585.449746030431;4939.616907265971;5157.9110460263655;5164.741762911839;5179.404368497596;4197.866576024518;4253.936190957138;4583.64782389196;4699.365585645963;4710.317004034396;2893.4682153116023;3157.2264795125343;3225.7258133058485;3246.805191688506;3248.366568519163;5298.489930369826;5539.806106786243;5811.186433899257;6364.936350636527;6405.647689377129;5098.731064676183;6048.516118710492;6163.96918015407;6270.3416141305415;6288.484606157482;5175.861310511681;5197.636165468457;5521.337439507285;6082.239720034996;6286.025666021774;5771.538276937751;6066.969665151646;6107.938920610737;6138.815835524942;6162.969185154046;5231.581473482189;5433.619646624698;5557.526545908807;5959.463648271503;6044.123602077762;5620.775168993358;5924.555658325729;6329.9050514243245;6348.809535713936;6383;3180.825054622018;3755.9248815023;3967.900802479961;3980.1144170476173;4027.6576490998596;5945.762169513171;6124.938750612437;6145.907811382922;6159.5688301818445;6160.090371984699;5878.559108066997;5988.251468566429;6015.338312785678;6029.668368239789;6031.36670649593;6011.587276989992;6036.7283472244735;6045.6070355426755;6048.455638992512;6048.60684055535;5526.143447765603;5832.591718579659;5905.320888097924;5915.131161386638;5931.228940237914;5073.300444351036;5987.64074155552;6017.398260173947;6021.2473440819895;6032.668203248688;4828.396450443694;5147.6540248838555;5286.418493965738;5915.911261330997;5940.702964851826 15:40:00 INFO - PROCESS | 1661 | |5;yui.html;741.6069483173919;744.9702011919524;780.6760194519275;785.3520845302625;868.3096937934341;15345.156016419092;15805.367785288603;15947.20263986802;15990.280437380317;16050;14270.143791372526;14551.490697825579;14752.483663071795;14834.925825370858;14896;856.4304737349671;874.5845723281454;879.2745984562729;880.2078129683272;882.2765332427412;695.7425752471593;845.8942632170979;861.4788053227801;871.9215270625642;875.369733791669;903.0698380667923;921.8156368726249;922.8569571716395;926.8980412154658;928.470771660154;897.344938195118;907.6233363154283;920.1672486399818;927.429630777074;927.5037854747745;665.2050799294844;668.0180135201294;678.9015592739074;684.103823990569;691.4572060932144;12931.482740690455;15353.309101090366;15558.144302063381;15584.376624934988;15803.762943555856;14730.55808325752;14838.777418338734;15014.849851501454;15097.169655668933;15260.771088433683;11997;12292.631221063382;12555.372231388485;12562.057845661611;12585;3802.8668996585266;3840.0783811885226;3956.960430395688;4055.878323650295;4090.386442033689;82485;120685.39657301745;121122;122443;122933;11249.606263780892;11251.549938002388;11339.206255562032;11410.771784564262;11543.249688770204;24201.63697544538;24255.151069712476;24256.51486970286;24292.878535607564;25322.620160697603;6706.5640733352175;7746.109197442366;7941.483803552751;8025.638846251933;8317.168283171635;4439.289713645801;4468.977655111704;4545.272756358967;4578.793954271999;4712.764361781966;3556.6265542117703;3702.9814850926114;3704.7777133372083;3707.9073023174637;3714.23858109087;650.8828410886086;664.4086762781129;666.6000399760202;670.6546128743603;673.0274752981894;546.6965833962189;590.1737567405667;612.2377639838429;614.717230074162;646.0986923242051;8291.875621865556;9102.31732620043;9104.908950910407;9116.179543841086;9147.77130571741;509.4319833385748;582.6649676436066;629.8960671489244;630.8076036808726;641.0992555459587;3991.640752332304;4311.288637374798;4776.761161941889;4852.4662287148385;4949.894619636514;97965;145081.54918450682;149733;151281;172425;140028;144254;146011;147819;148530.51469485383;101902.49048754857;102956;105766.47116764521;121247;125560.1165982511;8129.268365847102;9875.358101723365;9982.550785214538;10080.69757907264;10132.949335253277;54476;55017;62628.43428914314;65502.67248663726;66689.66655166693;42927.785361072994;55791.605209870075;60290.79418411695;82954.58522707348;99116;12125;13390.93304533471;13414.530491432753;13415.262160581262;13512.932435338154;11843.467043983213;14795.630109247355;14827.851721482648;15145.394184232508;15172.468963586221;13859.653508662364;13864;14091.929540352643;14100.506482273071;14458.06022608527;13401.932990334986;13615.25116118623;14008.299585020504;14173.149611023371;14191.361388737738;13206.603801885958;13490.460381584626;13570.457181712622;13667.658308542366;13770.862291376958;9504.572294246636;11216.327020378803;11224.60713875043;11562.30626162433;11840.993515551274;10826.350418974887;11100.278481898651;11390.829137563109;11707.2975621463;11725.589604363806 15:40:00 INFO - PROCESS | 1661 | __end_tp_report 15:40:00 INFO - PROCESS | 1661 | __start_cc_report 15:40:00 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,411 15:40:00 INFO - PROCESS | 1661 | __end_cc_report 15:40:00 INFO - PROCESS | 1661 | __startTimestamp1470955200982__endTimestamp 15:40:00 INFO - PROCESS | 1661 | 15:40:00 INFO - PROCESS | 1661 | ------- Summary: start ------- 15:40:00 INFO - PROCESS | 1661 | Number of tests: 6 15:40:00 INFO - PROCESS | 1661 | 15:40:00 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5711.29 Median:5882.50 stddev:647.65 (11.0%) stddev-sans-first:624.01 15:40:00 INFO - PROCESS | 1661 | Values: 3411.8 3423.0 3432.5 3436.7 3464.5 5553.8 5638.3 5692.4 5734.3 5750.3 5609.0 5618.4 5623.1 5731.8 5744.0 5078.2 5165.9 5210.7 5246.6 5276.7 5101.3 5201.7 5206.0 5299.3 5318.9 5129.9 5135.8 5136.3 5142.8 5209.7 5134.1 5160.3 5206.0 5225.0 5268.6 4568.2 5115.2 5180.4 5196.0 5205.6 5434.6 5668.2 5697.1 5698.6 5729.2 5168.0 6200.2 6201.8 6209.5 6304.3 5348.8 6098.1 6109.0 6245.7 6292.4 4847.8 5002.3 5889.2 5899.2 5905.9 6285.6 6315.0 6321.1 6323.1 6344.6 5969.4 6111.7 6129.2 6208.7 6224.3 5195.3 6248.0 6261.8 6277.8 6293.1 6144.3 6182.1 6206.3 6244.4 6247.0 6034.6 6091.5 6148.7 6252.2 6292.6 5035.4 5046.0 5057.1 5069.6 5101.5 4432.9 4479.6 4479.7 4490.5 4508.2 5603.7 5646.1 5688.1 5724.7 5725.5 5227.5 6271.2 6304.1 6321.9 6323.1 5758.5 5774.6 5777.3 5779.6 5792.8 5366.9 5473.3 5475.8 5479.5 5483.5 6271.0 6392.9 6445.5 6474.4 6490.1 5674.0 6259.2 6263.8 6276.8 6282.4 6167.7 6302.7 6332.7 6412.6 6417.5 5546.8 5830.0 6216.3 6252.8 6261.6 6229.8 6252.0 6291.2 6295.6 6307.8 5435.6 6087.4 6144.4 6168.3 6169.8 6155.2 6189.4 6203.8 6204.2 6204.7 4825.9 5882.5 5957.2 6049.6 6079.6 5805.3 6059.1 6141.5 6217.9 6241.6 5980.4 6034.0 6037.7 6060.5 6095.3 15:40:00 INFO - PROCESS | 1661 | 15:40:00 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:66990.09 Median:40932.90 stddev:142376.18 (347.8%) stddev-sans-first:142688.07 15:40:00 INFO - PROCESS | 1661 | Values: 501.7 521.2 538.6 541.5 542.7 38682.8 41771.6 41897.0 41964.4 42187.6 39627.4 42641.8 43268.6 43307.4 43336.0 9554.3 9754.7 9766.9 9786.3 9787.4 9632.7 9738.0 9762.8 9768.2 9787.7 9770.8 9776.7 9801.3 9804.7 9805.9 9681.4 9717.0 9755.0 9778.0 9797.3 9579.6 9646.2 9667.6 9671.9 9701.3 40435.0 40611.0 40742.8 40859.0 41006.8 3376.5 3407.9 3441.5 3542.2 4067.9 32213.2 32468.0 33349.7 33386.2 33416.2 3215.6 3359.0 3359.9 3394.5 3401.7 348341.0 462914.0 468720.7 470669.0 473492.0 60530.7 60677.0 60784.4 61118.0 61273.1 63457.0 63840.4 63951.7 63973.7 64225.7 15958.1 15967.7 15979.8 16162.8 16168.6 12482.9 12510.7 12560.1 12597.6 12618.1 16099.1 16682.9 16722.1 16751.3 16789.7 3247.9 6067.8 6808.3 7080.9 7136.8 823.9 887.6 990.6 1029.2 1056.5 30086.7 30577.4 30746.9 30900.7 30927.2 1044.4 1048.6 1059.3 1079.7 1083.8 15946.7 16018.4 16026.0 16066.4 16299.8 620377.0 628684.0 633157.0 633440.0 637208.0 59699.0 59701.7 60090.4 60185.4 60429.8 1360.2 1384.6 1431.8 1432.9 1433.1 29599.0 29824.0 30251.1 30286.4 30363.0 43369.0 50441.5 51948.2 52158.3 52184.2 463770.0 466843.0 468171.7 545297.0 576360.0 25478.9 25706.5 26193.0 27429.5 28209.9 47730.3 48360.8 49854.0 50137.7 50340.7 32587.7 39625.6 39897.2 41252.0 41637.8 31892.7 39918.2 40699.0 41048.9 41634.6 38215.4 39559.0 39695.8 39726.6 39859.8 28052.9 34431.7 35151.5 35372.8 35438.8 22238.3 25678.5 26137.5 26142.7 26259.2 15:40:00 INFO - PROCESS | 1661 | 15:40:00 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:35209.78 Median:12374.74 stddev:103050.65 (832.8%) stddev-sans-first:103306.48 15:40:01 INFO - PROCESS | 1661 | Values: 343.2 370.3 375.7 380.8 403.9 19738.5 20346.5 21198.9 21806.0 22300.6 11651.8 11946.5 12322.3 12328.0 12371.5 5484.6 5695.6 5733.9 5743.9 5747.7 3981.7 5682.1 5965.9 6229.9 6268.4 6243.7 6293.6 6308.5 6324.9 6337.8 6260.4 6288.0 6302.3 6303.8 6312.2 6094.7 6117.2 6190.1 6208.1 6217.7 13226.6 13398.3 13595.0 25680.0 25764.1 2078.2 2170.5 2314.6 2335.9 2352.0 10062.8 10292.7 10332.9 10339.7 10463.4 1892.9 1893.2 1900.8 1929.2 2012.8 121788.4 125174.0 126625.4 127717.0 127941.0 8731.3 11553.5 11714.9 11849.2 11888.0 14666.7 14711.3 14722.9 14735.3 14784.5 6692.8 7617.8 7771.0 8191.6 8281.7 8051.1 8142.8 8149.9 8174.8 8316.6 4541.3 4554.0 4557.8 4599.1 4618.8 1652.8 1787.8 1841.3 1938.0 1947.3 891.3 926.4 992.5 997.2 1003.0 21760.5 22178.8 22249.0 22370.8 22434.9 962.1 980.4 991.1 1018.3 1031.4 10921.3 11592.9 11612.4 11645.0 11725.8 609019.0 614490.0 618042.0 621805.0 625810.0 104744.0 121562.0 125076.5 128001.7 139733.3 831.8 974.3 994.6 996.5 997.8 16265.3 18878.3 19453.4 19724.1 19801.6 49942.8 52330.2 53198.0 54963.9 55412.0 56690.0 73983.6 76486.6 76634.6 80170.0 7100.3 7362.9 7565.5 7643.1 7757.0 11313.2 12952.9 13438.7 13842.8 13845.4 11014.3 11620.8 11726.8 11732.5 11757.7 11158.3 11586.1 11603.1 11819.3 11819.8 11602.8 11649.2 12063.6 12117.4 12201.2 7108.4 7373.5 7537.0 8239.8 8591.5 8404.5 10572.5 10896.6 11437.1 11718.0 15:40:01 INFO - PROCESS | 1661 | 15:40:01 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5638.76 Median:4823.78 stddev:3169.03 (65.7%) stddev-sans-first:3162.93 15:40:01 INFO - PROCESS | 1661 | Values: 1537.5 1576.0 1790.2 1875.1 1883.2 7843.6 7874.6 8324.0 8885.0 8915.3 7277.8 8671.3 8732.4 8735.0 8737.6 2284.4 2328.7 2333.6 2336.4 2340.1 1965.3 2334.4 2372.6 2374.7 2389.4 2356.4 2357.4 2368.1 2370.4 2374.9 2342.5 2343.2 2350.3 2351.0 2361.5 2319.1 2342.0 2349.6 2355.6 2356.2 8690.3 8716.7 8737.8 8825.7 8838.1 5138.1 5221.6 5247.8 5293.5 5311.9 2848.4 3506.6 3552.0 3622.0 3660.2 1052.4 1084.5 1090.3 1092.2 1107.6 11368.3 11491.3 11511.2 11582.5 11611.3 4508.0 4660.3 4735.9 4764.8 4769.9 9592.1 9764.6 9776.8 9787.7 9798.9 5239.6 5274.6 5289.1 5289.8 5299.1 4364.1 4613.2 4806.2 4841.3 4849.5 3880.6 3923.1 3984.4 4040.3 4075.9 1276.5 1295.9 1296.2 1304.4 1306.8 807.4 869.0 892.2 948.1 966.5 5570.2 5617.6 5914.8 5924.0 5929.6 442.8 448.5 456.6 458.7 463.3 3835.7 4024.7 4051.2 4172.7 4193.9 10380.3 10488.3 10556.5 10727.2 10742.6 10431.8 10464.5 10634.7 10714.0 10740.1 8013.7 8028.6 8133.8 8140.9 8144.5 5191.2 5448.9 5927.3 6060.3 6164.1 9566.6 9738.7 9949.3 9949.8 9974.4 10081.2 10098.0 10132.6 10134.4 10172.8 6931.5 7249.9 7414.1 7468.4 7551.3 8139.3 8239.0 8262.5 8324.3 8339.7 7266.6 7371.4 7409.6 7494.5 7512.0 6316.3 7255.0 7259.9 7293.9 7343.4 6949.0 6996.2 7050.6 7054.5 7075.3 4703.5 4755.5 4947.0 4985.4 5089.3 4201.6 4942.5 5021.7 5093.9 5121.7 15:40:01 INFO - PROCESS | 1661 | 15:40:01 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:4712.21 Median:5188.52 stddev:1489.46 (28.7%) stddev-sans-first:1456.42 15:40:01 INFO - PROCESS | 1661 | Values: 303.7 309.9 315.2 317.3 318.7 5485.3 5584.9 5696.8 5749.4 5768.7 5634.9 5676.3 5678.7 5694.3 5724.8 4336.6 4344.2 4348.5 4354.3 4357.7 3956.5 4231.5 4278.2 4359.6 4395.6 4197.5 4217.9 4228.1 4243.4 4252.4 3539.5 4229.7 4249.0 4270.8 4279.4 3047.5 3532.2 3648.2 3653.3 3666.2 5461.3 5462.8 5508.5 5528.6 5538.7 3904.2 4715.6 4818.0 4828.4 4890.0 4597.7 5449.3 5666.5 5973.7 6026.6 3514.3 3945.3 3956.7 3971.9 3985.5 5217.7 6193.4 6243.6 6321.3 6325.7 3402.6 3644.3 3865.2 3892.3 4053.9 3610.6 3905.9 4089.4 4105.0 4107.8 4844.6 4866.4 4872.2 4873.5 4878.2 5204.9 5323.0 6028.0 6075.5 6109.6 1170.4 1312.4 1378.7 1382.3 1392.6 702.8 762.2 850.4 860.6 861.2 4257.6 4335.0 4442.7 4662.7 4728.6 4585.4 4939.6 5157.9 5164.7 5179.4 4197.9 4253.9 4583.6 4699.4 4710.3 2893.5 3157.2 3225.7 3246.8 3248.4 5298.5 5539.8 5811.2 6364.9 6405.6 5098.7 6048.5 6164.0 6270.3 6288.5 5175.9 5197.6 5521.3 6082.2 6286.0 5771.5 6067.0 6107.9 6138.8 6163.0 5231.6 5433.6 5557.5 5959.5 6044.1 5620.8 5924.6 6329.9 6348.8 6383.0 3180.8 3755.9 3967.9 3980.1 4027.7 5945.8 6124.9 6145.9 6159.6 6160.1 5878.6 5988.3 6015.3 6029.7 6031.4 6011.6 6036.7 6045.6 6048.5 6048.6 5526.1 5832.6 5905.3 5915.1 5931.2 5073.3 5987.6 6017.4 6021.2 6032.7 4828.4 5147.7 5286.4 5915.9 5940.7 15:40:01 INFO - PROCESS | 1661 | 15:40:01 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:24813.18 Median:3703.88 stddev:40238.48 (1086.4%) stddev-sans-first:40310.77 15:40:01 INFO - PROCESS | 1661 | Values: 741.6 745.0 780.7 785.4 868.3 15345.2 15805.4 15947.2 15990.3 16050.0 14270.1 14551.5 14752.5 14834.9 14896.0 856.4 874.6 879.3 880.2 882.3 695.7 845.9 861.5 871.9 875.4 903.1 921.8 922.9 926.9 928.5 897.3 907.6 920.2 927.4 927.5 665.2 668.0 678.9 684.1 691.5 12931.5 15353.3 15558.1 15584.4 15803.8 14730.6 14838.8 15014.8 15097.2 15260.8 11997.0 12292.6 12555.4 12562.1 12585.0 3802.9 3840.1 3957.0 4055.9 4090.4 82485.0 120685.4 121122.0 122443.0 122933.0 11249.6 11251.5 11339.2 11410.8 11543.2 24201.6 24255.2 24256.5 24292.9 25322.6 6706.6 7746.1 7941.5 8025.6 8317.2 4439.3 4469.0 4545.3 4578.8 4712.8 3556.6 3703.0 3704.8 3707.9 3714.2 650.9 664.4 666.6 670.7 673.0 546.7 590.2 612.2 614.7 646.1 8291.9 9102.3 9104.9 9116.2 9147.8 509.4 582.7 629.9 630.8 641.1 3991.6 4311.3 4776.8 4852.5 4949.9 97965.0 145081.5 149733.0 151281.0 172425.0 140028.0 144254.0 146011.0 147819.0 148530.5 101902.5 102956.0 105766.5 121247.0 125560.1 8129.3 9875.4 9982.6 10080.7 10132.9 54476.0 55017.0 62628.4 65502.7 66689.7 42927.8 55791.6 60290.8 82954.6 99116.0 12125.0 13390.9 13414.5 13415.3 13512.9 11843.5 14795.6 14827.9 15145.4 15172.5 13859.7 13864.0 14091.9 14100.5 14458.1 13401.9 13615.3 14008.3 14173.1 14191.4 13206.6 13490.5 13570.5 13667.7 13770.9 9504.6 11216.3 11224.6 11562.3 11841.0 10826.4 11100.3 11390.8 11707.3 11725.6 15:40:01 INFO - PROCESS | 1661 | -------- Summary: end -------- 15:40:01 INFO - PROCESS | 1661 | 15:40:01 INFO - TEST-INFO | 1661: exit 0 15:40:01 INFO - TEST-OK | dromaeo_css | took 1113501ms 15:40:01 INFO - TEST-START | kraken 15:40:01 INFO - operating with platform_type : mac_ 15:40:01 INFO - Initialising browser for kraken test... 15:40:01 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpeHlbLp/profile http://localhost:49282/getInfo.html) 15:40:04 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 15:40:04 INFO - PROCESS | 1674 | colorDepth:24 15:40:04 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 15:40:04 INFO - PROCESS | 1674 | __metrics 15:40:04 ERROR - PROCESS | 1674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 15:40:05 INFO - TEST-INFO | 1674: exit 0 15:40:05 INFO - Browser initialized. 15:40:05 INFO - Running cycle 1/1 for kraken test... 15:40:05 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpeHlbLp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:40:17 INFO - PROCESS | 1676 | RSS: Main: 254992384 15:40:17 INFO - PROCESS | 1676 | 15:40:20 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection) 15:40:21 INFO - PROCESS | 1676 | RSS: Main: 267608064 15:40:21 INFO - PROCESS | 1676 | 15:40:23 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-dft) 15:40:24 INFO - PROCESS | 1676 | RSS: Main: 276238336 15:40:24 INFO - PROCESS | 1676 | 15:40:27 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-fft) 15:40:28 INFO - PROCESS | 1676 | RSS: Main: 279236608 15:40:28 INFO - PROCESS | 1676 | 15:40:30 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator) 15:40:31 INFO - PROCESS | 1676 | RSS: Main: 280649728 15:40:31 INFO - PROCESS | 1676 | 15:40:33 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:40:33 INFO - PROCESS | 1676 | RSS: Main: 281112576 15:40:33 INFO - PROCESS | 1676 | 15:40:36 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom) 15:40:37 INFO - PROCESS | 1676 | RSS: Main: 281227264 15:40:37 INFO - PROCESS | 1676 | 15:40:40 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate) 15:40:41 INFO - PROCESS | 1676 | RSS: Main: 282759168 15:40:41 INFO - PROCESS | 1676 | 15:40:44 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial) 15:40:45 INFO - PROCESS | 1676 | RSS: Main: 282972160 15:40:45 INFO - PROCESS | 1676 | 15:40:46 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:40:47 INFO - PROCESS | 1676 | RSS: Main: 282636288 15:40:47 INFO - PROCESS | 1676 | 15:40:49 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:40:49 INFO - PROCESS | 1676 | RSS: Main: 282669056 15:40:49 INFO - PROCESS | 1676 | 15:40:52 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:40:52 INFO - PROCESS | 1676 | RSS: Main: 282689536 15:40:52 INFO - PROCESS | 1676 | 15:40:55 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:40:56 INFO - PROCESS | 1676 | RSS: Main: 282873856 15:40:56 INFO - PROCESS | 1676 | 15:40:59 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:40:59 INFO - PROCESS | 1676 | RSS: Main: 282759168 15:40:59 INFO - PROCESS | 1676 | 15:41:01 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49282/tests/kraken/driver.html?testName=ai-astar) 15:41:02 INFO - PROCESS | 1676 | RSS: Main: 283934720 15:41:02 INFO - PROCESS | 1676 | 15:41:02 INFO - PROCESS | 1676 | __start_tp_report 15:41:02 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 15:41:02 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 15:41:02 INFO - PROCESS | 1676 | |i|pagename|runs| 15:41:02 INFO - PROCESS | 1676 | |0;ai-astar;107;158;106;118;115;114;113;115;115;118 15:41:02 INFO - PROCESS | 1676 | |1;audio-beat-detection;176;145;166;161;111;129;118;140;199;116 15:41:02 INFO - PROCESS | 1676 | |2;audio-dft;204;235;196;202;199;202;198;198;199;198 15:41:02 INFO - PROCESS | 1676 | |3;audio-fft;72;89;75;172;57;57;61;75;161;59 15:41:02 INFO - PROCESS | 1676 | |4;audio-oscillator;71;72;111;71;70;80;115;70;68;114 15:41:02 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;92;87;83;131;126;86;89;86;93;132 15:41:02 INFO - PROCESS | 1676 | |6;imaging-darkroom;94;123;110;154;120;105;152;151;111;150 15:41:02 INFO - PROCESS | 1676 | |7;imaging-desaturate;113;133;145;93;118;91;90;92;117;123 15:41:02 INFO - PROCESS | 1676 | |8;json-parse-financial;56;56;56;55;56;56;63;67;86;89 15:41:02 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;67;72;72;82;80;77;84;60;96;64 15:41:02 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;93;93;86;91;102;108;77;101;104;104 15:41:02 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;137;138;144;152;156;140;137;138;169;159 15:41:02 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;166;169;167;167;165;171;167;167;167;164 15:41:02 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;67;68;67;76;67;73;99;86;91;90 15:41:02 INFO - PROCESS | 1676 | __end_tp_report 15:41:02 INFO - PROCESS | 1676 | __start_cc_report 15:41:02 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1060 15:41:02 INFO - PROCESS | 1676 | __end_cc_report 15:41:02 INFO - PROCESS | 1676 | __startTimestamp1470955262018__endTimestamp 15:41:02 INFO - PROCESS | 1676 | 15:41:02 INFO - PROCESS | 1676 | ------- Summary: start ------- 15:41:02 INFO - PROCESS | 1676 | Number of tests: 14 15:41:02 INFO - PROCESS | 1676 | 15:41:02 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:117.90 Median:115.00 stddev:14.65 (12.7%) stddev-sans-first:15.00 15:41:02 INFO - PROCESS | 1676 | Values: 107.0 158.0 106.0 118.0 115.0 114.0 113.0 115.0 115.0 118.0 15:41:02 INFO - PROCESS | 1676 | 15:41:02 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:153.00 stddev:29.00 (19.0%) stddev-sans-first:28.67 15:41:02 INFO - PROCESS | 1676 | Values: 176.0 145.0 166.0 161.0 111.0 129.0 118.0 140.0 199.0 116.0 15:41:02 INFO - PROCESS | 1676 | 15:41:02 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:203.10 Median:200.50 stddev:11.46 (5.7%) stddev-sans-first:12.16 15:41:02 INFO - PROCESS | 1676 | Values: 204.0 235.0 196.0 202.0 199.0 202.0 198.0 198.0 199.0 198.0 15:41:02 INFO - PROCESS | 1676 | 15:41:02 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:87.80 Median:66.50 stddev:42.78 (64.3%) stddev-sans-first:44.99 15:41:02 INFO - PROCESS | 1676 | Values: 72.0 89.0 75.0 172.0 57.0 57.0 61.0 75.0 161.0 59.0 15:41:02 INFO - PROCESS | 1676 | 15:41:02 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:84.20 Median:70.50 stddev:20.37 (28.9%) stddev-sans-first:21.04 15:41:02 INFO - PROCESS | 1676 | Values: 71.0 72.0 111.0 71.0 70.0 80.0 115.0 70.0 68.0 114.0 15:41:02 INFO - PROCESS | 1676 | 15:41:02 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:100.50 Median:86.50 stddev:20.39 (23.6%) stddev-sans-first:21.40 15:41:02 INFO - PROCESS | 1676 | Values: 92.0 87.0 83.0 131.0 126.0 86.0 89.0 86.0 93.0 132.0 15:41:02 INFO - PROCESS | 1676 | 15:41:02 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:127.00 Median:150.50 stddev:22.71 (15.1%) stddev-sans-first:20.71 15:41:02 INFO - PROCESS | 1676 | Values: 94.0 123.0 110.0 154.0 120.0 105.0 152.0 151.0 111.0 150.0 15:41:02 INFO - PROCESS | 1676 | 15:41:02 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:111.50 Median:117.50 stddev:19.43 (16.5%) stddev-sans-first:20.60 15:41:02 INFO - PROCESS | 1676 | Values: 113.0 133.0 145.0 93.0 118.0 91.0 90.0 92.0 117.0 123.0 15:41:02 INFO - PROCESS | 1676 | 15:41:02 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:59.50 stddev:13.00 (21.8%) stddev-sans-first:13.46 15:41:02 INFO - PROCESS | 1676 | Values: 56.0 56.0 56.0 55.0 56.0 56.0 63.0 67.0 86.0 89.0 15:41:02 INFO - PROCESS | 1676 | 15:41:02 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:75.40 Median:78.50 stddev:10.68 (13.6%) stddev-sans-first:10.89 15:41:02 INFO - PROCESS | 1676 | Values: 67.0 72.0 72.0 82.0 80.0 77.0 84.0 60.0 96.0 64.0 15:41:02 INFO - PROCESS | 1676 | 15:41:02 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:95.90 Median:81.50 stddev:9.64 (11.8%) stddev-sans-first:10.17 15:41:02 INFO - PROCESS | 1676 | Values: 93.0 93.0 86.0 91.0 102.0 108.0 77.0 101.0 104.0 104.0 15:41:02 INFO - PROCESS | 1676 | 15:41:02 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:147.00 Median:148.00 stddev:11.32 (7.7%) stddev-sans-first:11.42 15:41:02 INFO - PROCESS | 1676 | Values: 137.0 138.0 144.0 152.0 156.0 140.0 137.0 138.0 169.0 159.0 15:41:02 INFO - PROCESS | 1676 | 15:41:02 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:167.00 stddev:1.94 (1.2%) stddev-sans-first:2.03 15:41:02 INFO - PROCESS | 1676 | Values: 166.0 169.0 167.0 167.0 165.0 171.0 167.0 167.0 167.0 164.0 15:41:02 INFO - PROCESS | 1676 | 15:41:02 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.40 Median:81.00 stddev:12.06 (14.9%) stddev-sans-first:12.06 15:41:02 INFO - PROCESS | 1676 | Values: 67.0 68.0 67.0 76.0 67.0 73.0 99.0 86.0 91.0 90.0 15:41:02 INFO - PROCESS | 1676 | -------- Summary: end -------- 15:41:02 INFO - PROCESS | 1676 | 15:41:02 INFO - TEST-INFO | 1676: exit 0 15:41:02 INFO - TEST-OK | kraken | took 61298ms 15:41:02 INFO - SUITE-END | took 1174s 15:41:03 INFO - Completed test suite (00:19:35) 15:41:03 INFO - javascript benchmark 15:41:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7359.171445214013, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3411.8464669089904, 3422.9999999999995, 3432.5194472773833, 3436.7250619950405, 3464.549608550888, 5553.750081246354, 5638.267025286712, 5692.402297758733, 5734.340550836645, 5750.252467179266, 5608.971955140229, 5618.410066942974, 5623.128415095656, 5731.828045158652, 5743.9712801436035, 5078.238264260353, 5165.9225111623355, 5210.739463026853, 5246.580273578104, 5276.657017293883, 5101.260317253996, 5201.661891977028, 5205.973970130144, 5299.284596579451, 5318.946810531903, 5129.871753206163, 5135.768890399941, 5136.332276803992, 5142.845714628567, 5209.6874187548865, 5134.127198376285, 5160.329157209576, 5206.0, 5225.0, 5268.631195816294, 4568.177728008957, 5115.18157094863, 5180.378354597435, 5196.012757576086, 5205.583553315726, 5434.592405569598, 5668.234788303567, 5697.088465845486, 5698.629589076697, 5729.197912292282, 5168.0, 6200.162977998003, 6201.844953876144, 6209.534284928648, 6304.306526282106, 5348.839534813962, 6098.1157732128595, 6109.040306147788, 6245.718942647592, 6292.370762923717, 4847.830325938575, 5002.349694539723, 5889.1755154278435, 5899.233099697012, 5905.852353691106, 6285.622862628257, 6315.0, 6321.051842223611, 6323.146375239284, 6344.587601805868, 5969.403059694083, 6111.694415279218, 6129.233845769279, 6208.72060757267, 6224.284207316216, 5195.3246078009615, 6248.0003199487865, 6261.78083767066, 6277.780277690259, 6293.118963345135, 6144.324124346318, 6182.1345011698395, 6206.317305096526, 6244.4380005798785, 6247.0, 6034.607750496204, 6091.51267898567, 6148.661823599745, 6252.187215661935, 6292.559520833498, 5035.395752509722, 5045.990801839646, 5057.14028615129, 5069.645124841226, 5101.464346243665, 4432.867013989586, 4479.61923236522, 4479.731216127043, 4490.461144662661, 4508.211063063951, 5603.663780173202, 5646.096624540054, 5688.11834165705, 5724.713764311768, 5725.456081672234, 5227.503387178212, 6271.153394291712, 6304.148939893147, 6321.936780632135, 6323.146375239376, 5758.510526605285, 5774.566907481955, 5777.30672319316, 5779.566532510079, 5792.82621521355, 5366.8658283542445, 5473.31583552056, 5475.753591088331, 5479.5342395896, 5483.506484416422, 6270.968645156745, 6392.904106438407, 6445.548811583238, 6474.449671777952, 6490.091387205795, 5674.0, 6259.186305780219, 6263.843403914756, 6276.811695649138, 6282.371762823681, 6167.6916154193, 6302.653354065387, 6332.715027823851, 6412.647304398303, 6417.454516366161, 5546.833594992157, 5830.0, 6216.316205217513, 6252.812415627538, 6261.624302541862, 6229.844253893689, 6252.021234781737, 6291.150694656163, 6295.5907865988565, 6307.842303942438, 5435.619506634655, 6087.371687753549, 6144.38556144382, 6168.25980882297, 6169.81490555284, 6155.199824022849, 6189.381061893775, 6203.751849926133, 6204.193454850841, 6204.689765511616, 4825.879353016203, 5882.499987500939, 5957.195778570011, 6049.576529642883, 6079.635221886701, 5805.274340707411, 6059.0608455689435, 6141.539384546266, 6217.875642487034, 6241.625502469867, 5980.401959803985, 6033.974224381954, 6037.698115094316, 6060.484858786876, 6095.299040610386], "value": 5673.0656831402985, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.73909567025146, 521.2467983763463, 538.6041259674139, 541.5478075806701, 542.6743953627824, 38682.80658596707, 41771.58228417715, 41897.0, 41964.37053444201, 42187.57812421879, 39627.40558891619, 42641.786791066, 43268.56731432685, 43307.3503897441, 43336.0, 9554.331196816243, 9754.658586949457, 9766.90233097667, 9786.314957952945, 9787.36382135159, 9632.662856800014, 9737.97751236117, 9762.804743905117, 9768.21854251658, 9787.657431989881, 9770.755731106743, 9776.657816976407, 9801.264905132144, 9804.656837010705, 9805.852912206323, 9681.37071090377, 9717.0, 9755.0, 9777.95111024444, 9797.265205109645, 9579.61681532738, 9646.180074693659, 9667.564959576835, 9671.90328096717, 9701.272404569685, 40434.98912527181, 40611.0, 40742.79628601838, 40859.0, 41006.79496602498, 3376.5104059911423, 3407.863685452579, 3441.5353927219753, 3542.167590616203, 4067.857624983141, 32213.194670133198, 32468.0, 33349.6665033349, 33386.165345866306, 33416.16459588506, 3215.614126304835, 3358.966410335914, 3359.9160020999425, 3394.4908263760385, 3401.710854577339, 348341.0, 462914.0, 468720.65639671584, 470669.0, 473492.0, 60530.697346513865, 60677.0, 60784.39215607876, 61118.0, 61273.08090378648, 63457.0, 63840.36159638344, 63951.68024159849, 63973.680131599045, 64225.71548569002, 15958.12230327343, 15967.680646387007, 15979.840201598068, 16162.838371616133, 16168.595785105466, 12482.937585312015, 12510.687232819071, 12560.120791544687, 12597.622071337875, 12618.116731828868, 16099.1145486997, 16682.91561048528, 16722.08028558441, 16751.329946802234, 16789.748153777702, 3247.8700851966128, 6067.848303792352, 6808.3191680832515, 7080.90246011869, 7136.821579460555, 823.9340852731887, 887.587271918561, 990.6483198464585, 1029.1818004686293, 1056.5140035583563, 30086.699133008828, 30577.38845223083, 30746.923857664875, 30900.69099309023, 30927.226819329248, 1044.4360045575456, 1048.632978457549, 1059.3167407022427, 1079.6922876980022, 1083.8374243863484, 15946.681066378607, 16018.439354622533, 16025.958312709636, 16066.38506336065, 16299.837001630069, 620377.0, 628684.0, 633157.0, 633440.0, 637208.0, 59699.0, 59701.70149149226, 60090.39909600848, 60185.39814601885, 60429.79140417167, 1360.2382665707235, 1384.5915454940816, 1431.8496557861274, 1432.9355179016968, 1433.104309806371, 29599.0, 29823.956161534243, 30251.11991300104, 30286.394272114874, 30363.0, 43369.0, 50441.49558504368, 51948.22077668762, 52158.30575248246, 52184.21723674224, 463770.0, 466843.0, 468171.6591417021, 545297.0, 576360.0, 25478.872605636854, 25706.485870282115, 26193.0, 27429.45141097127, 28209.858950705115, 47730.28404574004, 48360.75819620879, 49854.0, 50137.74931125321, 50340.74148146326, 32587.674123258465, 39625.603743962194, 39897.202055958136, 41252.0, 41637.79181104075, 31892.68107318897, 39918.2016359677, 40699.0, 41048.91930584087, 41634.58365416307, 38215.426768597936, 39559.0, 39695.816730078965, 39726.60273397345, 39859.80420587387, 28052.896032797213, 34431.655683443845, 35151.47272790859, 35372.82313588416, 35438.82280588581, 22238.332850014525, 25678.486430270917, 26137.477250454504, 26142.73857261403, 26259.21222363332], "value": 19944.794088211947, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.1917833502101, 370.33524822942815, 375.7351067497415, 380.82101412336203, 403.92325458162946, 19738.506537336554, 20346.491337716547, 21198.89400552995, 21806.0, 22300.553988920252, 11651.766964660701, 11946.462409191585, 12322.322272275022, 12327.952124069465, 12371.50513979442, 5484.61607687461, 5695.601307908448, 5733.913991290113, 5743.885122297552, 5747.712614369265, 3981.741186822862, 5682.090865461527, 5965.926133296027, 6229.937700623003, 6268.373162683741, 6243.687815609224, 6293.590916590407, 6308.526860485459, 6324.9051264231075, 6337.809865704014, 6260.40526150015, 6288.0, 6302.275238347603, 6303.810885673437, 6312.179416675849, 6094.695265236721, 6117.235345581802, 6190.102435146879, 6208.068789681539, 6217.658028808413, 13226.61920854246, 13398.263095529743, 13595.04834661574, 25680.0, 25764.067694922767, 2078.158345869925, 2170.4790850195996, 2314.5833749925005, 2335.8832058397184, 2352.023910077316, 10062.798744025078, 10292.742681432948, 10332.896671033268, 10339.741506462324, 10463.424511651856, 1892.924283028677, 1893.1670065171281, 1900.790912999569, 1929.1511734836627, 2012.7584689837167, 121788.39105804414, 125174.0, 126625.36687316504, 127717.0, 127941.0, 8731.25784308341, 11553.537858485566, 11714.88285117155, 11849.229800062969, 11888.048956083492, 14666.706665866623, 14711.337989790485, 14722.852771472148, 14735.263236838115, 14784.48254311094, 6692.799216023527, 7617.809554761176, 7771.028621422322, 8191.631376588068, 8281.710140145065, 8051.114377418479, 8142.7557173284895, 8149.877751833727, 8174.836503269901, 8316.584170791437, 4541.341505481687, 4554.0, 4557.772111394417, 4599.126166028444, 4618.792154353062, 1652.80997681669, 1787.8390944814769, 1841.2542920117373, 1937.9748163169522, 1947.3184385464974, 891.2825175733597, 926.3515539122641, 992.5136683025265, 997.2420960070399, 1002.9899701003043, 21760.455988600093, 22178.778212217992, 22249.0, 22370.776292237195, 22434.887825560767, 962.0860182826343, 980.4362491567377, 991.0881988570388, 1018.2821111116644, 1031.4069410089228, 10921.344719316867, 11592.88407115935, 11612.361320127475, 11644.951954324151, 11725.824112638316, 609019.0, 614490.0, 618042.0, 621805.0, 625810.0, 104744.0, 121562.0, 125076.49847003008, 128001.71998280085, 139733.30133349268, 831.7504748575524, 974.3325821812082, 994.627014869424, 996.4868092932146, 997.8375192900335, 16265.349386024427, 18878.3392581259, 19453.4163975081, 19724.112414941075, 19801.603967920848, 49942.75028624834, 52330.21504677357, 53198.0, 54963.90072198614, 55412.0, 56690.0, 73983.63008184925, 76486.61756691181, 76634.6168269155, 80170.0, 7100.325469080429, 7362.889556656547, 7565.546067235983, 7643.121041080347, 7757.0, 11313.20807543464, 12952.870471295544, 13438.664033398853, 13842.792358114837, 13845.376958037114, 11014.339139651647, 11620.825687614524, 11726.765464690488, 11732.530698772294, 11757.706057348634, 11158.330500170016, 11586.073114151017, 11603.12976526747, 11819.290842549475, 11819.822702659296, 11602.825957610812, 11649.184557080924, 12063.638090857288, 12117.394130293625, 12201.20692155007, 7108.360247577536, 7373.483856130234, 7536.962315188389, 8239.752807415787, 8591.484510929364, 8404.453710508797, 10572.524236409534, 10896.618618348637, 11437.08503319749, 11718.0], "value": 9413.5999710336, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.4926274329468, 1576.0386164439694, 1790.2212537546168, 1875.118694213719, 1883.1996401529348, 7843.568603726792, 7874.645640946157, 8324.0, 8884.955575222122, 8915.331350148741, 7277.818054548639, 8671.30629549636, 8732.432391894537, 8734.956325218365, 8737.60680769367, 2284.3603790938564, 2328.6972693549815, 2333.556624241389, 2336.404216924682, 2340.134150364359, 1965.3023176772253, 2334.3697201755517, 2372.620380739082, 2374.7269064057596, 2389.3668177932773, 2356.4226764442737, 2357.446000189954, 2368.135630494874, 2370.3600027992434, 2374.8931298091543, 2342.5197834443898, 2343.238447504568, 2350.341904266808, 2350.96473552896, 2361.456864921069, 2319.095552734435, 2341.9648705269433, 2349.635806450003, 2355.611324131516, 2356.1871154451687, 8690.304775617935, 8716.738497845075, 8737.825243495094, 8825.691100811506, 8838.07200243978, 5138.075146473633, 5221.582273418117, 5247.816326428595, 5293.470652934714, 5311.920321195185, 2848.4445533121047, 3506.6493350664728, 3552.0, 3622.0, 3660.2313514162056, 1052.4476203421393, 1084.4848696869003, 1090.3457925244868, 1092.2408925796574, 1107.6431371569763, 11368.261063030877, 11491.310521368745, 11511.194216404854, 11582.47878845454, 11611.303321800719, 4507.954920450754, 4660.277656963176, 4735.928961065587, 4764.761761911891, 4769.928451073237, 9592.136707696342, 9764.609415623438, 9776.804463910681, 9787.706368808947, 9798.853017204749, 5239.607029472805, 5274.551663108678, 5289.074411977888, 5289.761960711778, 5299.072662284085, 4364.127174565099, 4613.238815595456, 4806.2310030394965, 4841.3222148899185, 4849.4908034656555, 3880.611938806097, 3923.058465968147, 3984.362501999666, 4040.2727509048063, 4075.8777236682945, 1276.527684756646, 1295.9352032398342, 1296.1769276509485, 1304.4390911907972, 1306.8431788185478, 807.4105902691068, 868.9876294117408, 892.2193081054078, 948.0846397328106, 966.4587830814767, 5570.192322113352, 5617.578681598897, 5914.822555323347, 5924.0, 5929.555283353766, 442.84721770989603, 448.4752839178169, 456.5731041476164, 458.660591162544, 463.3443677196796, 3835.712321575837, 4024.678025757932, 4051.169510250392, 4172.687048471377, 4193.895152621209, 10380.273380863418, 10488.31825931312, 10556.47217639115, 10727.195460340507, 10742.570297188182, 10431.791364172674, 10464.476776161162, 10634.73413164677, 10714.0, 10740.087092597061, 8013.719519816778, 8028.638711258008, 8133.837323253501, 8140.87788683182, 8144.511329320141, 5191.247269145877, 5448.918266226089, 5927.2590926134235, 6060.272767267779, 6164.106204600218, 9566.61733530651, 9738.707838764849, 9949.253805964438, 9949.801003980025, 9974.351667141613, 10081.193504519768, 10098.0, 10132.64535741275, 10134.442605656759, 10172.847407289044, 6931.549449285781, 7249.927500725136, 7414.147373052168, 7468.402527797872, 7551.320381165721, 8139.267465928095, 8239.0, 8262.545559994258, 8324.29243514284, 8339.666413343399, 7266.564006159648, 7371.3734332582335, 7409.555426674417, 7494.475386722877, 7511.9624401877645, 6316.273628532777, 7254.96372518134, 7259.854802903807, 7293.890591641236, 7343.44924130703, 6949.0, 6996.160460744743, 7050.612216328152, 7054.541454805421, 7075.327843854826, 4703.482616912069, 4755.476897541337, 4947.010597880367, 4985.351904252569, 5089.262057001788, 4201.642860356904, 4942.5304596063315, 5021.698698078127, 5093.923591146062, 5121.743912804271], "value": 4471.0537032595, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.6917528708361, 309.87295208964326, 315.23240908388067, 317.2560345988659, 318.7338572292136, 5485.314335708036, 5584.888302233953, 5696.7721291148355, 5749.425057494253, 5768.653880767151, 5634.943650563493, 5676.3188417389865, 5678.716064196784, 5694.345150307716, 5724.828255152342, 4336.631386332166, 4344.152890186415, 4348.4999225089205, 4354.346847972798, 4357.7385356878685, 3956.5054368203973, 4231.513375961773, 4278.165757677254, 4359.564043595631, 4395.582419670126, 4197.517285512159, 4217.915641687165, 4228.118487273149, 4243.448351714273, 4252.362145678142, 3539.4513850353237, 4229.667654688778, 4248.9575104249025, 4270.7864606769535, 4279.443672322609, 3047.5123980163066, 3532.205253817896, 3648.1791596890753, 3653.342398368293, 3666.1934374437583, 5461.290032295816, 5462.808801691922, 5508.521165475512, 5528.640638358494, 5538.723063846792, 3904.160605469809, 4715.622750179978, 4817.975910120427, 4828.420589529279, 4889.975550122263, 4597.747123908183, 5449.346078470569, 5666.453306340784, 5973.729982606582, 6026.578139530235, 3514.3322768674125, 3945.309570825094, 3956.683465322796, 3971.8808435746973, 3985.481887354654, 5217.686938783685, 6193.411625895533, 6243.625382477066, 6321.304656487782, 6325.715342809584, 3402.625711171769, 3644.344018076719, 3865.1640470776156, 3892.260470510594, 4053.918921621551, 3610.5667319921777, 3905.92587038561, 4089.44792453021, 4104.958950410517, 4107.815148318333, 4844.563989240985, 4866.391701037371, 4872.171730805771, 4873.463918968911, 4878.219484882473, 5204.9219261711105, 5322.973385133049, 6027.969860150672, 6075.453209211104, 6109.59479319759, 1170.414792603698, 1312.3569450968957, 1378.6553361659585, 1382.3364784903304, 1392.6448755567264, 702.7997020849034, 762.1768490030754, 850.4217132350061, 860.6385318166385, 861.1646702698373, 4257.616814486649, 4334.9783251083545, 4442.73343599385, 4662.7202367858035, 4728.621710263171, 4585.449746030431, 4939.616907265971, 5157.9110460263655, 5164.741762911839, 5179.404368497596, 4197.866576024518, 4253.936190957138, 4583.64782389196, 4699.365585645963, 4710.317004034396, 2893.4682153116023, 3157.2264795125343, 3225.7258133058485, 3246.805191688506, 3248.366568519163, 5298.489930369826, 5539.806106786243, 5811.186433899257, 6364.936350636527, 6405.647689377129, 5098.731064676183, 6048.516118710492, 6163.96918015407, 6270.3416141305415, 6288.484606157482, 5175.861310511681, 5197.636165468457, 5521.337439507285, 6082.239720034996, 6286.025666021774, 5771.538276937751, 6066.969665151646, 6107.938920610737, 6138.815835524942, 6162.969185154046, 5231.581473482189, 5433.619646624698, 5557.526545908807, 5959.463648271503, 6044.123602077762, 5620.775168993358, 5924.555658325729, 6329.9050514243245, 6348.809535713936, 6383.0, 3180.825054622018, 3755.9248815023, 3967.900802479961, 3980.1144170476173, 4027.6576490998596, 5945.762169513171, 6124.938750612437, 6145.907811382922, 6159.5688301818445, 6160.090371984699, 5878.559108066997, 5988.251468566429, 6015.338312785678, 6029.668368239789, 6031.36670649593, 6011.587276989992, 6036.7283472244735, 6045.6070355426755, 6048.455638992512, 6048.60684055535, 5526.143447765603, 5832.591718579659, 5905.320888097924, 5915.131161386638, 5931.228940237914, 5073.300444351036, 5987.64074155552, 6017.398260173947, 6021.2473440819895, 6032.668203248688, 4828.396450443694, 5147.6540248838555, 5286.418493965738, 5915.911261330997, 5940.702964851826], "value": 4226.463842607346, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.6069483173919, 744.9702011919524, 780.6760194519275, 785.3520845302625, 868.3096937934341, 15345.156016419092, 15805.367785288603, 15947.20263986802, 15990.280437380317, 16050.0, 14270.143791372526, 14551.490697825579, 14752.483663071795, 14834.925825370858, 14896.0, 856.4304737349671, 874.5845723281454, 879.2745984562729, 880.2078129683272, 882.2765332427412, 695.7425752471593, 845.8942632170979, 861.4788053227801, 871.9215270625642, 875.369733791669, 903.0698380667923, 921.8156368726249, 922.8569571716395, 926.8980412154658, 928.470771660154, 897.344938195118, 907.6233363154283, 920.1672486399818, 927.429630777074, 927.5037854747745, 665.2050799294844, 668.0180135201294, 678.9015592739074, 684.103823990569, 691.4572060932144, 12931.482740690455, 15353.309101090366, 15558.144302063381, 15584.376624934988, 15803.762943555856, 14730.55808325752, 14838.777418338734, 15014.849851501454, 15097.169655668933, 15260.771088433683, 11997.0, 12292.631221063382, 12555.372231388485, 12562.057845661611, 12585.0, 3802.8668996585266, 3840.0783811885226, 3956.960430395688, 4055.878323650295, 4090.386442033689, 82485.0, 120685.39657301745, 121122.0, 122443.0, 122933.0, 11249.606263780892, 11251.549938002388, 11339.206255562032, 11410.771784564262, 11543.249688770204, 24201.63697544538, 24255.151069712476, 24256.51486970286, 24292.878535607564, 25322.620160697603, 6706.5640733352175, 7746.109197442366, 7941.483803552751, 8025.638846251933, 8317.168283171635, 4439.289713645801, 4468.977655111704, 4545.272756358967, 4578.793954271999, 4712.764361781966, 3556.6265542117703, 3702.9814850926114, 3704.7777133372083, 3707.9073023174637, 3714.23858109087, 650.8828410886086, 664.4086762781129, 666.6000399760202, 670.6546128743603, 673.0274752981894, 546.6965833962189, 590.1737567405667, 612.2377639838429, 614.717230074162, 646.0986923242051, 8291.875621865556, 9102.31732620043, 9104.908950910407, 9116.179543841086, 9147.77130571741, 509.4319833385748, 582.6649676436066, 629.8960671489244, 630.8076036808726, 641.0992555459587, 3991.640752332304, 4311.288637374798, 4776.761161941889, 4852.4662287148385, 4949.894619636514, 97965.0, 145081.54918450682, 149733.0, 151281.0, 172425.0, 140028.0, 144254.0, 146011.0, 147819.0, 148530.51469485383, 101902.49048754857, 102956.0, 105766.47116764521, 121247.0, 125560.1165982511, 8129.268365847102, 9875.358101723365, 9982.550785214538, 10080.69757907264, 10132.949335253277, 54476.0, 55017.0, 62628.43428914314, 65502.67248663726, 66689.66655166693, 42927.785361072994, 55791.605209870075, 60290.79418411695, 82954.58522707348, 99116.0, 12125.0, 13390.93304533471, 13414.530491432753, 13415.262160581262, 13512.932435338154, 11843.467043983213, 14795.630109247355, 14827.851721482648, 15145.394184232508, 15172.468963586221, 13859.653508662364, 13864.0, 14091.929540352643, 14100.506482273071, 14458.06022608527, 13401.932990334986, 13615.25116118623, 14008.299585020504, 14173.149611023371, 14191.361388737738, 13206.603801885958, 13490.460381584626, 13570.457181712622, 13667.658308542366, 13770.862291376958, 9504.572294246636, 11216.327020378803, 11224.60713875043, 11562.30626162433, 11840.993515551274, 10826.350418974887, 11100.278481898651, 11390.829137563109, 11707.2975621463, 11725.589604363806], "value": 7891.1096576226055, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1605.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 158.0, 106.0, 118.0, 115.0, 114.0, 113.0, 115.0, 115.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 145.0, 166.0, 161.0, 111.0, 129.0, 118.0, 140.0, 199.0, 116.0], "value": 146.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 235.0, 196.0, 202.0, 199.0, 202.0, 198.0, 198.0, 199.0, 198.0], "value": 203.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 89.0, 75.0, 172.0, 57.0, 57.0, 61.0, 75.0, 161.0, 59.0], "value": 87.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 111.0, 71.0, 70.0, 80.0, 115.0, 70.0, 68.0, 114.0], "value": 84.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 87.0, 83.0, 131.0, 126.0, 86.0, 89.0, 86.0, 93.0, 132.0], "value": 100.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 123.0, 110.0, 154.0, 120.0, 105.0, 152.0, 151.0, 111.0, 150.0], "value": 127.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 133.0, 145.0, 93.0, 118.0, 91.0, 90.0, 92.0, 117.0, 123.0], "value": 111.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 55.0, 56.0, 56.0, 63.0, 67.0, 86.0, 89.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 72.0, 82.0, 80.0, 77.0, 84.0, 60.0, 96.0, 64.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 86.0, 91.0, 102.0, 108.0, 77.0, 101.0, 104.0, 104.0], "value": 95.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 138.0, 144.0, 152.0, 156.0, 140.0, 137.0, 138.0, 169.0, 159.0], "value": 147.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 169.0, 167.0, 167.0, 165.0, 171.0, 167.0, 167.0, 167.0, 164.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 76.0, 67.0, 73.0, 99.0, 86.0, 91.0, 90.0], "value": 78.4, "unit": "score"}]}]} 15:41:03 INFO - Return code: 0 15:41:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:41:03 ERROR - # TBPL SUCCESS # 15:41:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:41:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:41:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:41:03 INFO - 2016-08-11 15:41:03.291 screenresolution[1681:10332] starting screenresolution argv=screenresolution get 15:41:03 INFO - 2016-08-11 15:41:03.293 screenresolution[1681:10332] Display 0: 1600x1200x32@60 15:41:03 INFO - 2016-08-11 15:41:03.299 screenresolution[1682:10335] starting screenresolution argv=screenresolution list 15:41:03 INFO - Available Modes on Display 0 15:41:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:41:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:41:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:41:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:41:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:41:03 INFO - Intel Iris: 15:41:03 INFO - Chipset Model: Intel Iris 15:41:03 INFO - Type: GPU 15:41:03 INFO - Bus: Built-In 15:41:03 INFO - VRAM (Dynamic, Max): 1536 MB 15:41:03 INFO - Vendor: Intel (0x8086) 15:41:03 INFO - Device ID: 0x0a2e 15:41:03 INFO - Revision ID: 0x0009 15:41:03 INFO - Displays: 15:41:03 INFO - Display: 15:41:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:41:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:41:03 INFO - Display Serial Number: 1600x1200 60 15:41:03 INFO - Main Display: Yes 15:41:03 INFO - Mirror: Off 15:41:03 INFO - Online: Yes 15:41:03 INFO - Rotation: Supported 15:41:03 INFO - Return code: 0 15:41:03 INFO - Running post-action listener: _resource_record_post_action 15:41:03 INFO - [mozharness: 2016-08-11 22:41:03.544138Z] Finished run-tests step (success) 15:41:03 INFO - Running post-run listener: _resource_record_post_run 15:41:03 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37954560; Write bytes: 703222272; Read time: 388; Write time: 1977 15:41:03 INFO - TinderboxPrint: CPU usage
54.3% 15:41:03 INFO - TinderboxPrint: I/O read bytes / time
37,954,560 / 388 15:41:03 INFO - TinderboxPrint: I/O write bytes / time
703,222,272 / 1,977 15:41:03 INFO - TinderboxPrint: CPU idle
2,211.7 (45.7%) 15:41:03 INFO - TinderboxPrint: CPU system
975.3 (20.1%) 15:41:03 INFO - TinderboxPrint: CPU user
1,654.7 (34.2%) 15:41:03 INFO - TinderboxPrint: Swap in / out
441,954,304 / 0 15:41:03 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 397505024; Write bytes: 390895104; Read time: 29432; Write time: 711 15:41:03 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 35894272; Write bytes: 296549376; Read time: 365; Write time: 1227 15:41:04 INFO - Running post-run listener: _upload_blobber_files 15:41:04 INFO - Blob upload gear active. 15:41:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:41:04 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 15:41:04 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'] 15:41:04 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 15:41:04 INFO - (blobuploader) - INFO - Open directory for files ... 15:41:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:41:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:41:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:41:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:41:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:41:05 INFO - (blobuploader) - INFO - Done attempting. 15:41:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:41:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:41:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:41:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:41:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:41:06 INFO - (blobuploader) - INFO - Done attempting. 15:41:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:41:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:41:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:41:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:41:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:41:09 INFO - (blobuploader) - INFO - Done attempting. 15:41:09 INFO - (blobuploader) - INFO - Iteration through files over. 15:41:09 INFO - Return code: 0 15:41:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:41:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:41:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b228311b80bbbf4fccc2fea823217d61c1e4aa56fa4f49cc853bed6eaa52711cb397e74cfc526713a44944a631db9f5b485a0b9d3394b8b39d4b652d3026742e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba5f4766e488ff7fc48d3bc109c81e3c845535ac240af5233be096072612ba1bbd2a00af7aaa8823d9a1363487ac76a0fb44bdcbdefc88485810c544925e3a40", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/46929ae5021afaf71b962f32a217ec446c8357bbd9e063341a755b2c245a2ee1a240da0bb12311ed94900e1d590bb6ccaaaf9e5462f3d24f9ed5d23251da478d"} 15:41:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:41:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:41:09 INFO - Contents: 15:41:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b228311b80bbbf4fccc2fea823217d61c1e4aa56fa4f49cc853bed6eaa52711cb397e74cfc526713a44944a631db9f5b485a0b9d3394b8b39d4b652d3026742e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba5f4766e488ff7fc48d3bc109c81e3c845535ac240af5233be096072612ba1bbd2a00af7aaa8823d9a1363487ac76a0fb44bdcbdefc88485810c544925e3a40", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/46929ae5021afaf71b962f32a217ec446c8357bbd9e063341a755b2c245a2ee1a240da0bb12311ed94900e1d590bb6ccaaaf9e5462f3d24f9ed5d23251da478d"} 15:41:09 INFO - Running post-run listener: copy_logs_to_upload_dir 15:41:09 INFO - Copying logs to upload dir... 15:41:09 INFO - mkdir: /builds/slave/test/build/upload/logs 15:41:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.890576 ========= master_lag: 2.57 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-11 15:41:11.635896) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 15:41:11.637143) ========= 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.NIOgcFUGd9/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.AiniTf8lVL/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b228311b80bbbf4fccc2fea823217d61c1e4aa56fa4f49cc853bed6eaa52711cb397e74cfc526713a44944a631db9f5b485a0b9d3394b8b39d4b652d3026742e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba5f4766e488ff7fc48d3bc109c81e3c845535ac240af5233be096072612ba1bbd2a00af7aaa8823d9a1363487ac76a0fb44bdcbdefc88485810c544925e3a40", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/46929ae5021afaf71b962f32a217ec446c8357bbd9e063341a755b2c245a2ee1a240da0bb12311ed94900e1d590bb6ccaaaf9e5462f3d24f9ed5d23251da478d"} build_url:https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011036 build_url: 'https://queue.taskcluster.net/v1/task/Ic9u-RP1SiKyTL0KVR7N-w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b228311b80bbbf4fccc2fea823217d61c1e4aa56fa4f49cc853bed6eaa52711cb397e74cfc526713a44944a631db9f5b485a0b9d3394b8b39d4b652d3026742e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba5f4766e488ff7fc48d3bc109c81e3c845535ac240af5233be096072612ba1bbd2a00af7aaa8823d9a1363487ac76a0fb44bdcbdefc88485810c544925e3a40", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/46929ae5021afaf71b962f32a217ec446c8357bbd9e063341a755b2c245a2ee1a240da0bb12311ed94900e1d590bb6ccaaaf9e5462f3d24f9ed5d23251da478d"}' ========= master_lag: 0.50 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 15:41:12.149958) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 15:41:12.150308) ========= 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.NIOgcFUGd9/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.AiniTf8lVL/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.005109 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 15:41:12.178596) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 15:41:12.178913) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 15:41:12.179241) ========= ========= Total master_lag: 3.19 =========