builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0104 starttime: 1470337116.09 results: success (0) buildid: 20160804092622 builduid: 1138ca26c8844dbcbb8fe3de05954448 revision: 5ad07719e3bdf424673e7f1c7d0e0dc9b6880cae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 11:58:36.090557) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 11:58:36.090979) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 11:58:36.091268) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 11:58:36.118495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 11:58:36.118883) ========= 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.14lh1D6hX9/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.OiiM85UTu5/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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-04 11:58:36-- 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% 163M=0s 2016-08-04 11:58:36 (163 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159652 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 11:58:36.301006) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 11:58:36.301345) ========= 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.14lh1D6hX9/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.OiiM85UTu5/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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.034407 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 11:58:36.355802) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-04 11:58:36.356136) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5ad07719e3bdf424673e7f1c7d0e0dc9b6880cae --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5ad07719e3bdf424673e7f1c7d0e0dc9b6880cae --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.14lh1D6hX9/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.OiiM85UTu5/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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-04 11:58:36,432 truncating revision to first 12 chars 2016-08-04 11:58:36,432 Setting DEBUG logging. 2016-08-04 11:58:36,432 attempt 1/10 2016-08-04 11:58:36,432 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5ad07719e3bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 11:58:37,341 unpacking tar archive at: fx-team-5ad07719e3bd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.166253 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-04 11:58:37.543857) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 11:58:37.544295) ========= script_repo_revision: 5ad07719e3bdf424673e7f1c7d0e0dc9b6880cae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 11:58:37.544678) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 11:58:37.544948) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 11:58:37.565920) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-04 11:58:37.566323) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.14lh1D6hX9/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.OiiM85UTu5/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 11:58:37 INFO - MultiFileLogger online at 20160804 11:58:37 in /builds/slave/test 11:58:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:58:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:58:37 INFO - {'append_to_log': False, 11:58:37 INFO - 'base_work_dir': '/builds/slave/test', 11:58:37 INFO - 'blob_upload_branch': 'Fx-Team', 11:58:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:58:37 INFO - 'branch': 'Fx-Team', 11:58:37 INFO - 'buildbot_json_path': 'buildprops.json', 11:58:37 INFO - 'config_files': ('talos/mac_config.py',), 11:58:37 INFO - 'default_actions': ('clobber', 11:58:37 INFO - 'read-buildbot-config', 11:58:37 INFO - 'download-and-extract', 11:58:37 INFO - 'populate-webroot', 11:58:37 INFO - 'create-virtualenv', 11:58:37 INFO - 'install', 11:58:37 INFO - 'run-tests'), 11:58:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:58:37 INFO - 'download_minidump_stackwalk': True, 11:58:37 INFO - 'download_symbols': 'ondemand', 11:58:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:58:37 INFO - 'tooltool.py': '/tools/tooltool.py', 11:58:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:58:37 INFO - '/tools/misc-python/virtualenv.py')}, 11:58:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:58:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:58:37 INFO - 'installer_path': 'installer.exe', 11:58:37 INFO - 'log_level': 'info', 11:58:37 INFO - 'log_name': 'talos', 11:58:37 INFO - 'log_to_console': True, 11:58:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:58:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:58:37 INFO - 'opt_config_files': (), 11:58:37 INFO - 'pip_index': False, 11:58:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:58:37 INFO - 'cmd': ('bash', 11:58:37 INFO - '-c', 11:58:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:58:37 INFO - 'enabled': True, 11:58:37 INFO - 'halt_on_failure': False, 11:58:37 INFO - 'name': 'check_screen_resolution'},), 11:58:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:58:37 INFO - 'cmd': ('bash', 11:58:37 INFO - '-c', 11:58:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:58:37 INFO - 'enabled': True, 11:58:37 INFO - 'halt_on_failure': False, 11:58:37 INFO - 'name': 'check_screen_resolution'},), 11:58:37 INFO - 'run_cmd_checks_enabled': True, 11:58:37 INFO - 'sps_profile': False, 11:58:37 INFO - 'sps_profile_interval': 0, 11:58:37 INFO - 'suite': 'dromaeojs', 11:58:37 INFO - 'system_bits': '32', 11:58:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:58:37 INFO - 'title': 't-yosemite-r7-0104', 11:58:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:58:37 INFO - 'use_talos_json': True, 11:58:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:58:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:58:37 INFO - 'work_dir': 'build'} 11:58:37 INFO - [mozharness: 2016-08-04 18:58:37.760390Z] Running clobber step. 11:58:37 INFO - Running pre-action listener: _resource_record_pre_action 11:58:37 INFO - Running main action method: clobber 11:58:37 INFO - rmtree: /builds/slave/test/build 11:58:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:58:39 INFO - Running post-action listener: _resource_record_post_action 11:58:39 INFO - [mozharness: 2016-08-04 18:58:39.818469Z] Finished clobber step (success) 11:58:39 INFO - [mozharness: 2016-08-04 18:58:39.818696Z] Running read-buildbot-config step. 11:58:39 INFO - Running pre-action listener: _resource_record_pre_action 11:58:39 INFO - Running main action method: read_buildbot_config 11:58:39 INFO - Using buildbot properties: 11:58:39 INFO - { 11:58:39 INFO - "project": "", 11:58:39 INFO - "product": "firefox", 11:58:39 INFO - "script_repo_revision": "production", 11:58:39 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:58:39 INFO - "repository": "", 11:58:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:58:39 INFO - "buildid": "20160804092622", 11:58:39 INFO - "pgo_build": "False", 11:58:39 INFO - "basedir": "/builds/slave/test", 11:58:39 INFO - "buildnumber": 122, 11:58:39 INFO - "slavename": "t-yosemite-r7-0104", 11:58:39 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 11:58:39 INFO - "platform": "yosemite_r7", 11:58:39 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 11:58:39 INFO - "branch": "fx-team", 11:58:39 INFO - "repo_path": "integration/fx-team", 11:58:39 INFO - "revision": "5ad07719e3bdf424673e7f1c7d0e0dc9b6880cae", 11:58:39 INFO - "stage_platform": "macosx64", 11:58:39 INFO - "builduid": "1138ca26c8844dbcbb8fe3de05954448", 11:58:39 INFO - "slavebuilddir": "test" 11:58:39 INFO - } 11:58:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 11:58:39 INFO - Running post-action listener: _resource_record_post_action 11:58:39 INFO - [mozharness: 2016-08-04 18:58:39.824540Z] Finished read-buildbot-config step (success) 11:58:39 INFO - [mozharness: 2016-08-04 18:58:39.824798Z] Running download-and-extract step. 11:58:39 INFO - Running pre-action listener: _resource_record_pre_action 11:58:39 INFO - Running main action method: download_and_extract 11:58:39 INFO - mkdir: /builds/slave/test/build/tests 11:58:39 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')]} 11:58:39 INFO - trying https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 11:58:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/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 11:58:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/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 11:58:41 INFO - Downloaded 1199 bytes. 11:58:41 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:58:41 INFO - Using the following test package requirements: 11:58:41 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:58:41 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:58:41 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 11:58:41 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:58:41 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 11:58:41 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:58:41 INFO - u'jsshell-mac.zip'], 11:58:41 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:58:41 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 11:58:41 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:58:41 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:58:41 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 11:58:41 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:58:41 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 11:58:41 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:58:41 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 11:58:41 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:58:41 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 11:58:41 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:58: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')]} 11:58:41 INFO - trying https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:58:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/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 11:58:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/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 11:58:42 INFO - Downloaded 16315685 bytes. 11:58:42 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'] 11:58:42 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 11:58:45 INFO - Return code: 0 11:58:45 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 11:58:45 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')]} 11:58:45 INFO - trying https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:58:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/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 11:58:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/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 11:58:46 INFO - Downloaded 16315685 bytes. 11:58:46 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'] 11:58:46 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 11:58:49 INFO - Return code: 0 11:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:49 INFO - trying https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:58:49 INFO - Downloading https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/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 11:58:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/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 11:58:50 INFO - Downloaded 14413723 bytes. 11:58:50 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'] 11:58:50 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 11:58:50 INFO - Return code: 0 11:58:50 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')]} 11:58:50 INFO - trying https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:58:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 11:58:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/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 11:58:54 INFO - Downloaded 111134294 bytes. 11:58:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:58:54 INFO - mkdir: /builds/slave/test/properties 11:58:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:58:54 INFO - Writing to file /builds/slave/test/properties/build_url 11:58:54 INFO - Contents: 11:58:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:58:55 INFO - Running post-action listener: _resource_record_post_action 11:58:55 INFO - Running post-action listener: set_extra_try_arguments 11:58:55 INFO - [mozharness: 2016-08-04 18:58:55.203907Z] Finished download-and-extract step (success) 11:58:55 INFO - [mozharness: 2016-08-04 18:58:55.204058Z] Running populate-webroot step. 11:58:55 INFO - Running pre-action listener: _resource_record_pre_action 11:58:55 INFO - Running main action method: populate_webroot 11:58:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:58:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:58:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:58:55 INFO - '--tppagecycles', 11:58:55 INFO - '7'], 11:58:55 INFO - 'tests': ['tsvgm']}}, 11:58:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:58:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:58:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:58:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:58:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:58:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:58:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:55 INFO - 'talos_options': ['--disable-e10s'], 11:58:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:58:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:58:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:55 INFO - 'talos_options': ['--disable-e10s'], 11:58:55 INFO - 'tests': ['damp', 'tps']}, 11:58:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:55 INFO - 'tests': ['damp', 'tps']}, 11:58:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:58:55 INFO - 'tests': ['dromaeo_dom']}, 11:58:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:58:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:58:55 INFO - 'tests': ['basic_compositor_video']}, 11:58:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:58:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:58:55 INFO - 'tests': ['a11yr', 11:58:55 INFO - 'ts_paint', 11:58:55 INFO - 'tpaint', 11:58:55 INFO - 'sessionrestore', 11:58:55 INFO - 'sessionrestore_no_auto_restore', 11:58:55 INFO - 'tabpaint']}, 11:58:55 INFO - 'other-e10s': {'tests': ['a11yr', 11:58:55 INFO - 'ts_paint', 11:58:55 INFO - 'tpaint', 11:58:55 INFO - 'sessionrestore', 11:58:55 INFO - 'sessionrestore_no_auto_restore', 11:58:55 INFO - 'tabpaint']}, 11:58:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:58:55 INFO - 'ts_paint', 11:58:55 INFO - 'tpaint', 11:58:55 INFO - 'sessionrestore', 11:58:55 INFO - 'sessionrestore_no_auto_restore', 11:58:55 INFO - 'tabpaint']}, 11:58:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:58:55 INFO - 'ts_paint', 11:58:55 INFO - 'tpaint', 11:58:55 INFO - 'sessionrestore', 11:58:55 INFO - 'sessionrestore_no_auto_restore', 11:58:55 INFO - 'tabpaint']}, 11:58:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:58:55 INFO - 'tests': ['a11yr', 11:58:55 INFO - 'ts_paint', 11:58:55 INFO - 'tpaint', 11:58:55 INFO - 'sessionrestore', 11:58:55 INFO - 'sessionrestore_no_auto_restore', 11:58:55 INFO - 'tabpaint']}, 11:58:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:58:55 INFO - 'tests': ['a11yr', 11:58:55 INFO - 'ts_paint', 11:58:55 INFO - 'tpaint', 11:58:55 INFO - 'sessionrestore', 11:58:55 INFO - 'sessionrestore_no_auto_restore', 11:58:55 INFO - 'tabpaint']}, 11:58:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:58:55 INFO - 'tests': ['tsvgx', 11:58:55 INFO - 'tsvgr_opacity', 11:58:55 INFO - 'tart', 11:58:55 INFO - 'tscrollx', 11:58:55 INFO - 'cart']}, 11:58:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:58:55 INFO - 'tsvgr_opacity', 11:58:55 INFO - 'tart', 11:58:55 INFO - 'tscrollx', 11:58:55 INFO - 'cart']}, 11:58:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:55 INFO - 'talos_options': ['--disable-e10s'], 11:58:55 INFO - 'tests': ['tp5o']}, 11:58:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:55 INFO - 'tests': ['tp5o']}, 11:58:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:55 INFO - 'talos_options': ['--disable-e10s', 11:58:55 INFO - '--xperf_path', 11:58:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:58:55 INFO - 'tests': ['tp5n']}, 11:58:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:55 INFO - 'talos_options': ['--xperf_path', 11:58:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:58:55 INFO - 'tests': ['tp5n']}}, 11:58:55 INFO - 'talos.zip': {'path': '', 11:58:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:58:55 INFO - Running post-action listener: _resource_record_post_action 11:58:55 INFO - [mozharness: 2016-08-04 18:58:55.222623Z] Finished populate-webroot step (success) 11:58:55 INFO - [mozharness: 2016-08-04 18:58:55.222734Z] Running create-virtualenv step. 11:58:55 INFO - Running pre-action listener: _resource_record_pre_action 11:58:55 INFO - Running main action method: create_virtualenv 11:58:55 INFO - Creating virtualenv /builds/slave/test/build/venv 11:58:55 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 11:58:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:58:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:58:55 INFO - Using real prefix '/tools/python27' 11:58:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:58:56 INFO - Installing distribute.............................................................................................................................................................................................done. 11:58:58 INFO - Installing pip.................done. 11:58:58 INFO - Return code: 0 11:58:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:58:58 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')]} 11:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:58 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')]} 11:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:58 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 0x105ef0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f85618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9248dc5010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e54d30>, '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 0x105bb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e4cb20>, '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.14lh1D6hX9/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.OiiM85UTu5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 11:58:58 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 11:58:58 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 11:58:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14lh1D6hX9/Render', 11:58:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:58 INFO - 'HOME': '/Users/cltbld', 11:58:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:58 INFO - 'LOGNAME': 'cltbld', 11:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:58 INFO - 'MOZ_NO_REMOTE': '1', 11:58:58 INFO - 'NO_EM_RESTART': '1', 11:58:58 INFO - 'PAGER': '/bin/cat', 11:58:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:58 INFO - 'PWD': '/builds/slave/test', 11:58:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:58 INFO - 'SHELL': '/bin/bash', 11:58:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OiiM85UTu5/Listeners', 11:58:58 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 11:58:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:58 INFO - 'USER': 'cltbld', 11:58:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:58 INFO - 'XPC_FLAGS': '0x0', 11:58:58 INFO - 'XPC_SERVICE_NAME': '0', 11:58:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:59 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 11:58:59 INFO - Cleaning up... 11:58:59 INFO - Return code: 0 11:58:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:58:59 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')]} 11:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:59 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')]} 11:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:59 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 0x105ef0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f85618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9248dc5010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e54d30>, '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 0x105bb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e4cb20>, '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.14lh1D6hX9/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.OiiM85UTu5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 11:58:59 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 11:58:59 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 11:58:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14lh1D6hX9/Render', 11:58:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:59 INFO - 'HOME': '/Users/cltbld', 11:58:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:59 INFO - 'LOGNAME': 'cltbld', 11:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:59 INFO - 'MOZ_NO_REMOTE': '1', 11:58:59 INFO - 'NO_EM_RESTART': '1', 11:58:59 INFO - 'PAGER': '/bin/cat', 11:58:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:59 INFO - 'PWD': '/builds/slave/test', 11:58:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:59 INFO - 'SHELL': '/bin/bash', 11:58:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OiiM85UTu5/Listeners', 11:58:59 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 11:58:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:59 INFO - 'USER': 'cltbld', 11:58:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:59 INFO - 'XPC_FLAGS': '0x0', 11:58:59 INFO - 'XPC_SERVICE_NAME': '0', 11:58:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:59 INFO - Downloading/unpacking psutil>=3.1.1 11:58:59 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 11:58:59 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 11:58:59 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 11:58:59 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 11:58:59 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 11:58:59 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 11:59:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:59:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:59:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:59:02 INFO - Installing collected packages: psutil 11:59:02 INFO - Running setup.py install for psutil 11:59:02 INFO - building 'psutil._psutil_osx' extension 11:59:02 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 11:59:03 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 11:59:03 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 11:59:03 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 11:59:03 INFO - building 'psutil._psutil_posix' extension 11:59:03 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 11:59:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:59:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:59:03 INFO - ^ 11:59:03 INFO - 1 warning generated. 11:59:03 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 11:59:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:59:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:59:03 INFO - Successfully installed psutil 11:59:03 INFO - Cleaning up... 11:59:04 INFO - Return code: 0 11:59:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:04 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 0x105ef0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f85618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9248dc5010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e54d30>, '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 0x105bb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e4cb20>, '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.14lh1D6hX9/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.OiiM85UTu5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 11:59:04 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 11:59:04 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 11:59:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14lh1D6hX9/Render', 11:59:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:04 INFO - 'HOME': '/Users/cltbld', 11:59:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:04 INFO - 'LOGNAME': 'cltbld', 11:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:04 INFO - 'MOZ_NO_REMOTE': '1', 11:59:04 INFO - 'NO_EM_RESTART': '1', 11:59:04 INFO - 'PAGER': '/bin/cat', 11:59:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:04 INFO - 'PWD': '/builds/slave/test', 11:59:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:04 INFO - 'SHELL': '/bin/bash', 11:59:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OiiM85UTu5/Listeners', 11:59:04 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 11:59:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:04 INFO - 'USER': 'cltbld', 11:59:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:04 INFO - 'XPC_FLAGS': '0x0', 11:59:04 INFO - 'XPC_SERVICE_NAME': '0', 11:59:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:59:04 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 11:59:04 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 11:59:04 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 11:59:04 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 11:59:04 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 11:59:04 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 11:59:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:59:06 INFO - Installing collected packages: mozsystemmonitor 11:59:06 INFO - Running setup.py install for mozsystemmonitor 11:59:06 INFO - Successfully installed mozsystemmonitor 11:59:06 INFO - Cleaning up... 11:59:07 INFO - Return code: 0 11:59:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:59: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')]} 11:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59: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')]} 11:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:07 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 0x105ef0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f85618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9248dc5010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e54d30>, '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 0x105bb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e4cb20>, '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.14lh1D6hX9/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.OiiM85UTu5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 11:59:07 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 11:59:07 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 11:59:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14lh1D6hX9/Render', 11:59:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:07 INFO - 'HOME': '/Users/cltbld', 11:59:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:07 INFO - 'LOGNAME': 'cltbld', 11:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:07 INFO - 'MOZ_NO_REMOTE': '1', 11:59:07 INFO - 'NO_EM_RESTART': '1', 11:59:07 INFO - 'PAGER': '/bin/cat', 11:59:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:07 INFO - 'PWD': '/builds/slave/test', 11:59:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:07 INFO - 'SHELL': '/bin/bash', 11:59:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OiiM85UTu5/Listeners', 11:59:07 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 11:59:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:07 INFO - 'USER': 'cltbld', 11:59:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:07 INFO - 'XPC_FLAGS': '0x0', 11:59:07 INFO - 'XPC_SERVICE_NAME': '0', 11:59:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:07 INFO - Downloading/unpacking jsonschema==2.5.1 11:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:59:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:10 INFO - Downloading functools32-3.2.3-2.tar.gz 11:59:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:59:10 INFO - warning: no files found matching '*.txt' 11:59:10 INFO - no previously-included directories found matching 'build' 11:59:10 INFO - no previously-included directories found matching 'dist' 11:59:10 INFO - no previously-included directories found matching '.git*' 11:59:10 INFO - Installing collected packages: jsonschema, functools32 11:59:10 INFO - Running setup.py install for functools32 11:59:10 INFO - warning: no files found matching '*.txt' 11:59:10 INFO - no previously-included directories found matching 'build' 11:59:10 INFO - no previously-included directories found matching 'dist' 11:59:10 INFO - no previously-included directories found matching '.git*' 11:59:10 INFO - Successfully installed jsonschema functools32 11:59:10 INFO - Cleaning up... 11:59:10 INFO - Return code: 0 11:59:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105ef0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f85618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9248dc5010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e54d30>, '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 0x105bb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e4cb20>, '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.14lh1D6hX9/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.OiiM85UTu5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 11:59:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:59:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:59:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14lh1D6hX9/Render', 11:59:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:10 INFO - 'HOME': '/Users/cltbld', 11:59:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:10 INFO - 'LOGNAME': 'cltbld', 11:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:10 INFO - 'MOZ_NO_REMOTE': '1', 11:59:10 INFO - 'NO_EM_RESTART': '1', 11:59:10 INFO - 'PAGER': '/bin/cat', 11:59:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:10 INFO - 'PWD': '/builds/slave/test', 11:59:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:10 INFO - 'SHELL': '/bin/bash', 11:59:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OiiM85UTu5/Listeners', 11:59:10 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 11:59:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:10 INFO - 'USER': 'cltbld', 11:59:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:10 INFO - 'XPC_FLAGS': '0x0', 11:59:10 INFO - 'XPC_SERVICE_NAME': '0', 11:59:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:59:10 INFO - Cleaning up... 11:59:10 INFO - Return code: 0 11:59:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105ef0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f85618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9248dc5010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e54d30>, '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 0x105bb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e4cb20>, '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.14lh1D6hX9/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.OiiM85UTu5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 11:59:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:59:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:59:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14lh1D6hX9/Render', 11:59:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:10 INFO - 'HOME': '/Users/cltbld', 11:59:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:10 INFO - 'LOGNAME': 'cltbld', 11:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:10 INFO - 'MOZ_NO_REMOTE': '1', 11:59:10 INFO - 'NO_EM_RESTART': '1', 11:59:10 INFO - 'PAGER': '/bin/cat', 11:59:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:10 INFO - 'PWD': '/builds/slave/test', 11:59:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:10 INFO - 'SHELL': '/bin/bash', 11:59:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OiiM85UTu5/Listeners', 11:59:10 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 11:59:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:10 INFO - 'USER': 'cltbld', 11:59:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:10 INFO - 'XPC_FLAGS': '0x0', 11:59:10 INFO - 'XPC_SERVICE_NAME': '0', 11:59:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:11 INFO - Downloading/unpacking blobuploader==1.2.4 11:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:13 INFO - Downloading blobuploader-1.2.4.tar.gz 11:59:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:59:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:59:13 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 11:59:13 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 11:59:13 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 11:59:13 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 11:59:13 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 11:59:13 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 11:59:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:59:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:14 INFO - Downloading docopt-0.6.1.tar.gz 11:59:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:59:14 INFO - Installing collected packages: blobuploader, requests, docopt 11:59:14 INFO - Running setup.py install for blobuploader 11:59:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:59:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:59:14 INFO - Running setup.py install for requests 11:59:15 INFO - Running setup.py install for docopt 11:59:15 INFO - Successfully installed blobuploader requests docopt 11:59:15 INFO - Cleaning up... 11:59:15 INFO - Return code: 0 11:59:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59: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')]} 11:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59: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')]} 11:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:15 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 0x105ef0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f85618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9248dc5010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e54d30>, '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 0x105bb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e4cb20>, '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.14lh1D6hX9/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.OiiM85UTu5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 11:59:15 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 11:59:15 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 11:59:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14lh1D6hX9/Render', 11:59:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:15 INFO - 'HOME': '/Users/cltbld', 11:59:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:15 INFO - 'LOGNAME': 'cltbld', 11:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:15 INFO - 'MOZ_NO_REMOTE': '1', 11:59:15 INFO - 'NO_EM_RESTART': '1', 11:59:15 INFO - 'PAGER': '/bin/cat', 11:59:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:15 INFO - 'PWD': '/builds/slave/test', 11:59:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:15 INFO - 'SHELL': '/bin/bash', 11:59:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OiiM85UTu5/Listeners', 11:59:15 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 11:59:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:15 INFO - 'USER': 'cltbld', 11:59:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:15 INFO - 'XPC_FLAGS': '0x0', 11:59:15 INFO - 'XPC_SERVICE_NAME': '0', 11:59:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:59:15 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-uhf1Yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:59:15 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-faooNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:59:16 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-FhuMIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:59:16 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-B2YjvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:59:16 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-eSBGiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:59:16 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-j3QLyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:59:16 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-bM1MUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:59:16 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-YjFEVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:59:16 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-2NC_aO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:59:16 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-yH3Lnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:59:16 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-9BrtfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:59:17 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-Zy_hP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:59:17 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-wEb3Me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:59:17 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-G9actH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:17 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-4QQp1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:59:17 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-IsHn4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:59:17 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-utQer1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:59:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:59:17 INFO - Running setup.py install for manifestparser 11:59:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:59:17 INFO - Running setup.py install for mozcrash 11:59:17 INFO - Running setup.py install for mozdebug 11:59:18 INFO - Running setup.py install for mozdevice 11:59:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:59:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:59:18 INFO - Running setup.py install for mozfile 11:59:18 INFO - Running setup.py install for mozhttpd 11:59:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:59:18 INFO - Running setup.py install for mozinfo 11:59:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:59:18 INFO - Running setup.py install for mozInstall 11:59:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:59:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:59:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:59:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:59:18 INFO - Running setup.py install for mozleak 11:59:19 INFO - Running setup.py install for mozlog 11:59:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:59:19 INFO - Running setup.py install for moznetwork 11:59:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:59:19 INFO - Running setup.py install for mozprocess 11:59:19 INFO - Running setup.py install for mozprofile 11:59:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:59:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:59:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:59:19 INFO - Running setup.py install for mozrunner 11:59:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:59:19 INFO - Running setup.py install for mozscreenshot 11:59:19 INFO - Running setup.py install for moztest 11:59:20 INFO - Running setup.py install for mozversion 11:59:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:59:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:59:20 INFO - Cleaning up... 11:59:20 INFO - Return code: 0 11:59:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59: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')]} 11:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59: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')]} 11:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:20 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 0x105ef0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f85618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9248dc5010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e54d30>, '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 0x105bb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e4cb20>, '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.14lh1D6hX9/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.OiiM85UTu5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 11:59:20 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 11:59:20 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 11:59:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14lh1D6hX9/Render', 11:59:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:20 INFO - 'HOME': '/Users/cltbld', 11:59:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:20 INFO - 'LOGNAME': 'cltbld', 11:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:20 INFO - 'MOZ_NO_REMOTE': '1', 11:59:20 INFO - 'NO_EM_RESTART': '1', 11:59:20 INFO - 'PAGER': '/bin/cat', 11:59:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:20 INFO - 'PWD': '/builds/slave/test', 11:59:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:20 INFO - 'SHELL': '/bin/bash', 11:59:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OiiM85UTu5/Listeners', 11:59:20 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 11:59:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:20 INFO - 'USER': 'cltbld', 11:59:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:20 INFO - 'XPC_FLAGS': '0x0', 11:59:20 INFO - 'XPC_SERVICE_NAME': '0', 11:59:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:59:20 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-cFCldE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:59:20 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)) 11:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:59:20 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-XXes9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:59:20 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)) 11:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:59:20 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-0ORGvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:59:20 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)) 11:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:59:20 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-U3n2Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:59:21 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)) 11:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:59:21 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-7P239v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:59:21 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)) 11:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:59:21 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-l6Mr42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:59:21 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)) 11:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:59:21 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-LA_3vU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:59:21 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)) 11:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:59:21 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-Ob2ndI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:59:21 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)) 11:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:59:21 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-NTUEUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:59:21 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)) 11:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:59:21 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-uqXxiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:59:21 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)) 11:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:59:21 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-ap26qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:59:21 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)) 11:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:59:21 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-NsSVkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:59:21 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)) 11:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:59:21 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-i9pDfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:59:21 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)) 11:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:59:21 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-t_amsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:59:22 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)) 11:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:22 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-qypb6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:22 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)) 11:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:59:22 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-VBl1Dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:59:22 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)) 11:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:59:22 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-k1YlmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:59:22 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)) 11:59:22 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)) 11:59:22 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)) 11:59:22 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)) 11:59:22 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)) 11:59:22 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)) 11:59:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:24 INFO - Downloading blessings-1.6.tar.gz 11:59:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:59:24 INFO - Installing collected packages: blessings 11:59:24 INFO - Running setup.py install for blessings 11:59:25 INFO - Successfully installed blessings 11:59:25 INFO - Cleaning up... 11:59:25 INFO - Return code: 0 11:59:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:59:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:59:25 INFO - Reading from file tmpfile_stdout 11:59:25 INFO - Current package versions: 11:59:25 INFO - blessings == 1.6 11:59:25 INFO - blobuploader == 1.2.4 11:59:25 INFO - docopt == 0.6.1 11:59:25 INFO - functools32 == 3.2.3-2 11:59:25 INFO - jsonschema == 2.5.1 11:59:25 INFO - manifestparser == 1.1 11:59:25 INFO - mozInstall == 1.12 11:59:25 INFO - mozcrash == 0.17 11:59:25 INFO - mozdebug == 0.1 11:59:25 INFO - mozdevice == 0.48 11:59:25 INFO - mozfile == 1.2 11:59:25 INFO - mozhttpd == 0.7 11:59:25 INFO - mozinfo == 0.9 11:59:25 INFO - mozleak == 0.1 11:59:25 INFO - mozlog == 3.3 11:59:25 INFO - moznetwork == 0.27 11:59:25 INFO - mozprocess == 0.23 11:59:25 INFO - mozprofile == 0.28 11:59:25 INFO - mozrunner == 6.12 11:59:25 INFO - mozscreenshot == 0.1 11:59:25 INFO - mozsystemmonitor == 0.3 11:59:25 INFO - moztest == 0.7 11:59:25 INFO - mozversion == 1.4 11:59:25 INFO - psutil == 3.1.1 11:59:25 INFO - requests == 1.2.3 11:59:25 INFO - wsgiref == 0.1.2 11:59:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:25 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 0x105ef0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f85618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9248dc5010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e54d30>, '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 0x105bb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e4cb20>, '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.14lh1D6hX9/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.OiiM85UTu5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 11:59:25 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 11:59:25 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 11:59:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14lh1D6hX9/Render', 11:59:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:25 INFO - 'HOME': '/Users/cltbld', 11:59:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:25 INFO - 'LOGNAME': 'cltbld', 11:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:25 INFO - 'MOZ_NO_REMOTE': '1', 11:59:25 INFO - 'NO_EM_RESTART': '1', 11:59:25 INFO - 'PAGER': '/bin/cat', 11:59:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:25 INFO - 'PWD': '/builds/slave/test', 11:59:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:25 INFO - 'SHELL': '/bin/bash', 11:59:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OiiM85UTu5/Listeners', 11:59:25 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 11:59:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:25 INFO - 'USER': 'cltbld', 11:59:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:25 INFO - 'XPC_FLAGS': '0x0', 11:59:25 INFO - 'XPC_SERVICE_NAME': '0', 11:59:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:25 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)) 11:59:25 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)) 11:59:25 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)) 11:59:25 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)) 11:59:25 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)) 11:59:25 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)) 11:59:25 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)) 11:59:25 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)) 11:59:25 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)) 11:59:25 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)) 11:59:25 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)) 11:59:25 INFO - Cleaning up... 11:59:25 INFO - Return code: 0 11:59:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105ef0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f85618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9248dc5010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e54d30>, '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 0x105bb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e4cb20>, '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.14lh1D6hX9/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.OiiM85UTu5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 11:59:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:59:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14lh1D6hX9/Render', 11:59:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:25 INFO - 'HOME': '/Users/cltbld', 11:59:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:25 INFO - 'LOGNAME': 'cltbld', 11:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:25 INFO - 'MOZ_NO_REMOTE': '1', 11:59:25 INFO - 'NO_EM_RESTART': '1', 11:59:25 INFO - 'PAGER': '/bin/cat', 11:59:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:25 INFO - 'PWD': '/builds/slave/test', 11:59:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:25 INFO - 'SHELL': '/bin/bash', 11:59:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OiiM85UTu5/Listeners', 11:59:25 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 11:59:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:25 INFO - 'USER': 'cltbld', 11:59:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:25 INFO - 'XPC_FLAGS': '0x0', 11:59:25 INFO - 'XPC_SERVICE_NAME': '0', 11:59:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:59:25 INFO - Cleaning up... 11:59:25 INFO - Return code: 0 11:59:25 INFO - Running post-action listener: _resource_record_post_action 11:59:25 INFO - Running post-action listener: _start_resource_monitoring 11:59:25 INFO - Starting resource monitoring. 11:59:25 INFO - [mozharness: 2016-08-04 18:59:25.961400Z] Finished create-virtualenv step (success) 11:59:25 INFO - [mozharness: 2016-08-04 18:59:25.962376Z] Running install step. 11:59:25 INFO - Running pre-action listener: _resource_record_pre_action 11:59:25 INFO - Running main action method: install 11:59:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:59:26 INFO - Reading from file tmpfile_stdout 11:59:26 INFO - Detecting whether we're running mozinstall >=1.0... 11:59:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:59:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:59:26 INFO - Reading from file tmpfile_stdout 11:59:26 INFO - Output received: 11:59:26 INFO - Usage: mozinstall [options] installer 11:59:26 INFO - Options: 11:59:26 INFO - -h, --help show this help message and exit 11:59:26 INFO - -d DEST, --destination=DEST 11:59:26 INFO - Directory to install application into. [default: 11:59:26 INFO - "/builds/slave/test"] 11:59:26 INFO - --app=APP Application being installed. [default: firefox] 11:59:26 INFO - mkdir: /builds/slave/test/build/application 11:59:26 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'] 11:59:26 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 11:59:59 INFO - Reading from file tmpfile_stdout 11:59:59 INFO - Output received: 11:59:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:59:59 INFO - Running post-action listener: _resource_record_post_action 11:59:59 INFO - [mozharness: 2016-08-04 18:59:59.975332Z] Finished install step (success) 11:59:59 INFO - [mozharness: 2016-08-04 18:59:59.975461Z] Running run-tests step. 11:59:59 INFO - Running pre-action listener: _resource_record_pre_action 11:59:59 INFO - Running main action method: run_tests 11:59:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:59:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:59:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:59:59 INFO - 2016-08-04 11:59:59.988 screenresolution[1639:7648] starting screenresolution argv=screenresolution get 11:59:59 INFO - 2016-08-04 11:59:59.990 screenresolution[1639:7648] Display 0: 1600x1200x32@60 11:59:59 INFO - 2016-08-04 11:59:59.995 screenresolution[1640:7650] starting screenresolution argv=screenresolution list 11:59:59 INFO - Available Modes on Display 0 11:59:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:59:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:59:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:59:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:00:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:00:00 INFO - Intel Iris: 12:00:00 INFO - Chipset Model: Intel Iris 12:00:00 INFO - Type: GPU 12:00:00 INFO - Bus: Built-In 12:00:00 INFO - VRAM (Dynamic, Max): 1536 MB 12:00:00 INFO - Vendor: Intel (0x8086) 12:00:00 INFO - Device ID: 0x0a2e 12:00:00 INFO - Revision ID: 0x0009 12:00:00 INFO - Displays: 12:00:00 INFO - Display: 12:00:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:00:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:00:00 INFO - Display Serial Number: 1600x1200 60 12:00:00 INFO - Main Display: Yes 12:00:00 INFO - Mirror: Off 12:00:00 INFO - Online: Yes 12:00:00 INFO - Rotation: Supported 12:00:00 INFO - Return code: 0 12:00:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:00:00 INFO - Python 2.7.3 12:00:00 INFO - Return code: 0 12:00:00 INFO - grabbing minidump binary from tooltool 12:00:00 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')]} 12:00:00 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 0x105e54d30>, '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 0x105bb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e4cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:00:00 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 12:00:00 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 12:00:00 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 12:00:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:00:00 INFO - Return code: 0 12:00:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:00:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:00:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:00:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:00:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:00:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0104', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0104 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:00:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.14lh1D6hX9/Render', 12:00:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:00:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:00:00 INFO - 'HOME': '/Users/cltbld', 12:00:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:00:00 INFO - 'LOGNAME': 'cltbld', 12:00:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:00:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:00 INFO - 'MOZ_NO_REMOTE': '1', 12:00:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:00:00 INFO - 'NO_EM_RESTART': '1', 12:00:00 INFO - 'PAGER': '/bin/cat', 12:00:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:00 INFO - 'PWD': '/builds/slave/test', 12:00:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:00:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:00:00 INFO - 'SHELL': '/bin/bash', 12:00:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OiiM85UTu5/Listeners', 12:00:00 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 12:00:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:00:00 INFO - 'USER': 'cltbld', 12:00:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:00:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:00 INFO - 'XPC_FLAGS': '0x0', 12:00:00 INFO - 'XPC_SERVICE_NAME': '0', 12:00:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:00:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0104', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:00:00 INFO - mozversion application_buildid: 20160804092622 12:00:00 INFO - mozversion application_changeset: 5ad07719e3bdf424673e7f1c7d0e0dc9b6880cae 12:00:00 INFO - mozversion application_display_name: Nightly 12:00:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:00:00 INFO - mozversion application_name: Firefox 12:00:00 INFO - mozversion application_remotingname: firefox 12:00:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:00:00 INFO - mozversion application_vendor: Mozilla 12:00:00 INFO - mozversion application_version: 51.0a1 12:00:00 INFO - mozversion platform_buildid: 20160804092622 12:00:00 INFO - mozversion platform_changeset: 5ad07719e3bdf424673e7f1c7d0e0dc9b6880cae 12:00:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:00:00 INFO - mozversion platform_version: 51.0a1 12:00:00 INFO - using testdate: 1470337200 12:00:00 INFO - actual date: 1470337200 12:00:00 INFO - starting webserver on 'localhost:49270' 12:00:00 INFO - SUITE-START | Running 2 tests 12:00:00 INFO - TEST-START | dromaeo_css 12:00:00 INFO - operating with platform_type : mac_ 12:00:00 INFO - Initialising browser for dromaeo_css test... 12:00:00 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmp8eXYNz/profile http://localhost:49270/getInfo.html) 12:00:03 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 12:00:03 INFO - PROCESS | 1651 | colorDepth:24 12:00:03 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 12:00:03 INFO - PROCESS | 1651 | __metrics 12:00:03 INFO - PROCESS | 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:00:03 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:00:03 INFO - TEST-INFO | 1651: exit 0 12:00:03 INFO - Browser initialized. 12:00:03 INFO - Running cycle 1/1 for dromaeo_css test... 12:00:03 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmp8eXYNz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:00:15 INFO - PROCESS | 1653 | RSS: Main: 242425856 12:00:15 INFO - PROCESS | 1653 | 12:01:07 INFO - PROCESS | 1653 | 1470337267114 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] 12:03:18 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 12:03:20 INFO - PROCESS | 1653 | RSS: Main: 384024576 12:03:20 INFO - PROCESS | 1653 | 12:06:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 12:06:23 INFO - PROCESS | 1653 | RSS: Main: 394493952 12:06:23 INFO - PROCESS | 1653 | 12:09:26 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 12:09:26 INFO - PROCESS | 1653 | RSS: Main: 357801984 12:09:26 INFO - PROCESS | 1653 | 12:12:29 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 12:12:29 INFO - PROCESS | 1653 | RSS: Main: 357715968 12:12:29 INFO - PROCESS | 1653 | 12:15:32 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 12:15:33 INFO - PROCESS | 1653 | RSS: Main: 346714112 12:15:33 INFO - PROCESS | 1653 | 12:18:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 12:18:37 INFO - PROCESS | 1653 | RSS: Main: 390123520 12:18:37 INFO - PROCESS | 1653 | 12:18:37 INFO - PROCESS | 1653 | __start_tp_report 12:18:37 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 12:18:37 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 12:18:37 INFO - PROCESS | 1653 | |i|pagename|runs| 12:18:37 INFO - PROCESS | 1653 | |0;dojo.html;3363.865445382185;3381.6956473917344;3394.828784069496;3414.2317978454835;3443.431833747432;4784.636378632091;5402.9729851350685;5589.133684278943;5638.548916086714;5673.602847800656;5187.144121219994;5552.833414997546;5672.432756724325;5698.43015698431;5766.452187042235;5110.361204849394;5145.0481660892665;5224.895502089956;5233;5393.568514518849;5285.154375299952;5311.282976798121;5317.255584218213;5338.733063346836;5348.277982472375;5121.4622464641425;5171.870703232449;5180.3265575475325;5184.585233181337;5272;5189.040027594907;5195;5212.452692467275;5231.503007214308;5262.657927234717;5212.6872387656485;5232.372115346145;5250.0549901018185;5261;5279.260903473517;5624.775008999676;5683.801066962677;5761.711914404305;5810.796622118206;5814.47669709724;6270.435660790551;6276.3409841966395;6278.372162783685;6305.558610897239;6327.5570710050315;6285.748570057192;6329.778457754002;6338.492920566344;6339.36606339367;6350.26971898233;5703.087505999062;5793.826185214451;5858.53131749459;5869.5010924071075;5894.056950887837;6284.183056202756;6285.717142728588;6292.622442653455;6295;6302.086197501337;6191.535634827316;6217.098520714471;6221.844453888689;6226.59527130735;6237.313895471494;6123.648682309606;6183.96908015457;6191.628502289877;6210.068489726486;6311.684415779285;6208.937910620836;6267.059941008885;6279.4662453691035;6285.59143655661;6292.465140463112;6212.968935155295;6295.748170073238;6306.054091886253;6316.778912738032;6318.052292156213;4925.827596034122;4956.3804524434445;4994.126027945095;5018.197088465828;5028.84913452597;4462.085272519126;4509.549045095464;4532.9320060199125;4538.29656403258;4545.250033744462;5705.686187259657;5735.684537350486;5744.856378590569;5785.739641716133;5877.794277200363;6205.503559715212;6238.719257633417;6297.874042519215;6298.905516417258;6298.937010629927;5606.495415412551;5799.5650326225705;5823.679697616587;5825.0679891217205;5825.300963884276;5415.593830462731;5438.673679579238;5491.862703432446;5494.203340515603;5519.365272993577;6344.143540621957;6377.904331435032;6381.361863813581;6382.8723425531225;6414.294427613052;6256.499480041677;6281.403266689657;6290.899092658858;6305.716242769178;6316.305206427198;6194.194754681863;6223.937760622336;6263.185785847811;6337.746490140343;6358.205224346957;6250.124982502362;6252;6269.5611307208055;6273.059041143682;6278.748850045947;6269;6308.842278943063;6312.495000399865;6314.715837787218;6315.336889626523;6018.157457955802;6102.694865256631;6106.908396374147;6154.169187159676;6219.751209951552;4925.827596034122;6125.11336343068;6177.073438984188;6199.318075011655;6226.875462490634;4967.627427942846;6000.309964354155;6025.18659980897;6067.392245562195;6106.480949119375;6009.308929473166;6134.467201660849;6144.41628045335;6171.259448865985;6186.19579454668;5145.948540514697;6032.3967603239325;6104.633721976696;6111.572189946661;6123.84690382744 12:18:37 INFO - PROCESS | 1653 | |1;ext.html;515.6442054982065;522.2218893848164;541.4477233222113;541.4991133201788;542.135294205742;25528.74471255287;41021.718262539;42329.576704232946;42428.57571424285;44614.7769261154;43898.78050609743;44126.11747765043;44144.779276103654;44183.89540261495;44402.77798611011;9272.794536710218;9383.530823458834;9784.461854597976;9972.052654997764;9986.201103911706;8817.823643527126;8997.77505562363;11775.352355620438;12025;12034.51861925522;11973.700657483589;12074.93962530186;12075.033997280196;12076.879231207708;12163;11961.342126183057;12002.09984251176;12040.036797056215;12044.036477081812;12054.035677145896;11830.171887967846;11872.881271187263;11896.940515297454;11924.224925379822;11936.880631193664;40928.38607420891;41199;41342.37986430206;41363.586364136274;41383.58616413827;3648;3718.1076541630086;3903.80793544585;4137.731047481904;4334.588214119685;31737.843216856603;32622.021339359857;32831.83584082088;32954.01137965865;33036.50445243299;3177.6663450337614;3304.041827869915;3307.3881331953426;3338.532605435241;3410.488426735985;476293;478103;478361.6081919603;478859;480140.59226742166;33983;55541.44458555443;55863.72068139714;55944.72027639836;55999.880002399725;34460.65539344575;35698.46452303218;36040.4593931086;36092;36123.4581481278;12809.871901280869;14207.502737404142;14700.485483008257;14700.926495367668;14713.822894168441;11287.097032237401;11462.828057579143;12263.570775022832;12345.629631111082;12358.938205309096;7748.651310691032;7884.29041386278;7895.368370530344;7983.401244906655;8092.190780921861;3065.938681226363;3245.415825151448;3263.510473429005;3263.510473429005;3304.8678052878095;948.9193418559362;981.4160574458186;991.5835349153373;994.3437331361412;1075.1882328841675;27447.588286175724;30811.38377232443;31624.75918587364;31794.841025795187;31891.840540797148;931.5807886451124;948.2650945517279;1049.7113293844102;1077.932846481977;1201.537408097871;15913.363465461483;15935.282912268976;16009.43966961174;16048.679026419406;16378.918105409397;697169;714385;714501;716662;718540.4072979601;43111.137777244905;43404;43435;43543.56456435459;43575.34636980448;1216.8478940132484;1267.5816980396446;1378.200643626674;1397.7623803953352;1414.887248054264;30963.225919352197;31762.682373176896;31807.04578862638;32149.839250803598;32459.837700811346;50702.74648626733;51147.60654918135;51226.23160652668;51277.48722512877;51375.48624513707;521514;524284;524914;525080;525282;26824;27466.45067098687;27881.442371152058;27984.44031119407;29249;48447.5155248443;48766.5123348762;48812.511874880794;49571.25643115284;49794.75102624464;34117.488237675956;40121.39817902792;40469;41042;41490;39554.2089158221;40407;40927;41031.38452923268;41407.585924140374;38640.8407747768;38720;39345.016374590865;39435.80282098686;39445.60554394419;32749.836250818593;34857.825710871286;35498.64501354953;35734.46398303976;36332.45501317535;25344.619830702923;25583.488330232918;25952.351191220372;25996.610050848874;26193.214203573923 12:18:37 INFO - PROCESS | 1653 | |2;jquery.html;337.4769107882782;349.9160201551628;370.51277569995455;376.4541414948324;402.47276068350465;14414.711705765878;15517.689646207084;19942.102605382755;20600.690989635168;21173.894130529327;19738.914359710212;20227.696584551206;20241.291554795585;20319.796802031975;20488.69266960997;5872.324682661506;6088.512918966494;6155.692215389235;6156.938430615682;6169.043798211262;4081.571434999327;4312.094460163369;6048.485878700316;6169.7532098716;6847.794566163023;6863.661585990734;6868.896966545506;6872.656367181646;6875.793726188197;6899.517033807636;5831.999999999979;6123.265208175003;6169.321374648785;6216.658083805389;6855.58866468011;5851.678157701324;5981.7308221129715;6028.6985650717725;6067.120267561223;6070.392960703938;13402.46390144393;13447.529336473177;13530.661733456644;13634.590962271048;13644.590662280048;2246.7191601049867;2293.908243670251;2310.953780924389;2350.2714158610884;2842.3888863894363;9712.980137085575;9853.458059806708;9867.309288349818;10008.59965601375;10186.185105191567;1787.3526450736222;1844.4097888675628;1903.1816318982833;1939.0304847576213;1943.9125239364262;86423.2467214303;108172;108663;116805.41597292044;117142;11220.943895280472;11479;11518;11528.423578821026;11851.051915846712;12722.491100355883;13489.190648561118;13571.66070848217;14350.784738228935;14356.497522586867;6989.33601307875;8336.416450848383;8477.109903460172;8580.099089595502;8584.8712269316;7717.405190797742;7779.260970207822;8374.036985746718;8566.91433085661;8625.309975201968;3717.6096509866616;3767.416050512175;4435.35687325336;4561.201789686792;4652.348671186037;1650.6698660267994;1860.4046705054252;1915.9712604310946;1936.2835750772304;1939.360011196302;743.8953154565465;848.1052489623506;881.2641444393875;958.8849338079335;1034.4103860799423;20083;20212.09045592952;21460;21649.783502165094;21773.782262177174;904.5206040798388;919.8390281700675;940.6942743608355;958.5159494455395;1008.6873069348526;10600.734981625366;11369.31784092957;11387.202895797214;11391.544338226544;11411.429428528707;598222;605767;607908;612535;621932;127341;130687;130793.34603326922;131759;132220.67779322277;966.5312323523086;996.6163027234567;1027.306568066567;1027.9229057820694;1028.6554004408458;17760.644787104444;19242.615147697248;19346;19403.4178974631;19769.110390032194;36895;39103.804480977415;50575;50674.49325506698;53415.93168136538;60242.39757602543;72162.27837721766;72878;76661.61669191618;77658;7851.725189618336;7979.202079792207;8095.635696393559;8138.738495533202;8286.83426331482;12034.338111403607;12681.873181268438;12725.427355769198;13039;13115.934420327838;10704.090152336827;11243.887561124284;11276.492557834754;11291.717707057389;11377.772444550897;10691.518881650189;10749.89250107489;10965.50655220533;11254.83117753218;11428.200025998432;10805.891941080803;11024.448777560929;11397.829032564685;11412.429378531206;11493;7918.683252669829;7949.972756946941;8074.273315401642;8207;8222.465539739898;7558.357539608975;7595.886061708969;7770.494917830323;7831.373490120891;8039.67841286342 12:18:37 INFO - PROCESS | 1653 | |3;mootools.html;1528.7019031288903;1554.5180993891895;1727.8704097192706;1872.1388161445734;1879.3516236898274;8449.662013519459;8937.972133204683;8941.284697224215;8948.865767013493;8949.105089491048;7802.063752349712;8043.879341809878;8052.838943221147;8164.795880103;8715;2143.035633964714;2177.2597316912247;2299.609066458706;2377.465070359173;2380.9642855357097;2354.6232602783557;2358.9410264743433;2359.0681680736097;2360.563295790276;2360.9645855312183;2298.5058212484314;2365.3613524348416;2368.4078980254935;2371.158238825218;2371.8221133414977;2333.125078095714;2344.988275058622;2362.1850461590725;2365.0303375616086;2366.9644955325684;2310.549442858643;2334.031376978552;2359.245041586693;2361.362432143329;2362.0669835414915;8783.209511144029;8928.598213080362;8928.598213080428;8938.19556239935;8941.150590693873;4596.862094137148;5169.379674439091;5315.335583052119;5335.546478549328;5343.385510666284;3485.35520928629;3616.132128289218;3672.320620685182;3681.226942342111;3692.316921369555;1039.7244730146517;1088.8366744988236;1102.3385968418966;1109.8168802147636;1117.050507068993;10612.522436490453;10995.90040995902;11614.59348922792;11669.59156429521;11683.591074312359;4362.17118747437;4624.28323609841;4755.096531658974;4781.832635857728;4788.760561971888;9882.01179882006;9882.308238423242;9892.80214395708;9904.55429505674;9916.405015699082;5338.733063346895;5339.839804805862;5342.3856256531;5345.438728933484;5361.276227709287;4698.85903422891;4876.658633895593;4878.536539028786;4906.31311616374;4906.55840974314;3599.9820000899826;3735.7384983050924;3743.082944678571;3758.1356288053903;3764.5858955514873;1152.3316476443642;1175.6355529785794;1177.5633726853225;1179.8820117988132;1182.4028865422906;755.71282912494;843.9831203375898;855.7946092937775;915.706973768401;930.5114814722325;5622.650563864725;5624.156376543469;5704.600677952587;5979.730912108966;6001.1898393717165;860.8278344331034;893.8257039877161;916.6333466613409;927.9489628070521;1000.6847842929454;3822.120912190156;3922.7057970651745;4006.1587066715733;4027.9798601006805;4064.9593504065174;10469.633562825264;10740.570377184826;10829.133669306437;10867.673969780919;10868.347899126078;10387.272890897715;10515.631952881613;10755.946220268848;10775.030247277782;10806.729831754112;7380.335769780745;8127;8262.306227223406;8264.586770661443;8319.584020799057;5902.498287645427;5939.376365481562;5942.049272116614;5948.762049518144;5991.730372133177;10061.849072263776;10196.796064078528;10270.743231419274;10286.897131028893;10293;8436.367272454469;10003.34978226413;10263.435511046666;10472;10475.214358922958;7088.822779430556;7222.638868056471;7225.349718525358;7227.891581626385;7240.963795181201;8317.209865062809;8404.285635720787;8409.747707568782;8424.28393586552;8428.620712068094;7258.129024517092;7304.38771897457;7502.662380192795;7553.282438168365;7595.962020189863;7413.740519081806;7442.516236444614;7451.105867295742;7486.663100160615;7533.510321829063;6864.725410983705;6998.545094568837;7076.787696369117;7080.610566418896;7089.503734738519;4986.15235409974;4988.750562471934;5017.749112544431;5023.799048038038;5133.383993920754;4772.427308722976;4923.778429970588;4927.211646136744;4970.950290497049;5084.3898732152375 12:18:37 INFO - PROCESS | 1653 | |4;prototype.html;261.97118316985114;291.804490991036;298.9925251868704;303.819227559602;313.5344014139003;5066.240063990394;5226;5233.633645644806;5254.527092561669;5317.490456298843;4118.402831589426;5028.547430731233;5154.664946778466;5186.11835987882;5199.818006369778;3403.3703764803467;4027.6979226558124;4048.858289959852;4060.2488539620117;4081.795910204493;3909.4526766252607;4082.857100001486;4083.5712250213746;4115.8971025724295;4136.958630413687;4021;4022.4971878515184;4044.9191016179657;4073.63337299643;4094.9590504095027;4010.2380547695843;4035.7376770509823;4039.53545342285;4044.211378781139;4078.472121614782;3281.885134020322;3534.3108093921696;3538.2746536960117;3562.8931132066077;3569.0006798096574;4271.850485233033;4289.592488713567;4853.199222128344;5103.8468845934685;5157.613179011551;4597.908041839144;4629.166749985001;4647.60495357895;4652.697574657636;4671.201587388846;5221.503957124067;5468.644538105011;5503.284573005523;5513;5586.24585680932;3562.613049257004;3683.5027271318295;3711.9072023199365;3880.06878349197;3881.378979363288;5373.032854086302;5423.728813559306;5451.591130665216;5784.975258659478;5813;3607.639236076371;3951.7826519541127;3972.503437070366;3984.2629113614075;3990.6009399059863;3526.9118272042892;3794.4118661607495;4001.5398229204015;4006.6193711597352;4012.558618551957;3809.628533727856;4575.954240457553;4584.518625544337;4592.7014744041535;4592.954070459319;5504.6421982571;5511.311086114236;5536.833894983157;5545.889082218333;5546.611737178439;1129.5989923577176;1163.906887449002;1256.6983923858209;1282.7621345401733;1324.966875828112;904.3217586809892;932.1424289653535;933.4691106585205;934.4626839567276;936.513013233115;4461.977690111528;4491.505934347219;5176.870578235499;5177.223416487557;5228.869278268074;5274.947250527523;5596.865755177114;5618.241537392481;5674.517665998354;5705.657660540381;5031.6729412588065;5063.772130254148;5076.390833100052;5097.821576244888;5137.974310128426;2205.7904499072883;2227.596614133086;2233.564454931273;2276.1350686739265;2420.939476513066;4171.290880550314;4812.951870481321;4865.829695960695;5371.4897084776885;5652.802151924663;5900.911486327708;5909.8227053188475;5911.261092363455;5920.881582368328;5937.317208521075;4834.95165048352;5687.317521897316;5989.610675306091;6026.819195424145;6039.365866584033;4297.871063867964;4641.257398816173;4836.153673107263;5463.863403414946;5561;4335.349697545394;4394.934075988799;5680.346760122638;5683.4816321024055;5749.741261643319;4703.788329525248;5582.427246562284;5967.6572771127885;5996.910046349221;6066.514678825595;3105.9534106987962;3229.934121739773;3660.7071434285726;3850.537935447764;3866.3233934060863;4522.773861306987;5318.7074710891275;5659.207710920557;5715.31416230055;5783.710814459176;5192.896142077213;5268.736563171903;5373.865653358697;5612.607117501736;5658.830235092953;4858.319835223142;5012.398512178562;5062.797488100435;5534.640248384003;5544.8355845272945;4952.013629028666;5207.3490813648295;5353.867987227515;5365.463453654604;5492.3911142207135;4839.685420447659;5462.399136095106;5563.5271001963665;5670.461306175906;5703.543716502587;5158.878878278588;5447.891042179055;5472.644278121909;5482.314710661168;5508.366537848038 12:18:37 INFO - PROCESS | 1653 | |5;yui.html;700.2752151523173;739.2865884421532;760.2929275773529;771.4908160613996;857.5155037403869;14776.77834832477;15860.206989650529;16248.918755406236;16273.942193757397;16733.91229570077;14672.266386680676;15064;15075.547733567983;15079.246037698098;15177.165255910948;683.0335075867641;709.3792931185213;846.4498076250441;864.4510735682824;865.4028720183085;826.5949684654536;860.5783166248556;865.3596338709341;867.9262262707678;872.3849685971375;903.5708038681606;905.6965916418008;907.2741806554762;907.419251678926;908.1463424381094;709.7693249693818;864.3258258558271;900.8918929728409;901.3285102598574;902.3277658144724;673.5891106425076;674.7065026713395;675.6284043775904;676.4520738202073;678.9849175482635;14953.252337383195;14983.250837458083;14983.925080374529;14987.925060374737;15001.174935378549;13663.38514766838;13755.38100785467;13934.024618276724;13960.930195348958;14082;10738;12502.312372819491;12545.498180072786;12624.873751262461;12956.740865182643;3453.1021934297014;3488.284901595167;3525.4359302511475;3575.8390872410805;3593.2993066352074;99139.50430247874;100752.49623751908;101380.98619013789;101387.49306253495;109445.45277273642;10015.499225038719;10531.473426328654;10902.945485272523;10981.890181098246;10987.670369888916;20641;20994.055267513;21534.569308614053;21544.892275538834;21654.458638533848;7855.803604909923;7871.0948240951875;7909.327707144842;7912.841743165104;7924.683012679544;4319.33050377192;4350.847720329773;4363.6072753452345;4368.475782906072;4378.4745830499905;3411.198368383428;3517.50754894315;3520.718342532591;3523.5419395478934;3537.398642230827;649.9285078641345;655.05017724299;662.6587307536622;666.1406785246977;668.0780522878493;525.5060243371219;576.8384852241379;587.4096532984323;613.923259592551;622.7353374815685;7441.925580744231;8355.582220888931;8986.281097512183;9238.030006849318;9319.039348385873;579.2122713110167;581.0441823200811;630.7792272704517;641.2497378067673;649.6881496881429;4295.892602684896;4359.673024523174;4407.493138289138;4469.240229161051;4567.703099298535;122348.16477752841;165753.08222260055;165945.59734435938;169393;173997.13001434912;115931;136706;147981;148185.25907370393;149287;72850.27149728542;92267.07732922585;97116.51441742887;100485;110520.99999999838;9614.855777163488;9644.855327170239;9845;10049;10129.44288064134;59968;60015.39984600098;60753.39246607654;60761.696191520525;61748.47545736351;57253.141202881154;78656.60671696834;87960.5601971986;90096.54951725199;98392;13369;13402.463901443833;13486.595402137558;13656.726865462833;13784.379702913593;14752.409903604164;15366.923165384102;15742.449014284444;15750.897437179288;15848.207589620242;13795.931020344835;13978.021538492614;14185.645358866112;14288.57134285973;14555.854441455449;13885.930570347084;14145.575632731034;14467.565973020826;14583;14639.560813175622;13573.86426135726;13606.727865442834;13706.040577159902;13749.656258593215;14174.858251417767;11002;11016.283941543774;11480.655580332603;11589.594364197214;11624.883751162719;9730.659426920023;10135.949320253352;11117.94441027822;11138.221058478242;11334.603288885179 12:18:37 INFO - PROCESS | 1653 | __end_tp_report 12:18:37 INFO - PROCESS | 1653 | __start_cc_report 12:18:37 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1376 12:18:37 INFO - PROCESS | 1653 | __end_cc_report 12:18:37 INFO - PROCESS | 1653 | __startTimestamp1470338317059__endTimestamp 12:18:37 INFO - PROCESS | 1653 | 12:18:37 INFO - PROCESS | 1653 | ------- Summary: start ------- 12:18:37 INFO - PROCESS | 1653 | Number of tests: 6 12:18:37 INFO - PROCESS | 1653 | 12:18:37 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5765.47 Median:6032.40 stddev:653.79 (10.8%) stddev-sans-first:628.06 12:18:37 INFO - PROCESS | 1653 | Values: 3363.9 3381.7 3394.8 3414.2 3443.4 4784.6 5403.0 5589.1 5638.5 5673.6 5187.1 5552.8 5672.4 5698.4 5766.5 5110.4 5145.0 5224.9 5233.0 5393.6 5285.2 5311.3 5317.3 5338.7 5348.3 5121.5 5171.9 5180.3 5184.6 5272.0 5189.0 5195.0 5212.5 5231.5 5262.7 5212.7 5232.4 5250.1 5261.0 5279.3 5624.8 5683.8 5761.7 5810.8 5814.5 6270.4 6276.3 6278.4 6305.6 6327.6 6285.7 6329.8 6338.5 6339.4 6350.3 5703.1 5793.8 5858.5 5869.5 5894.1 6284.2 6285.7 6292.6 6295.0 6302.1 6191.5 6217.1 6221.8 6226.6 6237.3 6123.6 6184.0 6191.6 6210.1 6311.7 6208.9 6267.1 6279.5 6285.6 6292.5 6213.0 6295.7 6306.1 6316.8 6318.1 4925.8 4956.4 4994.1 5018.2 5028.8 4462.1 4509.5 4532.9 4538.3 4545.3 5705.7 5735.7 5744.9 5785.7 5877.8 6205.5 6238.7 6297.9 6298.9 6298.9 5606.5 5799.6 5823.7 5825.1 5825.3 5415.6 5438.7 5491.9 5494.2 5519.4 6344.1 6377.9 6381.4 6382.9 6414.3 6256.5 6281.4 6290.9 6305.7 6316.3 6194.2 6223.9 6263.2 6337.7 6358.2 6250.1 6252.0 6269.6 6273.1 6278.7 6269.0 6308.8 6312.5 6314.7 6315.3 6018.2 6102.7 6106.9 6154.2 6219.8 4925.8 6125.1 6177.1 6199.3 6226.9 4967.6 6000.3 6025.2 6067.4 6106.5 6009.3 6134.5 6144.4 6171.3 6186.2 5145.9 6032.4 6104.6 6111.6 6123.8 12:18:37 INFO - PROCESS | 1653 | 12:18:37 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:69285.01 Median:3683.05 stddev:155541.07 (4223.2%) stddev-sans-first:155891.70 12:18:37 INFO - PROCESS | 1653 | Values: 515.6 522.2 541.4 541.5 542.1 25528.7 41021.7 42329.6 42428.6 44614.8 43898.8 44126.1 44144.8 44183.9 44402.8 9272.8 9383.5 9784.5 9972.1 9986.2 8817.8 8997.8 11775.4 12025.0 12034.5 11973.7 12074.9 12075.0 12076.9 12163.0 11961.3 12002.1 12040.0 12044.0 12054.0 11830.2 11872.9 11896.9 11924.2 11936.9 40928.4 41199.0 41342.4 41363.6 41383.6 3648.0 3718.1 3903.8 4137.7 4334.6 31737.8 32622.0 32831.8 32954.0 33036.5 3177.7 3304.0 3307.4 3338.5 3410.5 476293.0 478103.0 478361.6 478859.0 480140.6 33983.0 55541.4 55863.7 55944.7 55999.9 34460.7 35698.5 36040.5 36092.0 36123.5 12809.9 14207.5 14700.5 14700.9 14713.8 11287.1 11462.8 12263.6 12345.6 12358.9 7748.7 7884.3 7895.4 7983.4 8092.2 3065.9 3245.4 3263.5 3263.5 3304.9 948.9 981.4 991.6 994.3 1075.2 27447.6 30811.4 31624.8 31794.8 31891.8 931.6 948.3 1049.7 1077.9 1201.5 15913.4 15935.3 16009.4 16048.7 16378.9 697169.0 714385.0 714501.0 716662.0 718540.4 43111.1 43404.0 43435.0 43543.6 43575.3 1216.8 1267.6 1378.2 1397.8 1414.9 30963.2 31762.7 31807.0 32149.8 32459.8 50702.7 51147.6 51226.2 51277.5 51375.5 521514.0 524284.0 524914.0 525080.0 525282.0 26824.0 27466.5 27881.4 27984.4 29249.0 48447.5 48766.5 48812.5 49571.3 49794.8 34117.5 40121.4 40469.0 41042.0 41490.0 39554.2 40407.0 40927.0 41031.4 41407.6 38640.8 38720.0 39345.0 39435.8 39445.6 32749.8 34857.8 35498.6 35734.5 36332.5 25344.6 25583.5 25952.4 25996.6 26193.2 12:18:37 INFO - PROCESS | 1653 | 12:18:37 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:34295.92 Median:1589.93 stddev:101443.19 (6380.3%) stddev-sans-first:101695.71 12:18:37 INFO - PROCESS | 1653 | Values: 337.5 349.9 370.5 376.5 402.5 14414.7 15517.7 19942.1 20600.7 21173.9 19738.9 20227.7 20241.3 20319.8 20488.7 5872.3 6088.5 6155.7 6156.9 6169.0 4081.6 4312.1 6048.5 6169.8 6847.8 6863.7 6868.9 6872.7 6875.8 6899.5 5832.0 6123.3 6169.3 6216.7 6855.6 5851.7 5981.7 6028.7 6067.1 6070.4 13402.5 13447.5 13530.7 13634.6 13644.6 2246.7 2293.9 2311.0 2350.3 2842.4 9713.0 9853.5 9867.3 10008.6 10186.2 1787.4 1844.4 1903.2 1939.0 1943.9 86423.2 108172.0 108663.0 116805.4 117142.0 11220.9 11479.0 11518.0 11528.4 11851.1 12722.5 13489.2 13571.7 14350.8 14356.5 6989.3 8336.4 8477.1 8580.1 8584.9 7717.4 7779.3 8374.0 8566.9 8625.3 3717.6 3767.4 4435.4 4561.2 4652.3 1650.7 1860.4 1916.0 1936.3 1939.4 743.9 848.1 881.3 958.9 1034.4 20083.0 20212.1 21460.0 21649.8 21773.8 904.5 919.8 940.7 958.5 1008.7 10600.7 11369.3 11387.2 11391.5 11411.4 598222.0 605767.0 607908.0 612535.0 621932.0 127341.0 130687.0 130793.3 131759.0 132220.7 966.5 996.6 1027.3 1027.9 1028.7 17760.6 19242.6 19346.0 19403.4 19769.1 36895.0 39103.8 50575.0 50674.5 53415.9 60242.4 72162.3 72878.0 76661.6 77658.0 7851.7 7979.2 8095.6 8138.7 8286.8 12034.3 12681.9 12725.4 13039.0 13115.9 10704.1 11243.9 11276.5 11291.7 11377.8 10691.5 10749.9 10965.5 11254.8 11428.2 10805.9 11024.4 11397.8 11412.4 11493.0 7918.7 7950.0 8074.3 8207.0 8222.5 7558.4 7595.9 7770.5 7831.4 8039.7 12:18:37 INFO - PROCESS | 1653 | 12:18:37 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5687.41 Median:4906.44 stddev:3184.41 (64.9%) stddev-sans-first:3178.01 12:18:37 INFO - PROCESS | 1653 | Values: 1528.7 1554.5 1727.9 1872.1 1879.4 8449.7 8938.0 8941.3 8948.9 8949.1 7802.1 8043.9 8052.8 8164.8 8715.0 2143.0 2177.3 2299.6 2377.5 2381.0 2354.6 2358.9 2359.1 2360.6 2361.0 2298.5 2365.4 2368.4 2371.2 2371.8 2333.1 2345.0 2362.2 2365.0 2367.0 2310.5 2334.0 2359.2 2361.4 2362.1 8783.2 8928.6 8928.6 8938.2 8941.2 4596.9 5169.4 5315.3 5335.5 5343.4 3485.4 3616.1 3672.3 3681.2 3692.3 1039.7 1088.8 1102.3 1109.8 1117.1 10612.5 10995.9 11614.6 11669.6 11683.6 4362.2 4624.3 4755.1 4781.8 4788.8 9882.0 9882.3 9892.8 9904.6 9916.4 5338.7 5339.8 5342.4 5345.4 5361.3 4698.9 4876.7 4878.5 4906.3 4906.6 3600.0 3735.7 3743.1 3758.1 3764.6 1152.3 1175.6 1177.6 1179.9 1182.4 755.7 844.0 855.8 915.7 930.5 5622.7 5624.2 5704.6 5979.7 6001.2 860.8 893.8 916.6 927.9 1000.7 3822.1 3922.7 4006.2 4028.0 4065.0 10469.6 10740.6 10829.1 10867.7 10868.3 10387.3 10515.6 10755.9 10775.0 10806.7 7380.3 8127.0 8262.3 8264.6 8319.6 5902.5 5939.4 5942.0 5948.8 5991.7 10061.8 10196.8 10270.7 10286.9 10293.0 8436.4 10003.3 10263.4 10472.0 10475.2 7088.8 7222.6 7225.3 7227.9 7241.0 8317.2 8404.3 8409.7 8424.3 8428.6 7258.1 7304.4 7502.7 7553.3 7596.0 7413.7 7442.5 7451.1 7486.7 7533.5 6864.7 6998.5 7076.8 7080.6 7089.5 4986.2 4988.8 5017.7 5023.8 5133.4 4772.4 4923.8 4927.2 4971.0 5084.4 12:18:37 INFO - PROCESS | 1653 | 12:18:37 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4444.59 Median:5020.47 stddev:1385.40 (27.6%) stddev-sans-first:1353.25 12:18:37 INFO - PROCESS | 1653 | Values: 262.0 291.8 299.0 303.8 313.5 5066.2 5226.0 5233.6 5254.5 5317.5 4118.4 5028.5 5154.7 5186.1 5199.8 3403.4 4027.7 4048.9 4060.2 4081.8 3909.5 4082.9 4083.6 4115.9 4137.0 4021.0 4022.5 4044.9 4073.6 4095.0 4010.2 4035.7 4039.5 4044.2 4078.5 3281.9 3534.3 3538.3 3562.9 3569.0 4271.9 4289.6 4853.2 5103.8 5157.6 4597.9 4629.2 4647.6 4652.7 4671.2 5221.5 5468.6 5503.3 5513.0 5586.2 3562.6 3683.5 3711.9 3880.1 3881.4 5373.0 5423.7 5451.6 5785.0 5813.0 3607.6 3951.8 3972.5 3984.3 3990.6 3526.9 3794.4 4001.5 4006.6 4012.6 3809.6 4576.0 4584.5 4592.7 4593.0 5504.6 5511.3 5536.8 5545.9 5546.6 1129.6 1163.9 1256.7 1282.8 1325.0 904.3 932.1 933.5 934.5 936.5 4462.0 4491.5 5176.9 5177.2 5228.9 5274.9 5596.9 5618.2 5674.5 5705.7 5031.7 5063.8 5076.4 5097.8 5138.0 2205.8 2227.6 2233.6 2276.1 2420.9 4171.3 4813.0 4865.8 5371.5 5652.8 5900.9 5909.8 5911.3 5920.9 5937.3 4835.0 5687.3 5989.6 6026.8 6039.4 4297.9 4641.3 4836.2 5463.9 5561.0 4335.3 4394.9 5680.3 5683.5 5749.7 4703.8 5582.4 5967.7 5996.9 6066.5 3106.0 3229.9 3660.7 3850.5 3866.3 4522.8 5318.7 5659.2 5715.3 5783.7 5192.9 5268.7 5373.9 5612.6 5658.8 4858.3 5012.4 5062.8 5534.6 5544.8 4952.0 5207.3 5353.9 5365.5 5492.4 4839.7 5462.4 5563.5 5670.5 5703.5 5158.9 5447.9 5472.6 5482.3 5508.4 12:18:37 INFO - PROCESS | 1653 | 12:18:37 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:24601.58 Median:3519.11 stddev:39948.86 (1135.2%) stddev-sans-first:40020.62 12:18:37 INFO - PROCESS | 1653 | Values: 700.3 739.3 760.3 771.5 857.5 14776.8 15860.2 16248.9 16273.9 16733.9 14672.3 15064.0 15075.5 15079.2 15177.2 683.0 709.4 846.4 864.5 865.4 826.6 860.6 865.4 867.9 872.4 903.6 905.7 907.3 907.4 908.1 709.8 864.3 900.9 901.3 902.3 673.6 674.7 675.6 676.5 679.0 14953.3 14983.3 14983.9 14987.9 15001.2 13663.4 13755.4 13934.0 13960.9 14082.0 10738.0 12502.3 12545.5 12624.9 12956.7 3453.1 3488.3 3525.4 3575.8 3593.3 99139.5 100752.5 101381.0 101387.5 109445.5 10015.5 10531.5 10902.9 10981.9 10987.7 20641.0 20994.1 21534.6 21544.9 21654.5 7855.8 7871.1 7909.3 7912.8 7924.7 4319.3 4350.8 4363.6 4368.5 4378.5 3411.2 3517.5 3520.7 3523.5 3537.4 649.9 655.1 662.7 666.1 668.1 525.5 576.8 587.4 613.9 622.7 7441.9 8355.6 8986.3 9238.0 9319.0 579.2 581.0 630.8 641.2 649.7 4295.9 4359.7 4407.5 4469.2 4567.7 122348.2 165753.1 165945.6 169393.0 173997.1 115931.0 136706.0 147981.0 148185.3 149287.0 72850.3 92267.1 97116.5 100485.0 110521.0 9614.9 9644.9 9845.0 10049.0 10129.4 59968.0 60015.4 60753.4 60761.7 61748.5 57253.1 78656.6 87960.6 90096.5 98392.0 13369.0 13402.5 13486.6 13656.7 13784.4 14752.4 15366.9 15742.4 15750.9 15848.2 13795.9 13978.0 14185.6 14288.6 14555.9 13885.9 14145.6 14467.6 14583.0 14639.6 13573.9 13606.7 13706.0 13749.7 14174.9 11002.0 11016.3 11480.7 11589.6 11624.9 9730.7 10135.9 11117.9 11138.2 11334.6 12:18:37 INFO - PROCESS | 1653 | -------- Summary: end -------- 12:18:37 INFO - PROCESS | 1653 | 12:18:37 INFO - TEST-INFO | 1653: exit 0 12:18:37 INFO - TEST-OK | dromaeo_css | took 1117074ms 12:18:37 INFO - TEST-START | kraken 12:18:37 INFO - operating with platform_type : mac_ 12:18:37 INFO - Initialising browser for kraken test... 12:18:37 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpv_ZTpu/profile http://localhost:49270/getInfo.html) 12:18:39 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 12:18:39 INFO - PROCESS | 1663 | colorDepth:24 12:18:39 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 12:18:39 INFO - PROCESS | 1663 | __metrics 12:18:40 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:18:40 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:18:40 INFO - TEST-INFO | 1663: exit 0 12:18:40 INFO - Browser initialized. 12:18:40 INFO - Running cycle 1/1 for kraken test... 12:18:40 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpv_ZTpu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:18:52 INFO - PROCESS | 1664 | RSS: Main: 242040832 12:18:52 INFO - PROCESS | 1664 | 12:18:55 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 12:18:56 INFO - PROCESS | 1664 | RSS: Main: 292143104 12:18:56 INFO - PROCESS | 1664 | 12:18:59 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 12:18:59 INFO - PROCESS | 1664 | RSS: Main: 299085824 12:18:59 INFO - PROCESS | 1664 | 12:19:03 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 12:19:03 INFO - PROCESS | 1664 | RSS: Main: 392847360 12:19:03 INFO - PROCESS | 1664 | 12:19:05 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 12:19:06 INFO - PROCESS | 1664 | RSS: Main: 295510016 12:19:06 INFO - PROCESS | 1664 | 12:19:08 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:19:09 INFO - PROCESS | 1664 | RSS: Main: 300736512 12:19:09 INFO - PROCESS | 1664 | 12:19:11 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 12:19:12 INFO - PROCESS | 1664 | RSS: Main: 337813504 12:19:12 INFO - PROCESS | 1664 | 12:19:15 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 12:19:15 INFO - PROCESS | 1664 | RSS: Main: 339890176 12:19:15 INFO - PROCESS | 1664 | 12:19:18 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 12:19:19 INFO - PROCESS | 1664 | RSS: Main: 338329600 12:19:19 INFO - PROCESS | 1664 | 12:19:21 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:19:21 INFO - PROCESS | 1664 | RSS: Main: 312213504 12:19:21 INFO - PROCESS | 1664 | 12:19:23 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:19:24 INFO - PROCESS | 1664 | RSS: Main: 317890560 12:19:24 INFO - PROCESS | 1664 | 12:19:26 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:19:27 INFO - PROCESS | 1664 | RSS: Main: 323715072 12:19:27 INFO - PROCESS | 1664 | 12:19:30 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:19:30 INFO - PROCESS | 1664 | RSS: Main: 328810496 12:19:30 INFO - PROCESS | 1664 | 12:19:33 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:19:34 INFO - PROCESS | 1664 | RSS: Main: 330362880 12:19:34 INFO - PROCESS | 1664 | 12:19:36 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 12:19:36 INFO - PROCESS | 1664 | RSS: Main: 373297152 12:19:36 INFO - PROCESS | 1664 | 12:19:36 INFO - PROCESS | 1664 | __start_tp_report 12:19:36 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 12:19:36 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 12:19:36 INFO - PROCESS | 1664 | |i|pagename|runs| 12:19:36 INFO - PROCESS | 1664 | |0;ai-astar;102;112;110;110;115;113;115;160;90;157 12:19:36 INFO - PROCESS | 1664 | |1;audio-beat-detection;147;107;109;167;111;112;154;108;142;107 12:19:36 INFO - PROCESS | 1664 | |2;audio-dft;184;184;183;185;181;184;182;184;183;182 12:19:36 INFO - PROCESS | 1664 | |3;audio-fft;75;57;57;106;57;57;61;67;84;60 12:19:36 INFO - PROCESS | 1664 | |4;audio-oscillator;86;68;92;70;77;68;96;69;67;101 12:19:36 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;90;87;87;84;86;83;87;83;86;83 12:19:36 INFO - PROCESS | 1664 | |6;imaging-darkroom;92;92;92;93;92;91;92;92;92;92 12:19:36 INFO - PROCESS | 1664 | |7;imaging-desaturate;91;131;84;83;101;132;134;86;87;84 12:19:36 INFO - PROCESS | 1664 | |8;json-parse-financial;55;53;53;53;53;54;52;53;53;53 12:19:36 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;66;68;72;78;78;73;70;71;70;71 12:19:36 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;86;81;84;83;84;85;83;88;87;87 12:19:36 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;152;129;145;145;141;146;142;135;138;135 12:19:36 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;213;223;163;165;165;163;165;163;164;164 12:19:36 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;65;66;65;65;60;59;81;84;84;82 12:19:36 INFO - PROCESS | 1664 | __end_tp_report 12:19:36 INFO - PROCESS | 1664 | __start_cc_report 12:19:36 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,2155 12:19:36 INFO - PROCESS | 1664 | __end_cc_report 12:19:36 INFO - PROCESS | 1664 | __startTimestamp1470338376373__endTimestamp 12:19:36 INFO - PROCESS | 1664 | 12:19:36 INFO - PROCESS | 1664 | ------- Summary: start ------- 12:19:36 INFO - PROCESS | 1664 | Number of tests: 14 12:19:36 INFO - PROCESS | 1664 | 12:19:36 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:118.40 Median:115.00 stddev:22.44 (19.5%) stddev-sans-first:23.00 12:19:36 INFO - PROCESS | 1664 | Values: 102.0 112.0 110.0 110.0 115.0 113.0 115.0 160.0 90.0 157.0 12:19:36 INFO - PROCESS | 1664 | 12:19:36 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:126.40 Median:127.00 stddev:23.37 (18.4%) stddev-sans-first:23.57 12:19:36 INFO - PROCESS | 1664 | Values: 147.0 107.0 109.0 167.0 111.0 112.0 154.0 108.0 142.0 107.0 12:19:36 INFO - PROCESS | 1664 | 12:19:36 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:183.20 Median:184.00 stddev:1.23 (0.7%) stddev-sans-first:1.27 12:19:36 INFO - PROCESS | 1664 | Values: 184.0 184.0 183.0 185.0 181.0 184.0 182.0 184.0 183.0 182.0 12:19:36 INFO - PROCESS | 1664 | 12:19:36 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:68.10 Median:60.50 stddev:16.15 (26.7%) stddev-sans-first:16.93 12:19:36 INFO - PROCESS | 1664 | Values: 75.0 57.0 57.0 106.0 57.0 57.0 61.0 67.0 84.0 60.0 12:19:36 INFO - PROCESS | 1664 | 12:19:36 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:79.40 Median:73.50 stddev:13.17 (17.9%) stddev-sans-first:13.75 12:19:36 INFO - PROCESS | 1664 | Values: 86.0 68.0 92.0 70.0 77.0 68.0 96.0 69.0 67.0 101.0 12:19:36 INFO - PROCESS | 1664 | 12:19:36 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:86.50 stddev:2.32 (2.7%) stddev-sans-first:1.83 12:19:36 INFO - PROCESS | 1664 | Values: 90.0 87.0 87.0 84.0 86.0 83.0 87.0 83.0 86.0 83.0 12:19:36 INFO - PROCESS | 1664 | 12:19:36 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:92.00 Median:92.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 12:19:36 INFO - PROCESS | 1664 | Values: 92.0 92.0 92.0 93.0 92.0 91.0 92.0 92.0 92.0 92.0 12:19:36 INFO - PROCESS | 1664 | 12:19:36 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:101.30 Median:84.00 stddev:22.04 (26.2%) stddev-sans-first:23.06 12:19:36 INFO - PROCESS | 1664 | Values: 91.0 131.0 84.0 83.0 101.0 132.0 134.0 86.0 87.0 84.0 12:19:36 INFO - PROCESS | 1664 | 12:19:36 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.00 stddev:0.79 (1.5%) stddev-sans-first:0.50 12:19:36 INFO - PROCESS | 1664 | Values: 55.0 53.0 53.0 53.0 53.0 54.0 52.0 53.0 53.0 53.0 12:19:36 INFO - PROCESS | 1664 | 12:19:36 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:71.50 stddev:3.86 (5.4%) stddev-sans-first:3.50 12:19:36 INFO - PROCESS | 1664 | Values: 66.0 68.0 72.0 78.0 78.0 73.0 70.0 71.0 70.0 71.0 12:19:36 INFO - PROCESS | 1664 | 12:19:36 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.50 stddev:2.20 (2.6%) stddev-sans-first:2.29 12:19:36 INFO - PROCESS | 1664 | Values: 86.0 81.0 84.0 83.0 84.0 85.0 83.0 88.0 87.0 87.0 12:19:36 INFO - PROCESS | 1664 | 12:19:36 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:143.50 stddev:6.70 (4.7%) stddev-sans-first:5.75 12:19:36 INFO - PROCESS | 1664 | Values: 152.0 129.0 145.0 145.0 141.0 146.0 142.0 135.0 138.0 135.0 12:19:36 INFO - PROCESS | 1664 | 12:19:36 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:165.00 stddev:22.90 (13.9%) stddev-sans-first:19.69 12:19:36 INFO - PROCESS | 1664 | Values: 213.0 223.0 163.0 165.0 165.0 163.0 165.0 163.0 164.0 164.0 12:19:36 INFO - PROCESS | 1664 | 12:19:36 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:73.50 stddev:10.31 (14.0%) stddev-sans-first:10.70 12:19:36 INFO - PROCESS | 1664 | Values: 65.0 66.0 65.0 65.0 60.0 59.0 81.0 84.0 84.0 82.0 12:19:36 INFO - PROCESS | 1664 | -------- Summary: end -------- 12:19:36 INFO - PROCESS | 1664 | 12:19:37 INFO - TEST-INFO | 1664: exit 0 12:19:37 INFO - TEST-OK | kraken | took 59566ms 12:19:37 INFO - SUITE-END | took 1176s 12:19:37 INFO - Completed test suite (00:19:36) 12:19:37 INFO - javascript benchmark 12:19:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3363.865445382185, 3381.6956473917344, 3394.828784069496, 3414.2317978454835, 3443.431833747432, 4784.636378632091, 5402.9729851350685, 5589.133684278943, 5638.548916086714, 5673.602847800656, 5187.144121219994, 5552.833414997546, 5672.432756724325, 5698.43015698431, 5766.452187042235, 5110.361204849394, 5145.0481660892665, 5224.895502089956, 5233.0, 5393.568514518849, 5285.154375299952, 5311.282976798121, 5317.255584218213, 5338.733063346836, 5348.277982472375, 5121.4622464641425, 5171.870703232449, 5180.3265575475325, 5184.585233181337, 5272.0, 5189.040027594907, 5195.0, 5212.452692467275, 5231.503007214308, 5262.657927234717, 5212.6872387656485, 5232.372115346145, 5250.0549901018185, 5261.0, 5279.260903473517, 5624.775008999676, 5683.801066962677, 5761.711914404305, 5810.796622118206, 5814.47669709724, 6270.435660790551, 6276.3409841966395, 6278.372162783685, 6305.558610897239, 6327.5570710050315, 6285.748570057192, 6329.778457754002, 6338.492920566344, 6339.36606339367, 6350.26971898233, 5703.087505999062, 5793.826185214451, 5858.53131749459, 5869.5010924071075, 5894.056950887837, 6284.183056202756, 6285.717142728588, 6292.622442653455, 6295.0, 6302.086197501337, 6191.535634827316, 6217.098520714471, 6221.844453888689, 6226.59527130735, 6237.313895471494, 6123.648682309606, 6183.96908015457, 6191.628502289877, 6210.068489726486, 6311.684415779285, 6208.937910620836, 6267.059941008885, 6279.4662453691035, 6285.59143655661, 6292.465140463112, 6212.968935155295, 6295.748170073238, 6306.054091886253, 6316.778912738032, 6318.052292156213, 4925.827596034122, 4956.3804524434445, 4994.126027945095, 5018.197088465828, 5028.84913452597, 4462.085272519126, 4509.549045095464, 4532.9320060199125, 4538.29656403258, 4545.250033744462, 5705.686187259657, 5735.684537350486, 5744.856378590569, 5785.739641716133, 5877.794277200363, 6205.503559715212, 6238.719257633417, 6297.874042519215, 6298.905516417258, 6298.937010629927, 5606.495415412551, 5799.5650326225705, 5823.679697616587, 5825.0679891217205, 5825.300963884276, 5415.593830462731, 5438.673679579238, 5491.862703432446, 5494.203340515603, 5519.365272993577, 6344.143540621957, 6377.904331435032, 6381.361863813581, 6382.8723425531225, 6414.294427613052, 6256.499480041677, 6281.403266689657, 6290.899092658858, 6305.716242769178, 6316.305206427198, 6194.194754681863, 6223.937760622336, 6263.185785847811, 6337.746490140343, 6358.205224346957, 6250.124982502362, 6252.0, 6269.5611307208055, 6273.059041143682, 6278.748850045947, 6269.0, 6308.842278943063, 6312.495000399865, 6314.715837787218, 6315.336889626523, 6018.157457955802, 6102.694865256631, 6106.908396374147, 6154.169187159676, 6219.751209951552, 4925.827596034122, 6125.11336343068, 6177.073438984188, 6199.318075011655, 6226.875462490634, 4967.627427942846, 6000.309964354155, 6025.18659980897, 6067.392245562195, 6106.480949119375, 6009.308929473166, 6134.467201660849, 6144.41628045335, 6171.259448865985, 6186.19579454668, 5145.948540514697, 6032.3967603239325, 6104.633721976696, 6111.572189946661, 6123.84690382744], "value": 5724.41932648422, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [515.6442054982065, 522.2218893848164, 541.4477233222113, 541.4991133201788, 542.135294205742, 25528.74471255287, 41021.718262539, 42329.576704232946, 42428.57571424285, 44614.7769261154, 43898.78050609743, 44126.11747765043, 44144.779276103654, 44183.89540261495, 44402.77798611011, 9272.794536710218, 9383.530823458834, 9784.461854597976, 9972.052654997764, 9986.201103911706, 8817.823643527126, 8997.77505562363, 11775.352355620438, 12025.0, 12034.51861925522, 11973.700657483589, 12074.93962530186, 12075.033997280196, 12076.879231207708, 12163.0, 11961.342126183057, 12002.09984251176, 12040.036797056215, 12044.036477081812, 12054.035677145896, 11830.171887967846, 11872.881271187263, 11896.940515297454, 11924.224925379822, 11936.880631193664, 40928.38607420891, 41199.0, 41342.37986430206, 41363.586364136274, 41383.58616413827, 3648.0, 3718.1076541630086, 3903.80793544585, 4137.731047481904, 4334.588214119685, 31737.843216856603, 32622.021339359857, 32831.83584082088, 32954.01137965865, 33036.50445243299, 3177.6663450337614, 3304.041827869915, 3307.3881331953426, 3338.532605435241, 3410.488426735985, 476293.0, 478103.0, 478361.6081919603, 478859.0, 480140.59226742166, 33983.0, 55541.44458555443, 55863.72068139714, 55944.72027639836, 55999.880002399725, 34460.65539344575, 35698.46452303218, 36040.4593931086, 36092.0, 36123.4581481278, 12809.871901280869, 14207.502737404142, 14700.485483008257, 14700.926495367668, 14713.822894168441, 11287.097032237401, 11462.828057579143, 12263.570775022832, 12345.629631111082, 12358.938205309096, 7748.651310691032, 7884.29041386278, 7895.368370530344, 7983.401244906655, 8092.190780921861, 3065.938681226363, 3245.415825151448, 3263.510473429005, 3263.510473429005, 3304.8678052878095, 948.9193418559362, 981.4160574458186, 991.5835349153373, 994.3437331361412, 1075.1882328841675, 27447.588286175724, 30811.38377232443, 31624.75918587364, 31794.841025795187, 31891.840540797148, 931.5807886451124, 948.2650945517279, 1049.7113293844102, 1077.932846481977, 1201.537408097871, 15913.363465461483, 15935.282912268976, 16009.43966961174, 16048.679026419406, 16378.918105409397, 697169.0, 714385.0, 714501.0, 716662.0, 718540.4072979601, 43111.137777244905, 43404.0, 43435.0, 43543.56456435459, 43575.34636980448, 1216.8478940132484, 1267.5816980396446, 1378.200643626674, 1397.7623803953352, 1414.887248054264, 30963.225919352197, 31762.682373176896, 31807.04578862638, 32149.839250803598, 32459.837700811346, 50702.74648626733, 51147.60654918135, 51226.23160652668, 51277.48722512877, 51375.48624513707, 521514.0, 524284.0, 524914.0, 525080.0, 525282.0, 26824.0, 27466.45067098687, 27881.442371152058, 27984.44031119407, 29249.0, 48447.5155248443, 48766.5123348762, 48812.511874880794, 49571.25643115284, 49794.75102624464, 34117.488237675956, 40121.39817902792, 40469.0, 41042.0, 41490.0, 39554.2089158221, 40407.0, 40927.0, 41031.38452923268, 41407.585924140374, 38640.8407747768, 38720.0, 39345.016374590865, 39435.80282098686, 39445.60554394419, 32749.836250818593, 34857.825710871286, 35498.64501354953, 35734.46398303976, 36332.45501317535, 25344.619830702923, 25583.488330232918, 25952.351191220372, 25996.610050848874, 26193.214203573923], "value": 19193.904619275192, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.4769107882782, 349.9160201551628, 370.51277569995455, 376.4541414948324, 402.47276068350465, 14414.711705765878, 15517.689646207084, 19942.102605382755, 20600.690989635168, 21173.894130529327, 19738.914359710212, 20227.696584551206, 20241.291554795585, 20319.796802031975, 20488.69266960997, 5872.324682661506, 6088.512918966494, 6155.692215389235, 6156.938430615682, 6169.043798211262, 4081.571434999327, 4312.094460163369, 6048.485878700316, 6169.7532098716, 6847.794566163023, 6863.661585990734, 6868.896966545506, 6872.656367181646, 6875.793726188197, 6899.517033807636, 5831.999999999979, 6123.265208175003, 6169.321374648785, 6216.658083805389, 6855.58866468011, 5851.678157701324, 5981.7308221129715, 6028.6985650717725, 6067.120267561223, 6070.392960703938, 13402.46390144393, 13447.529336473177, 13530.661733456644, 13634.590962271048, 13644.590662280048, 2246.7191601049867, 2293.908243670251, 2310.953780924389, 2350.2714158610884, 2842.3888863894363, 9712.980137085575, 9853.458059806708, 9867.309288349818, 10008.59965601375, 10186.185105191567, 1787.3526450736222, 1844.4097888675628, 1903.1816318982833, 1939.0304847576213, 1943.9125239364262, 86423.2467214303, 108172.0, 108663.0, 116805.41597292044, 117142.0, 11220.943895280472, 11479.0, 11518.0, 11528.423578821026, 11851.051915846712, 12722.491100355883, 13489.190648561118, 13571.66070848217, 14350.784738228935, 14356.497522586867, 6989.33601307875, 8336.416450848383, 8477.109903460172, 8580.099089595502, 8584.8712269316, 7717.405190797742, 7779.260970207822, 8374.036985746718, 8566.91433085661, 8625.309975201968, 3717.6096509866616, 3767.416050512175, 4435.35687325336, 4561.201789686792, 4652.348671186037, 1650.6698660267994, 1860.4046705054252, 1915.9712604310946, 1936.2835750772304, 1939.360011196302, 743.8953154565465, 848.1052489623506, 881.2641444393875, 958.8849338079335, 1034.4103860799423, 20083.0, 20212.09045592952, 21460.0, 21649.783502165094, 21773.782262177174, 904.5206040798388, 919.8390281700675, 940.6942743608355, 958.5159494455395, 1008.6873069348526, 10600.734981625366, 11369.31784092957, 11387.202895797214, 11391.544338226544, 11411.429428528707, 598222.0, 605767.0, 607908.0, 612535.0, 621932.0, 127341.0, 130687.0, 130793.34603326922, 131759.0, 132220.67779322277, 966.5312323523086, 996.6163027234567, 1027.306568066567, 1027.9229057820694, 1028.6554004408458, 17760.644787104444, 19242.615147697248, 19346.0, 19403.4178974631, 19769.110390032194, 36895.0, 39103.804480977415, 50575.0, 50674.49325506698, 53415.93168136538, 60242.39757602543, 72162.27837721766, 72878.0, 76661.61669191618, 77658.0, 7851.725189618336, 7979.202079792207, 8095.635696393559, 8138.738495533202, 8286.83426331482, 12034.338111403607, 12681.873181268438, 12725.427355769198, 13039.0, 13115.934420327838, 10704.090152336827, 11243.887561124284, 11276.492557834754, 11291.717707057389, 11377.772444550897, 10691.518881650189, 10749.89250107489, 10965.50655220533, 11254.83117753218, 11428.200025998432, 10805.891941080803, 11024.448777560929, 11397.829032564685, 11412.429378531206, 11493.0, 7918.683252669829, 7949.972756946941, 8074.273315401642, 8207.0, 8222.465539739898, 7558.357539608975, 7595.886061708969, 7770.494917830323, 7831.373490120891, 8039.67841286342], "value": 9240.625816305703, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1528.7019031288903, 1554.5180993891895, 1727.8704097192706, 1872.1388161445734, 1879.3516236898274, 8449.662013519459, 8937.972133204683, 8941.284697224215, 8948.865767013493, 8949.105089491048, 7802.063752349712, 8043.879341809878, 8052.838943221147, 8164.795880103, 8715.0, 2143.035633964714, 2177.2597316912247, 2299.609066458706, 2377.465070359173, 2380.9642855357097, 2354.6232602783557, 2358.9410264743433, 2359.0681680736097, 2360.563295790276, 2360.9645855312183, 2298.5058212484314, 2365.3613524348416, 2368.4078980254935, 2371.158238825218, 2371.8221133414977, 2333.125078095714, 2344.988275058622, 2362.1850461590725, 2365.0303375616086, 2366.9644955325684, 2310.549442858643, 2334.031376978552, 2359.245041586693, 2361.362432143329, 2362.0669835414915, 8783.209511144029, 8928.598213080362, 8928.598213080428, 8938.19556239935, 8941.150590693873, 4596.862094137148, 5169.379674439091, 5315.335583052119, 5335.546478549328, 5343.385510666284, 3485.35520928629, 3616.132128289218, 3672.320620685182, 3681.226942342111, 3692.316921369555, 1039.7244730146517, 1088.8366744988236, 1102.3385968418966, 1109.8168802147636, 1117.050507068993, 10612.522436490453, 10995.90040995902, 11614.59348922792, 11669.59156429521, 11683.591074312359, 4362.17118747437, 4624.28323609841, 4755.096531658974, 4781.832635857728, 4788.760561971888, 9882.01179882006, 9882.308238423242, 9892.80214395708, 9904.55429505674, 9916.405015699082, 5338.733063346895, 5339.839804805862, 5342.3856256531, 5345.438728933484, 5361.276227709287, 4698.85903422891, 4876.658633895593, 4878.536539028786, 4906.31311616374, 4906.55840974314, 3599.9820000899826, 3735.7384983050924, 3743.082944678571, 3758.1356288053903, 3764.5858955514873, 1152.3316476443642, 1175.6355529785794, 1177.5633726853225, 1179.8820117988132, 1182.4028865422906, 755.71282912494, 843.9831203375898, 855.7946092937775, 915.706973768401, 930.5114814722325, 5622.650563864725, 5624.156376543469, 5704.600677952587, 5979.730912108966, 6001.1898393717165, 860.8278344331034, 893.8257039877161, 916.6333466613409, 927.9489628070521, 1000.6847842929454, 3822.120912190156, 3922.7057970651745, 4006.1587066715733, 4027.9798601006805, 4064.9593504065174, 10469.633562825264, 10740.570377184826, 10829.133669306437, 10867.673969780919, 10868.347899126078, 10387.272890897715, 10515.631952881613, 10755.946220268848, 10775.030247277782, 10806.729831754112, 7380.335769780745, 8127.0, 8262.306227223406, 8264.586770661443, 8319.584020799057, 5902.498287645427, 5939.376365481562, 5942.049272116614, 5948.762049518144, 5991.730372133177, 10061.849072263776, 10196.796064078528, 10270.743231419274, 10286.897131028893, 10293.0, 8436.367272454469, 10003.34978226413, 10263.435511046666, 10472.0, 10475.214358922958, 7088.822779430556, 7222.638868056471, 7225.349718525358, 7227.891581626385, 7240.963795181201, 8317.209865062809, 8404.285635720787, 8409.747707568782, 8424.28393586552, 8428.620712068094, 7258.129024517092, 7304.38771897457, 7502.662380192795, 7553.282438168365, 7595.962020189863, 7413.740519081806, 7442.516236444614, 7451.105867295742, 7486.663100160615, 7533.510321829063, 6864.725410983705, 6998.545094568837, 7076.787696369117, 7080.610566418896, 7089.503734738519, 4986.15235409974, 4988.750562471934, 5017.749112544431, 5023.799048038038, 5133.383993920754, 4772.427308722976, 4923.778429970588, 4927.211646136744, 4970.950290497049, 5084.3898732152375], "value": 4565.605620795874, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [261.97118316985114, 291.804490991036, 298.9925251868704, 303.819227559602, 313.5344014139003, 5066.240063990394, 5226.0, 5233.633645644806, 5254.527092561669, 5317.490456298843, 4118.402831589426, 5028.547430731233, 5154.664946778466, 5186.11835987882, 5199.818006369778, 3403.3703764803467, 4027.6979226558124, 4048.858289959852, 4060.2488539620117, 4081.795910204493, 3909.4526766252607, 4082.857100001486, 4083.5712250213746, 4115.8971025724295, 4136.958630413687, 4021.0, 4022.4971878515184, 4044.9191016179657, 4073.63337299643, 4094.9590504095027, 4010.2380547695843, 4035.7376770509823, 4039.53545342285, 4044.211378781139, 4078.472121614782, 3281.885134020322, 3534.3108093921696, 3538.2746536960117, 3562.8931132066077, 3569.0006798096574, 4271.850485233033, 4289.592488713567, 4853.199222128344, 5103.8468845934685, 5157.613179011551, 4597.908041839144, 4629.166749985001, 4647.60495357895, 4652.697574657636, 4671.201587388846, 5221.503957124067, 5468.644538105011, 5503.284573005523, 5513.0, 5586.24585680932, 3562.613049257004, 3683.5027271318295, 3711.9072023199365, 3880.06878349197, 3881.378979363288, 5373.032854086302, 5423.728813559306, 5451.591130665216, 5784.975258659478, 5813.0, 3607.639236076371, 3951.7826519541127, 3972.503437070366, 3984.2629113614075, 3990.6009399059863, 3526.9118272042892, 3794.4118661607495, 4001.5398229204015, 4006.6193711597352, 4012.558618551957, 3809.628533727856, 4575.954240457553, 4584.518625544337, 4592.7014744041535, 4592.954070459319, 5504.6421982571, 5511.311086114236, 5536.833894983157, 5545.889082218333, 5546.611737178439, 1129.5989923577176, 1163.906887449002, 1256.6983923858209, 1282.7621345401733, 1324.966875828112, 904.3217586809892, 932.1424289653535, 933.4691106585205, 934.4626839567276, 936.513013233115, 4461.977690111528, 4491.505934347219, 5176.870578235499, 5177.223416487557, 5228.869278268074, 5274.947250527523, 5596.865755177114, 5618.241537392481, 5674.517665998354, 5705.657660540381, 5031.6729412588065, 5063.772130254148, 5076.390833100052, 5097.821576244888, 5137.974310128426, 2205.7904499072883, 2227.596614133086, 2233.564454931273, 2276.1350686739265, 2420.939476513066, 4171.290880550314, 4812.951870481321, 4865.829695960695, 5371.4897084776885, 5652.802151924663, 5900.911486327708, 5909.8227053188475, 5911.261092363455, 5920.881582368328, 5937.317208521075, 4834.95165048352, 5687.317521897316, 5989.610675306091, 6026.819195424145, 6039.365866584033, 4297.871063867964, 4641.257398816173, 4836.153673107263, 5463.863403414946, 5561.0, 4335.349697545394, 4394.934075988799, 5680.346760122638, 5683.4816321024055, 5749.741261643319, 4703.788329525248, 5582.427246562284, 5967.6572771127885, 5996.910046349221, 6066.514678825595, 3105.9534106987962, 3229.934121739773, 3660.7071434285726, 3850.537935447764, 3866.3233934060863, 4522.773861306987, 5318.7074710891275, 5659.207710920557, 5715.31416230055, 5783.710814459176, 5192.896142077213, 5268.736563171903, 5373.865653358697, 5612.607117501736, 5658.830235092953, 4858.319835223142, 5012.398512178562, 5062.797488100435, 5534.640248384003, 5544.8355845272945, 4952.013629028666, 5207.3490813648295, 5353.867987227515, 5365.463453654604, 5492.3911142207135, 4839.685420447659, 5462.399136095106, 5563.5271001963665, 5670.461306175906, 5703.543716502587, 5158.878878278588, 5447.891042179055, 5472.644278121909, 5482.314710661168, 5508.366537848038], "value": 4000.7894474647874, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.2752151523173, 739.2865884421532, 760.2929275773529, 771.4908160613996, 857.5155037403869, 14776.77834832477, 15860.206989650529, 16248.918755406236, 16273.942193757397, 16733.91229570077, 14672.266386680676, 15064.0, 15075.547733567983, 15079.246037698098, 15177.165255910948, 683.0335075867641, 709.3792931185213, 846.4498076250441, 864.4510735682824, 865.4028720183085, 826.5949684654536, 860.5783166248556, 865.3596338709341, 867.9262262707678, 872.3849685971375, 903.5708038681606, 905.6965916418008, 907.2741806554762, 907.419251678926, 908.1463424381094, 709.7693249693818, 864.3258258558271, 900.8918929728409, 901.3285102598574, 902.3277658144724, 673.5891106425076, 674.7065026713395, 675.6284043775904, 676.4520738202073, 678.9849175482635, 14953.252337383195, 14983.250837458083, 14983.925080374529, 14987.925060374737, 15001.174935378549, 13663.38514766838, 13755.38100785467, 13934.024618276724, 13960.930195348958, 14082.0, 10738.0, 12502.312372819491, 12545.498180072786, 12624.873751262461, 12956.740865182643, 3453.1021934297014, 3488.284901595167, 3525.4359302511475, 3575.8390872410805, 3593.2993066352074, 99139.50430247874, 100752.49623751908, 101380.98619013789, 101387.49306253495, 109445.45277273642, 10015.499225038719, 10531.473426328654, 10902.945485272523, 10981.890181098246, 10987.670369888916, 20641.0, 20994.055267513, 21534.569308614053, 21544.892275538834, 21654.458638533848, 7855.803604909923, 7871.0948240951875, 7909.327707144842, 7912.841743165104, 7924.683012679544, 4319.33050377192, 4350.847720329773, 4363.6072753452345, 4368.475782906072, 4378.4745830499905, 3411.198368383428, 3517.50754894315, 3520.718342532591, 3523.5419395478934, 3537.398642230827, 649.9285078641345, 655.05017724299, 662.6587307536622, 666.1406785246977, 668.0780522878493, 525.5060243371219, 576.8384852241379, 587.4096532984323, 613.923259592551, 622.7353374815685, 7441.925580744231, 8355.582220888931, 8986.281097512183, 9238.030006849318, 9319.039348385873, 579.2122713110167, 581.0441823200811, 630.7792272704517, 641.2497378067673, 649.6881496881429, 4295.892602684896, 4359.673024523174, 4407.493138289138, 4469.240229161051, 4567.703099298535, 122348.16477752841, 165753.08222260055, 165945.59734435938, 169393.0, 173997.13001434912, 115931.0, 136706.0, 147981.0, 148185.25907370393, 149287.0, 72850.27149728542, 92267.07732922585, 97116.51441742887, 100485.0, 110520.99999999838, 9614.855777163488, 9644.855327170239, 9845.0, 10049.0, 10129.44288064134, 59968.0, 60015.39984600098, 60753.39246607654, 60761.696191520525, 61748.47545736351, 57253.141202881154, 78656.60671696834, 87960.5601971986, 90096.54951725199, 98392.0, 13369.0, 13402.463901443833, 13486.595402137558, 13656.726865462833, 13784.379702913593, 14752.409903604164, 15366.923165384102, 15742.449014284444, 15750.897437179288, 15848.207589620242, 13795.931020344835, 13978.021538492614, 14185.645358866112, 14288.57134285973, 14555.854441455449, 13885.930570347084, 14145.575632731034, 14467.565973020826, 14583.0, 14639.560813175622, 13573.86426135726, 13606.727865442834, 13706.040577159902, 13749.656258593215, 14174.858251417767, 11002.0, 11016.283941543774, 11480.655580332603, 11589.594364197214, 11624.883751162719, 9730.659426920023, 10135.949320253352, 11117.94441027822, 11138.221058478242, 11334.603288885179], "value": 7768.686322992036, "unit": "score"}], "name": "dromaeo_css", "value": 7240.56018235093, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 110.0, 110.0, 115.0, 113.0, 115.0, 160.0, 90.0, 157.0], "value": 118.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 107.0, 109.0, 167.0, 111.0, 112.0, 154.0, 108.0, 142.0, 107.0], "value": 126.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 183.0, 185.0, 181.0, 184.0, 182.0, 184.0, 183.0, 182.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 57.0, 57.0, 106.0, 57.0, 57.0, 61.0, 67.0, 84.0, 60.0], "value": 68.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 68.0, 92.0, 70.0, 77.0, 68.0, 96.0, 69.0, 67.0, 101.0], "value": 79.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 87.0, 84.0, 86.0, 83.0, 87.0, 83.0, 86.0, 83.0], "value": 85.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 92.0, 93.0, 92.0, 91.0, 92.0, 92.0, 92.0, 92.0], "value": 92.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 131.0, 84.0, 83.0, 101.0, 132.0, 134.0, 86.0, 87.0, 84.0], "value": 101.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 53.0, 53.0, 54.0, 52.0, 53.0, 53.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 72.0, 78.0, 78.0, 73.0, 70.0, 71.0, 70.0, 71.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 81.0, 84.0, 83.0, 84.0, 85.0, 83.0, 88.0, 87.0, 87.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 129.0, 145.0, 145.0, 141.0, 146.0, 142.0, 135.0, 138.0, 135.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [213.0, 223.0, 163.0, 165.0, 165.0, 163.0, 165.0, 163.0, 164.0, 164.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 60.0, 59.0, 81.0, 84.0, 84.0, 82.0], "value": 71.1, "unit": "score"}], "name": "kraken", "value": 1450.8, "alertThreshold": 2.0}]} 12:19:37 INFO - Return code: 0 12:19:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:19:37 INFO - # TBPL SUCCESS # 12:19:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:19:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:19:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:19:37 INFO - 2016-08-04 12:19:37.682 screenresolution[1668:10071] starting screenresolution argv=screenresolution get 12:19:37 INFO - 2016-08-04 12:19:37.685 screenresolution[1668:10071] Display 0: 1600x1200x32@60 12:19:37 INFO - 2016-08-04 12:19:37.691 screenresolution[1669:10074] starting screenresolution argv=screenresolution list 12:19:37 INFO - Available Modes on Display 0 12:19:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:19:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:19:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:19:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:19:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:19:37 INFO - Intel Iris: 12:19:37 INFO - Chipset Model: Intel Iris 12:19:37 INFO - Type: GPU 12:19:37 INFO - Bus: Built-In 12:19:37 INFO - VRAM (Dynamic, Max): 1536 MB 12:19:37 INFO - Vendor: Intel (0x8086) 12:19:37 INFO - Device ID: 0x0a2e 12:19:37 INFO - Revision ID: 0x0009 12:19:37 INFO - Displays: 12:19:37 INFO - Display: 12:19:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:19:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:19:37 INFO - Display Serial Number: 1600x1200 60 12:19:37 INFO - Main Display: Yes 12:19:37 INFO - Mirror: Off 12:19:37 INFO - Online: Yes 12:19:37 INFO - Rotation: Supported 12:19:37 INFO - Return code: 0 12:19:37 INFO - Running post-action listener: _resource_record_post_action 12:19:37 INFO - [mozharness: 2016-08-04 19:19:37.926241Z] Finished run-tests step (success) 12:19:37 INFO - Running post-run listener: _resource_record_post_run 12:19:37 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 38192128; Write bytes: 701204480; Read time: 377; Write time: 1974 12:19:37 INFO - TinderboxPrint: CPU usage
53.4% 12:19:37 INFO - TinderboxPrint: I/O read bytes / time
38,192,128 / 377 12:19:37 INFO - TinderboxPrint: I/O write bytes / time
701,204,480 / 1,974 12:19:37 INFO - TinderboxPrint: CPU idle
2,255.7 (46.6%) 12:19:37 INFO - TinderboxPrint: CPU system
967.6 (20.0%) 12:19:37 INFO - TinderboxPrint: CPU user
1,622.4 (33.5%) 12:19:37 INFO - TinderboxPrint: Swap in / out
440,705,024 / 0 12:19:37 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 270336; Write bytes: 405399040; Read time: 7; Write time: 790 12:19:37 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 34546176; Write bytes: 294240768; Read time: 343; Write time: 1179 12:19:38 INFO - Running post-run listener: _upload_blobber_files 12:19:38 INFO - Blob upload gear active. 12:19:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:19:38 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 12:19:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:19:38 INFO - (blobuploader) - INFO - Open directory for files ... 12:19:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:19:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:19:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:39 INFO - (blobuploader) - INFO - Done attempting. 12:19:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:19:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:19:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:40 INFO - (blobuploader) - INFO - Done attempting. 12:19:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:19:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:19:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:43 INFO - (blobuploader) - INFO - Done attempting. 12:19:43 INFO - (blobuploader) - INFO - Iteration through files over. 12:19:43 INFO - Return code: 0 12:19:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:19:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:19:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/031a551b19a40a3cac613831376e6321602a000bbe3a4246703fb0b939dfabbf685664ae402a286924e616896177646a41f21b020a4b673ca194e91aeebcdba9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d05aabe382d242c4aded5368134dfa42f3f11ee0ebcbcf2b7b726084f838861899a144c84b422576247e097c151e3ad55aa240485f4065ed2301fabe3406f03c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/183e997ec092f98ff4a7d582689c3d8b140f493f76d67621e57fed5cc994eddf18d1c87f14847b11b56a65b571a65c12beca3ec0a4c117154b24691ccb0a8da8"} 12:19:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:19:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:19:43 INFO - Contents: 12:19:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/031a551b19a40a3cac613831376e6321602a000bbe3a4246703fb0b939dfabbf685664ae402a286924e616896177646a41f21b020a4b673ca194e91aeebcdba9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d05aabe382d242c4aded5368134dfa42f3f11ee0ebcbcf2b7b726084f838861899a144c84b422576247e097c151e3ad55aa240485f4065ed2301fabe3406f03c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/183e997ec092f98ff4a7d582689c3d8b140f493f76d67621e57fed5cc994eddf18d1c87f14847b11b56a65b571a65c12beca3ec0a4c117154b24691ccb0a8da8"} 12:19:43 INFO - Running post-run listener: copy_logs_to_upload_dir 12:19:43 INFO - Copying logs to upload dir... 12:19:43 INFO - mkdir: /builds/slave/test/build/upload/logs 12:19:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.563921 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-04 12:19:43.182732) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 12:19:43.187478) ========= 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.14lh1D6hX9/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.OiiM85UTu5/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/031a551b19a40a3cac613831376e6321602a000bbe3a4246703fb0b939dfabbf685664ae402a286924e616896177646a41f21b020a4b673ca194e91aeebcdba9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d05aabe382d242c4aded5368134dfa42f3f11ee0ebcbcf2b7b726084f838861899a144c84b422576247e097c151e3ad55aa240485f4065ed2301fabe3406f03c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/183e997ec092f98ff4a7d582689c3d8b140f493f76d67621e57fed5cc994eddf18d1c87f14847b11b56a65b571a65c12beca3ec0a4c117154b24691ccb0a8da8"} build_url:https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011089 build_url: 'https://queue.taskcluster.net/v1/task/Nkc60dVYTwidfPsYklg-2Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/031a551b19a40a3cac613831376e6321602a000bbe3a4246703fb0b939dfabbf685664ae402a286924e616896177646a41f21b020a4b673ca194e91aeebcdba9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d05aabe382d242c4aded5368134dfa42f3f11ee0ebcbcf2b7b726084f838861899a144c84b422576247e097c151e3ad55aa240485f4065ed2301fabe3406f03c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/183e997ec092f98ff4a7d582689c3d8b140f493f76d67621e57fed5cc994eddf18d1c87f14847b11b56a65b571a65c12beca3ec0a4c117154b24691ccb0a8da8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 12:19:43.219653) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 12:19:43.219937) ========= 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.14lh1D6hX9/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.OiiM85UTu5/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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.005411 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 12:19:43.267513) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 12:19:43.267794) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 12:19:43.268083) ========= ========= Total master_lag: 0.18 =========