builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0065 starttime: 1470871673.08 results: success (0) buildid: 20160810141321 builduid: 58b1ea34d3434e7b829dd625cb82caa3 revision: bddf684f5b461f2f40b907c5ae7fab4b05211a96 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 16:27:53.075625) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 16:27:53.076074) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 16:27:53.076344) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 16:27:53.100928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 16:27:53.101275) ========= 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.1vpFPi0Ta9/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.FksBzIkb17/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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-10 16:27:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.8M=0.001s 2016-08-10 16:27:53 (15.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155220 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 16:27:53.279078) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 16:27:53.279407) ========= 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.1vpFPi0Ta9/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.FksBzIkb17/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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.027451 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 16:27:53.327513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-10 16:27:53.327961) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev bddf684f5b461f2f40b907c5ae7fab4b05211a96 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev bddf684f5b461f2f40b907c5ae7fab4b05211a96 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1vpFPi0Ta9/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.FksBzIkb17/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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-10 16:27:53,403 truncating revision to first 12 chars 2016-08-10 16:27:53,403 Setting DEBUG logging. 2016-08-10 16:27:53,403 attempt 1/10 2016-08-10 16:27:53,404 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/bddf684f5b46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 16:27:54,494 unpacking tar archive at: autoland-bddf684f5b46/testing/mozharness/ program finished with exit code 0 elapsedTime=1.336429 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-10 16:27:54.688006) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 16:27:54.688666) ========= script_repo_revision: bddf684f5b461f2f40b907c5ae7fab4b05211a96 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 16:27:54.689411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 16:27:54.689929) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 16:27:54.708986) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-08-10 16:27:54.709577) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1vpFPi0Ta9/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.FksBzIkb17/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 16:27:54 INFO - MultiFileLogger online at 20160810 16:27:54 in /builds/slave/test 16:27:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 16:27:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:27:54 INFO - {'append_to_log': False, 16:27:54 INFO - 'base_work_dir': '/builds/slave/test', 16:27:54 INFO - 'blob_upload_branch': 'Autoland', 16:27:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:27:54 INFO - 'branch': 'Autoland', 16:27:54 INFO - 'buildbot_json_path': 'buildprops.json', 16:27:54 INFO - 'config_files': ('talos/mac_config.py',), 16:27:54 INFO - 'default_actions': ('clobber', 16:27:54 INFO - 'read-buildbot-config', 16:27:54 INFO - 'download-and-extract', 16:27:54 INFO - 'populate-webroot', 16:27:54 INFO - 'create-virtualenv', 16:27:54 INFO - 'install', 16:27:54 INFO - 'run-tests'), 16:27:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:27:54 INFO - 'download_minidump_stackwalk': True, 16:27:54 INFO - 'download_symbols': 'ondemand', 16:27:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:27:54 INFO - 'tooltool.py': '/tools/tooltool.py', 16:27:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:27:54 INFO - '/tools/misc-python/virtualenv.py')}, 16:27:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:27:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:27:54 INFO - 'installer_path': 'installer.exe', 16:27:54 INFO - 'log_level': 'info', 16:27:54 INFO - 'log_name': 'talos', 16:27:54 INFO - 'log_to_console': True, 16:27:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:27:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:27:54 INFO - 'opt_config_files': (), 16:27:54 INFO - 'pip_index': False, 16:27:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:27:54 INFO - 'cmd': ('bash', 16:27:54 INFO - '-c', 16:27:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:27:54 INFO - 'enabled': True, 16:27:54 INFO - 'halt_on_failure': False, 16:27:54 INFO - 'name': 'check_screen_resolution'},), 16:27:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:27:54 INFO - 'cmd': ('bash', 16:27:54 INFO - '-c', 16:27:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:27:54 INFO - 'enabled': True, 16:27:54 INFO - 'halt_on_failure': False, 16:27:54 INFO - 'name': 'check_screen_resolution'},), 16:27:54 INFO - 'run_cmd_checks_enabled': True, 16:27:54 INFO - 'sps_profile': False, 16:27:54 INFO - 'sps_profile_interval': 0, 16:27:54 INFO - 'suite': 'dromaeojs-e10s', 16:27:54 INFO - 'system_bits': '32', 16:27:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:27:54 INFO - 'title': 't-yosemite-r7-0065', 16:27:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:27:54 INFO - 'use_talos_json': True, 16:27:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:27:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:27:54 INFO - 'work_dir': 'build'} 16:27:54 INFO - [mozharness: 2016-08-10 23:27:54.903250Z] Running clobber step. 16:27:54 INFO - Running pre-action listener: _resource_record_pre_action 16:27:54 INFO - Running main action method: clobber 16:27:54 INFO - rmtree: /builds/slave/test/build 16:27:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:27:57 INFO - Running post-action listener: _resource_record_post_action 16:27:57 INFO - [mozharness: 2016-08-10 23:27:57.042898Z] Finished clobber step (success) 16:27:57 INFO - [mozharness: 2016-08-10 23:27:57.043020Z] Running read-buildbot-config step. 16:27:57 INFO - Running pre-action listener: _resource_record_pre_action 16:27:57 INFO - Running main action method: read_buildbot_config 16:27:57 INFO - Using buildbot properties: 16:27:57 INFO - { 16:27:57 INFO - "project": "", 16:27:57 INFO - "product": "firefox", 16:27:57 INFO - "script_repo_revision": "production", 16:27:57 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 16:27:57 INFO - "repository": "", 16:27:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 16:27:57 INFO - "buildid": "20160810141321", 16:27:57 INFO - "pgo_build": "False", 16:27:57 INFO - "basedir": "/builds/slave/test", 16:27:57 INFO - "buildnumber": 111, 16:27:57 INFO - "slavename": "t-yosemite-r7-0065", 16:27:57 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 16:27:57 INFO - "platform": "yosemite_r7", 16:27:57 INFO - "scheduler": "tests-autoland-macosx64-talos", 16:27:57 INFO - "branch": "autoland", 16:27:57 INFO - "repo_path": "integration/autoland", 16:27:57 INFO - "revision": "bddf684f5b461f2f40b907c5ae7fab4b05211a96", 16:27:57 INFO - "stage_platform": "macosx64", 16:27:57 INFO - "builduid": "58b1ea34d3434e7b829dd625cb82caa3", 16:27:57 INFO - "slavebuilddir": "test" 16:27:57 INFO - } 16:27:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 16:27:57 INFO - Running post-action listener: _resource_record_post_action 16:27:57 INFO - [mozharness: 2016-08-10 23:27:57.046236Z] Finished read-buildbot-config step (success) 16:27:57 INFO - [mozharness: 2016-08-10 23:27:57.046383Z] Running download-and-extract step. 16:27:57 INFO - Running pre-action listener: _resource_record_pre_action 16:27:57 INFO - Running main action method: download_and_extract 16:27:57 INFO - mkdir: /builds/slave/test/build/tests 16:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:57 INFO - trying https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 16:27:57 INFO - Downloading https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/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 16:27:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/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 16:27:57 INFO - Downloaded 1199 bytes. 16:27:57 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 16:27:57 INFO - Using the following test package requirements: 16:27:57 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:27:57 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:27:57 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 16:27:57 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:27:57 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 16:27:57 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:27:57 INFO - u'jsshell-mac.zip'], 16:27:57 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:27:57 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 16:27:57 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:27:57 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:27:57 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 16:27:57 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:27:57 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 16:27:57 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:27:57 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 16:27:57 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:27:57 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 16:27:57 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:57 INFO - trying https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:27:57 INFO - Downloading https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/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 16:27:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/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 16:27:58 INFO - Downloaded 16325996 bytes. 16:27:58 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'] 16:27:58 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 16:28:02 INFO - Return code: 0 16:28:02 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 16:28:02 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')]} 16:28:02 INFO - trying https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:28:02 INFO - Downloading https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/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 16:28:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/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 16:28:03 INFO - Downloaded 16325996 bytes. 16:28:03 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'] 16:28:03 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 16:28:06 INFO - Return code: 0 16:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:06 INFO - trying https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 16:28:06 INFO - Downloading https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/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 16:28:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/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 16:28:07 INFO - Downloaded 14413719 bytes. 16:28:07 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'] 16:28:07 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 16:28:07 INFO - Return code: 0 16:28:07 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')]} 16:28:07 INFO - trying https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:28:07 INFO - Downloading https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 16:28:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/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 16:28:11 INFO - Downloaded 110931069 bytes. 16:28:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:28:11 INFO - mkdir: /builds/slave/test/properties 16:28:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:28:11 INFO - Writing to file /builds/slave/test/properties/build_url 16:28:11 INFO - Contents: 16:28:11 INFO - build_url:https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:28:11 INFO - Running post-action listener: _resource_record_post_action 16:28:11 INFO - Running post-action listener: set_extra_try_arguments 16:28:11 INFO - [mozharness: 2016-08-10 23:28:11.758886Z] Finished download-and-extract step (success) 16:28:11 INFO - [mozharness: 2016-08-10 23:28:11.759043Z] Running populate-webroot step. 16:28:11 INFO - Running pre-action listener: _resource_record_pre_action 16:28:11 INFO - Running main action method: populate_webroot 16:28:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:28:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:28:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:28:11 INFO - '--tppagecycles', 16:28:11 INFO - '7'], 16:28:11 INFO - 'tests': ['tsvgm']}}, 16:28:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:28:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:28:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:28:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:28:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:28:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:28:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:11 INFO - 'talos_options': ['--disable-e10s'], 16:28:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:28:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:28:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:11 INFO - 'talos_options': ['--disable-e10s'], 16:28:11 INFO - 'tests': ['damp', 'tps']}, 16:28:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:11 INFO - 'tests': ['damp', 'tps']}, 16:28:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:28:11 INFO - 'tests': ['dromaeo_dom']}, 16:28:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:28:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:28:11 INFO - 'tests': ['basic_compositor_video']}, 16:28:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:28:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:28:11 INFO - 'tests': ['a11yr', 16:28:11 INFO - 'ts_paint', 16:28:11 INFO - 'tpaint', 16:28:11 INFO - 'sessionrestore', 16:28:11 INFO - 'sessionrestore_no_auto_restore', 16:28:11 INFO - 'tabpaint']}, 16:28:11 INFO - 'other-e10s': {'tests': ['a11yr', 16:28:11 INFO - 'ts_paint', 16:28:11 INFO - 'tpaint', 16:28:11 INFO - 'sessionrestore', 16:28:11 INFO - 'sessionrestore_no_auto_restore', 16:28:11 INFO - 'tabpaint']}, 16:28:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:28:11 INFO - 'ts_paint', 16:28:11 INFO - 'tpaint', 16:28:11 INFO - 'sessionrestore', 16:28:11 INFO - 'sessionrestore_no_auto_restore', 16:28:11 INFO - 'tabpaint']}, 16:28:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:28:11 INFO - 'ts_paint', 16:28:11 INFO - 'tpaint', 16:28:11 INFO - 'sessionrestore', 16:28:11 INFO - 'sessionrestore_no_auto_restore', 16:28:11 INFO - 'tabpaint']}, 16:28:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:28:11 INFO - 'tests': ['a11yr', 16:28:11 INFO - 'ts_paint', 16:28:11 INFO - 'tpaint', 16:28:11 INFO - 'sessionrestore', 16:28:11 INFO - 'sessionrestore_no_auto_restore', 16:28:11 INFO - 'tabpaint']}, 16:28:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:28:11 INFO - 'tests': ['a11yr', 16:28:11 INFO - 'ts_paint', 16:28:11 INFO - 'tpaint', 16:28:11 INFO - 'sessionrestore', 16:28:11 INFO - 'sessionrestore_no_auto_restore', 16:28:11 INFO - 'tabpaint']}, 16:28:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:28:11 INFO - 'tests': ['tsvgx', 16:28:11 INFO - 'tsvgr_opacity', 16:28:11 INFO - 'tart', 16:28:11 INFO - 'tscrollx', 16:28:11 INFO - 'cart']}, 16:28:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:28:11 INFO - 'tsvgr_opacity', 16:28:11 INFO - 'tart', 16:28:11 INFO - 'tscrollx', 16:28:11 INFO - 'cart']}, 16:28:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:11 INFO - 'talos_options': ['--disable-e10s'], 16:28:11 INFO - 'tests': ['tp5o']}, 16:28:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:11 INFO - 'tests': ['tp5o']}, 16:28:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:11 INFO - 'talos_options': ['--disable-e10s', 16:28:11 INFO - '--xperf_path', 16:28:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:11 INFO - 'tests': ['tp5n']}, 16:28:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:11 INFO - 'talos_options': ['--xperf_path', 16:28:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:11 INFO - 'tests': ['tp5n']}}, 16:28:11 INFO - 'talos.zip': {'path': '', 16:28:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:28:11 INFO - Running post-action listener: _resource_record_post_action 16:28:11 INFO - [mozharness: 2016-08-10 23:28:11.778117Z] Finished populate-webroot step (success) 16:28:11 INFO - [mozharness: 2016-08-10 23:28:11.778244Z] Running create-virtualenv step. 16:28:11 INFO - Running pre-action listener: _resource_record_pre_action 16:28:11 INFO - Running main action method: create_virtualenv 16:28:11 INFO - Creating virtualenv /builds/slave/test/build/venv 16:28:11 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 16:28:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:28:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:28:11 INFO - Using real prefix '/tools/python27' 16:28:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:28:12 INFO - Installing distribute.............................................................................................................................................................................................done. 16:28:15 INFO - Installing pip.................done. 16:28:15 INFO - Return code: 0 16:28:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:15 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 0x10a611a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6a6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86f14d7bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a575d30>, '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 0x10a2dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56db20>, '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.1vpFPi0Ta9/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.FksBzIkb17/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 16:28:15 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 16:28:15 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 16:28:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1vpFPi0Ta9/Render', 16:28:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:15 INFO - 'HOME': '/Users/cltbld', 16:28:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:15 INFO - 'LOGNAME': 'cltbld', 16:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:15 INFO - 'MOZ_NO_REMOTE': '1', 16:28:15 INFO - 'NO_EM_RESTART': '1', 16:28:15 INFO - 'PAGER': '/bin/cat', 16:28:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:15 INFO - 'PWD': '/builds/slave/test', 16:28:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:15 INFO - 'SHELL': '/bin/bash', 16:28:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FksBzIkb17/Listeners', 16:28:15 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 16:28:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:15 INFO - 'USER': 'cltbld', 16:28:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:15 INFO - 'XPC_FLAGS': '0x0', 16:28:15 INFO - 'XPC_SERVICE_NAME': '0', 16:28:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:15 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 16:28:15 INFO - Cleaning up... 16:28:15 INFO - Return code: 0 16:28:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:15 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 0x10a611a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6a6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86f14d7bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a575d30>, '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 0x10a2dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56db20>, '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.1vpFPi0Ta9/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.FksBzIkb17/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 16:28:15 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 16:28:15 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 16:28:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1vpFPi0Ta9/Render', 16:28:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:15 INFO - 'HOME': '/Users/cltbld', 16:28:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:15 INFO - 'LOGNAME': 'cltbld', 16:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:15 INFO - 'MOZ_NO_REMOTE': '1', 16:28:15 INFO - 'NO_EM_RESTART': '1', 16:28:15 INFO - 'PAGER': '/bin/cat', 16:28:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:15 INFO - 'PWD': '/builds/slave/test', 16:28:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:15 INFO - 'SHELL': '/bin/bash', 16:28:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FksBzIkb17/Listeners', 16:28:15 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 16:28:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:15 INFO - 'USER': 'cltbld', 16:28:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:15 INFO - 'XPC_FLAGS': '0x0', 16:28:15 INFO - 'XPC_SERVICE_NAME': '0', 16:28:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:16 INFO - Downloading/unpacking psutil>=3.1.1 16:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:28:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:28:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:28:18 INFO - Installing collected packages: psutil 16:28:18 INFO - Running setup.py install for psutil 16:28:19 INFO - building 'psutil._psutil_osx' extension 16:28:19 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 16:28:19 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 16:28:19 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 16:28:19 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 16:28:19 INFO - building 'psutil._psutil_posix' extension 16:28:19 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 16:28:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:28:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:28:19 INFO - ^ 16:28:19 INFO - 1 warning generated. 16:28:19 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 16:28:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:28:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:28:20 INFO - Successfully installed psutil 16:28:20 INFO - Cleaning up... 16:28:20 INFO - Return code: 0 16:28:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a611a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6a6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86f14d7bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a575d30>, '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 0x10a2dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56db20>, '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.1vpFPi0Ta9/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.FksBzIkb17/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 16:28:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:28:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1vpFPi0Ta9/Render', 16:28:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:20 INFO - 'HOME': '/Users/cltbld', 16:28:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:20 INFO - 'LOGNAME': 'cltbld', 16:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:20 INFO - 'MOZ_NO_REMOTE': '1', 16:28:20 INFO - 'NO_EM_RESTART': '1', 16:28:20 INFO - 'PAGER': '/bin/cat', 16:28:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:20 INFO - 'PWD': '/builds/slave/test', 16:28:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:20 INFO - 'SHELL': '/bin/bash', 16:28:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FksBzIkb17/Listeners', 16:28:20 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 16:28:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:20 INFO - 'USER': 'cltbld', 16:28:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:20 INFO - 'XPC_FLAGS': '0x0', 16:28:20 INFO - 'XPC_SERVICE_NAME': '0', 16:28:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:28:22 INFO - Installing collected packages: mozsystemmonitor 16:28:22 INFO - Running setup.py install for mozsystemmonitor 16:28:23 INFO - Successfully installed mozsystemmonitor 16:28:23 INFO - Cleaning up... 16:28:23 INFO - Return code: 0 16:28:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:23 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 0x10a611a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6a6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86f14d7bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a575d30>, '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 0x10a2dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56db20>, '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.1vpFPi0Ta9/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.FksBzIkb17/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 16:28:23 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 16:28:23 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 16:28:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1vpFPi0Ta9/Render', 16:28:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:23 INFO - 'HOME': '/Users/cltbld', 16:28:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:23 INFO - 'LOGNAME': 'cltbld', 16:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:23 INFO - 'MOZ_NO_REMOTE': '1', 16:28:23 INFO - 'NO_EM_RESTART': '1', 16:28:23 INFO - 'PAGER': '/bin/cat', 16:28:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:23 INFO - 'PWD': '/builds/slave/test', 16:28:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:23 INFO - 'SHELL': '/bin/bash', 16:28:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FksBzIkb17/Listeners', 16:28:23 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 16:28:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:23 INFO - 'USER': 'cltbld', 16:28:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:23 INFO - 'XPC_FLAGS': '0x0', 16:28:23 INFO - 'XPC_SERVICE_NAME': '0', 16:28:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:23 INFO - Downloading/unpacking jsonschema==2.5.1 16:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:28:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:28: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 16:28: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 16:28: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 16:28: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 16:28: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 16:28: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 16:28:26 INFO - Downloading functools32-3.2.3-2.tar.gz 16:28:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:28:26 INFO - warning: no files found matching '*.txt' 16:28:26 INFO - no previously-included directories found matching 'build' 16:28:26 INFO - no previously-included directories found matching 'dist' 16:28:26 INFO - no previously-included directories found matching '.git*' 16:28:26 INFO - Installing collected packages: jsonschema, functools32 16:28:26 INFO - Running setup.py install for functools32 16:28:26 INFO - warning: no files found matching '*.txt' 16:28:26 INFO - no previously-included directories found matching 'build' 16:28:26 INFO - no previously-included directories found matching 'dist' 16:28:26 INFO - no previously-included directories found matching '.git*' 16:28:26 INFO - Successfully installed jsonschema functools32 16:28:26 INFO - Cleaning up... 16:28:26 INFO - Return code: 0 16:28:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:26 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 0x10a611a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6a6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86f14d7bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a575d30>, '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 0x10a2dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56db20>, '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.1vpFPi0Ta9/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.FksBzIkb17/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 16:28:26 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 16:28:26 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 16:28:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1vpFPi0Ta9/Render', 16:28:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:26 INFO - 'HOME': '/Users/cltbld', 16:28:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:26 INFO - 'LOGNAME': 'cltbld', 16:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:26 INFO - 'MOZ_NO_REMOTE': '1', 16:28:26 INFO - 'NO_EM_RESTART': '1', 16:28:26 INFO - 'PAGER': '/bin/cat', 16:28:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:26 INFO - 'PWD': '/builds/slave/test', 16:28:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:26 INFO - 'SHELL': '/bin/bash', 16:28:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FksBzIkb17/Listeners', 16:28:26 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 16:28:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:26 INFO - 'USER': 'cltbld', 16:28:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:26 INFO - 'XPC_FLAGS': '0x0', 16:28:26 INFO - 'XPC_SERVICE_NAME': '0', 16:28:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:28:26 INFO - Cleaning up... 16:28:26 INFO - Return code: 0 16:28:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:26 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 0x10a611a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6a6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86f14d7bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a575d30>, '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 0x10a2dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56db20>, '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.1vpFPi0Ta9/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.FksBzIkb17/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 16:28:26 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 16:28:26 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 16:28:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1vpFPi0Ta9/Render', 16:28:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:26 INFO - 'HOME': '/Users/cltbld', 16:28:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:26 INFO - 'LOGNAME': 'cltbld', 16:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:26 INFO - 'MOZ_NO_REMOTE': '1', 16:28:26 INFO - 'NO_EM_RESTART': '1', 16:28:26 INFO - 'PAGER': '/bin/cat', 16:28:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:26 INFO - 'PWD': '/builds/slave/test', 16:28:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:26 INFO - 'SHELL': '/bin/bash', 16:28:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FksBzIkb17/Listeners', 16:28:26 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 16:28:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:26 INFO - 'USER': 'cltbld', 16:28:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:26 INFO - 'XPC_FLAGS': '0x0', 16:28:26 INFO - 'XPC_SERVICE_NAME': '0', 16:28:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:27 INFO - Downloading/unpacking blobuploader==1.2.4 16:28:27 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 16:28:27 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 16:28:27 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 16:28:27 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 16:28:27 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 16:28:27 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 16:28:29 INFO - Downloading blobuploader-1.2.4.tar.gz 16:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:28:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:28:29 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 16:28:29 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 16:28:29 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 16:28:29 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 16:28:29 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 16:28:29 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 16:28:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:28:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:28: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 16:28: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 16:28: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 16:28: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 16:28: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 16:28: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 16:28:30 INFO - Downloading docopt-0.6.1.tar.gz 16:28:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:28:30 INFO - Installing collected packages: blobuploader, requests, docopt 16:28:30 INFO - Running setup.py install for blobuploader 16:28:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:28:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:28:31 INFO - Running setup.py install for requests 16:28:31 INFO - Running setup.py install for docopt 16:28:31 INFO - Successfully installed blobuploader requests docopt 16:28:31 INFO - Cleaning up... 16:28:31 INFO - Return code: 0 16:28:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:31 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 0x10a611a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6a6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86f14d7bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a575d30>, '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 0x10a2dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56db20>, '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.1vpFPi0Ta9/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.FksBzIkb17/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 16:28:31 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 16:28:31 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 16:28:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1vpFPi0Ta9/Render', 16:28:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:31 INFO - 'HOME': '/Users/cltbld', 16:28:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:31 INFO - 'LOGNAME': 'cltbld', 16:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:31 INFO - 'MOZ_NO_REMOTE': '1', 16:28:31 INFO - 'NO_EM_RESTART': '1', 16:28:31 INFO - 'PAGER': '/bin/cat', 16:28:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:31 INFO - 'PWD': '/builds/slave/test', 16:28:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:31 INFO - 'SHELL': '/bin/bash', 16:28:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FksBzIkb17/Listeners', 16:28:31 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 16:28:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:31 INFO - 'USER': 'cltbld', 16:28:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:31 INFO - 'XPC_FLAGS': '0x0', 16:28:31 INFO - 'XPC_SERVICE_NAME': '0', 16:28:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:28:32 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-_XPVkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:28:32 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-nNWTAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:28:32 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-PK63AV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:28:32 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-aHwGO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:28:32 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-5PSPet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:28:32 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-jrTlUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:28:32 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-5UbUVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:28:32 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-Z3irMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:28:32 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-2a9bLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:28:32 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-cCMTyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:28:33 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-nxwXBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:28:33 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-3GJRvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:28:33 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-tFlHR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:28:33 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-Ejpwfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:33 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-bCjUj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:28:33 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-xxRasJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:28:33 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-xia9mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:28:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:28:33 INFO - Running setup.py install for manifestparser 16:28:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:28:33 INFO - Running setup.py install for mozcrash 16:28:34 INFO - Running setup.py install for mozdebug 16:28:34 INFO - Running setup.py install for mozdevice 16:28:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:28:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:28:34 INFO - Running setup.py install for mozfile 16:28:34 INFO - Running setup.py install for mozhttpd 16:28:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:28:34 INFO - Running setup.py install for mozinfo 16:28:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:28:34 INFO - Running setup.py install for mozInstall 16:28:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:28:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:28:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:28:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:28:34 INFO - Running setup.py install for mozleak 16:28:35 INFO - Running setup.py install for mozlog 16:28:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:28:35 INFO - Running setup.py install for moznetwork 16:28:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:28:35 INFO - Running setup.py install for mozprocess 16:28:35 INFO - Running setup.py install for mozprofile 16:28:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:28:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:28:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:28:35 INFO - Running setup.py install for mozrunner 16:28:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:28:35 INFO - Running setup.py install for mozscreenshot 16:28:36 INFO - Running setup.py install for moztest 16:28:36 INFO - Running setup.py install for mozversion 16:28:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:28:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:28:36 INFO - Cleaning up... 16:28:36 INFO - Return code: 0 16:28:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:28: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')]} 16:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28: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')]} 16:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:36 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 0x10a611a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6a6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86f14d7bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a575d30>, '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 0x10a2dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56db20>, '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.1vpFPi0Ta9/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.FksBzIkb17/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 16:28:36 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 16:28:36 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 16:28:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1vpFPi0Ta9/Render', 16:28:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:36 INFO - 'HOME': '/Users/cltbld', 16:28:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:36 INFO - 'LOGNAME': 'cltbld', 16:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:36 INFO - 'MOZ_NO_REMOTE': '1', 16:28:36 INFO - 'NO_EM_RESTART': '1', 16:28:36 INFO - 'PAGER': '/bin/cat', 16:28:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:36 INFO - 'PWD': '/builds/slave/test', 16:28:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:36 INFO - 'SHELL': '/bin/bash', 16:28:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FksBzIkb17/Listeners', 16:28:36 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 16:28:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:36 INFO - 'USER': 'cltbld', 16:28:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:36 INFO - 'XPC_FLAGS': '0x0', 16:28:36 INFO - 'XPC_SERVICE_NAME': '0', 16:28:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:28:36 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-WFRdV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:28:36 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)) 16:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:28:36 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-hEER4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:28:36 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)) 16:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:28:36 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-bbMZS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:28:36 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)) 16:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:28:36 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-6RrPuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:28:37 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)) 16:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:28:37 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-iSTsBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:28:37 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)) 16:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:28:37 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-UCNBjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:28:37 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)) 16:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:28:37 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-R4UK7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:28:37 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)) 16:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:28:37 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-WDVmUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:28:37 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)) 16:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:28:37 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-84O5Pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:28:37 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)) 16:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:28:37 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-KDMKEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:28:37 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)) 16:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:28:37 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-svaIQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:28:37 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)) 16:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:28:37 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-OLqSYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:28:37 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)) 16:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:28:37 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-_Hm0rE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:28:38 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)) 16:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:28:38 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-5BIbWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:28:38 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)) 16:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:38 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-pnMAjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:38 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)) 16:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:28:38 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-CQzqQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:28:38 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)) 16:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:28:38 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-0kFHZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:28:38 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)) 16:28:38 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)) 16:28:38 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)) 16:28:38 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)) 16:28:38 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)) 16:28:38 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)) 16:28:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:40 INFO - Downloading blessings-1.6.tar.gz 16:28:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:28:41 INFO - Installing collected packages: blessings 16:28:41 INFO - Running setup.py install for blessings 16:28:41 INFO - Successfully installed blessings 16:28:41 INFO - Cleaning up... 16:28:41 INFO - Return code: 0 16:28:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:28:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:28:41 INFO - Reading from file tmpfile_stdout 16:28:41 INFO - Current package versions: 16:28:41 INFO - blessings == 1.6 16:28:41 INFO - blobuploader == 1.2.4 16:28:41 INFO - docopt == 0.6.1 16:28:41 INFO - functools32 == 3.2.3-2 16:28:41 INFO - jsonschema == 2.5.1 16:28:41 INFO - manifestparser == 1.1 16:28:41 INFO - mozInstall == 1.12 16:28:41 INFO - mozcrash == 0.17 16:28:41 INFO - mozdebug == 0.1 16:28:41 INFO - mozdevice == 0.48 16:28:41 INFO - mozfile == 1.2 16:28:41 INFO - mozhttpd == 0.7 16:28:41 INFO - mozinfo == 0.9 16:28:41 INFO - mozleak == 0.1 16:28:41 INFO - mozlog == 3.3 16:28:41 INFO - moznetwork == 0.27 16:28:41 INFO - mozprocess == 0.23 16:28:41 INFO - mozprofile == 0.28 16:28:41 INFO - mozrunner == 6.12 16:28:41 INFO - mozscreenshot == 0.1 16:28:41 INFO - mozsystemmonitor == 0.3 16:28:41 INFO - moztest == 0.7 16:28:41 INFO - mozversion == 1.4 16:28:41 INFO - psutil == 3.1.1 16:28:41 INFO - requests == 1.2.3 16:28:41 INFO - wsgiref == 0.1.2 16:28:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:28: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')]} 16:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28: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')]} 16:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:41 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 0x10a611a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6a6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86f14d7bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a575d30>, '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 0x10a2dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56db20>, '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.1vpFPi0Ta9/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.FksBzIkb17/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 16:28:41 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 16:28:41 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 16:28:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1vpFPi0Ta9/Render', 16:28:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:41 INFO - 'HOME': '/Users/cltbld', 16:28:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:41 INFO - 'LOGNAME': 'cltbld', 16:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:41 INFO - 'MOZ_NO_REMOTE': '1', 16:28:41 INFO - 'NO_EM_RESTART': '1', 16:28:41 INFO - 'PAGER': '/bin/cat', 16:28:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:41 INFO - 'PWD': '/builds/slave/test', 16:28:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:41 INFO - 'SHELL': '/bin/bash', 16:28:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FksBzIkb17/Listeners', 16:28:41 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 16:28:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:41 INFO - 'USER': 'cltbld', 16:28:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:41 INFO - 'XPC_FLAGS': '0x0', 16:28:41 INFO - 'XPC_SERVICE_NAME': '0', 16:28:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:41 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)) 16:28:41 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)) 16:28:41 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)) 16:28:41 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)) 16:28:41 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)) 16:28:41 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)) 16:28:41 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)) 16:28:41 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)) 16:28:41 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)) 16:28:41 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)) 16:28:41 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)) 16:28:41 INFO - Cleaning up... 16:28:41 INFO - Return code: 0 16:28:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:28: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')]} 16:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28: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')]} 16:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:41 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 0x10a611a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6a6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86f14d7bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a575d30>, '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 0x10a2dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56db20>, '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.1vpFPi0Ta9/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.FksBzIkb17/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 16:28:41 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 16:28:41 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 16:28:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1vpFPi0Ta9/Render', 16:28:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:41 INFO - 'HOME': '/Users/cltbld', 16:28:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:41 INFO - 'LOGNAME': 'cltbld', 16:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:41 INFO - 'MOZ_NO_REMOTE': '1', 16:28:41 INFO - 'NO_EM_RESTART': '1', 16:28:41 INFO - 'PAGER': '/bin/cat', 16:28:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:41 INFO - 'PWD': '/builds/slave/test', 16:28:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:41 INFO - 'SHELL': '/bin/bash', 16:28:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FksBzIkb17/Listeners', 16:28:41 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 16:28:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:41 INFO - 'USER': 'cltbld', 16:28:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:41 INFO - 'XPC_FLAGS': '0x0', 16:28:41 INFO - 'XPC_SERVICE_NAME': '0', 16:28:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:28:42 INFO - Cleaning up... 16:28:42 INFO - Return code: 0 16:28:42 INFO - Running post-action listener: _resource_record_post_action 16:28:42 INFO - Running post-action listener: _start_resource_monitoring 16:28:42 INFO - Starting resource monitoring. 16:28:42 INFO - [mozharness: 2016-08-10 23:28:42.203445Z] Finished create-virtualenv step (success) 16:28:42 INFO - [mozharness: 2016-08-10 23:28:42.204335Z] Running install step. 16:28:42 INFO - Running pre-action listener: _resource_record_pre_action 16:28:42 INFO - Running main action method: install 16:28:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:28:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:28:42 INFO - Reading from file tmpfile_stdout 16:28:42 INFO - Detecting whether we're running mozinstall >=1.0... 16:28:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:28:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:28:42 INFO - Reading from file tmpfile_stdout 16:28:42 INFO - Output received: 16:28:42 INFO - Usage: mozinstall [options] installer 16:28:42 INFO - Options: 16:28:42 INFO - -h, --help show this help message and exit 16:28:42 INFO - -d DEST, --destination=DEST 16:28:42 INFO - Directory to install application into. [default: 16:28:42 INFO - "/builds/slave/test"] 16:28:42 INFO - --app=APP Application being installed. [default: firefox] 16:28:42 INFO - mkdir: /builds/slave/test/build/application 16:28:42 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'] 16:28:42 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 16:29:17 INFO - Reading from file tmpfile_stdout 16:29:17 INFO - Output received: 16:29:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:29:17 INFO - Running post-action listener: _resource_record_post_action 16:29:17 INFO - [mozharness: 2016-08-10 23:29:17.051702Z] Finished install step (success) 16:29:17 INFO - [mozharness: 2016-08-10 23:29:17.051865Z] Running run-tests step. 16:29:17 INFO - Running pre-action listener: _resource_record_pre_action 16:29:17 INFO - Running main action method: run_tests 16:29:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:29:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:29:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:29:17 INFO - 2016-08-10 16:29:17.066 screenresolution[1640:7418] starting screenresolution argv=screenresolution get 16:29:17 INFO - 2016-08-10 16:29:17.069 screenresolution[1640:7418] Display 0: 1600x1200x32@60 16:29:17 INFO - 2016-08-10 16:29:17.075 screenresolution[1641:7420] starting screenresolution argv=screenresolution list 16:29:17 INFO - Available Modes on Display 0 16:29:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:29:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:29:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:29:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:29:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:29:17 INFO - Intel Iris: 16:29:17 INFO - Chipset Model: Intel Iris 16:29:17 INFO - Type: GPU 16:29:17 INFO - Bus: Built-In 16:29:17 INFO - VRAM (Dynamic, Max): 1536 MB 16:29:17 INFO - Vendor: Intel (0x8086) 16:29:17 INFO - Device ID: 0x0a2e 16:29:17 INFO - Revision ID: 0x0009 16:29:17 INFO - Displays: 16:29:17 INFO - Display: 16:29:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:29:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:29:17 INFO - Display Serial Number: 1600x1200 60 16:29:17 INFO - Main Display: Yes 16:29:17 INFO - Mirror: Off 16:29:17 INFO - Online: Yes 16:29:17 INFO - Rotation: Supported 16:29:17 INFO - Return code: 0 16:29:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:29:17 INFO - Python 2.7.3 16:29:17 INFO - Return code: 0 16:29:17 INFO - grabbing minidump binary from tooltool 16:29: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')]} 16:29:17 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 0x10a575d30>, '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 0x10a2dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:29:17 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 16:29:17 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 16:29:17 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 16:29:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:29:17 INFO - Return code: 0 16:29:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:29:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:29:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:29:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:29:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:29:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0065', '--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 16:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0065 --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 16:29:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1vpFPi0Ta9/Render', 16:29:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:29:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:29:17 INFO - 'HOME': '/Users/cltbld', 16:29:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:29:17 INFO - 'LOGNAME': 'cltbld', 16:29:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:29:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:17 INFO - 'MOZ_NO_REMOTE': '1', 16:29:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:29:17 INFO - 'NO_EM_RESTART': '1', 16:29:17 INFO - 'PAGER': '/bin/cat', 16:29:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:17 INFO - 'PWD': '/builds/slave/test', 16:29:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:29:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:29:17 INFO - 'SHELL': '/bin/bash', 16:29:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FksBzIkb17/Listeners', 16:29:17 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 16:29:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:29:17 INFO - 'USER': 'cltbld', 16:29:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:29:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:17 INFO - 'XPC_FLAGS': '0x0', 16:29:17 INFO - 'XPC_SERVICE_NAME': '0', 16:29:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:29:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0065', '--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 16:29:17 INFO - mozversion application_buildid: 20160810141321 16:29:17 INFO - mozversion application_changeset: bddf684f5b461f2f40b907c5ae7fab4b05211a96 16:29:17 INFO - mozversion application_display_name: Nightly 16:29:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:29:17 INFO - mozversion application_name: Firefox 16:29:17 INFO - mozversion application_remotingname: firefox 16:29:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 16:29:17 INFO - mozversion application_vendor: Mozilla 16:29:17 INFO - mozversion application_version: 51.0a1 16:29:17 INFO - mozversion platform_buildid: 20160810141321 16:29:17 INFO - mozversion platform_changeset: bddf684f5b461f2f40b907c5ae7fab4b05211a96 16:29:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 16:29:17 INFO - mozversion platform_version: 51.0a1 16:29:17 INFO - using testdate: 1470871757 16:29:17 INFO - actual date: 1470871757 16:29:17 INFO - starting webserver on 'localhost:49271' 16:29:17 INFO - SUITE-START | Running 2 tests 16:29:17 INFO - TEST-START | dromaeo_css 16:29:17 INFO - operating with platform_type : mac_ 16:29:17 INFO - Initialising browser for dromaeo_css test... 16:29:17 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmpgYKH8Y/profile http://localhost:49271/getInfo.html) 16:29:20 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 16:29:20 INFO - PROCESS | 1651 | colorDepth:24 16:29:20 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 16:29:20 INFO - PROCESS | 1651 | __metrics 16:29:20 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:29:21 INFO - TEST-INFO | 1651: exit 0 16:29:21 INFO - Browser initialized. 16:29:21 INFO - Running cycle 1/1 for dromaeo_css test... 16:29:21 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmpgYKH8Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:29:33 INFO - PROCESS | 1654 | RSS: Main: 254816256 16:29:33 INFO - PROCESS | 1654 | 16:30:23 INFO - PROCESS | 1654 | 1470871823099 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] 16:32:34 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 16:32:35 INFO - PROCESS | 1654 | RSS: Main: 267542528 16:32:35 INFO - PROCESS | 1654 | 16:35:38 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 16:35:38 INFO - PROCESS | 1654 | RSS: Main: 276545536 16:35:38 INFO - PROCESS | 1654 | 16:38:40 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 16:38:41 INFO - PROCESS | 1654 | RSS: Main: 280498176 16:38:41 INFO - PROCESS | 1654 | 16:41:43 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 16:41:44 INFO - PROCESS | 1654 | RSS: Main: 278863872 16:41:44 INFO - PROCESS | 1654 | 16:44:46 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 16:44:47 INFO - PROCESS | 1654 | RSS: Main: 283267072 16:44:47 INFO - PROCESS | 1654 | 16:47:50 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 16:47:50 INFO - PROCESS | 1654 | RSS: Main: 285011968 16:47:50 INFO - PROCESS | 1654 | 16:47:50 INFO - PROCESS | 1654 | __start_tp_report 16:47:50 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 16:47:50 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 16:47:50 INFO - PROCESS | 1654 | |i|pagename|runs| 16:47:50 INFO - PROCESS | 1654 | |0;dojo.html;2655.721149279326;3360.327934413118;3399.2351720862807;3413.4197186478295;3426.9890382337207;4795.880102997427;4946.431160416553;5606.55147588193;5636.859078523039;5684.5332908569635;5517.475839795223;5675.744591493382;5742.6841523716175;5752;5883;5175.275461435393;5231.712255825928;5319.813806516772;5336.38631557372;5341.679499230039;5165.81919632813;5316.73416329184;5319.627626066177;5413.810516631918;5417.674939503642;4007.8777942176093;5079.187330027215;5167.199084141964;5170.741462926876;5236.607254455893;5212.061828870802;5218.321618189649;5221.973890130525;5224.320838291036;5225.503577160163;5149.510796474329;5196.662216955886;5205.765740541685;5214.634975551713;5245.134552798783;4316.805743741539;5560.916586251209;5671.319441666985;5756.251687280668;5811.82564523065;6147.47746441553;6190.81427557174;6194.225721784777;6218.067289906505;6221.346758590328;6195.887984395833;6259.061140828912;6265.185525881606;6274.843128921768;6307.684615769193;5600.5799565032785;5690.772369105231;5722.513586345124;5767.509761670305;5826.271716035496;6189.731105123529;6236.656983865841;6236.656983865841;6239.719212635442;6270.561060725797;6065.721977753093;6102;6129.325774164839;6129.540284478593;6151.3541078186145;6036.275646922398;6159.384061593894;6178.196834411498;6191.566590338633;6274.592151510137;5794.1308803679785;6140.197513349931;6143.416375444325;6151.876962460726;6238.220222472191;4632.791524381411;5977.103434484775;6224.346443623445;6249.500039996789;6264.279607845065;4480.7535585542455;4752.52474752522;4842.975785121052;4876.244182151701;4904.215325547895;4405.757683327448;4409.581089796464;4433.401490798766;4447.110577884436;4504.414426124583;5484.149956756709;5503.486541201201;5503.944960550423;5786.797462088806;5803.6807975560905;6124.960759790047;6139.4781443577795;6170.10533472644;6223.439890409885;6247.031710084944;5752.798652047159;5759;5766.567507436959;5773.336066352339;5833.445822646841;5350.304460420199;5359.196120581944;5381.811636592701;5392.299001129828;5407.242985981966;6146.815595532052;6160.507159427325;6181.721822517908;6259.78090766821;6265.843353916189;6220.688965551613;6223.502119830312;6236.438720515175;6256.687165641791;6268.435840774352;6266.874662506815;6288.5598008138995;6293.653849038164;6299.748010079546;6301.7164227608955;6009;6099.128199784669;6100.511959043355;6141.140240366263;6156.78451254204;6015.428534289235;6136.457808108435;6198.194234749454;6240.219972503437;6248.187735594525;6109.938900610937;6128.601640893327;6134.14122022926;6146.877062458815;6154.922888494406;5017.62367822422;5861.0915308127305;6115.388461153849;6128.846778830565;6135.233095863017;5779.7110144493445;5955.464008239279;6028.246469191351;6031.095335699505;6068.362821903636;6136.631802091889;6155;6155.507559395327;6164.630122192682;6173.536984726074;5840.445157710011;5869.706514674334;5916.911246331222;6064.545159112996;6078.088286757022 16:47:50 INFO - PROCESS | 1654 | |1;ext.html;465.99068018639605;470.58588442170895;494.0810093226598;518.6861948521145;545.1033050631713;35658.82170589147;41052.58947410525;41052.58947410529;41054;41118.58881411185;42017.57982420175;42678.573214267926;42712.78643606778;42739.14521709564;42811.71564853052;9616.519174041305;9819.852702209473;9823.95088024559;9827.754306142333;9842.655507057254;9704.902950970505;9799;9830.9508452458;9838.901610983907;9855.950720246388;9791.755206119868;9847.261455390839;9860.408375497493;9861.654842080528;9866.506674666274;9737.464439455827;9824.06671366219;9833.213342932548;9837.114659680663;9852.408855468695;9653.806923861483;9755.12203901645;9763.658271960447;9783.41299522031;9797.118259356692;33326.33347333064;39642.60357396418;39710.808675739776;39867.8006609968;39970.40044399336;2572.588385858254;2998;3201.855916483764;3441.5698037745283;4231.830726770956;31056.068317950496;31839.363212735614;32179;33339.6666033339;33350.33299334024;3237.96762032379;3256.7557433192605;3278.1149089745636;3279.1638132276357;3365.6970872621337;463626;479769;502484;507640;509027.454862727;62856;63156;63572.364276356646;63612.36387636064;63738.681306594095;34589.13527161841;34882;35443.936681899584;36160;66394;16540.75188872168;16641.33434662624;16703.16484175786;16844.410445634345;16847.747283790508;10803.945980270048;12773.744525109445;12808.80786788199;12838.293893835742;12857.228566286052;19121.309405806245;19596.608067838562;19661.410157695005;19661.410157695293;19663.41009769709;6864.450843932574;7888.32949199313;7919.643616037177;7949.403794715419;8030.718924837603;876.8246350729752;938.4463166731662;1020.1430798129607;1029.1818004686143;1078.6763970808884;24419.877900610383;30366;30518.54222186669;30858.537121943187;31105.68894311073;900.0639335091562;1039.3711804358406;1094.9379102270784;1103.9172062095374;1123.326004397355;15630.921845390927;15653.621151872061;15711.135887526067;15871.52385428439;16042.358305667643;579052;689173;692310;694903;697084;59450.10824837631;59652.403475965555;59934.400655993755;60066.39933600696;60101.699491502266;1088.0697004061572;1143.188336281233;1341.597520743773;1345.3676771917183;1394.5258612071943;24430.389240269134;29662.406751865274;29663;30212.5468117974;30700.84649576827;50612.49387506225;51096;51246.231306531176;51297.23054154265;51308.97382052413;605017;606720;608690;613518;613831;26740.7325926746;26763.86618066897;26945.595816063167;27191.72808271892;27276.454470910074;48029.75985120052;48099.5190048095;48493.5150648489;49629.759256018886;49978.50021499739;39580.80209598933;39582.80208598939;40465;41006.384904225866;41759.7912010438;37014.44478332881;38824.611753883226;39575.80212098921;40337.79831100943;40686.79656601698;38640.6135938637;40712.59287407088;41234.587654123075;41313;41413.1717365657;32026.19934501656;34849.78025769086;34889.65110348864;35335.46996794999;35526.64473355233;20481;25893.74106258913;25991.48017039611;26210.95156193731;26564.468710626064 16:47:50 INFO - PROCESS | 1654 | |2;jquery.html;334.4915728093297;364.31145135693544;368.4822823932375;373.27957042907195;392.23122679548084;14747.262636868154;19416.223351065957;20995.63528370655;21023.159073637034;21289.14843406266;19900.601987960268;20647.277345292918;20936.895315523438;20941.581168376622;21520.892395538;5994.220751302336;6064.727087281083;6115.3884611538715;6199.194104766374;6203.937960620381;5352.759125839347;5946.643201407929;6071.453569178773;6124.448799608034;6137.324894261627;6000;6031.909521357183;6085.6348619083;6093.512518998492;6096.116063170837;5924.822255332347;6101.664408457533;6111;6117.755289788448;6130.877382452349;5219.634625576211;5226.55574276187;5254.238135470374;5305.938812237529;5314.096603577401;20988.16047358104;25438.109666161596;26005.609915851277;26359.34101647474;26667.733322666718;2285.0859656137513;2333.6849525314037;2955.994961713028;3116.4234616596004;3176.8093914365213;12517.93741031289;15544.455944041903;15613.921930390388;15744.212789360601;16280.75578866318;1845.750823638805;1883.0867029490687;1887.9150438230313;1922.298361098203;1967.6851703727477;112268;112646;115613;118672.21991670132;121081;10416.1667066636;10505.9474702626;11051.281666691639;11067;11264.43677816106;11384.658460246206;11475.827862582068;11502.309861408343;11743.706407339885;13710.38303276355;7369.484136110528;7607.315341619281;8373.455725377831;8442.324614030862;8512.191341822518;7310.853782924418;8185.836283274301;8780.956095219482;8783.604737786687;8992.235659968845;5546.029444847136;5880.941190588125;6583.275839657634;6606.517333808986;6731.427828634621;1747.1788259518007;1829;1830.496613431317;1832.58766777474;1837.118183272037;887.1616322575234;910.6539514984264;943.1370296179057;983.5918093990914;986.5215370545279;21921.451963700718;22281.888590556944;22302.330930072123;22716.432089197573;22728.318150455514;843.6161546496329;848.5841937450605;878.5168157513342;951.9952400237954;1004.2167109654481;8955.596998135099;11044.944775276072;11391.316521008766;11434.142439317084;11944.940275298743;510454;598998;605071;607258;621949;117967;135620.86781491694;136505.63494365127;148484;152510.23744881205;972.0910948263396;991.8512223166583;1013.3008224325192;1021.5760459409411;1046.2519298701466;18678.71981920245;19534.413967580997;19648.312309069115;19725.60548789045;19817.801821981597;56783.7286508535;57340.13989790073;57986.84026319534;58194;58628.4137158623;67610.3238967604;83150;84477;85209.57395212984;86144;6800.387965083166;6912.792616221522;8022.799430014296;8136;8466.915330846612;9277;12825.679358016125;13321.200727956353;13658.453661853415;13854.861451385761;11571.305721656727;11780.116491263017;11916.463759130687;12046.337451440255;12047.457864396298;9836.655717049869;11508.654740357802;11550.747604217433;11776.352300623548;11787.764244714886;11620.244684095507;11708.356040417859;12036.939815301217;12046.518139274682;12096.576619818265;7161.140663120251;7339.9266007341375;7539.321461068311;7786.727464538714;8272.793180170303;10153.64462243818;11606.70983225426;11891.10816688769;11915.582954596548;11950.282983021047 16:47:50 INFO - PROCESS | 1654 | |3;mootools.html;1543.3826469412238;1577.313868467217;1822.9062562462525;1885.9811401885977;1902.961940761185;7897.447178697494;8306.293965012967;8395.034571024335;8958.596863141158;8975.326850486215;8382.706605268817;8546.44448110874;8584.914150858489;8678.088800675932;8685.522296273703;2256.3569382725927;2301.1830800065986;2308.1113771198125;2308.665243539686;2316.733575638798;2253.11002154149;2309.607366747657;2324.2910912171783;2329.10329523134;2334.0897050150456;2301.309607117866;2314.0975019742314;2316.9884150579223;2320.814334853216;2323.721153461587;1974.4372853736688;2291.7937385635373;2297.425643589103;2299.321700098475;2300.1834348806183;2296.5866144094057;2297.5634629420356;2303.309007297804;2306.757790432014;2311.3528212100637;8718.520481373522;8749.868751968726;8775.64897404103;8778.692745753868;8778.912210877937;5145.125328694131;5274.10340242156;5276.7889284428575;5290.338707661543;5300.992811365828;3395.1172695099203;3451.758376913617;3595.6044835068124;3596.82015899204;3598.2623562169956;1026.4457193115709;1060.6446840308506;1062.3519653011656;1082.5236895765838;1086.1528008153653;11380.203385763;11409.60066397672;11549.191556591042;11619.6514104577;11648.835116488368;4487.326900964816;4568.862934111982;4715.434147902273;4751.881202969954;4767.213409787416;9864.704058878246;9954.054364835329;9970.35489144283;9981.151602113756;9994.400335979864;4943.876403089952;5268.762905669254;5297.761600727899;5311.601629877775;5315.01672190646;4326.307790753464;4350.456192975878;4590.403247577793;4791.353167322437;4823.662343635911;3260.396826587089;3912.980435097806;3978.900527486836;3992.401139829049;4076.735012224196;1262.3498898067503;1275.5663074554695;1282.8332316798756;1295.3393769177599;1296.4360503181147;836.8159005018886;883.6597909804772;920.1856357123994;921.0007142250599;926.6895589977433;5747.3103227612955;5915.881682366415;5950.7917222896995;6108;6180.289266734383;829.6142293833396;911.64901512918;944;952.1288021460286;962.8603852441357;4032.704064092798;4036.374361973899;4081.6938729594804;4140;4151.356539736285;9092.81814363709;9227.400218985744;10806.08148307387;10807.40559269232;10814;9125.726228213165;10771.299865508874;10815.242932994772;10816.837747433794;10824.837627435594;6776.7966960992235;8122.431429799857;8276.131006244377;8282.58587070644;8285.8342833143;5233.921491177559;5703.942960570341;5931.911021334769;6200.937990620036;6209.689515524296;9833.459159745997;9877.111060004634;9992.250581206294;10099.091081802673;10175.694729158136;10005.349652272578;10198.388096714221;10252.538635761557;10371;10452.529636166542;7028.8594228114125;7401.444891633257;7523.172451030492;7577.318041376303;7698.845173224061;8406.411551191359;8474.703385381483;8476.406651534333;8489.87265191035;8490.61792219364;7272.127344718668;7399.852002960019;7539.660715267716;7614.733484328022;7634.045744281965;7205.567665940061;7384.704611815468;7406.851862962818;7507.699692012258;7560.697572097055;6960.338767817049;6983.580985140908;7024.473164512579;7036.683349249193;7045.647717614202;4303.591158839905;4963.875903102306;5106.080905437057;5111.1311077117725;5167.811403377169;4295.892602684958;4978.850634480971;5012.248162775612;5244.292020577173;5283.947160528499 16:47:50 INFO - PROCESS | 1654 | |4;prototype.html;262.67428388797896;280.32162167554515;293.6916237950153;306.0970138092627;312.2739630359415;4365.886698891778;5163.993021360831;5381.919271210935;5530.529904958078;5617.550595952324;4597.42532183477;4755.762211889409;4794.520547945203;5213.879016011557;5426.399212232391;3500.3174380995715;3730.9253814923686;3904.75047984645;4003.938956176601;4293.3989241506215;3329.700326970572;3531.629178936213;4009.9198016039663;4162.188373267214;4223.61987421132;3897.694272418743;4012.3179059559798;4077.6533994610495;4123.649489793371;4148.357004664267;3703.6296370363016;3848.5958974307855;4089.8568550100754;4126.587341265879;4148.62662360389;3548.982255088734;3554.893353199408;3558.181618227822;3561.4123669594487;3580.7493475456727;4928.728919909404;5039.521245481674;5218.947810521884;5267.604929630293;5387.4073851876265;4331.263685173497;4686.250199968023;4691.577758001762;4701.717896926195;4712.9057418851435;5721.542276617861;5729.598928075036;5776.8844623107725;5786.739596718157;5786.768529258825;3267.7917529055912;3882.145927895858;3904.570497245301;3955.545112312092;3957.2679054374744;5104.923426148611;5777.768889244425;6101.694915254219;6151.292601350857;6189.412005859436;3315.8342082896243;3859.9421008684894;3994.900127496836;4001.779902105412;4016.718829681894;3541.327147841902;3915.9216815663526;3972.6821854252166;4032.5967403260024;4051.2707712612014;3919.3729003359326;4689.343491911135;4737.715737055788;4738.810447582058;4758.500357462486;5820.76716931318;5833.374981258451;5841.912371314434;5852.473277404969;5857.7949771757785;1286.1961274203622;1333.3200067965213;1349.9527516536873;1350.9392077356542;1365.6654119740726;819.4100247821559;825.9256666900008;889.2663552569156;919.3932004876749;920.6869664314031;5255.921161182585;5332.840014799563;5350.197470379474;5351.6788992659785;5365.356157261075;4650.953490465052;5130.127128807805;5166.560842328444;5581.237287542693;5856.707164641751;4634.791434385461;4736.360591320196;5178.6116041297055;5267.631265811433;5312.5218730314455;2278.735301907457;2322.897777511355;2545.6889701803584;2562.3722188064044;2570.4859028194437;4779.928301075487;4922.950770492249;4956.405231372259;5155.278261043457;5309.239195618334;4164.937525937114;4333.458317710286;4503.909921801545;4842.9319371727215;5510.531604813636;5692.402297758758;6205.983055506978;6218.129461875341;6322.810315690536;6323.620582765049;5995.400459953969;6028.6985650716415;6030.396960303934;6072.392760723892;6073.54234983592;5525.696086715269;5891.528677705859;5915.58590898633;5927.347991720993;5974.701264936823;5208.791648334176;5516.200150978166;5580.051391263414;6168.691565421801;6240.812775616739;3961.801909904551;3983.143624120828;3983.506185180557;3992.5246347264883;3995.420664003645;5265.3944796348915;5590.301212348457;5763.386251849489;5962.8968640801595;6016.939830601638;5351.59863010268;5740.712964351682;5846.766129354948;5887.146363777314;5917.272118565276;5774.249347584787;5826.242588463472;5828.59199856006;5861.769028504062;5866.354700982974;5512.090505066619;5665.376808551138;5700.315962084576;5725.456081672234;5725.51333136688;5792.247007888947;5808.883822323614;5846.473817356458;5870.911936320873;5888.116782482662;5454.863628409322;5683.163864391602;5692.459216374438;5695.063678349381;5758.596898217253 16:47:50 INFO - PROCESS | 1654 | |5;yui.html;706.3431009161479;709.6877373955459;710.9893351599724;743.7359737293258;819.455062383515;15193.392264309428;15681.607959800996;15842;15848.3660653574;17383.47849564515;15959;16073.196340183002;16099.678006439864;16099.83900161001;16275.51173464798;838.5890913452395;854.9871751923695;860.7503823891095;865.0830120072711;870.2820173356974;676.6954870308356;755.0976582983337;848.7708318753932;857.4041041476177;859.7420773767876;889.1508609278123;896.1620884473039;904.4708845325459;906.2568693671192;911.1935936696038;845.5898889038812;847.9872801908007;902.5938327752538;904.5025236120141;905.0587389115312;649.6134799794115;653.5882394091692;672.5393105722595;676.651524464901;677.4309579952863;15069;15103.093814371063;15286.464973725866;15380.230988450532;15428.537143885702;14378.496752613713;14381.496647617389;14407.639809004753;14449.205293708841;14553.490627827976;11745.823812642817;12069.879301207051;12089.516419343216;12303;12395.194312369757;3754.3242216401036;3784.8486060557543;3815.8473661053804;3831.3678243089857;3953.525576930787;114599.42700286445;116176.25735613973;116772.8322716779;117427.65144697059;117976;9030.63877444908;10297.897021029843;11037.503312350964;11111.444427778579;11154.996050355507;22168.778312216993;22350.60731563014;22810.543789124124;22862.42843928915;22886;7793.649285782153;8106.148854370206;8156.836863262702;8260.256576908107;8431.95784021076;4644.628429725613;4653.95346046542;4677.2750223715375;4748.738819364899;4816.95183048172;3445.397055515325;3550.0237434705145;3584.8207589620415;3592.137886907176;3605.387084195693;615.6398506873439;641.9807405777834;653.8626888353499;661.1735330836455;664.4584663499329;613.352912677121;681.4820736240493;690.4993879437468;697.5152269172978;710.733474946895;8611.354148438892;9464.148226659634;9497.015436371506;9645.469499177472;9784.804303914025;582.7202942587581;596.4125336543501;669.2450141742944;688.721067967474;696.8919817428307;4455.6658250631335;4572.611328037154;4580.725156490555;4591.357209990604;4609.492886062462;140672;145317;148562;149971.2501437486;156080.21959890128;125743.74256257503;126717;129102;137768.31115844558;143448.84826727607;84898.15101849026;106105.99999999846;109671;110600;112056.4397178009;7634.732784352521;9729.854052189365;9886.357386769838;10002.349847259904;10044.748881278027;59571.40428595659;60666.393336066074;62598.37401626108;63664.68167659317;64117.67941160264;65886;73309.6334518324;76973;80425.391492171;85482;13429.19424834474;13612;13681.931590341985;13719.725605488034;13836.308184590529;15211.771823422436;15378.872342119968;15613;15899.364025438854;16038.278277477308;13295.66760830987;13667.931660342032;13743.587692369245;14388.784168237275;14392.928035359757;14289.571312860631;14436.855631443552;14623;14841.183734894252;14971.92514037423;13665.316734163052;13853.722925541231;13889.888808895063;14169.22069286199;14301.09393991996;10836.75377331617;11201.495932682887;11318.660440186808;11459.022016314628;12073.879261207276;8487.321014318963;9796.363236389612;10793.244472886823;11507.769844603228;11691.532338706356 16:47:50 INFO - PROCESS | 1654 | __end_tp_report 16:47:50 INFO - PROCESS | 1654 | __start_cc_report 16:47:50 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,415 16:47:50 INFO - PROCESS | 1654 | __end_cc_report 16:47:50 INFO - PROCESS | 1654 | __startTimestamp1470872870269__endTimestamp 16:47:50 INFO - PROCESS | 1654 | 16:47:50 INFO - PROCESS | 1654 | ------- Summary: start ------- 16:47:50 INFO - PROCESS | 1654 | Number of tests: 6 16:47:50 INFO - PROCESS | 1654 | 16:47:50 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5684.27 Median:5916.91 stddev:679.08 (11.5%) stddev-sans-first:638.25 16:47:50 INFO - PROCESS | 1654 | Values: 2655.7 3360.3 3399.2 3413.4 3427.0 4795.9 4946.4 5606.6 5636.9 5684.5 5517.5 5675.7 5742.7 5752.0 5883.0 5175.3 5231.7 5319.8 5336.4 5341.7 5165.8 5316.7 5319.6 5413.8 5417.7 4007.9 5079.2 5167.2 5170.7 5236.6 5212.1 5218.3 5222.0 5224.3 5225.5 5149.5 5196.7 5205.8 5214.6 5245.1 4316.8 5560.9 5671.3 5756.3 5811.8 6147.5 6190.8 6194.2 6218.1 6221.3 6195.9 6259.1 6265.2 6274.8 6307.7 5600.6 5690.8 5722.5 5767.5 5826.3 6189.7 6236.7 6236.7 6239.7 6270.6 6065.7 6102.0 6129.3 6129.5 6151.4 6036.3 6159.4 6178.2 6191.6 6274.6 5794.1 6140.2 6143.4 6151.9 6238.2 4632.8 5977.1 6224.3 6249.5 6264.3 4480.8 4752.5 4843.0 4876.2 4904.2 4405.8 4409.6 4433.4 4447.1 4504.4 5484.1 5503.5 5503.9 5786.8 5803.7 6125.0 6139.5 6170.1 6223.4 6247.0 5752.8 5759.0 5766.6 5773.3 5833.4 5350.3 5359.2 5381.8 5392.3 5407.2 6146.8 6160.5 6181.7 6259.8 6265.8 6220.7 6223.5 6236.4 6256.7 6268.4 6266.9 6288.6 6293.7 6299.7 6301.7 6009.0 6099.1 6100.5 6141.1 6156.8 6015.4 6136.5 6198.2 6240.2 6248.2 6109.9 6128.6 6134.1 6146.9 6154.9 5017.6 5861.1 6115.4 6128.8 6135.2 5779.7 5955.5 6028.2 6031.1 6068.4 6136.6 6155.0 6155.5 6164.6 6173.5 5840.4 5869.7 5916.9 6064.5 6078.1 16:47:50 INFO - PROCESS | 1654 | 16:47:50 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:71877.92 Median:40859.49 stddev:159547.85 (390.5%) stddev-sans-first:159905.33 16:47:50 INFO - PROCESS | 1654 | Values: 466.0 470.6 494.1 518.7 545.1 35658.8 41052.6 41052.6 41054.0 41118.6 42017.6 42678.6 42712.8 42739.1 42811.7 9616.5 9819.9 9824.0 9827.8 9842.7 9704.9 9799.0 9831.0 9838.9 9856.0 9791.8 9847.3 9860.4 9861.7 9866.5 9737.5 9824.1 9833.2 9837.1 9852.4 9653.8 9755.1 9763.7 9783.4 9797.1 33326.3 39642.6 39710.8 39867.8 39970.4 2572.6 2998.0 3201.9 3441.6 4231.8 31056.1 31839.4 32179.0 33339.7 33350.3 3238.0 3256.8 3278.1 3279.2 3365.7 463626.0 479769.0 502484.0 507640.0 509027.5 62856.0 63156.0 63572.4 63612.4 63738.7 34589.1 34882.0 35443.9 36160.0 66394.0 16540.8 16641.3 16703.2 16844.4 16847.7 10803.9 12773.7 12808.8 12838.3 12857.2 19121.3 19596.6 19661.4 19661.4 19663.4 6864.5 7888.3 7919.6 7949.4 8030.7 876.8 938.4 1020.1 1029.2 1078.7 24419.9 30366.0 30518.5 30858.5 31105.7 900.1 1039.4 1094.9 1103.9 1123.3 15630.9 15653.6 15711.1 15871.5 16042.4 579052.0 689173.0 692310.0 694903.0 697084.0 59450.1 59652.4 59934.4 60066.4 60101.7 1088.1 1143.2 1341.6 1345.4 1394.5 24430.4 29662.4 29663.0 30212.5 30700.8 50612.5 51096.0 51246.2 51297.2 51309.0 605017.0 606720.0 608690.0 613518.0 613831.0 26740.7 26763.9 26945.6 27191.7 27276.5 48029.8 48099.5 48493.5 49629.8 49978.5 39580.8 39582.8 40465.0 41006.4 41759.8 37014.4 38824.6 39575.8 40337.8 40686.8 38640.6 40712.6 41234.6 41313.0 41413.2 32026.2 34849.8 34889.7 35335.5 35526.6 20481.0 25893.7 25991.5 26211.0 26564.5 16:47:50 INFO - PROCESS | 1654 | 16:47:50 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:35406.50 Median:26182.48 stddev:98869.20 (377.6%) stddev-sans-first:99111.48 16:47:50 INFO - PROCESS | 1654 | Values: 334.5 364.3 368.5 373.3 392.2 14747.3 19416.2 20995.6 21023.2 21289.1 19900.6 20647.3 20936.9 20941.6 21520.9 5994.2 6064.7 6115.4 6199.2 6203.9 5352.8 5946.6 6071.5 6124.4 6137.3 6000.0 6031.9 6085.6 6093.5 6096.1 5924.8 6101.7 6111.0 6117.8 6130.9 5219.6 5226.6 5254.2 5305.9 5314.1 20988.2 25438.1 26005.6 26359.3 26667.7 2285.1 2333.7 2956.0 3116.4 3176.8 12517.9 15544.5 15613.9 15744.2 16280.8 1845.8 1883.1 1887.9 1922.3 1967.7 112268.0 112646.0 115613.0 118672.2 121081.0 10416.2 10505.9 11051.3 11067.0 11264.4 11384.7 11475.8 11502.3 11743.7 13710.4 7369.5 7607.3 8373.5 8442.3 8512.2 7310.9 8185.8 8781.0 8783.6 8992.2 5546.0 5880.9 6583.3 6606.5 6731.4 1747.2 1829.0 1830.5 1832.6 1837.1 887.2 910.7 943.1 983.6 986.5 21921.5 22281.9 22302.3 22716.4 22728.3 843.6 848.6 878.5 952.0 1004.2 8955.6 11044.9 11391.3 11434.1 11944.9 510454.0 598998.0 605071.0 607258.0 621949.0 117967.0 135620.9 136505.6 148484.0 152510.2 972.1 991.9 1013.3 1021.6 1046.3 18678.7 19534.4 19648.3 19725.6 19817.8 56783.7 57340.1 57986.8 58194.0 58628.4 67610.3 83150.0 84477.0 85209.6 86144.0 6800.4 6912.8 8022.8 8136.0 8466.9 9277.0 12825.7 13321.2 13658.5 13854.9 11571.3 11780.1 11916.5 12046.3 12047.5 9836.7 11508.7 11550.7 11776.4 11787.8 11620.2 11708.4 12036.9 12046.5 12096.6 7161.1 7339.9 7539.3 7786.7 8272.8 10153.6 11606.7 11891.1 11915.6 11950.3 16:47:50 INFO - PROCESS | 1654 | 16:47:50 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5673.49 Median:5108.61 stddev:3173.93 (62.1%) stddev-sans-first:3167.66 16:47:50 INFO - PROCESS | 1654 | Values: 1543.4 1577.3 1822.9 1886.0 1903.0 7897.4 8306.3 8395.0 8958.6 8975.3 8382.7 8546.4 8584.9 8678.1 8685.5 2256.4 2301.2 2308.1 2308.7 2316.7 2253.1 2309.6 2324.3 2329.1 2334.1 2301.3 2314.1 2317.0 2320.8 2323.7 1974.4 2291.8 2297.4 2299.3 2300.2 2296.6 2297.6 2303.3 2306.8 2311.4 8718.5 8749.9 8775.6 8778.7 8778.9 5145.1 5274.1 5276.8 5290.3 5301.0 3395.1 3451.8 3595.6 3596.8 3598.3 1026.4 1060.6 1062.4 1082.5 1086.2 11380.2 11409.6 11549.2 11619.7 11648.8 4487.3 4568.9 4715.4 4751.9 4767.2 9864.7 9954.1 9970.4 9981.2 9994.4 4943.9 5268.8 5297.8 5311.6 5315.0 4326.3 4350.5 4590.4 4791.4 4823.7 3260.4 3913.0 3978.9 3992.4 4076.7 1262.3 1275.6 1282.8 1295.3 1296.4 836.8 883.7 920.2 921.0 926.7 5747.3 5915.9 5950.8 6108.0 6180.3 829.6 911.6 944.0 952.1 962.9 4032.7 4036.4 4081.7 4140.0 4151.4 9092.8 9227.4 10806.1 10807.4 10814.0 9125.7 10771.3 10815.2 10816.8 10824.8 6776.8 8122.4 8276.1 8282.6 8285.8 5233.9 5703.9 5931.9 6200.9 6209.7 9833.5 9877.1 9992.3 10099.1 10175.7 10005.3 10198.4 10252.5 10371.0 10452.5 7028.9 7401.4 7523.2 7577.3 7698.8 8406.4 8474.7 8476.4 8489.9 8490.6 7272.1 7399.9 7539.7 7614.7 7634.0 7205.6 7384.7 7406.9 7507.7 7560.7 6960.3 6983.6 7024.5 7036.7 7045.6 4303.6 4963.9 5106.1 5111.1 5167.8 4295.9 4978.9 5012.2 5244.3 5283.9 16:47:50 INFO - PROCESS | 1654 | 16:47:50 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4594.04 Median:5172.59 stddev:1461.43 (28.3%) stddev-sans-first:1428.91 16:47:50 INFO - PROCESS | 1654 | Values: 262.7 280.3 293.7 306.1 312.3 4365.9 5164.0 5381.9 5530.5 5617.6 4597.4 4755.8 4794.5 5213.9 5426.4 3500.3 3730.9 3904.8 4003.9 4293.4 3329.7 3531.6 4009.9 4162.2 4223.6 3897.7 4012.3 4077.7 4123.6 4148.4 3703.6 3848.6 4089.9 4126.6 4148.6 3549.0 3554.9 3558.2 3561.4 3580.7 4928.7 5039.5 5218.9 5267.6 5387.4 4331.3 4686.3 4691.6 4701.7 4712.9 5721.5 5729.6 5776.9 5786.7 5786.8 3267.8 3882.1 3904.6 3955.5 3957.3 5104.9 5777.8 6101.7 6151.3 6189.4 3315.8 3859.9 3994.9 4001.8 4016.7 3541.3 3915.9 3972.7 4032.6 4051.3 3919.4 4689.3 4737.7 4738.8 4758.5 5820.8 5833.4 5841.9 5852.5 5857.8 1286.2 1333.3 1350.0 1350.9 1365.7 819.4 825.9 889.3 919.4 920.7 5255.9 5332.8 5350.2 5351.7 5365.4 4651.0 5130.1 5166.6 5581.2 5856.7 4634.8 4736.4 5178.6 5267.6 5312.5 2278.7 2322.9 2545.7 2562.4 2570.5 4779.9 4923.0 4956.4 5155.3 5309.2 4164.9 4333.5 4503.9 4842.9 5510.5 5692.4 6206.0 6218.1 6322.8 6323.6 5995.4 6028.7 6030.4 6072.4 6073.5 5525.7 5891.5 5915.6 5927.3 5974.7 5208.8 5516.2 5580.1 6168.7 6240.8 3961.8 3983.1 3983.5 3992.5 3995.4 5265.4 5590.3 5763.4 5962.9 6016.9 5351.6 5740.7 5846.8 5887.1 5917.3 5774.2 5826.2 5828.6 5861.8 5866.4 5512.1 5665.4 5700.3 5725.5 5725.5 5792.2 5808.9 5846.5 5870.9 5888.1 5454.9 5683.2 5692.5 5695.1 5758.6 16:47:50 INFO - PROCESS | 1654 | 16:47:50 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:24767.16 Median:3588.48 stddev:39274.09 (1094.4%) stddev-sans-first:39342.71 16:47:50 INFO - PROCESS | 1654 | Values: 706.3 709.7 711.0 743.7 819.5 15193.4 15681.6 15842.0 15848.4 17383.5 15959.0 16073.2 16099.7 16099.8 16275.5 838.6 855.0 860.8 865.1 870.3 676.7 755.1 848.8 857.4 859.7 889.2 896.2 904.5 906.3 911.2 845.6 848.0 902.6 904.5 905.1 649.6 653.6 672.5 676.7 677.4 15069.0 15103.1 15286.5 15380.2 15428.5 14378.5 14381.5 14407.6 14449.2 14553.5 11745.8 12069.9 12089.5 12303.0 12395.2 3754.3 3784.8 3815.8 3831.4 3953.5 114599.4 116176.3 116772.8 117427.7 117976.0 9030.6 10297.9 11037.5 11111.4 11155.0 22168.8 22350.6 22810.5 22862.4 22886.0 7793.6 8106.1 8156.8 8260.3 8432.0 4644.6 4654.0 4677.3 4748.7 4817.0 3445.4 3550.0 3584.8 3592.1 3605.4 615.6 642.0 653.9 661.2 664.5 613.4 681.5 690.5 697.5 710.7 8611.4 9464.1 9497.0 9645.5 9784.8 582.7 596.4 669.2 688.7 696.9 4455.7 4572.6 4580.7 4591.4 4609.5 140672.0 145317.0 148562.0 149971.3 156080.2 125743.7 126717.0 129102.0 137768.3 143448.8 84898.2 106106.0 109671.0 110600.0 112056.4 7634.7 9729.9 9886.4 10002.3 10044.7 59571.4 60666.4 62598.4 63664.7 64117.7 65886.0 73309.6 76973.0 80425.4 85482.0 13429.2 13612.0 13681.9 13719.7 13836.3 15211.8 15378.9 15613.0 15899.4 16038.3 13295.7 13667.9 13743.6 14388.8 14392.9 14289.6 14436.9 14623.0 14841.2 14971.9 13665.3 13853.7 13889.9 14169.2 14301.1 10836.8 11201.5 11318.7 11459.0 12073.9 8487.3 9796.4 10793.2 11507.8 11691.5 16:47:50 INFO - PROCESS | 1654 | -------- Summary: end -------- 16:47:50 INFO - PROCESS | 1654 | 16:47:50 INFO - TEST-INFO | 1654: exit 0 16:47:50 INFO - TEST-OK | dromaeo_css | took 1113264ms 16:47:50 INFO - TEST-START | kraken 16:47:50 INFO - operating with platform_type : mac_ 16:47:50 INFO - Initialising browser for kraken test... 16:47:50 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmpyEU0SR/profile http://localhost:49271/getInfo.html) 16:47:53 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 16:47:53 INFO - PROCESS | 1666 | colorDepth:24 16:47:53 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 16:47:53 INFO - PROCESS | 1666 | __metrics 16:47:53 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:47:54 INFO - TEST-INFO | 1666: exit 0 16:47:54 INFO - Browser initialized. 16:47:54 INFO - Running cycle 1/1 for kraken test... 16:47:54 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmpyEU0SR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:48:06 INFO - PROCESS | 1668 | RSS: Main: 254939136 16:48:06 INFO - PROCESS | 1668 | 16:48:09 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 16:48:09 INFO - PROCESS | 1668 | RSS: Main: 267436032 16:48:09 INFO - PROCESS | 1668 | 16:48:12 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 16:48:13 INFO - PROCESS | 1668 | RSS: Main: 276725760 16:48:13 INFO - PROCESS | 1668 | 16:48:17 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 16:48:17 INFO - PROCESS | 1668 | RSS: Main: 279093248 16:48:17 INFO - PROCESS | 1668 | 16:48:19 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 16:48:20 INFO - PROCESS | 1668 | RSS: Main: 281399296 16:48:20 INFO - PROCESS | 1668 | 16:48:22 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:48:23 INFO - PROCESS | 1668 | RSS: Main: 282005504 16:48:23 INFO - PROCESS | 1668 | 16:48:26 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 16:48:26 INFO - PROCESS | 1668 | RSS: Main: 282017792 16:48:26 INFO - PROCESS | 1668 | 16:48:29 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 16:48:30 INFO - PROCESS | 1668 | RSS: Main: 282275840 16:48:30 INFO - PROCESS | 1668 | 16:48:33 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 16:48:33 INFO - PROCESS | 1668 | RSS: Main: 282365952 16:48:33 INFO - PROCESS | 1668 | 16:48:35 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:48:36 INFO - PROCESS | 1668 | RSS: Main: 282140672 16:48:36 INFO - PROCESS | 1668 | 16:48:38 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:48:38 INFO - PROCESS | 1668 | RSS: Main: 282193920 16:48:38 INFO - PROCESS | 1668 | 16:48:40 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:48:41 INFO - PROCESS | 1668 | RSS: Main: 282550272 16:48:41 INFO - PROCESS | 1668 | 16:48:44 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:48:45 INFO - PROCESS | 1668 | RSS: Main: 282673152 16:48:45 INFO - PROCESS | 1668 | 16:48:47 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:48:48 INFO - PROCESS | 1668 | RSS: Main: 282587136 16:48:48 INFO - PROCESS | 1668 | 16:48:50 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 16:48:50 INFO - PROCESS | 1668 | RSS: Main: 283389952 16:48:50 INFO - PROCESS | 1668 | 16:48:50 INFO - PROCESS | 1668 | __start_tp_report 16:48:50 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 16:48:50 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 16:48:50 INFO - PROCESS | 1668 | |i|pagename|runs| 16:48:50 INFO - PROCESS | 1668 | |0;ai-astar;103;113;106;116;134;160;113;116;117;149 16:48:50 INFO - PROCESS | 1668 | |1;audio-beat-detection;168;108;166;165;113;131;132;134;204;142 16:48:50 INFO - PROCESS | 1668 | |2;audio-dft;282;199;270;275;206;178;268;280;240;198 16:48:50 INFO - PROCESS | 1668 | |3;audio-fft;68;79;84;179;51;67;86;86;162;51 16:48:50 INFO - PROCESS | 1668 | |4;audio-oscillator;69;76;126;71;73;76;138;92;74;116 16:48:50 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;135;114;88;97;114;85;112;76;121;131 16:48:50 INFO - PROCESS | 1668 | |6;imaging-darkroom;150;98;95;96;95;96;96;97;95;95 16:48:50 INFO - PROCESS | 1668 | |7;imaging-desaturate;91;91;92;95;95;114;114;91;88;90 16:48:50 INFO - PROCESS | 1668 | |8;json-parse-financial;55;60;58;57;60;56;58;59;58;57 16:48:50 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;68;71;71;77;78;75;73;73;73;73 16:48:50 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;86;83;87;85;89;106;98;104;89;81 16:48:50 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;150;154;130;138;138;136;139;149;169;142 16:48:50 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;168;167;165;168;167;167;168;170;171;168 16:48:50 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;66;69;66;68;68;66;67;68;69;68 16:48:50 INFO - PROCESS | 1668 | __end_tp_report 16:48:50 INFO - PROCESS | 1668 | __start_cc_report 16:48:50 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1062 16:48:50 INFO - PROCESS | 1668 | __end_cc_report 16:48:50 INFO - PROCESS | 1668 | __startTimestamp1470872930537__endTimestamp 16:48:50 INFO - PROCESS | 1668 | 16:48:50 INFO - PROCESS | 1668 | ------- Summary: start ------- 16:48:50 INFO - PROCESS | 1668 | Number of tests: 14 16:48:50 INFO - PROCESS | 1668 | 16:48:50 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:122.70 Median:116.50 stddev:18.82 (16.2%) stddev-sans-first:18.56 16:48:50 INFO - PROCESS | 1668 | Values: 103.0 113.0 106.0 116.0 134.0 160.0 113.0 116.0 117.0 149.0 16:48:50 INFO - PROCESS | 1668 | 16:48:50 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:153.50 stddev:29.29 (19.1%) stddev-sans-first:30.00 16:48:50 INFO - PROCESS | 1668 | Values: 168.0 108.0 166.0 165.0 113.0 131.0 132.0 134.0 204.0 142.0 16:48:50 INFO - PROCESS | 1668 | 16:48:50 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:239.60 Median:269.00 stddev:40.44 (15.0%) stddev-sans-first:39.87 16:48:50 INFO - PROCESS | 1668 | Values: 282.0 199.0 270.0 275.0 206.0 178.0 268.0 280.0 240.0 198.0 16:48:50 INFO - PROCESS | 1668 | 16:48:50 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:91.30 Median:73.50 stddev:43.88 (59.7%) stddev-sans-first:45.73 16:48:50 INFO - PROCESS | 1668 | Values: 68.0 79.0 84.0 179.0 51.0 67.0 86.0 86.0 162.0 51.0 16:48:50 INFO - PROCESS | 1668 | 16:48:50 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:73.50 stddev:25.83 (35.1%) stddev-sans-first:26.13 16:48:50 INFO - PROCESS | 1668 | Values: 69.0 76.0 126.0 71.0 73.0 76.0 138.0 92.0 74.0 116.0 16:48:50 INFO - PROCESS | 1668 | 16:48:50 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:107.30 Median:105.50 stddev:19.96 (18.9%) stddev-sans-first:18.48 16:48:50 INFO - PROCESS | 1668 | Values: 135.0 114.0 88.0 97.0 114.0 85.0 112.0 76.0 121.0 131.0 16:48:50 INFO - PROCESS | 1668 | 16:48:50 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:101.30 Median:96.00 stddev:17.14 (17.9%) stddev-sans-first:1.05 16:48:50 INFO - PROCESS | 1668 | Values: 150.0 98.0 95.0 96.0 95.0 96.0 96.0 97.0 95.0 95.0 16:48:50 INFO - PROCESS | 1668 | 16:48:50 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:91.00 stddev:9.67 (10.6%) stddev-sans-first:10.07 16:48:50 INFO - PROCESS | 1668 | Values: 91.0 91.0 92.0 95.0 95.0 114.0 114.0 91.0 88.0 90.0 16:48:50 INFO - PROCESS | 1668 | 16:48:50 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:1.62 (2.8%) stddev-sans-first:1.36 16:48:50 INFO - PROCESS | 1668 | Values: 55.0 60.0 58.0 57.0 60.0 56.0 58.0 59.0 58.0 57.0 16:48:50 INFO - PROCESS | 1668 | 16:48:50 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:73.20 Median:73.00 stddev:2.94 (4.0%) stddev-sans-first:2.44 16:48:50 INFO - PROCESS | 1668 | Values: 68.0 71.0 71.0 77.0 78.0 75.0 73.0 73.0 73.0 73.0 16:48:50 INFO - PROCESS | 1668 | 16:48:50 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:90.80 Median:86.50 stddev:8.77 (10.1%) stddev-sans-first:9.12 16:48:50 INFO - PROCESS | 1668 | Values: 86.0 83.0 87.0 85.0 89.0 106.0 98.0 104.0 89.0 81.0 16:48:50 INFO - PROCESS | 1668 | 16:48:50 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:144.50 Median:145.50 stddev:11.28 (7.8%) stddev-sans-first:11.78 16:48:50 INFO - PROCESS | 1668 | Values: 150.0 154.0 130.0 138.0 138.0 136.0 139.0 149.0 169.0 142.0 16:48:50 INFO - PROCESS | 1668 | 16:48:50 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:168.00 stddev:1.66 (1.0%) stddev-sans-first:1.76 16:48:50 INFO - PROCESS | 1668 | Values: 168.0 167.0 165.0 168.0 167.0 167.0 168.0 170.0 171.0 168.0 16:48:50 INFO - PROCESS | 1668 | 16:48:50 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.18 (1.7%) stddev-sans-first:1.12 16:48:50 INFO - PROCESS | 1668 | Values: 66.0 69.0 66.0 68.0 68.0 66.0 67.0 68.0 69.0 68.0 16:48:50 INFO - PROCESS | 1668 | -------- Summary: end -------- 16:48:50 INFO - PROCESS | 1668 | 16:48:51 INFO - TEST-INFO | 1668: exit 0 16:48:51 INFO - TEST-OK | kraken | took 60576ms 16:48:51 INFO - SUITE-END | took 1173s 16:48:51 INFO - Completed test suite (00:19:34) 16:48:51 INFO - javascript benchmark 16:48:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7404.097259985466, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2655.721149279326, 3360.327934413118, 3399.2351720862807, 3413.4197186478295, 3426.9890382337207, 4795.880102997427, 4946.431160416553, 5606.55147588193, 5636.859078523039, 5684.5332908569635, 5517.475839795223, 5675.744591493382, 5742.6841523716175, 5752.0, 5883.0, 5175.275461435393, 5231.712255825928, 5319.813806516772, 5336.38631557372, 5341.679499230039, 5165.81919632813, 5316.73416329184, 5319.627626066177, 5413.810516631918, 5417.674939503642, 4007.8777942176093, 5079.187330027215, 5167.199084141964, 5170.741462926876, 5236.607254455893, 5212.061828870802, 5218.321618189649, 5221.973890130525, 5224.320838291036, 5225.503577160163, 5149.510796474329, 5196.662216955886, 5205.765740541685, 5214.634975551713, 5245.134552798783, 4316.805743741539, 5560.916586251209, 5671.319441666985, 5756.251687280668, 5811.82564523065, 6147.47746441553, 6190.81427557174, 6194.225721784777, 6218.067289906505, 6221.346758590328, 6195.887984395833, 6259.061140828912, 6265.185525881606, 6274.843128921768, 6307.684615769193, 5600.5799565032785, 5690.772369105231, 5722.513586345124, 5767.509761670305, 5826.271716035496, 6189.731105123529, 6236.656983865841, 6236.656983865841, 6239.719212635442, 6270.561060725797, 6065.721977753093, 6102.0, 6129.325774164839, 6129.540284478593, 6151.3541078186145, 6036.275646922398, 6159.384061593894, 6178.196834411498, 6191.566590338633, 6274.592151510137, 5794.1308803679785, 6140.197513349931, 6143.416375444325, 6151.876962460726, 6238.220222472191, 4632.791524381411, 5977.103434484775, 6224.346443623445, 6249.500039996789, 6264.279607845065, 4480.7535585542455, 4752.52474752522, 4842.975785121052, 4876.244182151701, 4904.215325547895, 4405.757683327448, 4409.581089796464, 4433.401490798766, 4447.110577884436, 4504.414426124583, 5484.149956756709, 5503.486541201201, 5503.944960550423, 5786.797462088806, 5803.6807975560905, 6124.960759790047, 6139.4781443577795, 6170.10533472644, 6223.439890409885, 6247.031710084944, 5752.798652047159, 5759.0, 5766.567507436959, 5773.336066352339, 5833.445822646841, 5350.304460420199, 5359.196120581944, 5381.811636592701, 5392.299001129828, 5407.242985981966, 6146.815595532052, 6160.507159427325, 6181.721822517908, 6259.78090766821, 6265.843353916189, 6220.688965551613, 6223.502119830312, 6236.438720515175, 6256.687165641791, 6268.435840774352, 6266.874662506815, 6288.5598008138995, 6293.653849038164, 6299.748010079546, 6301.7164227608955, 6009.0, 6099.128199784669, 6100.511959043355, 6141.140240366263, 6156.78451254204, 6015.428534289235, 6136.457808108435, 6198.194234749454, 6240.219972503437, 6248.187735594525, 6109.938900610937, 6128.601640893327, 6134.14122022926, 6146.877062458815, 6154.922888494406, 5017.62367822422, 5861.0915308127305, 6115.388461153849, 6128.846778830565, 6135.233095863017, 5779.7110144493445, 5955.464008239279, 6028.246469191351, 6031.095335699505, 6068.362821903636, 6136.631802091889, 6155.0, 6155.507559395327, 6164.630122192682, 6173.536984726074, 5840.445157710011, 5869.706514674334, 5916.911246331222, 6064.545159112996, 6078.088286757022], "value": 5640.645735756303, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.99068018639605, 470.58588442170895, 494.0810093226598, 518.6861948521145, 545.1033050631713, 35658.82170589147, 41052.58947410525, 41052.58947410529, 41054.0, 41118.58881411185, 42017.57982420175, 42678.573214267926, 42712.78643606778, 42739.14521709564, 42811.71564853052, 9616.519174041305, 9819.852702209473, 9823.95088024559, 9827.754306142333, 9842.655507057254, 9704.902950970505, 9799.0, 9830.9508452458, 9838.901610983907, 9855.950720246388, 9791.755206119868, 9847.261455390839, 9860.408375497493, 9861.654842080528, 9866.506674666274, 9737.464439455827, 9824.06671366219, 9833.213342932548, 9837.114659680663, 9852.408855468695, 9653.806923861483, 9755.12203901645, 9763.658271960447, 9783.41299522031, 9797.118259356692, 33326.33347333064, 39642.60357396418, 39710.808675739776, 39867.8006609968, 39970.40044399336, 2572.588385858254, 2998.0, 3201.855916483764, 3441.5698037745283, 4231.830726770956, 31056.068317950496, 31839.363212735614, 32179.0, 33339.6666033339, 33350.33299334024, 3237.96762032379, 3256.7557433192605, 3278.1149089745636, 3279.1638132276357, 3365.6970872621337, 463626.0, 479769.0, 502484.0, 507640.0, 509027.454862727, 62856.0, 63156.0, 63572.364276356646, 63612.36387636064, 63738.681306594095, 34589.13527161841, 34882.0, 35443.936681899584, 36160.0, 66394.0, 16540.75188872168, 16641.33434662624, 16703.16484175786, 16844.410445634345, 16847.747283790508, 10803.945980270048, 12773.744525109445, 12808.80786788199, 12838.293893835742, 12857.228566286052, 19121.309405806245, 19596.608067838562, 19661.410157695005, 19661.410157695293, 19663.41009769709, 6864.450843932574, 7888.32949199313, 7919.643616037177, 7949.403794715419, 8030.718924837603, 876.8246350729752, 938.4463166731662, 1020.1430798129607, 1029.1818004686143, 1078.6763970808884, 24419.877900610383, 30366.0, 30518.54222186669, 30858.537121943187, 31105.68894311073, 900.0639335091562, 1039.3711804358406, 1094.9379102270784, 1103.9172062095374, 1123.326004397355, 15630.921845390927, 15653.621151872061, 15711.135887526067, 15871.52385428439, 16042.358305667643, 579052.0, 689173.0, 692310.0, 694903.0, 697084.0, 59450.10824837631, 59652.403475965555, 59934.400655993755, 60066.39933600696, 60101.699491502266, 1088.0697004061572, 1143.188336281233, 1341.597520743773, 1345.3676771917183, 1394.5258612071943, 24430.389240269134, 29662.406751865274, 29663.0, 30212.5468117974, 30700.84649576827, 50612.49387506225, 51096.0, 51246.231306531176, 51297.23054154265, 51308.97382052413, 605017.0, 606720.0, 608690.0, 613518.0, 613831.0, 26740.7325926746, 26763.86618066897, 26945.595816063167, 27191.72808271892, 27276.454470910074, 48029.75985120052, 48099.5190048095, 48493.5150648489, 49629.759256018886, 49978.50021499739, 39580.80209598933, 39582.80208598939, 40465.0, 41006.384904225866, 41759.7912010438, 37014.44478332881, 38824.611753883226, 39575.80212098921, 40337.79831100943, 40686.79656601698, 38640.6135938637, 40712.59287407088, 41234.587654123075, 41313.0, 41413.1717365657, 32026.19934501656, 34849.78025769086, 34889.65110348864, 35335.46996794999, 35526.64473355233, 20481.0, 25893.74106258913, 25991.48017039611, 26210.95156193731, 26564.468710626064], "value": 19999.278176068092, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.4915728093297, 364.31145135693544, 368.4822823932375, 373.27957042907195, 392.23122679548084, 14747.262636868154, 19416.223351065957, 20995.63528370655, 21023.159073637034, 21289.14843406266, 19900.601987960268, 20647.277345292918, 20936.895315523438, 20941.581168376622, 21520.892395538, 5994.220751302336, 6064.727087281083, 6115.3884611538715, 6199.194104766374, 6203.937960620381, 5352.759125839347, 5946.643201407929, 6071.453569178773, 6124.448799608034, 6137.324894261627, 6000.0, 6031.909521357183, 6085.6348619083, 6093.512518998492, 6096.116063170837, 5924.822255332347, 6101.664408457533, 6111.0, 6117.755289788448, 6130.877382452349, 5219.634625576211, 5226.55574276187, 5254.238135470374, 5305.938812237529, 5314.096603577401, 20988.16047358104, 25438.109666161596, 26005.609915851277, 26359.34101647474, 26667.733322666718, 2285.0859656137513, 2333.6849525314037, 2955.994961713028, 3116.4234616596004, 3176.8093914365213, 12517.93741031289, 15544.455944041903, 15613.921930390388, 15744.212789360601, 16280.75578866318, 1845.750823638805, 1883.0867029490687, 1887.9150438230313, 1922.298361098203, 1967.6851703727477, 112268.0, 112646.0, 115613.0, 118672.21991670132, 121081.0, 10416.1667066636, 10505.9474702626, 11051.281666691639, 11067.0, 11264.43677816106, 11384.658460246206, 11475.827862582068, 11502.309861408343, 11743.706407339885, 13710.38303276355, 7369.484136110528, 7607.315341619281, 8373.455725377831, 8442.324614030862, 8512.191341822518, 7310.853782924418, 8185.836283274301, 8780.956095219482, 8783.604737786687, 8992.235659968845, 5546.029444847136, 5880.941190588125, 6583.275839657634, 6606.517333808986, 6731.427828634621, 1747.1788259518007, 1829.0, 1830.496613431317, 1832.58766777474, 1837.118183272037, 887.1616322575234, 910.6539514984264, 943.1370296179057, 983.5918093990914, 986.5215370545279, 21921.451963700718, 22281.888590556944, 22302.330930072123, 22716.432089197573, 22728.318150455514, 843.6161546496329, 848.5841937450605, 878.5168157513342, 951.9952400237954, 1004.2167109654481, 8955.596998135099, 11044.944775276072, 11391.316521008766, 11434.142439317084, 11944.940275298743, 510454.0, 598998.0, 605071.0, 607258.0, 621949.0, 117967.0, 135620.86781491694, 136505.63494365127, 148484.0, 152510.23744881205, 972.0910948263396, 991.8512223166583, 1013.3008224325192, 1021.5760459409411, 1046.2519298701466, 18678.71981920245, 19534.413967580997, 19648.312309069115, 19725.60548789045, 19817.801821981597, 56783.7286508535, 57340.13989790073, 57986.84026319534, 58194.0, 58628.4137158623, 67610.3238967604, 83150.0, 84477.0, 85209.57395212984, 86144.0, 6800.387965083166, 6912.792616221522, 8022.799430014296, 8136.0, 8466.915330846612, 9277.0, 12825.679358016125, 13321.200727956353, 13658.453661853415, 13854.861451385761, 11571.305721656727, 11780.116491263017, 11916.463759130687, 12046.337451440255, 12047.457864396298, 9836.655717049869, 11508.654740357802, 11550.747604217433, 11776.352300623548, 11787.764244714886, 11620.244684095507, 11708.356040417859, 12036.939815301217, 12046.518139274682, 12096.576619818265, 7161.140663120251, 7339.9266007341375, 7539.321461068311, 7786.727464538714, 8272.793180170303, 10153.64462243818, 11606.70983225426, 11891.10816688769, 11915.582954596548, 11950.282983021047], "value": 9819.947408838867, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1543.3826469412238, 1577.313868467217, 1822.9062562462525, 1885.9811401885977, 1902.961940761185, 7897.447178697494, 8306.293965012967, 8395.034571024335, 8958.596863141158, 8975.326850486215, 8382.706605268817, 8546.44448110874, 8584.914150858489, 8678.088800675932, 8685.522296273703, 2256.3569382725927, 2301.1830800065986, 2308.1113771198125, 2308.665243539686, 2316.733575638798, 2253.11002154149, 2309.607366747657, 2324.2910912171783, 2329.10329523134, 2334.0897050150456, 2301.309607117866, 2314.0975019742314, 2316.9884150579223, 2320.814334853216, 2323.721153461587, 1974.4372853736688, 2291.7937385635373, 2297.425643589103, 2299.321700098475, 2300.1834348806183, 2296.5866144094057, 2297.5634629420356, 2303.309007297804, 2306.757790432014, 2311.3528212100637, 8718.520481373522, 8749.868751968726, 8775.64897404103, 8778.692745753868, 8778.912210877937, 5145.125328694131, 5274.10340242156, 5276.7889284428575, 5290.338707661543, 5300.992811365828, 3395.1172695099203, 3451.758376913617, 3595.6044835068124, 3596.82015899204, 3598.2623562169956, 1026.4457193115709, 1060.6446840308506, 1062.3519653011656, 1082.5236895765838, 1086.1528008153653, 11380.203385763, 11409.60066397672, 11549.191556591042, 11619.6514104577, 11648.835116488368, 4487.326900964816, 4568.862934111982, 4715.434147902273, 4751.881202969954, 4767.213409787416, 9864.704058878246, 9954.054364835329, 9970.35489144283, 9981.151602113756, 9994.400335979864, 4943.876403089952, 5268.762905669254, 5297.761600727899, 5311.601629877775, 5315.01672190646, 4326.307790753464, 4350.456192975878, 4590.403247577793, 4791.353167322437, 4823.662343635911, 3260.396826587089, 3912.980435097806, 3978.900527486836, 3992.401139829049, 4076.735012224196, 1262.3498898067503, 1275.5663074554695, 1282.8332316798756, 1295.3393769177599, 1296.4360503181147, 836.8159005018886, 883.6597909804772, 920.1856357123994, 921.0007142250599, 926.6895589977433, 5747.3103227612955, 5915.881682366415, 5950.7917222896995, 6108.0, 6180.289266734383, 829.6142293833396, 911.64901512918, 944.0, 952.1288021460286, 962.8603852441357, 4032.704064092798, 4036.374361973899, 4081.6938729594804, 4140.0, 4151.356539736285, 9092.81814363709, 9227.400218985744, 10806.08148307387, 10807.40559269232, 10814.0, 9125.726228213165, 10771.299865508874, 10815.242932994772, 10816.837747433794, 10824.837627435594, 6776.7966960992235, 8122.431429799857, 8276.131006244377, 8282.58587070644, 8285.8342833143, 5233.921491177559, 5703.942960570341, 5931.911021334769, 6200.937990620036, 6209.689515524296, 9833.459159745997, 9877.111060004634, 9992.250581206294, 10099.091081802673, 10175.694729158136, 10005.349652272578, 10198.388096714221, 10252.538635761557, 10371.0, 10452.529636166542, 7028.8594228114125, 7401.444891633257, 7523.172451030492, 7577.318041376303, 7698.845173224061, 8406.411551191359, 8474.703385381483, 8476.406651534333, 8489.87265191035, 8490.61792219364, 7272.127344718668, 7399.852002960019, 7539.660715267716, 7614.733484328022, 7634.045744281965, 7205.567665940061, 7384.704611815468, 7406.851862962818, 7507.699692012258, 7560.697572097055, 6960.338767817049, 6983.580985140908, 7024.473164512579, 7036.683349249193, 7045.647717614202, 4303.591158839905, 4963.875903102306, 5106.080905437057, 5111.1311077117725, 5167.811403377169, 4295.892602684958, 4978.850634480971, 5012.248162775612, 5244.292020577173, 5283.947160528499], "value": 4563.018844719612, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [262.67428388797896, 280.32162167554515, 293.6916237950153, 306.0970138092627, 312.2739630359415, 4365.886698891778, 5163.993021360831, 5381.919271210935, 5530.529904958078, 5617.550595952324, 4597.42532183477, 4755.762211889409, 4794.520547945203, 5213.879016011557, 5426.399212232391, 3500.3174380995715, 3730.9253814923686, 3904.75047984645, 4003.938956176601, 4293.3989241506215, 3329.700326970572, 3531.629178936213, 4009.9198016039663, 4162.188373267214, 4223.61987421132, 3897.694272418743, 4012.3179059559798, 4077.6533994610495, 4123.649489793371, 4148.357004664267, 3703.6296370363016, 3848.5958974307855, 4089.8568550100754, 4126.587341265879, 4148.62662360389, 3548.982255088734, 3554.893353199408, 3558.181618227822, 3561.4123669594487, 3580.7493475456727, 4928.728919909404, 5039.521245481674, 5218.947810521884, 5267.604929630293, 5387.4073851876265, 4331.263685173497, 4686.250199968023, 4691.577758001762, 4701.717896926195, 4712.9057418851435, 5721.542276617861, 5729.598928075036, 5776.8844623107725, 5786.739596718157, 5786.768529258825, 3267.7917529055912, 3882.145927895858, 3904.570497245301, 3955.545112312092, 3957.2679054374744, 5104.923426148611, 5777.768889244425, 6101.694915254219, 6151.292601350857, 6189.412005859436, 3315.8342082896243, 3859.9421008684894, 3994.900127496836, 4001.779902105412, 4016.718829681894, 3541.327147841902, 3915.9216815663526, 3972.6821854252166, 4032.5967403260024, 4051.2707712612014, 3919.3729003359326, 4689.343491911135, 4737.715737055788, 4738.810447582058, 4758.500357462486, 5820.76716931318, 5833.374981258451, 5841.912371314434, 5852.473277404969, 5857.7949771757785, 1286.1961274203622, 1333.3200067965213, 1349.9527516536873, 1350.9392077356542, 1365.6654119740726, 819.4100247821559, 825.9256666900008, 889.2663552569156, 919.3932004876749, 920.6869664314031, 5255.921161182585, 5332.840014799563, 5350.197470379474, 5351.6788992659785, 5365.356157261075, 4650.953490465052, 5130.127128807805, 5166.560842328444, 5581.237287542693, 5856.707164641751, 4634.791434385461, 4736.360591320196, 5178.6116041297055, 5267.631265811433, 5312.5218730314455, 2278.735301907457, 2322.897777511355, 2545.6889701803584, 2562.3722188064044, 2570.4859028194437, 4779.928301075487, 4922.950770492249, 4956.405231372259, 5155.278261043457, 5309.239195618334, 4164.937525937114, 4333.458317710286, 4503.909921801545, 4842.9319371727215, 5510.531604813636, 5692.402297758758, 6205.983055506978, 6218.129461875341, 6322.810315690536, 6323.620582765049, 5995.400459953969, 6028.6985650716415, 6030.396960303934, 6072.392760723892, 6073.54234983592, 5525.696086715269, 5891.528677705859, 5915.58590898633, 5927.347991720993, 5974.701264936823, 5208.791648334176, 5516.200150978166, 5580.051391263414, 6168.691565421801, 6240.812775616739, 3961.801909904551, 3983.143624120828, 3983.506185180557, 3992.5246347264883, 3995.420664003645, 5265.3944796348915, 5590.301212348457, 5763.386251849489, 5962.8968640801595, 6016.939830601638, 5351.59863010268, 5740.712964351682, 5846.766129354948, 5887.146363777314, 5917.272118565276, 5774.249347584787, 5826.242588463472, 5828.59199856006, 5861.769028504062, 5866.354700982974, 5512.090505066619, 5665.376808551138, 5700.315962084576, 5725.456081672234, 5725.51333136688, 5792.247007888947, 5808.883822323614, 5846.473817356458, 5870.911936320873, 5888.116782482662, 5454.863628409322, 5683.163864391602, 5692.459216374438, 5695.063678349381, 5758.596898217253], "value": 4118.664102522948, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.3431009161479, 709.6877373955459, 710.9893351599724, 743.7359737293258, 819.455062383515, 15193.392264309428, 15681.607959800996, 15842.0, 15848.3660653574, 17383.47849564515, 15959.0, 16073.196340183002, 16099.678006439864, 16099.83900161001, 16275.51173464798, 838.5890913452395, 854.9871751923695, 860.7503823891095, 865.0830120072711, 870.2820173356974, 676.6954870308356, 755.0976582983337, 848.7708318753932, 857.4041041476177, 859.7420773767876, 889.1508609278123, 896.1620884473039, 904.4708845325459, 906.2568693671192, 911.1935936696038, 845.5898889038812, 847.9872801908007, 902.5938327752538, 904.5025236120141, 905.0587389115312, 649.6134799794115, 653.5882394091692, 672.5393105722595, 676.651524464901, 677.4309579952863, 15069.0, 15103.093814371063, 15286.464973725866, 15380.230988450532, 15428.537143885702, 14378.496752613713, 14381.496647617389, 14407.639809004753, 14449.205293708841, 14553.490627827976, 11745.823812642817, 12069.879301207051, 12089.516419343216, 12303.0, 12395.194312369757, 3754.3242216401036, 3784.8486060557543, 3815.8473661053804, 3831.3678243089857, 3953.525576930787, 114599.42700286445, 116176.25735613973, 116772.8322716779, 117427.65144697059, 117976.0, 9030.63877444908, 10297.897021029843, 11037.503312350964, 11111.444427778579, 11154.996050355507, 22168.778312216993, 22350.60731563014, 22810.543789124124, 22862.42843928915, 22886.0, 7793.649285782153, 8106.148854370206, 8156.836863262702, 8260.256576908107, 8431.95784021076, 4644.628429725613, 4653.95346046542, 4677.2750223715375, 4748.738819364899, 4816.95183048172, 3445.397055515325, 3550.0237434705145, 3584.8207589620415, 3592.137886907176, 3605.387084195693, 615.6398506873439, 641.9807405777834, 653.8626888353499, 661.1735330836455, 664.4584663499329, 613.352912677121, 681.4820736240493, 690.4993879437468, 697.5152269172978, 710.733474946895, 8611.354148438892, 9464.148226659634, 9497.015436371506, 9645.469499177472, 9784.804303914025, 582.7202942587581, 596.4125336543501, 669.2450141742944, 688.721067967474, 696.8919817428307, 4455.6658250631335, 4572.611328037154, 4580.725156490555, 4591.357209990604, 4609.492886062462, 140672.0, 145317.0, 148562.0, 149971.2501437486, 156080.21959890128, 125743.74256257503, 126717.0, 129102.0, 137768.31115844558, 143448.84826727607, 84898.15101849026, 106105.99999999846, 109671.0, 110600.0, 112056.4397178009, 7634.732784352521, 9729.854052189365, 9886.357386769838, 10002.349847259904, 10044.748881278027, 59571.40428595659, 60666.393336066074, 62598.37401626108, 63664.68167659317, 64117.67941160264, 65886.0, 73309.6334518324, 76973.0, 80425.391492171, 85482.0, 13429.19424834474, 13612.0, 13681.931590341985, 13719.725605488034, 13836.308184590529, 15211.771823422436, 15378.872342119968, 15613.0, 15899.364025438854, 16038.278277477308, 13295.66760830987, 13667.931660342032, 13743.587692369245, 14388.784168237275, 14392.928035359757, 14289.571312860631, 14436.855631443552, 14623.0, 14841.183734894252, 14971.92514037423, 13665.316734163052, 13853.722925541231, 13889.888808895063, 14169.22069286199, 14301.09393991996, 10836.75377331617, 11201.495932682887, 11318.660440186808, 11459.022016314628, 12073.879261207276, 8487.321014318963, 9796.363236389612, 10793.244472886823, 11507.769844603228, 11691.532338706356], "value": 7912.710028545216, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1597.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 106.0, 116.0, 134.0, 160.0, 113.0, 116.0, 117.0, 149.0], "value": 122.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 108.0, 166.0, 165.0, 113.0, 131.0, 132.0, 134.0, 204.0, 142.0], "value": 146.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [282.0, 199.0, 270.0, 275.0, 206.0, 178.0, 268.0, 280.0, 240.0, 198.0], "value": 239.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 79.0, 84.0, 179.0, 51.0, 67.0, 86.0, 86.0, 162.0, 51.0], "value": 91.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 76.0, 126.0, 71.0, 73.0, 76.0, 138.0, 92.0, 74.0, 116.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 114.0, 88.0, 97.0, 114.0, 85.0, 112.0, 76.0, 121.0, 131.0], "value": 107.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 98.0, 95.0, 96.0, 95.0, 96.0, 96.0, 97.0, 95.0, 95.0], "value": 101.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 92.0, 95.0, 95.0, 114.0, 114.0, 91.0, 88.0, 90.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 60.0, 58.0, 57.0, 60.0, 56.0, 58.0, 59.0, 58.0, 57.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 71.0, 77.0, 78.0, 75.0, 73.0, 73.0, 73.0, 73.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 87.0, 85.0, 89.0, 106.0, 98.0, 104.0, 89.0, 81.0], "value": 90.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 154.0, 130.0, 138.0, 138.0, 136.0, 139.0, 149.0, 169.0, 142.0], "value": 144.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 165.0, 168.0, 167.0, 167.0, 168.0, 170.0, 171.0, 168.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 66.0, 68.0, 68.0, 66.0, 67.0, 68.0, 69.0, 68.0], "value": 67.5, "unit": "score"}]}]} 16:48:51 INFO - Return code: 0 16:48:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:48:51 ERROR - # TBPL SUCCESS # 16:48:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:48:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:48:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:48:51 INFO - 2016-08-10 16:48:51.870 screenresolution[1673:10277] starting screenresolution argv=screenresolution get 16:48:51 INFO - 2016-08-10 16:48:51.872 screenresolution[1673:10277] Display 0: 1600x1200x32@60 16:48:51 INFO - 2016-08-10 16:48:51.880 screenresolution[1674:10280] starting screenresolution argv=screenresolution list 16:48:51 INFO - Available Modes on Display 0 16:48:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:48:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:48:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:48:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:48:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:48:52 INFO - Intel Iris: 16:48:52 INFO - Chipset Model: Intel Iris 16:48:52 INFO - Type: GPU 16:48:52 INFO - Bus: Built-In 16:48:52 INFO - VRAM (Dynamic, Max): 1536 MB 16:48:52 INFO - Vendor: Intel (0x8086) 16:48:52 INFO - Device ID: 0x0a2e 16:48:52 INFO - Revision ID: 0x0009 16:48:52 INFO - Displays: 16:48:52 INFO - Display: 16:48:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:48:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:48:52 INFO - Display Serial Number: 1600x1200 60 16:48:52 INFO - Main Display: Yes 16:48:52 INFO - Mirror: Off 16:48:52 INFO - Online: Yes 16:48:52 INFO - Rotation: Supported 16:48:52 INFO - Return code: 0 16:48:52 INFO - Running post-action listener: _resource_record_post_action 16:48:52 INFO - [mozharness: 2016-08-10 23:48:52.118791Z] Finished run-tests step (success) 16:48:52 INFO - Running post-run listener: _resource_record_post_run 16:48:52 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 38196224; Write bytes: 702913536; Read time: 375; Write time: 1902 16:48:52 INFO - TinderboxPrint: CPU usage
54.4% 16:48:52 INFO - TinderboxPrint: I/O read bytes / time
38,196,224 / 375 16:48:52 INFO - TinderboxPrint: I/O write bytes / time
702,913,536 / 1,902 16:48:52 INFO - TinderboxPrint: CPU idle
2,207.5 (45.6%) 16:48:52 INFO - TinderboxPrint: CPU system
977.7 (20.2%) 16:48:52 INFO - TinderboxPrint: CPU user
1,652.5 (34.2%) 16:48:52 INFO - TinderboxPrint: Swap in / out
441,438,208 / 0 16:48:52 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 386599424; Write bytes: 380802560; Read time: 29784; Write time: 720 16:48:52 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 37241856; Write bytes: 296760832; Read time: 361; Write time: 1136 16:48:52 INFO - Running post-run listener: _upload_blobber_files 16:48:52 INFO - Blob upload gear active. 16:48:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:48:52 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 16:48:52 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:48:52 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:48:52 INFO - (blobuploader) - INFO - Open directory for files ... 16:48:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:48:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:48:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:48:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:48:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:48:54 INFO - (blobuploader) - INFO - Done attempting. 16:48:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:48:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:48:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:48:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:48:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:48:55 INFO - (blobuploader) - INFO - Done attempting. 16:48:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:48:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:48:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:48:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:48:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:48:57 INFO - (blobuploader) - INFO - Done attempting. 16:48:57 INFO - (blobuploader) - INFO - Iteration through files over. 16:48:57 INFO - Return code: 0 16:48:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:48:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:48:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c2e0e950c9401a070aed91c05b4f6be031ebf45cfc00bf3109993c093d3d9b406ae980d7196c00c81bc772ca05f7cc194e5c4a78ec8ebbe2151445d572c927ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/275edfbc03d1571e725a16f480096ecf2f7bbc8765a4c622139f1e7c7b4fe1c8b7fdb2df7ef148e0c39c283806fa840545a04381c3aab6d2e7f0c7d31a23bb9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6ed6db7d450a548a4f0d361f416d06d554559807a152b6b9af16ec4207d87dde9f443b8108b71d9324e69ec515ded5f56eebbacf3b5d11b203e86f5645669ee1"} 16:48:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:48:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:48:57 INFO - Contents: 16:48:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c2e0e950c9401a070aed91c05b4f6be031ebf45cfc00bf3109993c093d3d9b406ae980d7196c00c81bc772ca05f7cc194e5c4a78ec8ebbe2151445d572c927ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/275edfbc03d1571e725a16f480096ecf2f7bbc8765a4c622139f1e7c7b4fe1c8b7fdb2df7ef148e0c39c283806fa840545a04381c3aab6d2e7f0c7d31a23bb9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6ed6db7d450a548a4f0d361f416d06d554559807a152b6b9af16ec4207d87dde9f443b8108b71d9324e69ec515ded5f56eebbacf3b5d11b203e86f5645669ee1"} 16:48:57 INFO - Running post-run listener: copy_logs_to_upload_dir 16:48:57 INFO - Copying logs to upload dir... 16:48:57 INFO - mkdir: /builds/slave/test/build/upload/logs 16:48:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.577943 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-08-10 16:48:57.326260) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 16:48:57.330121) ========= 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.1vpFPi0Ta9/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.FksBzIkb17/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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/Autoland/sha512/c2e0e950c9401a070aed91c05b4f6be031ebf45cfc00bf3109993c093d3d9b406ae980d7196c00c81bc772ca05f7cc194e5c4a78ec8ebbe2151445d572c927ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/275edfbc03d1571e725a16f480096ecf2f7bbc8765a4c622139f1e7c7b4fe1c8b7fdb2df7ef148e0c39c283806fa840545a04381c3aab6d2e7f0c7d31a23bb9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6ed6db7d450a548a4f0d361f416d06d554559807a152b6b9af16ec4207d87dde9f443b8108b71d9324e69ec515ded5f56eebbacf3b5d11b203e86f5645669ee1"} build_url:https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011127 build_url: 'https://queue.taskcluster.net/v1/task/WtD_4yMaR36RFdbahLxzsQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c2e0e950c9401a070aed91c05b4f6be031ebf45cfc00bf3109993c093d3d9b406ae980d7196c00c81bc772ca05f7cc194e5c4a78ec8ebbe2151445d572c927ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/275edfbc03d1571e725a16f480096ecf2f7bbc8765a4c622139f1e7c7b4fe1c8b7fdb2df7ef148e0c39c283806fa840545a04381c3aab6d2e7f0c7d31a23bb9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6ed6db7d450a548a4f0d361f416d06d554559807a152b6b9af16ec4207d87dde9f443b8108b71d9324e69ec515ded5f56eebbacf3b5d11b203e86f5645669ee1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 16:48:57.363384) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 16:48:57.363775) ========= 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.1vpFPi0Ta9/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.FksBzIkb17/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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.004607 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 16:48:57.412322) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 16:48:57.412644) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 16:48:57.412937) ========= ========= Total master_lag: 0.17 =========