builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0136 starttime: 1472861316.0 results: success (0) buildid: 20160902133750 builduid: 9a1789dd9d844ceba142ec1b05528fd9 revision: 969397f22187cfd25fca153f0d1624dde9490589 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 17:08:36.002937) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 17:08:36.003408) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 17:08:36.003716) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 17:08:36.027420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 17:08:36.027752) ========= 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.owo2nUY4IM/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.OFD6qaEVjV/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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-09-02 17:08:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 170M=0s 2016-09-02 17:08:36 (170 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131760 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 17:08:36.182399) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 17:08:36.182722) ========= 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.owo2nUY4IM/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.OFD6qaEVjV/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.020252 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 17:08:36.231042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-02 17:08:36.231465) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 969397f22187cfd25fca153f0d1624dde9490589 --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 969397f22187cfd25fca153f0d1624dde9490589 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.owo2nUY4IM/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.OFD6qaEVjV/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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-09-02 17:08:36,308 truncating revision to first 12 chars 2016-09-02 17:08:36,309 Setting DEBUG logging. 2016-09-02 17:08:36,309 attempt 1/10 2016-09-02 17:08:36,309 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/969397f22187?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-02 17:08:38,491 unpacking tar archive at: fx-team-969397f22187/testing/mozharness/ program finished with exit code 0 elapsedTime=2.433630 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-02 17:08:38.687507) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 17:08:38.687827) ========= script_repo_revision: 969397f22187cfd25fca153f0d1624dde9490589 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 17:08:38.688214) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 17:08:38.688492) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 17:08:38.705558) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-09-02 17:08:38.705842) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.owo2nUY4IM/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.OFD6qaEVjV/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:08:38 INFO - MultiFileLogger online at 20160902 17:08:38 in /builds/slave/test 17:08:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:08:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:08:38 INFO - {'append_to_log': False, 17:08:38 INFO - 'base_work_dir': '/builds/slave/test', 17:08:38 INFO - 'blob_upload_branch': 'Fx-Team', 17:08:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:08:38 INFO - 'branch': 'Fx-Team', 17:08:38 INFO - 'buildbot_json_path': 'buildprops.json', 17:08:38 INFO - 'config_files': ('talos/mac_config.py',), 17:08:38 INFO - 'default_actions': ('clobber', 17:08:38 INFO - 'read-buildbot-config', 17:08:38 INFO - 'download-and-extract', 17:08:38 INFO - 'populate-webroot', 17:08:38 INFO - 'create-virtualenv', 17:08:38 INFO - 'install', 17:08:38 INFO - 'run-tests'), 17:08:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:08:38 INFO - 'download_minidump_stackwalk': True, 17:08:38 INFO - 'download_symbols': 'ondemand', 17:08:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:08:38 INFO - 'tooltool.py': '/tools/tooltool.py', 17:08:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:08:38 INFO - '/tools/misc-python/virtualenv.py')}, 17:08:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:08:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:08:38 INFO - 'installer_path': 'installer.exe', 17:08:38 INFO - 'log_level': 'info', 17:08:38 INFO - 'log_name': 'talos', 17:08:38 INFO - 'log_to_console': True, 17:08:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:08:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:08:38 INFO - 'opt_config_files': (), 17:08:38 INFO - 'pip_index': False, 17:08:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:08:38 INFO - 'cmd': ('bash', 17:08:38 INFO - '-c', 17:08:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:08:38 INFO - 'enabled': True, 17:08:38 INFO - 'halt_on_failure': False, 17:08:38 INFO - 'name': 'check_screen_resolution'},), 17:08:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:08:38 INFO - 'cmd': ('bash', 17:08:38 INFO - '-c', 17:08:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:08:38 INFO - 'enabled': True, 17:08:38 INFO - 'halt_on_failure': False, 17:08:38 INFO - 'name': 'check_screen_resolution'},), 17:08:38 INFO - 'run_cmd_checks_enabled': True, 17:08:38 INFO - 'sps_profile': False, 17:08:38 INFO - 'sps_profile_interval': 0, 17:08:38 INFO - 'suite': 'dromaeojs-e10s', 17:08:38 INFO - 'system_bits': '32', 17:08:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:08:38 INFO - 'title': 't-yosemite-r7-0136', 17:08:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:08:38 INFO - 'use_talos_json': True, 17:08:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:08:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:08:38 INFO - 'work_dir': 'build'} 17:08:38 INFO - [mozharness: 2016-09-03 00:08:38.899973Z] Running clobber step. 17:08:38 INFO - Running pre-action listener: _resource_record_pre_action 17:08:38 INFO - Running main action method: clobber 17:08:38 INFO - rmtree: /builds/slave/test/build 17:08:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:08:40 INFO - Running post-action listener: _resource_record_post_action 17:08:40 INFO - [mozharness: 2016-09-03 00:08:40.287921Z] Finished clobber step (success) 17:08:40 INFO - [mozharness: 2016-09-03 00:08:40.288104Z] Running read-buildbot-config step. 17:08:40 INFO - Running pre-action listener: _resource_record_pre_action 17:08:40 INFO - Running main action method: read_buildbot_config 17:08:40 INFO - Using buildbot properties: 17:08:40 INFO - { 17:08:40 INFO - "project": "", 17:08:40 INFO - "product": "firefox", 17:08:40 INFO - "script_repo_revision": "production", 17:08:40 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 17:08:40 INFO - "repository": "", 17:08:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 17:08:40 INFO - "buildid": "20160902133750", 17:08:40 INFO - "pgo_build": "False", 17:08:40 INFO - "basedir": "/builds/slave/test", 17:08:40 INFO - "buildnumber": 91, 17:08:40 INFO - "slavename": "t-yosemite-r7-0136", 17:08:40 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 17:08:40 INFO - "platform": "yosemite_r7", 17:08:40 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 17:08:40 INFO - "branch": "fx-team", 17:08:40 INFO - "repo_path": "integration/fx-team", 17:08:40 INFO - "revision": "969397f22187cfd25fca153f0d1624dde9490589", 17:08:40 INFO - "stage_platform": "macosx64", 17:08:40 INFO - "builduid": "9a1789dd9d844ceba142ec1b05528fd9", 17:08:40 INFO - "slavebuilddir": "test" 17:08:40 INFO - } 17:08:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 17:08:40 INFO - Running post-action listener: _resource_record_post_action 17:08:40 INFO - [mozharness: 2016-09-03 00:08:40.291360Z] Finished read-buildbot-config step (success) 17:08:40 INFO - [mozharness: 2016-09-03 00:08:40.291488Z] Running download-and-extract step. 17:08:40 INFO - Running pre-action listener: _resource_record_pre_action 17:08:40 INFO - Running main action method: download_and_extract 17:08:40 INFO - mkdir: /builds/slave/test/build/tests 17:08:40 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')]} 17:08:40 INFO - trying https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 17:08:40 INFO - Downloading https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/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 17:08:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/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 17:08:40 INFO - Downloaded 1199 bytes. 17:08:40 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:08:40 INFO - Using the following test package requirements: 17:08:40 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:08:40 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:08:40 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 17:08:40 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:08:40 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 17:08:40 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:08:40 INFO - u'jsshell-mac.zip'], 17:08:40 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:08:40 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 17:08:40 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:08:40 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:08:40 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 17:08:40 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:08:40 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 17:08:40 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:08:40 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 17:08:40 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:08:40 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 17:08:40 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:08:40 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')]} 17:08:40 INFO - trying https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:08:40 INFO - Downloading https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/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 17:08:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/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 17:08:41 INFO - Downloaded 16399974 bytes. 17:08:41 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 17:08:48 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 17:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:48 INFO - trying https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:08:48 INFO - Downloading https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/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 17:08:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/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 17:08:49 INFO - Downloaded 16399974 bytes. 17:08:49 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 17:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:56 INFO - trying https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 17:08:56 INFO - Downloading https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/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 17:08:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/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 17:08:56 INFO - Downloaded 14413998 bytes. 17:08:56 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 17:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:57 INFO - trying https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:08:57 INFO - Downloading https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 17:08:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/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 17:09:00 INFO - Downloaded 111490088 bytes. 17:09:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:09:00 INFO - mkdir: /builds/slave/test/properties 17:09:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:09:00 INFO - Writing to file /builds/slave/test/properties/build_url 17:09:00 INFO - Contents: 17:09:00 INFO - build_url:https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:09:00 INFO - Running post-action listener: _resource_record_post_action 17:09:00 INFO - Running post-action listener: set_extra_try_arguments 17:09:00 INFO - [mozharness: 2016-09-03 00:09:00.820394Z] Finished download-and-extract step (success) 17:09:00 INFO - [mozharness: 2016-09-03 00:09:00.820530Z] Running populate-webroot step. 17:09:00 INFO - Running pre-action listener: _resource_record_pre_action 17:09:00 INFO - Running main action method: populate_webroot 17:09:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:09:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:09:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:09:00 INFO - '--tppagecycles', 17:09:00 INFO - '7'], 17:09:00 INFO - 'tests': ['tsvgm']}}, 17:09:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:09:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:09:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:09:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:09:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:09:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:09:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:00 INFO - 'talos_options': ['--disable-e10s'], 17:09:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:00 INFO - 'talos_options': ['--disable-e10s'], 17:09:00 INFO - 'tests': ['damp', 'tps']}, 17:09:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:00 INFO - 'tests': ['damp', 'tps']}, 17:09:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:09:00 INFO - 'tests': ['dromaeo_dom']}, 17:09:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:09:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:09:00 INFO - 'tests': ['basic_compositor_video']}, 17:09:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:09:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:09:00 INFO - 'tests': ['a11yr', 17:09:00 INFO - 'ts_paint', 17:09:00 INFO - 'tpaint', 17:09:00 INFO - 'sessionrestore', 17:09:00 INFO - 'sessionrestore_no_auto_restore', 17:09:00 INFO - 'tabpaint']}, 17:09:00 INFO - 'other-e10s': {'tests': ['a11yr', 17:09:00 INFO - 'ts_paint', 17:09:00 INFO - 'tpaint', 17:09:00 INFO - 'sessionrestore', 17:09:00 INFO - 'sessionrestore_no_auto_restore', 17:09:00 INFO - 'tabpaint']}, 17:09:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:09:00 INFO - 'ts_paint', 17:09:00 INFO - 'tpaint', 17:09:00 INFO - 'sessionrestore', 17:09:00 INFO - 'sessionrestore_no_auto_restore', 17:09:00 INFO - 'tabpaint']}, 17:09:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:09:00 INFO - 'ts_paint', 17:09:00 INFO - 'tpaint', 17:09:00 INFO - 'sessionrestore', 17:09:00 INFO - 'sessionrestore_no_auto_restore', 17:09:00 INFO - 'tabpaint']}, 17:09:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:09:00 INFO - 'tests': ['a11yr', 17:09:00 INFO - 'ts_paint', 17:09:00 INFO - 'tpaint', 17:09:00 INFO - 'sessionrestore', 17:09:00 INFO - 'sessionrestore_no_auto_restore', 17:09:00 INFO - 'tabpaint']}, 17:09:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:09:00 INFO - 'tests': ['a11yr', 17:09:00 INFO - 'ts_paint', 17:09:00 INFO - 'tpaint', 17:09:00 INFO - 'sessionrestore', 17:09:00 INFO - 'sessionrestore_no_auto_restore', 17:09:00 INFO - 'tabpaint']}, 17:09:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:09:00 INFO - 'tests': ['tsvgx', 17:09:00 INFO - 'tsvgr_opacity', 17:09:00 INFO - 'tart', 17:09:00 INFO - 'tscrollx', 17:09:00 INFO - 'cart']}, 17:09:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:09:00 INFO - 'tsvgr_opacity', 17:09:00 INFO - 'tart', 17:09:00 INFO - 'tscrollx', 17:09:00 INFO - 'cart']}, 17:09:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:00 INFO - 'talos_options': ['--disable-e10s'], 17:09:00 INFO - 'tests': ['tp5o']}, 17:09:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:00 INFO - 'tests': ['tp5o']}, 17:09:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:00 INFO - 'talos_options': ['--disable-e10s', 17:09:00 INFO - '--xperf_path', 17:09:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:00 INFO - 'tests': ['tp5n']}, 17:09:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:00 INFO - 'talos_options': ['--xperf_path', 17:09:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:00 INFO - 'tests': ['tp5n']}}, 17:09:00 INFO - 'talos.zip': {'path': '', 17:09:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:09:00 INFO - Running post-action listener: _resource_record_post_action 17:09:00 INFO - [mozharness: 2016-09-03 00:09:00.839526Z] Finished populate-webroot step (success) 17:09:00 INFO - [mozharness: 2016-09-03 00:09:00.839639Z] Running create-virtualenv step. 17:09:00 INFO - Running pre-action listener: _resource_record_pre_action 17:09:00 INFO - Running main action method: create_virtualenv 17:09:00 INFO - Creating virtualenv /builds/slave/test/build/venv 17:09:00 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 17:09:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:09:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:09:00 INFO - Using real prefix '/tools/python27' 17:09:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:09:01 INFO - Installing distribute.............................................................................................................................................................................................done. 17:09:04 INFO - Installing pip.................done. 17:09:04 INFO - Return code: 0 17:09:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a5b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a648618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f861a491680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a517d30>, '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 0x10a27cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a50fb20>, '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.owo2nUY4IM/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.OFD6qaEVjV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:09: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', 'pip>=1.5'] in /builds/slave/test/build 17:09: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 pip>=1.5 17:09:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.owo2nUY4IM/Render', 17:09:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:04 INFO - 'HOME': '/Users/cltbld', 17:09:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:04 INFO - 'LOGNAME': 'cltbld', 17:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:04 INFO - 'MOZ_NO_REMOTE': '1', 17:09:04 INFO - 'NO_EM_RESTART': '1', 17:09:04 INFO - 'PAGER': '/bin/cat', 17:09:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:04 INFO - 'PWD': '/builds/slave/test', 17:09:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:04 INFO - 'SHELL': '/bin/bash', 17:09:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFD6qaEVjV/Listeners', 17:09:04 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:09:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:04 INFO - 'USER': 'cltbld', 17:09:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:04 INFO - 'XPC_FLAGS': '0x0', 17:09:04 INFO - 'XPC_SERVICE_NAME': '0', 17:09:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:04 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 17:09:04 INFO - Cleaning up... 17:09:04 INFO - Return code: 0 17:09:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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', '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 0x10a5b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a648618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f861a491680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a517d30>, '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 0x10a27cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a50fb20>, '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.owo2nUY4IM/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.OFD6qaEVjV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:09: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:09: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 psutil>=3.1.1 17:09:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.owo2nUY4IM/Render', 17:09:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:04 INFO - 'HOME': '/Users/cltbld', 17:09:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:04 INFO - 'LOGNAME': 'cltbld', 17:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:04 INFO - 'MOZ_NO_REMOTE': '1', 17:09:04 INFO - 'NO_EM_RESTART': '1', 17:09:04 INFO - 'PAGER': '/bin/cat', 17:09:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:04 INFO - 'PWD': '/builds/slave/test', 17:09:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:04 INFO - 'SHELL': '/bin/bash', 17:09:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFD6qaEVjV/Listeners', 17:09:04 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:09:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:04 INFO - 'USER': 'cltbld', 17:09:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:04 INFO - 'XPC_FLAGS': '0x0', 17:09:04 INFO - 'XPC_SERVICE_NAME': '0', 17:09:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:05 INFO - Downloading/unpacking psutil>=3.1.1 17:09:05 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 17:09:05 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 17:09:05 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 17:09:05 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 17:09:05 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 17:09:05 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 17:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:09:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:08 INFO - Installing collected packages: psutil 17:09:08 INFO - Running setup.py install for psutil 17:09:08 INFO - building 'psutil._psutil_osx' extension 17:09:08 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 17:09:08 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 17:09:08 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 17:09:08 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 17:09:08 INFO - building 'psutil._psutil_posix' extension 17:09:08 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 17:09:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:09:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:09:09 INFO - ^ 17:09:09 INFO - 1 warning generated. 17:09:09 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 17:09:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:09 INFO - Successfully installed psutil 17:09:09 INFO - Cleaning up... 17:09:09 INFO - Return code: 0 17:09:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a5b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a648618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f861a491680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a517d30>, '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 0x10a27cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a50fb20>, '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.owo2nUY4IM/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.OFD6qaEVjV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:09:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.owo2nUY4IM/Render', 17:09:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:09 INFO - 'HOME': '/Users/cltbld', 17:09:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:09 INFO - 'LOGNAME': 'cltbld', 17:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:09 INFO - 'MOZ_NO_REMOTE': '1', 17:09:09 INFO - 'NO_EM_RESTART': '1', 17:09:09 INFO - 'PAGER': '/bin/cat', 17:09:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:09 INFO - 'PWD': '/builds/slave/test', 17:09:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:09 INFO - 'SHELL': '/bin/bash', 17:09:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFD6qaEVjV/Listeners', 17:09:09 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:09:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:09 INFO - 'USER': 'cltbld', 17:09:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:09 INFO - 'XPC_FLAGS': '0x0', 17:09:09 INFO - 'XPC_SERVICE_NAME': '0', 17:09:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:09:12 INFO - Installing collected packages: mozsystemmonitor 17:09:12 INFO - Running setup.py install for mozsystemmonitor 17:09:12 INFO - Successfully installed mozsystemmonitor 17:09:12 INFO - Cleaning up... 17:09:12 INFO - Return code: 0 17:09:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:09:12 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')]} 17:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:12 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')]} 17:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:12 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 0x10a5b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a648618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f861a491680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a517d30>, '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 0x10a27cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a50fb20>, '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.owo2nUY4IM/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.OFD6qaEVjV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:09:12 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 17:09:12 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 17:09:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.owo2nUY4IM/Render', 17:09:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:12 INFO - 'HOME': '/Users/cltbld', 17:09:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:12 INFO - 'LOGNAME': 'cltbld', 17:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:12 INFO - 'MOZ_NO_REMOTE': '1', 17:09:12 INFO - 'NO_EM_RESTART': '1', 17:09:12 INFO - 'PAGER': '/bin/cat', 17:09:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:12 INFO - 'PWD': '/builds/slave/test', 17:09:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:12 INFO - 'SHELL': '/bin/bash', 17:09:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFD6qaEVjV/Listeners', 17:09:12 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:09:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:12 INFO - 'USER': 'cltbld', 17:09:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:12 INFO - 'XPC_FLAGS': '0x0', 17:09:12 INFO - 'XPC_SERVICE_NAME': '0', 17:09:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:12 INFO - Downloading/unpacking jsonschema==2.5.1 17:09:12 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 17:09:12 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 17:09:12 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 17:09:12 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 17:09:12 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 17:09:12 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 17:09:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:09:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:09:15 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 17:09:15 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 17:09:15 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 17:09:15 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 17:09:15 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 17:09:15 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 17:09:15 INFO - Downloading functools32-3.2.3-2.tar.gz 17:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:09:15 INFO - warning: no files found matching '*.txt' 17:09:15 INFO - no previously-included directories found matching 'build' 17:09:15 INFO - no previously-included directories found matching 'dist' 17:09:15 INFO - no previously-included directories found matching '.git*' 17:09:15 INFO - Installing collected packages: jsonschema, functools32 17:09:15 INFO - Running setup.py install for functools32 17:09:15 INFO - warning: no files found matching '*.txt' 17:09:15 INFO - no previously-included directories found matching 'build' 17:09:15 INFO - no previously-included directories found matching 'dist' 17:09:15 INFO - no previously-included directories found matching '.git*' 17:09:15 INFO - Successfully installed jsonschema functools32 17:09:15 INFO - Cleaning up... 17:09:15 INFO - Return code: 0 17:09:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a5b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a648618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f861a491680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a517d30>, '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 0x10a27cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a50fb20>, '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.owo2nUY4IM/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.OFD6qaEVjV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:09:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:09:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.owo2nUY4IM/Render', 17:09:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:15 INFO - 'HOME': '/Users/cltbld', 17:09:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:15 INFO - 'LOGNAME': 'cltbld', 17:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:15 INFO - 'MOZ_NO_REMOTE': '1', 17:09:15 INFO - 'NO_EM_RESTART': '1', 17:09:15 INFO - 'PAGER': '/bin/cat', 17:09:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:15 INFO - 'PWD': '/builds/slave/test', 17:09:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:15 INFO - 'SHELL': '/bin/bash', 17:09:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFD6qaEVjV/Listeners', 17:09:15 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:09:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:15 INFO - 'USER': 'cltbld', 17:09:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:15 INFO - 'XPC_FLAGS': '0x0', 17:09:15 INFO - 'XPC_SERVICE_NAME': '0', 17:09:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:09:16 INFO - Cleaning up... 17:09:16 INFO - Return code: 0 17:09:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a5b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a648618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f861a491680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a517d30>, '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 0x10a27cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a50fb20>, '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.owo2nUY4IM/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.OFD6qaEVjV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:09:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:09:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.owo2nUY4IM/Render', 17:09:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:16 INFO - 'HOME': '/Users/cltbld', 17:09:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:16 INFO - 'LOGNAME': 'cltbld', 17:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:16 INFO - 'MOZ_NO_REMOTE': '1', 17:09:16 INFO - 'NO_EM_RESTART': '1', 17:09:16 INFO - 'PAGER': '/bin/cat', 17:09:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:16 INFO - 'PWD': '/builds/slave/test', 17:09:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:16 INFO - 'SHELL': '/bin/bash', 17:09:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFD6qaEVjV/Listeners', 17:09:16 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:09:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:16 INFO - 'USER': 'cltbld', 17:09:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:16 INFO - 'XPC_FLAGS': '0x0', 17:09:16 INFO - 'XPC_SERVICE_NAME': '0', 17:09:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:16 INFO - Downloading/unpacking blobuploader==1.2.4 17:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:18 INFO - Downloading blobuploader-1.2.4.tar.gz 17:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:09:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:09:18 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 17:09:18 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 17:09:18 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 17:09:18 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 17:09:18 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 17:09:18 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 17:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:09:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:19 INFO - Downloading docopt-0.6.1.tar.gz 17:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:09:19 INFO - Installing collected packages: blobuploader, requests, docopt 17:09:19 INFO - Running setup.py install for blobuploader 17:09:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:09:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:09:20 INFO - Running setup.py install for requests 17:09:20 INFO - Running setup.py install for docopt 17:09:20 INFO - Successfully installed blobuploader requests docopt 17:09:20 INFO - Cleaning up... 17:09:20 INFO - Return code: 0 17:09:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:20 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 0x10a5b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a648618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f861a491680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a517d30>, '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 0x10a27cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a50fb20>, '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.owo2nUY4IM/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.OFD6qaEVjV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:09:20 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 17:09:20 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 17:09:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.owo2nUY4IM/Render', 17:09:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:20 INFO - 'HOME': '/Users/cltbld', 17:09:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:20 INFO - 'LOGNAME': 'cltbld', 17:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:20 INFO - 'MOZ_NO_REMOTE': '1', 17:09:20 INFO - 'NO_EM_RESTART': '1', 17:09:20 INFO - 'PAGER': '/bin/cat', 17:09:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:20 INFO - 'PWD': '/builds/slave/test', 17:09:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:20 INFO - 'SHELL': '/bin/bash', 17:09:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFD6qaEVjV/Listeners', 17:09:20 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:09:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:20 INFO - 'USER': 'cltbld', 17:09:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:20 INFO - 'XPC_FLAGS': '0x0', 17:09:20 INFO - 'XPC_SERVICE_NAME': '0', 17:09:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:21 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-cKPb60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:21 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-XJ46YL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:21 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Ri_aTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:21 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-f9H05u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:21 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-ykJTk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:21 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-TWBza5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:21 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-i26fRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:21 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-S21ceg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:21 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-bdKYft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:22 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-sJSfu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:22 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-YOevcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:22 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-LylDK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:22 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-yOfaMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:22 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-BLXphB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:22 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-qNhyG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:22 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-EkEStW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:22 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-7fGwGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:09:22 INFO - Running setup.py install for manifestparser 17:09:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:09:23 INFO - Running setup.py install for mozcrash 17:09:23 INFO - Running setup.py install for mozdebug 17:09:23 INFO - Running setup.py install for mozdevice 17:09:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:09:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:09:23 INFO - Running setup.py install for mozfile 17:09:23 INFO - Running setup.py install for mozhttpd 17:09:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:09:23 INFO - Running setup.py install for mozinfo 17:09:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:09:23 INFO - Running setup.py install for mozInstall 17:09:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:09:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:09:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:09:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:09:24 INFO - Running setup.py install for mozleak 17:09:24 INFO - Running setup.py install for mozlog 17:09:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:09:24 INFO - Running setup.py install for moznetwork 17:09:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:09:24 INFO - Running setup.py install for mozprocess 17:09:24 INFO - Running setup.py install for mozprofile 17:09:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:09:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:09:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:09:24 INFO - Running setup.py install for mozrunner 17:09:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:09:25 INFO - Running setup.py install for mozscreenshot 17:09:25 INFO - Running setup.py install for moztest 17:09:25 INFO - Running setup.py install for mozversion 17:09:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:09:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:09:25 INFO - Cleaning up... 17:09:25 INFO - Return code: 0 17:09:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:25 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 0x10a5b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a648618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f861a491680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a517d30>, '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 0x10a27cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a50fb20>, '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.owo2nUY4IM/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.OFD6qaEVjV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:09:25 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 17:09:25 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 17:09:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.owo2nUY4IM/Render', 17:09:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:25 INFO - 'HOME': '/Users/cltbld', 17:09:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:25 INFO - 'LOGNAME': 'cltbld', 17:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:25 INFO - 'MOZ_NO_REMOTE': '1', 17:09:25 INFO - 'NO_EM_RESTART': '1', 17:09:25 INFO - 'PAGER': '/bin/cat', 17:09:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:25 INFO - 'PWD': '/builds/slave/test', 17:09:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:25 INFO - 'SHELL': '/bin/bash', 17:09:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFD6qaEVjV/Listeners', 17:09:25 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:09:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:25 INFO - 'USER': 'cltbld', 17:09:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:25 INFO - 'XPC_FLAGS': '0x0', 17:09:25 INFO - 'XPC_SERVICE_NAME': '0', 17:09:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:25 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-n7ViOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:25 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)) 17:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:25 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-5KQYmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:25 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)) 17:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:25 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-ilSsOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:26 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-DAdHwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:26 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-9jffWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:26 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-1d920W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:26 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)) 17:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:26 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-JdU_z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:26 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)) 17:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:26 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-z_fO59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:26 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)) 17:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:26 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-KAmdlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:26 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)) 17:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:26 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-wAiDxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:26 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)) 17:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:26 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-keLf3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:26 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)) 17:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:26 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-F2Kg5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:27 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)) 17:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:27 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-1SvLYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:27 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-17mVCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:27 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)) 17:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:27 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-d5qKAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:27 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)) 17:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:27 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-sF8HB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:27 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)) 17:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:27 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-XK9SEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:27 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)) 17:09:27 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)) 17:09:27 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)) 17:09:27 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)) 17:09:27 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)) 17:09:27 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)) 17:09:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:30 INFO - Downloading blessings-1.6.tar.gz 17:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:09:30 INFO - Installing collected packages: blessings 17:09:30 INFO - Running setup.py install for blessings 17:09:30 INFO - Successfully installed blessings 17:09:30 INFO - Cleaning up... 17:09:30 INFO - Return code: 0 17:09:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:09:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:30 INFO - Reading from file tmpfile_stdout 17:09:30 INFO - Current package versions: 17:09:30 INFO - blessings == 1.6 17:09:30 INFO - blobuploader == 1.2.4 17:09:30 INFO - docopt == 0.6.1 17:09:30 INFO - functools32 == 3.2.3-2 17:09:30 INFO - jsonschema == 2.5.1 17:09:30 INFO - manifestparser == 1.1 17:09:30 INFO - mozInstall == 1.12 17:09:30 INFO - mozcrash == 0.17 17:09:30 INFO - mozdebug == 0.1 17:09:30 INFO - mozdevice == 0.48 17:09:30 INFO - mozfile == 1.2 17:09:30 INFO - mozhttpd == 0.7 17:09:30 INFO - mozinfo == 0.9 17:09:30 INFO - mozleak == 0.1 17:09:30 INFO - mozlog == 3.3 17:09:30 INFO - moznetwork == 0.27 17:09:30 INFO - mozprocess == 0.23 17:09:30 INFO - mozprofile == 0.28 17:09:30 INFO - mozrunner == 6.12 17:09:30 INFO - mozscreenshot == 0.1 17:09:30 INFO - mozsystemmonitor == 0.3 17:09:30 INFO - moztest == 0.7 17:09:30 INFO - mozversion == 1.4 17:09:30 INFO - psutil == 3.1.1 17:09:30 INFO - requests == 1.2.3 17:09:30 INFO - wsgiref == 0.1.2 17:09:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:30 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 0x10a5b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a648618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f861a491680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a517d30>, '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 0x10a27cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a50fb20>, '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.owo2nUY4IM/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.OFD6qaEVjV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:09:30 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 17:09:30 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 17:09:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.owo2nUY4IM/Render', 17:09:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:30 INFO - 'HOME': '/Users/cltbld', 17:09:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:30 INFO - 'LOGNAME': 'cltbld', 17:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:30 INFO - 'MOZ_NO_REMOTE': '1', 17:09:30 INFO - 'NO_EM_RESTART': '1', 17:09:30 INFO - 'PAGER': '/bin/cat', 17:09:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:30 INFO - 'PWD': '/builds/slave/test', 17:09:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:30 INFO - 'SHELL': '/bin/bash', 17:09:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFD6qaEVjV/Listeners', 17:09:30 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:09:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:30 INFO - 'USER': 'cltbld', 17:09:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:30 INFO - 'XPC_FLAGS': '0x0', 17:09:30 INFO - 'XPC_SERVICE_NAME': '0', 17:09:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:30 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)) 17:09:30 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)) 17:09:30 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)) 17:09:30 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)) 17:09:30 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)) 17:09:30 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)) 17:09:30 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)) 17:09:30 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)) 17:09:30 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)) 17:09:30 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)) 17:09:30 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)) 17:09:30 INFO - Cleaning up... 17:09:30 INFO - Return code: 0 17:09:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a5b3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a648618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f861a491680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a517d30>, '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 0x10a27cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a50fb20>, '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.owo2nUY4IM/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.OFD6qaEVjV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 17:09:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:09:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.owo2nUY4IM/Render', 17:09:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:30 INFO - 'HOME': '/Users/cltbld', 17:09:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:30 INFO - 'LOGNAME': 'cltbld', 17:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:30 INFO - 'MOZ_NO_REMOTE': '1', 17:09:30 INFO - 'NO_EM_RESTART': '1', 17:09:30 INFO - 'PAGER': '/bin/cat', 17:09:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:30 INFO - 'PWD': '/builds/slave/test', 17:09:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:30 INFO - 'SHELL': '/bin/bash', 17:09:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFD6qaEVjV/Listeners', 17:09:30 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:09:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:30 INFO - 'USER': 'cltbld', 17:09:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:30 INFO - 'XPC_FLAGS': '0x0', 17:09:30 INFO - 'XPC_SERVICE_NAME': '0', 17:09:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:09:31 INFO - Cleaning up... 17:09:31 INFO - Return code: 0 17:09:31 INFO - Running post-action listener: _resource_record_post_action 17:09:31 INFO - Running post-action listener: _start_resource_monitoring 17:09:31 INFO - Starting resource monitoring. 17:09:31 INFO - [mozharness: 2016-09-03 00:09:31.233381Z] Finished create-virtualenv step (success) 17:09:31 INFO - [mozharness: 2016-09-03 00:09:31.234414Z] Running install step. 17:09:31 INFO - Running pre-action listener: _resource_record_pre_action 17:09:31 INFO - Running main action method: install 17:09:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:31 INFO - Reading from file tmpfile_stdout 17:09:31 INFO - Detecting whether we're running mozinstall >=1.0... 17:09:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:09:31 INFO - Reading from file tmpfile_stdout 17:09:31 INFO - Output received: 17:09:31 INFO - Usage: mozinstall [options] installer 17:09:31 INFO - Options: 17:09:31 INFO - -h, --help show this help message and exit 17:09:31 INFO - -d DEST, --destination=DEST 17:09:31 INFO - Directory to install application into. [default: 17:09:31 INFO - "/builds/slave/test"] 17:09:31 INFO - --app=APP Application being installed. [default: firefox] 17:09:31 INFO - mkdir: /builds/slave/test/build/application 17:09:31 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'] 17:09:31 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 17:10:05 INFO - Reading from file tmpfile_stdout 17:10:05 INFO - Output received: 17:10:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:10:05 INFO - Running post-action listener: _resource_record_post_action 17:10:05 INFO - [mozharness: 2016-09-03 00:10:05.793753Z] Finished install step (success) 17:10:05 INFO - [mozharness: 2016-09-03 00:10:05.793886Z] Running run-tests step. 17:10:05 INFO - Running pre-action listener: _resource_record_pre_action 17:10:05 INFO - Running main action method: run_tests 17:10:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:10:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:10:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:10:05 INFO - 2016-09-02 17:10:05.808 screenresolution[1942:11574] starting screenresolution argv=screenresolution get 17:10:05 INFO - 2016-09-02 17:10:05.811 screenresolution[1942:11574] Display 0: 1600x1200x32@60 17:10:05 INFO - 2016-09-02 17:10:05.816 screenresolution[1943:11576] starting screenresolution argv=screenresolution list 17:10:05 INFO - Available Modes on Display 0 17:10:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:10:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:10:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:10:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:10:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:10:06 INFO - Intel Iris: 17:10:06 INFO - Chipset Model: Intel Iris 17:10:06 INFO - Type: GPU 17:10:06 INFO - Bus: Built-In 17:10:06 INFO - VRAM (Dynamic, Max): 1536 MB 17:10:06 INFO - Vendor: Intel (0x8086) 17:10:06 INFO - Device ID: 0x0a2e 17:10:06 INFO - Revision ID: 0x0009 17:10:06 INFO - Displays: 17:10:06 INFO - Display: 17:10:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:10:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:10:06 INFO - Display Serial Number: 1600x1200 60 17:10:06 INFO - Main Display: Yes 17:10:06 INFO - Mirror: Off 17:10:06 INFO - Online: Yes 17:10:06 INFO - Rotation: Supported 17:10:06 INFO - Return code: 0 17:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:10:06 INFO - Python 2.7.3 17:10:06 INFO - Return code: 0 17:10:06 INFO - grabbing minidump binary from tooltool 17:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:10:06 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 0x10a517d30>, '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 0x10a27cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a50fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:10:06 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 17:10:06 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 17:10:06 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 17:10:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:10:06 INFO - Return code: 0 17:10:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:10:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:10:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:10:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:10:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0136', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0136 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:10:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.owo2nUY4IM/Render', 17:10:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:06 INFO - 'HOME': '/Users/cltbld', 17:10:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:06 INFO - 'LOGNAME': 'cltbld', 17:10:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:10:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:06 INFO - 'MOZ_NO_REMOTE': '1', 17:10:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:10:06 INFO - 'NO_EM_RESTART': '1', 17:10:06 INFO - 'PAGER': '/bin/cat', 17:10:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:06 INFO - 'PWD': '/builds/slave/test', 17:10:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:10:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:06 INFO - 'SHELL': '/bin/bash', 17:10:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OFD6qaEVjV/Listeners', 17:10:06 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 17:10:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:06 INFO - 'USER': 'cltbld', 17:10:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:06 INFO - 'XPC_FLAGS': '0x0', 17:10:06 INFO - 'XPC_SERVICE_NAME': '0', 17:10:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0136', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:10:06 INFO - mozversion application_buildid: 20160902133750 17:10:06 INFO - mozversion application_changeset: 969397f22187cfd25fca153f0d1624dde9490589 17:10:06 INFO - mozversion application_display_name: Nightly 17:10:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:10:06 INFO - mozversion application_name: Firefox 17:10:06 INFO - mozversion application_remotingname: firefox 17:10:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:10:06 INFO - mozversion application_vendor: Mozilla 17:10:06 INFO - mozversion application_version: 51.0a1 17:10:06 INFO - mozversion platform_buildid: 20160902133750 17:10:06 INFO - mozversion platform_changeset: 969397f22187cfd25fca153f0d1624dde9490589 17:10:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:10:06 INFO - mozversion platform_version: 51.0a1 17:10:06 INFO - using testdate: 1472861406 17:10:06 INFO - actual date: 1472861406 17:10:06 INFO - starting webserver on 'localhost:50348' 17:10:06 INFO - SUITE-START | Running 2 tests 17:10:06 INFO - TEST-START | dromaeo_css 17:10:06 INFO - operating with platform_type : mac_ 17:10:06 INFO - Initialising browser for dromaeo_css test... 17:10:06 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpeWZWbr/profile http://localhost:50348/getInfo.html) 17:10:09 INFO - PROCESS | 1953 | __metrics Screen width/height:1600/1200 17:10:09 INFO - PROCESS | 1953 | colorDepth:24 17:10:09 INFO - PROCESS | 1953 | Browser inner width/height: 1024/689 17:10:09 INFO - PROCESS | 1953 | __metrics 17:10:09 ERROR - PROCESS | 1953 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 17:10:10 INFO - TEST-INFO | 1953: exit 0 17:10:10 INFO - Browser initialized. 17:10:10 INFO - Running cycle 1/1 for dromaeo_css test... 17:10:10 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpeWZWbr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:22 INFO - PROCESS | 1956 | RSS: Main: 245358592 17:10:22 INFO - PROCESS | 1956 | 17:11:11 INFO - PROCESS | 1956 | 1472861471730 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] 17:13:23 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:50348/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50348/tests/dromaeo/cssquery-ext.html) 17:13:25 INFO - PROCESS | 1956 | RSS: Main: 267444224 17:13:25 INFO - PROCESS | 1956 | 17:16:27 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:50348/tests/dromaeo/cssquery-ext.html (next: http://localhost:50348/tests/dromaeo/cssquery-jquery.html) 17:16:28 INFO - PROCESS | 1956 | RSS: Main: 274845696 17:16:28 INFO - PROCESS | 1956 | 17:19:30 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:50348/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50348/tests/dromaeo/cssquery-mootools.html) 17:19:30 INFO - PROCESS | 1956 | RSS: Main: 274370560 17:19:30 INFO - PROCESS | 1956 | 17:22:32 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:50348/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50348/tests/dromaeo/cssquery-prototype.html) 17:22:33 INFO - PROCESS | 1956 | RSS: Main: 269361152 17:22:33 INFO - PROCESS | 1956 | 17:25:36 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:50348/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50348/tests/dromaeo/cssquery-yui.html) 17:25:36 INFO - PROCESS | 1956 | RSS: Main: 274849792 17:25:36 INFO - PROCESS | 1956 | 17:28:39 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:50348/tests/dromaeo/cssquery-yui.html (next: http://localhost:50348/tests/dromaeo/cssquery-dojo.html) 17:28:40 INFO - PROCESS | 1956 | RSS: Main: 278614016 17:28:40 INFO - PROCESS | 1956 | 17:28:40 INFO - PROCESS | 1956 | __start_tp_report 17:28:40 INFO - PROCESS | 1956 | _x_x_mozilla_page_load 17:28:40 INFO - PROCESS | 1956 | _x_x_mozilla_page_load_details 17:28:40 INFO - PROCESS | 1956 | |i|pagename|runs| 17:28:40 INFO - PROCESS | 1956 | |0;dojo.html;3338.432466480698;3371.308881679255;3372.4772660237663;3381.746369022321;3382.932341353173;5594.748236329365;5612.83161505155;5613.663180209191;5670.319561652603;5671.517920976712;5579.442055794419;5706.115552089433;5762.827115186541;5765.942340576593;5787.710614469281;5181.274621552986;5190.558802501791;5237.371515418136;5261.210818377236;5323.467653234665;5238.47615238475;5364.651297665659;5402.162664786944;5408.134698448249;5421.9457805421835;5124.76938537763;5246.737663116829;5269.420363759983;5274.947250527484;5299.470052994709;5155.9484405155845;5180.974095129538;5198;5216.739163041832;5239.397469291042;5137.9724055188735;5162.406323272834;5164.586833053384;5248.343957005374;5312.76092575835;5167.276581278624;5687.544996400278;5796.652200867961;5814.156947242626;5830.4461076197695;6195.256569211679;6196.163517925068;6273.404026617464;6280.403361680633;6299.622022678654;6250.656213908279;6326.683665816737;6330.923742963707;6332.873342533169;6348.206474190726;5721.942780572141;5805.390434004369;5853.882922341614;5892.616979896293;5900;6317.6209427434505;6326.335734747785;6330.208723909512;6332.271788744261;6349.587276826992;6201.96899015502;6208.1308616793685;6219.191505104308;6230.813075607739;6234.407731265523;6139.3388173831;6185.907211391743;6247.125402443661;6321.051842223703;6322.272938612118;6101.7559297627595;6114.3277820888225;6132.20254427538;6179.567430279837;6220.720067596969;6212.223472065992;6240.594361366497;6255.093011513305;6261.405166509175;6294.307626161119;4829.517048295143;4930.433000204951;4932.136876046749;4939.629527785431;4960.429550601655;3870.838748375476;4086.734362266443;4351.325544540601;4367.541408152162;4391.538888416734;5518.862028449321;5621.184928185472;5624.803131890364;5660.632058916157;5672.602917795797;6135.32395826069;6149.600275982137;6149.631022138686;6161.199044124235;6171.783987560414;5780.566457515703;5835.183074369592;5870.7945221917025;5872.412758724179;5933.258342707161;5399.541039011728;5422.75597598109;5428.022955867903;5432;5458.972705136528;6241.31345551998;6327.209098862642;6375.71309291083;6395.456386207225;6406.423421892052;6184.041473571604;6217.906731398942;6272.6236425814595;6315.08431277453;6337.8732425352155;6295.464885484602;6305.085762564494;6316.589421687576;6326.905096423649;6337.397947195009;6098;6098.603590766586;6187.041008643668;6189.752409903554;6208.9689551551955;4980.726060066586;6079.240094988127;6184.196054512884;6202.4417802398;6206.255249370104;5994.700264986646;6009.971701926838;6013;6019.1573179754;6045.697715114315;5912.970435147969;6037.698115094316;6048.939510605013;6050.21347224858;6068.848278793065;5817.680027598522;5849.883002339844;5885.852853678693;5888.852778680567;5895;5013.573846223112;5062.139436295765;5794.7682092717505;6045.425684559959;6091.269047714302;5632.718364081861;5854.414558544111;5901.232839730807;5902.1146827976145;5939 17:28:40 INFO - PROCESS | 1956 | |1;ext.html;469.21406643871507;483.3233473137607;483.54788272964805;493.4917035453484;501.07551567358223;31036.689633103662;39913.60086399135;39921.40117898227;40050.59949400505;40097.1980560389;39988.60011399885;39994.200115997664;40599.39100913489;40613.39079913796;40622.79688601553;8286.502809831414;9836.852447213298;9845.901540984605;9854.802903941916;9883.703488895344;9648.903510964907;9727.27045471589;9757.219422446222;9762;9765.023497650214;9767.51162441875;9768.413895166314;9786.363886347364;9792.11870931616;9807.06832850878;9716.56275467602;9772.560234789451;9775;9778.65774697882;9780.853287200698;8201.95899020501;9806.215502759833;9877.357971731886;9881.456519891402;9907.504624768733;38986;39050;39293.41059884104;39312.410313845314;39339;2821.7460428561526;3313.8343082845763;3343.8829640962695;3386.0519054664733;3444.8622055117767;30230;30958.22604434907;31279.218019549466;32094;32184.517232241535;3014.442328169274;3192.696693814084;3265.9020229393154;3303.8513266903046;3389.779664321811;393540;437734;482394.58802706114;482464;483682.58158709336;51159.23261151086;55694.72152639211;59522.91669791537;60432.79134417287;63125.684371577845;33261.50107748386;34084.44366672509;61979;62355.6882215586;62576.374236257056;15935.521934341989;16157.838421615868;16293.185340732916;16318.184090795412;16400;10721.571137154426;12461.252324860538;12581.433835477426;12669.176503527242;12681.809772853414;18538.536536586424;18542.907285463487;18598.256069757328;18632.068396580118;18673.066346682885;6843.349881761224;8044.678212871537;8150.959245203736;8239.516886960404;8268.553003224411;815.4740192575874;843.6035063520136;935.6444551070549;956.4118067388645;1047.6333283350918;28407.715922840922;28833.42333153367;30016.39967200644;30033;30445.695543044287;947.985655348784;1046.6194192757284;1050.726811029138;1057.9735506612242;1103.2883789955433;14907.180105094323;15603.609909752347;15628.687426251412;15833.52499425019;16028.439004634782;617357;628150;634198;635401;636077;57096.14355784666;57667;57727.4227257722;57768.71115644395;57805.421945780006;1330.9068365214537;1347.1243691600341;1386.334559411488;1389.215093472185;1392.4012674549838;28959.276018098873;30015.69984300129;30326.84836575803;30451;30509.084727458212;45068.64794056184;50610;51997.480025199264;52384.738076309375;52414.737926310125;572742;576804.0876321151;576994;577175;578410;41722.74831755052;42059;42150.36774448447;42444.78777606092;42670.57329426666;45967.54032459766;46705.598832035095;47094;47266.76366618145;47438.05123897434;38761.224775504896;38959.805200974944;39022.219555608164;39723.00692482711;40259;37766.622333777406;38302.808485957394;38415.61584384232;38977.80511097427;39391.40912886251;36760.63239367572;36778.8161059193;37772.86681399562;38086.61913380831;38787.61212387953;30893.53659695151;31807.36385272328;32508.837455813515;34063;34568.96293111211;24278.77353117426;25345.239642810746;25653.486930261664;25853.965841366135;26107.955681773277 17:28:40 INFO - PROCESS | 1956 | |2;jquery.html;301.5702623761141;320.24422363222806;328.985195666195;352.91706448984485;375.71445701267027;17054.82945170548;17999.730004049918;20914.45132920247;21063.94680265988;21220.469488262803;20080.397588072345;20212.98935053245;20293;20569.38291851243;20581.485462863435;4906.730129842857;5870.70646467677;5915.698546319824;6126.571140020178;6135.141080248769;5778.6243894146955;6085.843689698965;6153.969230153865;6179.505639548848;6195.039768835815;6074;6121.204243448346;6158.507319414459;6188;6697.263301036882;6795.354441328066;6797.5921444712985;6801.4558835293055;6821.556598821086;6845.315468453165;5852.473277405012;5942.702864856783;5972.754108823991;6023.066424704134;6031.8793624127275;12945.288009159493;13180.6704832379;13302.733945321137;23456;24599.770011499353;2103.2112957640884;2131.531063166101;2250.4148921280585;2252.662100684894;2435.232901635979;9921.454320012397;10198.388096714221;10345.482725863752;12556.937215313956;14468.421263149461;1838.3565751986832;1845.3910209630924;1848.4362269507794;1873.3068764557202;1877.5963167918826;89573;105563;111059;111890;113027.99999999917;11275.94362028201;11339.489722962486;11510.36692981894;11524.2509236901;11550.249233799776;14321.14073155614;14337.494563070935;14342.784858227134;14345.139291642536;14373.993820432679;8233.629486673113;8424.458936576502;8428.157184281523;8460.915390846136;8541.444806087584;8355.289800367036;8384.371172161991;8545.871811922827;8563.443376180529;8581.95709021451;4090.1615168890307;4199.601037901394;4386.078923426053;4420.226460369422;4524.163029839425;1895.4597939587152;1926.922923083061;1931.1889006617255;1932.4106147624827;1977.3573588583768;835.703325319515;856.4390324337569;866.8526350520426;903.1420150856712;928.661038720862;18982.525436863914;20040.799592003892;20753.066112024993;20754.896225519078;20768;872.9432586881959;880.6125304865839;895.8880139982502;933.6032186320922;964.7052979309918;10249.38503689781;10467.476626168662;10770.192235582363;10986.835197472044;11052.336859788438;512180;552789.3605319718;554259;563130;563508;109076;127039.36480317725;129968;136441;139070.3046484761;826.4380221449352;953.3850666320324;955.3312681123242;987.7728122531857;1012.1649639047815;18802.623947521246;19236.23055077781;19408.708869367252;19558;19660.115294812054;55272;55439.891202176535;55869.720651396485;56177;56448.435515645964;60330;78051.60974195093;82404.76392854232;84303;85088.5745571293;6970.686319115754;7718.729844455417;7872.212778722311;7922.405819563441;8081.060545469162;8969.50667713282;9991.050850169513;12556.49774009066;12605.49578016869;12666.240025598494;9215.907840921773;10674.946625266824;10849.02358787713;10936.507857146607;11135.777284454427;10443.321184123311;10519.158467322748;10829.945850270698;10856.45717714127;10948;10631.468426578795;11060.668179954615;11097.889021110008;11109.166812489257;11197.328160310408;7828.686852525835;7896.68413263463;7989.520628762293;8012.158723333966;8020.799480012813;9110.817783644157;10414.583416663248;10787.946060269649;11088.833667495155;11091.500882460146 17:28:40 INFO - PROCESS | 1956 | |3;mootools.html;1467.7871708602254;1492.2240434973814;1541.4219667624645;1739.6607661506002;1867.7011678131503;7916.485428447147;8428.283595894349;8516.020657624375;9007.864882026766;9009.234215091717;8682.262007729334;8740.038595754479;8755.737327880173;8764.474131552111;8776.561171941394;2030.7766145723958;2039.2556716798335;2361.9409514762096;2381.714194296678;2412.0592968742203;2061.4331058958833;2368.751281115484;2388.5103553771437;2395.197608801054;2412.9879350603223;1935.419374187738;2374.03851440167;2392.796612287949;2408.434018005767;2411.385096800322;2364.9527009459716;2380.690510233676;2381.166591692911;2390.3546042568582;2394.018452434511;2366.988165059181;2382.9285121446383;2386.2364043506086;2386.4153282445914;2387.1048356866177;8731.912680873236;8755.912440875574;8782.341324400631;8782.956085219597;8814.162654547808;5204.531592156686;5277.70972596507;5346.144616861284;5361.088614935431;5368.489993450616;3491.214476742738;3578.481120237577;3650.2152037312107;3708.960071960411;3712.2761061593;1027.9023492768174;1060.8567843341127;1064.0689396777818;1083.1334932054403;1085.0234788690163;11545.191836571443;11559.884401156049;11630.360330181837;11649.76700465986;11673.299602023906;4551.704139230939;4628.074385122989;4807.351007613997;4826.758662066883;4832.710037397767;9788.902110978941;9853.50732463374;9883.555240014217;9895.3177959747;9896.476398518333;5330.987112448623;5334.146536554133;5336.653117547347;5348.946510534923;5382.757775900094;4397.25246708054;4703.741294228782;4821.108095002436;4886.315915771795;4887.315775791392;3894.357431023849;3899.2591407633026;3990.920181596352;4004.4794176756836;4011;1294.9611511654477;1312.3503865586595;1318.973620527584;1320.7820709583004;1332.4603535567917;749.6589051981335;769.157772239397;900.3922352412096;903.4534106865383;936.7704912296394;4768.976155119202;5596.188552659842;5926.377730338339;5944.821655350346;6031.185789918392;903.7650210945202;954.8329042417549;959.1511512311655;973.9366941148803;987.5753426026733;3226.5160225965824;3326.4511355626532;3337.8497967591516;3345.514900339437;3715.368387374153;10387.065164135112;10697.946510267398;10704.250702450754;10705.1435885129;10716.839247411295;10550.630727924487;10638.946805265925;10677.89322106769;10682.62610808618;10695.144388448905;7735.342495887912;8065.233802788725;8065.516069035877;8143.75568732939;8221.095679475373;4972.627052970969;5198.844034678966;5846.912296315473;5904;6076.8784624308155;7770.300672939463;9197.172254497127;9884.505774711091;10212.285140040125;10235;9948.303618746908;9991.950040249752;10024.498775061364;10066.8489972649;10104.84842727345;6806.693698783468;7212.8918066228;7371.262873712586;7378.077740282465;7481.251874812475;6939.201991771011;7741.651625676745;8184.386171037077;8209.507429554245;8250.669973201246;7314.158871729819;7419.925800741924;7473.476856619985;7557.093148821957;7577.8105547359555;7346.11846578414;7585.469017168745;7607.695692172251;7638;7648.464607477423;5641.323041235078;5906.173135760911;6831.009503621847;6946.166460024628;6957.930420695729;5142.794288228429;5142.845714628567;5182.97408512955;5229.712365819916;5323.0950738373795;4258.6593072553505;4920.077314080984;4957.429895562056;5213.6350455467755;5250.26496290512 17:28:40 INFO - PROCESS | 1956 | |4;prototype.html;287.7985410212851;303.85111295465214;311.4642814359302;314.22700157612275;315.7647552573333;5411.83764487065;5500.3949565547855;5587.972060139698;5714.514266287365;5718.970585294651;5552.611847038241;5606.299212598426;5631.746571404286;5656.830295091144;5690.089585666295;4273.201053310071;4305.225059489307;4319.33050377192;4334.829596009075;4340.914771307173;3262.771605987582;4214.494260688706;4214.704970652056;4297.699161058727;4385.4737431508265;3147.9842600786965;4144.626983571478;4185.560516145806;4204.0540878302445;4229.6404805591565;4211.789410529476;4212.705110642256;4236.6187043166265;4264.594863487995;4288.541895755458;3508.245727168671;3641.65404286595;3642.562892452896;3649.7445178837493;3659.4876717259604;5083.297095473021;5363.490468405535;5411.18832175173;5423.915216956624;5481.314835645544;4451.59613808543;4465.040016396458;4613.976930115362;4763.3569468121705;4830.1064303103685;5213.464286071105;5554.527865131468;5893;5920.200772895647;5958.5828991970575;3760.9623903761158;3973.602639736032;3976.920461590781;3982.26328129297;4005.459262999487;5741.368449470555;6281.497480201573;6339.746410143589;6348.222497700651;6348.396902294275;3506.5441492605796;3824.8571017097893;3938.9015274618364;4056.51321841375;4065.3495440729343;3432.467967465047;4008.659263962596;4051.6961227908023;4053.8378464861667;4061.13689848656;4206.789660516962;4714.245720684674;4785.712857228577;4825.9758701206265;4833.3958255218095;5503.944960550423;5672;6013.218281623361;6032.668203248863;6033.3061697905305;1203.1818363512896;1262.8003396773101;1332.3937608388353;1368.6236285021698;1375.1474086066503;736.6464097233358;786.8859015442729;827.5613924619961;844.2233145506149;855.4952577979022;3981.5620281768984;4158.9376159357635;4683.524689722726;4750.406199225097;4796.400449943757;4174.749515029047;5120.924605832743;5168.53483186515;5222.276648705918;5228.457605006456;3815.8473661053804;3862.9227415451533;4469.7318160910445;4720.787564559603;4725.40932383452;2400.3639035655565;2427.831679658028;2429.62340837167;2707.458508298348;2741.383188782508;4664.416947881515;4669.486356500782;5050.04049230645;5271;5331.573474122061;4222.831086756495;4364.4980827204645;4715.7877895494785;4914.827981020647;5173.4826517347965;4353.49934757507;4418.851098714357;4705.717656940595;4739.004808990082;5316.670832291927;4360.803763830571;5176.663516871542;5181.404138524118;5199.974000129975;5264.420913699567;4439.735734775223;4444.8444304449185;5112.060565175114;5133.8716532087;5143.254228136824;3908.5895980922733;4586.931196032129;5280.81517146898;5289.576833853205;5373.462653734595;3198.2324242182176;3499.5678003788144;3514.5606799150105;3534.851173368717;3536.9469457957634;4798.592119669727;5193.68837869729;5239.607029472881;5252.290940723106;5464.535514481314;5811.94188058114;5956.702164891652;5967.671778052075;5993.250843644544;6003.669798161143;5045.470225626256;5119.312361010499;5998.4601385875485;6037.335893051849;6060.363661815446;5550.389457159628;5778.479936805707;5814.592978491465;5821.476067153976;5851.882962340645;5896.852578685567;5962.154410405177;5981.7906373278465;6024.849378765566;6026.203491800138;4642.350070990132;5580.9162862557905;5762.1068734346245;5801.332846722512;5841.678707671119 17:28:40 INFO - PROCESS | 1956 | |5;yui.html;684.7432212920158;710.2684235237707;716.3016059342141;741.1995045351022;817.7669364231195;12212.511499540018;15938.52184434466;15957.12235827029;15980.680386392265;15999.760003599955;11747.882521174806;14357.49748758791;14491.42034318626;14503.202323872183;14521.983461157697;829.2702421868762;848.7156802471179;850.4684572142411;851.2083762101244;856.6402111113347;672.3008071605525;828.6354004238146;848.8217474330398;852.0074113657581;854.3421565394642;879.1779685993585;885.2873436883339;894.7584152278881;916.8533034714447;919.3610440743686;906.9047749986288;907.845666236738;908.7546362482126;909.6134142989204;910.2035718746097;663.5056882622429;668.4719071933216;672.9125213722234;674.0092064664934;676.5602358466987;15207.619809504851;15329.846701533064;15332;15352.616184595363;15375.384984600603;11821.822672659917;14219.146851188858;14393.92803035978;14641.560753177422;14915.179665118414;12011.219270747373;12052.216605920587;12069.155159138863;12084.830733396964;12184.20802647834;3801.7909015004166;3807.619238076198;3813.580506144322;3858.498395208605;3991.2815693175216;123138.38430807878;126176.36911815473;130319.34840325832;130338.3483082588;131299;10795.78408431827;11048.502817373237;11056.226064175431;11246.212765106364;11508;23010.65484017741;23076;23092.191773288192;23098.53802923966;23157.768422315898;7859.174786647434;7875.763727088197;7942.285194332538;7955.880661790078;8013.519188848688;3405.761596688208;3812.5321751126016;3869.7678139311734;3970.8014599269923;3997.760134391946;3569.0006798096574;3643.9635603644156;3673.3204357194004;3681.5582130144016;3683.981580092136;648.7956293767448;652.2108249018646;668.6255696809802;684.6816230452863;700.8913618389158;522.5506064784282;575.8281896340926;599.6252342286072;652.7225928980259;694.2536772969079;9479.289053321028;10087.546060427152;10148.492575371201;10252.538635761408;10500.474976251156;617.3147805935408;641.2369280556123;687.9140107486564;692.6155983429245;700.6251655364457;4405.3612226227015;4624.329472226508;4727.432708075053;4734.526547345238;4754.857354279377;156254;162008;164416.53375199382;164700.17649911673;166282;89865.55067224622;132361.33819331034;136808;142459.2877035629;144865;119594.40202799105;120141.39929300298;120418;120634.39682801705;122066;8278;8837.293016558788;8859.71534127535;9037.231835294073;9312.348135630711;47285.763571181924;61291.693541533794;61920.69039654773;63664.68167659132;66476.33523664702;55461;56277.43722562722;86549.56725216334;91308.71728206582;98193.01806981838;10752.892471075189;12990.740185196055;13116.409761560562;13311.334433278103;13880.305984700926;11647.359395233005;14599.708005840037;14729.189894555902;14834.406623735362;15286.235688215322;13778.104423212459;14006.719865602427;14026.438942442188;14041.1575305482;14678.77981830252;13864.168149911038;13922.791158132433;14060.156390616186;14133.010689251654;14472.565823025327;13628.523001694894;13649.863501365257;13720.588382348546;14209.928950355183;14312.284385780462;11021.228514003942;11193.384363860067;11279.379634120201;11854.510552783668;12020.879791201976;11006.229563930448;11415.315081095161;11533.769324613628;11799.823002654795;11824.172307938361 17:28:40 INFO - PROCESS | 1956 | __end_tp_report 17:28:40 INFO - PROCESS | 1956 | __start_cc_report 17:28:40 INFO - PROCESS | 1956 | _x_x_mozilla_cycle_collect,379 17:28:40 INFO - PROCESS | 1956 | __end_cc_report 17:28:40 INFO - PROCESS | 1956 | __startTimestamp1472862520058__endTimestamp 17:28:40 INFO - PROCESS | 1956 | 17:28:40 INFO - PROCESS | 1956 | ------- Summary: start ------- 17:28:40 INFO - PROCESS | 1956 | Number of tests: 6 17:28:40 INFO - PROCESS | 1956 | 17:28:40 INFO - PROCESS | 1956 | [#0] dojo.html Cycles:165 Average:5721.10 Median:5892.62 stddev:654.01 (11.1%) stddev-sans-first:628.74 17:28:40 INFO - PROCESS | 1956 | Values: 3338.4 3371.3 3372.5 3381.7 3382.9 5594.7 5612.8 5613.7 5670.3 5671.5 5579.4 5706.1 5762.8 5765.9 5787.7 5181.3 5190.6 5237.4 5261.2 5323.5 5238.5 5364.7 5402.2 5408.1 5421.9 5124.8 5246.7 5269.4 5274.9 5299.5 5155.9 5181.0 5198.0 5216.7 5239.4 5138.0 5162.4 5164.6 5248.3 5312.8 5167.3 5687.5 5796.7 5814.2 5830.4 6195.3 6196.2 6273.4 6280.4 6299.6 6250.7 6326.7 6330.9 6332.9 6348.2 5721.9 5805.4 5853.9 5892.6 5900.0 6317.6 6326.3 6330.2 6332.3 6349.6 6202.0 6208.1 6219.2 6230.8 6234.4 6139.3 6185.9 6247.1 6321.1 6322.3 6101.8 6114.3 6132.2 6179.6 6220.7 6212.2 6240.6 6255.1 6261.4 6294.3 4829.5 4930.4 4932.1 4939.6 4960.4 3870.8 4086.7 4351.3 4367.5 4391.5 5518.9 5621.2 5624.8 5660.6 5672.6 6135.3 6149.6 6149.6 6161.2 6171.8 5780.6 5835.2 5870.8 5872.4 5933.3 5399.5 5422.8 5428.0 5432.0 5459.0 6241.3 6327.2 6375.7 6395.5 6406.4 6184.0 6217.9 6272.6 6315.1 6337.9 6295.5 6305.1 6316.6 6326.9 6337.4 6098.0 6098.6 6187.0 6189.8 6209.0 4980.7 6079.2 6184.2 6202.4 6206.3 5994.7 6010.0 6013.0 6019.2 6045.7 5913.0 6037.7 6048.9 6050.2 6068.8 5817.7 5849.9 5885.9 5888.9 5895.0 5013.6 5062.1 5794.8 6045.4 6091.3 5632.7 5854.4 5901.2 5902.1 5939.0 17:28:40 INFO - PROCESS | 1956 | 17:28:40 INFO - PROCESS | 1956 | [#1] ext.html Cycles:180 Average:68899.36 Median:39991.40 stddev:149389.62 (373.6%) stddev-sans-first:149720.35 17:28:40 INFO - PROCESS | 1956 | Values: 469.2 483.3 483.5 493.5 501.1 31036.7 39913.6 39921.4 40050.6 40097.2 39988.6 39994.2 40599.4 40613.4 40622.8 8286.5 9836.9 9845.9 9854.8 9883.7 9648.9 9727.3 9757.2 9762.0 9765.0 9767.5 9768.4 9786.4 9792.1 9807.1 9716.6 9772.6 9775.0 9778.7 9780.9 8202.0 9806.2 9877.4 9881.5 9907.5 38986.0 39050.0 39293.4 39312.4 39339.0 2821.7 3313.8 3343.9 3386.1 3444.9 30230.0 30958.2 31279.2 32094.0 32184.5 3014.4 3192.7 3265.9 3303.9 3389.8 393540.0 437734.0 482394.6 482464.0 483682.6 51159.2 55694.7 59522.9 60432.8 63125.7 33261.5 34084.4 61979.0 62355.7 62576.4 15935.5 16157.8 16293.2 16318.2 16400.0 10721.6 12461.3 12581.4 12669.2 12681.8 18538.5 18542.9 18598.3 18632.1 18673.1 6843.3 8044.7 8151.0 8239.5 8268.6 815.5 843.6 935.6 956.4 1047.6 28407.7 28833.4 30016.4 30033.0 30445.7 948.0 1046.6 1050.7 1058.0 1103.3 14907.2 15603.6 15628.7 15833.5 16028.4 617357.0 628150.0 634198.0 635401.0 636077.0 57096.1 57667.0 57727.4 57768.7 57805.4 1330.9 1347.1 1386.3 1389.2 1392.4 28959.3 30015.7 30326.8 30451.0 30509.1 45068.6 50610.0 51997.5 52384.7 52414.7 572742.0 576804.1 576994.0 577175.0 578410.0 41722.7 42059.0 42150.4 42444.8 42670.6 45967.5 46705.6 47094.0 47266.8 47438.1 38761.2 38959.8 39022.2 39723.0 40259.0 37766.6 38302.8 38415.6 38977.8 39391.4 36760.6 36778.8 37772.9 38086.6 38787.6 30893.5 31807.4 32508.8 34063.0 34569.0 24278.8 25345.2 25653.5 25854.0 26108.0 17:28:40 INFO - PROCESS | 1956 | 17:28:40 INFO - PROCESS | 1956 | [#2] jquery.html Cycles:180 Average:33158.45 Median:310.91 stddev:92027.31 (29599.6%) stddev-sans-first:92252.40 17:28:40 INFO - PROCESS | 1956 | Values: 301.6 320.2 329.0 352.9 375.7 17054.8 17999.7 20914.5 21063.9 21220.5 20080.4 20213.0 20293.0 20569.4 20581.5 4906.7 5870.7 5915.7 6126.6 6135.1 5778.6 6085.8 6154.0 6179.5 6195.0 6074.0 6121.2 6158.5 6188.0 6697.3 6795.4 6797.6 6801.5 6821.6 6845.3 5852.5 5942.7 5972.8 6023.1 6031.9 12945.3 13180.7 13302.7 23456.0 24599.8 2103.2 2131.5 2250.4 2252.7 2435.2 9921.5 10198.4 10345.5 12556.9 14468.4 1838.4 1845.4 1848.4 1873.3 1877.6 89573.0 105563.0 111059.0 111890.0 113028.0 11275.9 11339.5 11510.4 11524.3 11550.2 14321.1 14337.5 14342.8 14345.1 14374.0 8233.6 8424.5 8428.2 8460.9 8541.4 8355.3 8384.4 8545.9 8563.4 8582.0 4090.2 4199.6 4386.1 4420.2 4524.2 1895.5 1926.9 1931.2 1932.4 1977.4 835.7 856.4 866.9 903.1 928.7 18982.5 20040.8 20753.1 20754.9 20768.0 872.9 880.6 895.9 933.6 964.7 10249.4 10467.5 10770.2 10986.8 11052.3 512180.0 552789.4 554259.0 563130.0 563508.0 109076.0 127039.4 129968.0 136441.0 139070.3 826.4 953.4 955.3 987.8 1012.2 18802.6 19236.2 19408.7 19558.0 19660.1 55272.0 55439.9 55869.7 56177.0 56448.4 60330.0 78051.6 82404.8 84303.0 85088.6 6970.7 7718.7 7872.2 7922.4 8081.1 8969.5 9991.1 12556.5 12605.5 12666.2 9215.9 10674.9 10849.0 10936.5 11135.8 10443.3 10519.2 10829.9 10856.5 10948.0 10631.5 11060.7 11097.9 11109.2 11197.3 7828.7 7896.7 7989.5 8012.2 8020.8 9110.8 10414.6 10787.9 11088.8 11091.5 17:28:40 INFO - PROCESS | 1956 | 17:28:40 INFO - PROCESS | 1956 | [#3] mootools.html Cycles:180 Average:5636.94 Median:5142.82 stddev:3166.79 (61.6%) stddev-sans-first:3160.18 17:28:40 INFO - PROCESS | 1956 | Values: 1467.8 1492.2 1541.4 1739.7 1867.7 7916.5 8428.3 8516.0 9007.9 9009.2 8682.3 8740.0 8755.7 8764.5 8776.6 2030.8 2039.3 2361.9 2381.7 2412.1 2061.4 2368.8 2388.5 2395.2 2413.0 1935.4 2374.0 2392.8 2408.4 2411.4 2365.0 2380.7 2381.2 2390.4 2394.0 2367.0 2382.9 2386.2 2386.4 2387.1 8731.9 8755.9 8782.3 8783.0 8814.2 5204.5 5277.7 5346.1 5361.1 5368.5 3491.2 3578.5 3650.2 3709.0 3712.3 1027.9 1060.9 1064.1 1083.1 1085.0 11545.2 11559.9 11630.4 11649.8 11673.3 4551.7 4628.1 4807.4 4826.8 4832.7 9788.9 9853.5 9883.6 9895.3 9896.5 5331.0 5334.1 5336.7 5348.9 5382.8 4397.3 4703.7 4821.1 4886.3 4887.3 3894.4 3899.3 3990.9 4004.5 4011.0 1295.0 1312.4 1319.0 1320.8 1332.5 749.7 769.2 900.4 903.5 936.8 4769.0 5596.2 5926.4 5944.8 6031.2 903.8 954.8 959.2 973.9 987.6 3226.5 3326.5 3337.8 3345.5 3715.4 10387.1 10697.9 10704.3 10705.1 10716.8 10550.6 10638.9 10677.9 10682.6 10695.1 7735.3 8065.2 8065.5 8143.8 8221.1 4972.6 5198.8 5846.9 5904.0 6076.9 7770.3 9197.2 9884.5 10212.3 10235.0 9948.3 9992.0 10024.5 10066.8 10104.8 6806.7 7212.9 7371.3 7378.1 7481.3 6939.2 7741.7 8184.4 8209.5 8250.7 7314.2 7419.9 7473.5 7557.1 7577.8 7346.1 7585.5 7607.7 7638.0 7648.5 5641.3 5906.2 6831.0 6946.2 6957.9 5142.8 5142.8 5183.0 5229.7 5323.1 4258.7 4920.1 4957.4 5213.6 5250.3 17:28:40 INFO - PROCESS | 1956 | 17:28:40 INFO - PROCESS | 1956 | [#4] prototype.html Cycles:180 Average:4473.00 Median:4774.53 stddev:1403.96 (29.4%) stddev-sans-first:1372.31 17:28:40 INFO - PROCESS | 1956 | Values: 287.8 303.9 311.5 314.2 315.8 5411.8 5500.4 5588.0 5714.5 5719.0 5552.6 5606.3 5631.7 5656.8 5690.1 4273.2 4305.2 4319.3 4334.8 4340.9 3262.8 4214.5 4214.7 4297.7 4385.5 3148.0 4144.6 4185.6 4204.1 4229.6 4211.8 4212.7 4236.6 4264.6 4288.5 3508.2 3641.7 3642.6 3649.7 3659.5 5083.3 5363.5 5411.2 5423.9 5481.3 4451.6 4465.0 4614.0 4763.4 4830.1 5213.5 5554.5 5893.0 5920.2 5958.6 3761.0 3973.6 3976.9 3982.3 4005.5 5741.4 6281.5 6339.7 6348.2 6348.4 3506.5 3824.9 3938.9 4056.5 4065.3 3432.5 4008.7 4051.7 4053.8 4061.1 4206.8 4714.2 4785.7 4826.0 4833.4 5503.9 5672.0 6013.2 6032.7 6033.3 1203.2 1262.8 1332.4 1368.6 1375.1 736.6 786.9 827.6 844.2 855.5 3981.6 4158.9 4683.5 4750.4 4796.4 4174.7 5120.9 5168.5 5222.3 5228.5 3815.8 3862.9 4469.7 4720.8 4725.4 2400.4 2427.8 2429.6 2707.5 2741.4 4664.4 4669.5 5050.0 5271.0 5331.6 4222.8 4364.5 4715.8 4914.8 5173.5 4353.5 4418.9 4705.7 4739.0 5316.7 4360.8 5176.7 5181.4 5200.0 5264.4 4439.7 4444.8 5112.1 5133.9 5143.3 3908.6 4586.9 5280.8 5289.6 5373.5 3198.2 3499.6 3514.6 3534.9 3536.9 4798.6 5193.7 5239.6 5252.3 5464.5 5811.9 5956.7 5967.7 5993.3 6003.7 5045.5 5119.3 5998.5 6037.3 6060.4 5550.4 5778.5 5814.6 5821.5 5851.9 5896.9 5962.2 5981.8 6024.8 6026.2 4642.4 5580.9 5762.1 5801.3 5841.7 17:28:40 INFO - PROCESS | 1956 | 17:28:40 INFO - PROCESS | 1956 | [#5] yui.html Cycles:180 Average:25696.29 Median:23095.36 stddev:42295.43 (183.1%) stddev-sans-first:42372.39 17:28:40 INFO - PROCESS | 1956 | Values: 684.7 710.3 716.3 741.2 817.8 12212.5 15938.5 15957.1 15980.7 15999.8 11747.9 14357.5 14491.4 14503.2 14522.0 829.3 848.7 850.5 851.2 856.6 672.3 828.6 848.8 852.0 854.3 879.2 885.3 894.8 916.9 919.4 906.9 907.8 908.8 909.6 910.2 663.5 668.5 672.9 674.0 676.6 15207.6 15329.8 15332.0 15352.6 15375.4 11821.8 14219.1 14393.9 14641.6 14915.2 12011.2 12052.2 12069.2 12084.8 12184.2 3801.8 3807.6 3813.6 3858.5 3991.3 123138.4 126176.4 130319.3 130338.3 131299.0 10795.8 11048.5 11056.2 11246.2 11508.0 23010.7 23076.0 23092.2 23098.5 23157.8 7859.2 7875.8 7942.3 7955.9 8013.5 3405.8 3812.5 3869.8 3970.8 3997.8 3569.0 3644.0 3673.3 3681.6 3684.0 648.8 652.2 668.6 684.7 700.9 522.6 575.8 599.6 652.7 694.3 9479.3 10087.5 10148.5 10252.5 10500.5 617.3 641.2 687.9 692.6 700.6 4405.4 4624.3 4727.4 4734.5 4754.9 156254.0 162008.0 164416.5 164700.2 166282.0 89865.6 132361.3 136808.0 142459.3 144865.0 119594.4 120141.4 120418.0 120634.4 122066.0 8278.0 8837.3 8859.7 9037.2 9312.3 47285.8 61291.7 61920.7 63664.7 66476.3 55461.0 56277.4 86549.6 91308.7 98193.0 10752.9 12990.7 13116.4 13311.3 13880.3 11647.4 14599.7 14729.2 14834.4 15286.2 13778.1 14006.7 14026.4 14041.2 14678.8 13864.2 13922.8 14060.2 14133.0 14472.6 13628.5 13649.9 13720.6 14209.9 14312.3 11021.2 11193.4 11279.4 11854.5 12020.9 11006.2 11415.3 11533.8 11799.8 11824.2 17:28:40 INFO - PROCESS | 1956 | -------- Summary: end -------- 17:28:40 INFO - PROCESS | 1956 | 17:28:40 INFO - TEST-INFO | 1956: exit 0 17:28:40 INFO - TEST-OK | dromaeo_css | took 1114264ms 17:28:40 INFO - TEST-START | kraken 17:28:40 INFO - operating with platform_type : mac_ 17:28:40 INFO - Initialising browser for kraken test... 17:28:40 INFO - TEST-INFO | started process 1962 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpBTCl7e/profile http://localhost:50348/getInfo.html) 17:28:43 INFO - PROCESS | 1962 | __metrics Screen width/height:1600/1200 17:28:43 INFO - PROCESS | 1962 | colorDepth:24 17:28:43 INFO - PROCESS | 1962 | Browser inner width/height: 1024/689 17:28:43 INFO - PROCESS | 1962 | __metrics 17:28:43 ERROR - PROCESS | 1962 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 17:28:44 INFO - TEST-INFO | 1962: exit 0 17:28:44 INFO - Browser initialized. 17:28:44 INFO - Running cycle 1/1 for kraken test... 17:28:44 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpBTCl7e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:28:56 INFO - PROCESS | 1964 | RSS: Main: 245415936 17:28:56 INFO - PROCESS | 1964 | 17:28:59 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:50348/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50348/tests/kraken/driver.html?testName=audio-beat-detection) 17:29:00 INFO - PROCESS | 1964 | RSS: Main: 258273280 17:29:00 INFO - PROCESS | 1964 | 17:29:03 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:50348/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50348/tests/kraken/driver.html?testName=audio-dft) 17:29:03 INFO - PROCESS | 1964 | RSS: Main: 266956800 17:29:03 INFO - PROCESS | 1964 | 17:29:07 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:50348/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50348/tests/kraken/driver.html?testName=audio-fft) 17:29:07 INFO - PROCESS | 1964 | RSS: Main: 264720384 17:29:07 INFO - PROCESS | 1964 | 17:29:09 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:50348/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50348/tests/kraken/driver.html?testName=audio-oscillator) 17:29:10 INFO - PROCESS | 1964 | RSS: Main: 266047488 17:29:10 INFO - PROCESS | 1964 | 17:29:12 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:50348/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50348/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:29:13 INFO - PROCESS | 1964 | RSS: Main: 267661312 17:29:13 INFO - PROCESS | 1964 | 17:29:16 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:50348/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50348/tests/kraken/driver.html?testName=imaging-darkroom) 17:29:16 INFO - PROCESS | 1964 | RSS: Main: 268201984 17:29:16 INFO - PROCESS | 1964 | 17:29:19 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:50348/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50348/tests/kraken/driver.html?testName=imaging-desaturate) 17:29:20 INFO - PROCESS | 1964 | RSS: Main: 268406784 17:29:20 INFO - PROCESS | 1964 | 17:29:23 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:50348/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50348/tests/kraken/driver.html?testName=json-parse-financial) 17:29:23 INFO - PROCESS | 1964 | RSS: Main: 268369920 17:29:23 INFO - PROCESS | 1964 | 17:29:25 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:50348/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50348/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:29:26 INFO - PROCESS | 1964 | RSS: Main: 268296192 17:29:26 INFO - PROCESS | 1964 | 17:29:28 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:50348/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50348/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:29:28 INFO - PROCESS | 1964 | RSS: Main: 268292096 17:29:28 INFO - PROCESS | 1964 | 17:29:30 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:50348/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50348/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:29:31 INFO - PROCESS | 1964 | RSS: Main: 268607488 17:29:31 INFO - PROCESS | 1964 | 17:29:34 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:50348/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50348/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:29:35 INFO - PROCESS | 1964 | RSS: Main: 268697600 17:29:35 INFO - PROCESS | 1964 | 17:29:38 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:50348/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50348/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:29:38 INFO - PROCESS | 1964 | RSS: Main: 268656640 17:29:38 INFO - PROCESS | 1964 | 17:29:40 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:50348/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50348/tests/kraken/driver.html?testName=ai-astar) 17:29:40 INFO - PROCESS | 1964 | RSS: Main: 270995456 17:29:40 INFO - PROCESS | 1964 | 17:29:40 INFO - PROCESS | 1964 | __start_tp_report 17:29:40 INFO - PROCESS | 1964 | _x_x_mozilla_page_load 17:29:40 INFO - PROCESS | 1964 | _x_x_mozilla_page_load_details 17:29:40 INFO - PROCESS | 1964 | |i|pagename|runs| 17:29:40 INFO - PROCESS | 1964 | |0;ai-astar;108;114;118;114;117;116;118;117;117;136 17:29:40 INFO - PROCESS | 1964 | |1;audio-beat-detection;152;146;126;191;145;170;156;113;158;112 17:29:40 INFO - PROCESS | 1964 | |2;audio-dft;209;238;214;279;212;197;202;202;193;196 17:29:40 INFO - PROCESS | 1964 | |3;audio-fft;74;83;76;146;59;60;59;61;149;83 17:29:40 INFO - PROCESS | 1964 | |4;audio-oscillator;71;104;158;94;71;80;113;69;72;114 17:29:40 INFO - PROCESS | 1964 | |5;imaging-gaussian-blur;106;102;90;87;89;107;91;88;91;87 17:29:40 INFO - PROCESS | 1964 | |6;imaging-darkroom;125;152;97;120;95;96;98;156;127;97 17:29:40 INFO - PROCESS | 1964 | |7;imaging-desaturate;91;93;93;93;94;91;91;87;93;98 17:29:40 INFO - PROCESS | 1964 | |8;json-parse-financial;55;57;58;57;59;58;57;58;61;79 17:29:40 INFO - PROCESS | 1964 | |9;json-stringify-tinderbox;69;74;69;77;75;77;76;76;72;74 17:29:40 INFO - PROCESS | 1964 | |10;stanford-crypto-aes;92;86;90;88;87;86;87;87;89;87 17:29:40 INFO - PROCESS | 1964 | |11;stanford-crypto-ccm;140;147;152;132;154;132;131;143;197;166 17:29:40 INFO - PROCESS | 1964 | |12;stanford-crypto-pbkdf2;237;181;176;173;175;175;174;179;170;174 17:29:40 INFO - PROCESS | 1964 | |13;stanford-crypto-sha256-iterative;70;70;70;70;71;69;69;67;69;70 17:29:40 INFO - PROCESS | 1964 | __end_tp_report 17:29:40 INFO - PROCESS | 1964 | __start_cc_report 17:29:40 INFO - PROCESS | 1964 | _x_x_mozilla_cycle_collect,971 17:29:40 INFO - PROCESS | 1964 | __end_cc_report 17:29:40 INFO - PROCESS | 1964 | __startTimestamp1472862580770__endTimestamp 17:29:40 INFO - PROCESS | 1964 | 17:29:40 INFO - PROCESS | 1964 | ------- Summary: start ------- 17:29:40 INFO - PROCESS | 1964 | Number of tests: 14 17:29:40 INFO - PROCESS | 1964 | 17:29:40 INFO - PROCESS | 1964 | [#0] ai-astar Cycles:10 Average:117.50 Median:117.00 stddev:7.15 (6.1%) stddev-sans-first:6.71 17:29:40 INFO - PROCESS | 1964 | Values: 108.0 114.0 118.0 114.0 117.0 116.0 118.0 117.0 117.0 136.0 17:29:40 INFO - PROCESS | 1964 | 17:29:40 INFO - PROCESS | 1964 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:154.00 stddev:24.76 (16.1%) stddev-sans-first:26.20 17:29:40 INFO - PROCESS | 1964 | Values: 152.0 146.0 126.0 191.0 145.0 170.0 156.0 113.0 158.0 112.0 17:29:40 INFO - PROCESS | 1964 | 17:29:40 INFO - PROCESS | 1964 | [#2] audio-dft Cycles:10 Average:214.20 Median:210.50 stddev:26.19 (12.4%) stddev-sans-first:27.71 17:29:40 INFO - PROCESS | 1964 | Values: 209.0 238.0 214.0 279.0 212.0 197.0 202.0 202.0 193.0 196.0 17:29:40 INFO - PROCESS | 1964 | 17:29:40 INFO - PROCESS | 1964 | [#3] audio-fft Cycles:10 Average:85.00 Median:67.50 stddev:34.29 (50.8%) stddev-sans-first:36.13 17:29:40 INFO - PROCESS | 1964 | Values: 74.0 83.0 76.0 146.0 59.0 60.0 59.0 61.0 149.0 83.0 17:29:40 INFO - PROCESS | 1964 | 17:29:40 INFO - PROCESS | 1964 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:71.00 stddev:28.51 (40.2%) stddev-sans-first:28.93 17:29:40 INFO - PROCESS | 1964 | Values: 71.0 104.0 158.0 94.0 71.0 80.0 113.0 69.0 72.0 114.0 17:29:40 INFO - PROCESS | 1964 | 17:29:40 INFO - PROCESS | 1964 | [#5] imaging-gaussian-blur Cycles:10 Average:93.80 Median:88.50 stddev:7.96 (9.0%) stddev-sans-first:7.11 17:29:40 INFO - PROCESS | 1964 | Values: 106.0 102.0 90.0 87.0 89.0 107.0 91.0 88.0 91.0 87.0 17:29:40 INFO - PROCESS | 1964 | 17:29:40 INFO - PROCESS | 1964 | [#6] imaging-darkroom Cycles:10 Average:116.30 Median:95.50 stddev:23.57 (24.7%) stddev-sans-first:24.79 17:29:40 INFO - PROCESS | 1964 | Values: 125.0 152.0 97.0 120.0 95.0 96.0 98.0 156.0 127.0 97.0 17:29:40 INFO - PROCESS | 1964 | 17:29:40 INFO - PROCESS | 1964 | [#7] imaging-desaturate Cycles:10 Average:92.40 Median:93.00 stddev:2.80 (3.0%) stddev-sans-first:2.92 17:29:40 INFO - PROCESS | 1964 | Values: 91.0 93.0 93.0 93.0 94.0 91.0 91.0 87.0 93.0 98.0 17:29:40 INFO - PROCESS | 1964 | 17:29:40 INFO - PROCESS | 1964 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:58.00 stddev:6.89 (11.9%) stddev-sans-first:7.07 17:29:40 INFO - PROCESS | 1964 | Values: 55.0 57.0 58.0 57.0 59.0 58.0 57.0 58.0 61.0 79.0 17:29:40 INFO - PROCESS | 1964 | 17:29:40 INFO - PROCESS | 1964 | [#9] json-stringify-tinderbox Cycles:10 Average:73.90 Median:75.50 stddev:3.00 (4.0%) stddev-sans-first:2.60 17:29:40 INFO - PROCESS | 1964 | Values: 69.0 74.0 69.0 77.0 75.0 77.0 76.0 76.0 72.0 74.0 17:29:40 INFO - PROCESS | 1964 | 17:29:40 INFO - PROCESS | 1964 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:87.50 stddev:1.91 (2.2%) stddev-sans-first:1.33 17:29:40 INFO - PROCESS | 1964 | Values: 92.0 86.0 90.0 88.0 87.0 86.0 87.0 87.0 89.0 87.0 17:29:40 INFO - PROCESS | 1964 | 17:29:40 INFO - PROCESS | 1964 | [#11] stanford-crypto-ccm Cycles:10 Average:149.40 Median:149.50 stddev:20.13 (13.5%) stddev-sans-first:21.07 17:29:40 INFO - PROCESS | 1964 | Values: 140.0 147.0 152.0 132.0 154.0 132.0 131.0 143.0 197.0 166.0 17:29:40 INFO - PROCESS | 1964 | 17:29:40 INFO - PROCESS | 1964 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.40 Median:175.50 stddev:19.77 (11.3%) stddev-sans-first:3.23 17:29:40 INFO - PROCESS | 1964 | Values: 237.0 181.0 176.0 173.0 175.0 175.0 174.0 179.0 170.0 174.0 17:29:40 INFO - PROCESS | 1964 | 17:29:40 INFO - PROCESS | 1964 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:1.08 (1.5%) stddev-sans-first:1.13 17:29:40 INFO - PROCESS | 1964 | Values: 70.0 70.0 70.0 70.0 71.0 69.0 69.0 67.0 69.0 70.0 17:29:40 INFO - PROCESS | 1964 | -------- Summary: end -------- 17:29:40 INFO - PROCESS | 1964 | 17:29:41 INFO - TEST-INFO | 1964: exit 0 17:29:41 INFO - TEST-OK | kraken | took 61051ms 17:29:41 INFO - SUITE-END | took 1175s 17:29:41 INFO - Completed test suite (00:19:35) 17:29:41 INFO - javascript benchmark 17:29:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7307.847428017988, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3338.432466480698, 3371.308881679255, 3372.4772660237663, 3381.746369022321, 3382.932341353173, 5594.748236329365, 5612.83161505155, 5613.663180209191, 5670.319561652603, 5671.517920976712, 5579.442055794419, 5706.115552089433, 5762.827115186541, 5765.942340576593, 5787.710614469281, 5181.274621552986, 5190.558802501791, 5237.371515418136, 5261.210818377236, 5323.467653234665, 5238.47615238475, 5364.651297665659, 5402.162664786944, 5408.134698448249, 5421.9457805421835, 5124.76938537763, 5246.737663116829, 5269.420363759983, 5274.947250527484, 5299.470052994709, 5155.9484405155845, 5180.974095129538, 5198.0, 5216.739163041832, 5239.397469291042, 5137.9724055188735, 5162.406323272834, 5164.586833053384, 5248.343957005374, 5312.76092575835, 5167.276581278624, 5687.544996400278, 5796.652200867961, 5814.156947242626, 5830.4461076197695, 6195.256569211679, 6196.163517925068, 6273.404026617464, 6280.403361680633, 6299.622022678654, 6250.656213908279, 6326.683665816737, 6330.923742963707, 6332.873342533169, 6348.206474190726, 5721.942780572141, 5805.390434004369, 5853.882922341614, 5892.616979896293, 5900.0, 6317.6209427434505, 6326.335734747785, 6330.208723909512, 6332.271788744261, 6349.587276826992, 6201.96899015502, 6208.1308616793685, 6219.191505104308, 6230.813075607739, 6234.407731265523, 6139.3388173831, 6185.907211391743, 6247.125402443661, 6321.051842223703, 6322.272938612118, 6101.7559297627595, 6114.3277820888225, 6132.20254427538, 6179.567430279837, 6220.720067596969, 6212.223472065992, 6240.594361366497, 6255.093011513305, 6261.405166509175, 6294.307626161119, 4829.517048295143, 4930.433000204951, 4932.136876046749, 4939.629527785431, 4960.429550601655, 3870.838748375476, 4086.734362266443, 4351.325544540601, 4367.541408152162, 4391.538888416734, 5518.862028449321, 5621.184928185472, 5624.803131890364, 5660.632058916157, 5672.602917795797, 6135.32395826069, 6149.600275982137, 6149.631022138686, 6161.199044124235, 6171.783987560414, 5780.566457515703, 5835.183074369592, 5870.7945221917025, 5872.412758724179, 5933.258342707161, 5399.541039011728, 5422.75597598109, 5428.022955867903, 5432.0, 5458.972705136528, 6241.31345551998, 6327.209098862642, 6375.71309291083, 6395.456386207225, 6406.423421892052, 6184.041473571604, 6217.906731398942, 6272.6236425814595, 6315.08431277453, 6337.8732425352155, 6295.464885484602, 6305.085762564494, 6316.589421687576, 6326.905096423649, 6337.397947195009, 6098.0, 6098.603590766586, 6187.041008643668, 6189.752409903554, 6208.9689551551955, 4980.726060066586, 6079.240094988127, 6184.196054512884, 6202.4417802398, 6206.255249370104, 5994.700264986646, 6009.971701926838, 6013.0, 6019.1573179754, 6045.697715114315, 5912.970435147969, 6037.698115094316, 6048.939510605013, 6050.21347224858, 6068.848278793065, 5817.680027598522, 5849.883002339844, 5885.852853678693, 5888.852778680567, 5895.0, 5013.573846223112, 5062.139436295765, 5794.7682092717505, 6045.425684559959, 6091.269047714302, 5632.718364081861, 5854.414558544111, 5901.232839730807, 5902.1146827976145, 5939.0], "value": 5678.761897698971, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.21406643871507, 483.3233473137607, 483.54788272964805, 493.4917035453484, 501.07551567358223, 31036.689633103662, 39913.60086399135, 39921.40117898227, 40050.59949400505, 40097.1980560389, 39988.60011399885, 39994.200115997664, 40599.39100913489, 40613.39079913796, 40622.79688601553, 8286.502809831414, 9836.852447213298, 9845.901540984605, 9854.802903941916, 9883.703488895344, 9648.903510964907, 9727.27045471589, 9757.219422446222, 9762.0, 9765.023497650214, 9767.51162441875, 9768.413895166314, 9786.363886347364, 9792.11870931616, 9807.06832850878, 9716.56275467602, 9772.560234789451, 9775.0, 9778.65774697882, 9780.853287200698, 8201.95899020501, 9806.215502759833, 9877.357971731886, 9881.456519891402, 9907.504624768733, 38986.0, 39050.0, 39293.41059884104, 39312.410313845314, 39339.0, 2821.7460428561526, 3313.8343082845763, 3343.8829640962695, 3386.0519054664733, 3444.8622055117767, 30230.0, 30958.22604434907, 31279.218019549466, 32094.0, 32184.517232241535, 3014.442328169274, 3192.696693814084, 3265.9020229393154, 3303.8513266903046, 3389.779664321811, 393540.0, 437734.0, 482394.58802706114, 482464.0, 483682.58158709336, 51159.23261151086, 55694.72152639211, 59522.91669791537, 60432.79134417287, 63125.684371577845, 33261.50107748386, 34084.44366672509, 61979.0, 62355.6882215586, 62576.374236257056, 15935.521934341989, 16157.838421615868, 16293.185340732916, 16318.184090795412, 16400.0, 10721.571137154426, 12461.252324860538, 12581.433835477426, 12669.176503527242, 12681.809772853414, 18538.536536586424, 18542.907285463487, 18598.256069757328, 18632.068396580118, 18673.066346682885, 6843.349881761224, 8044.678212871537, 8150.959245203736, 8239.516886960404, 8268.553003224411, 815.4740192575874, 843.6035063520136, 935.6444551070549, 956.4118067388645, 1047.6333283350918, 28407.715922840922, 28833.42333153367, 30016.39967200644, 30033.0, 30445.695543044287, 947.985655348784, 1046.6194192757284, 1050.726811029138, 1057.9735506612242, 1103.2883789955433, 14907.180105094323, 15603.609909752347, 15628.687426251412, 15833.52499425019, 16028.439004634782, 617357.0, 628150.0, 634198.0, 635401.0, 636077.0, 57096.14355784666, 57667.0, 57727.4227257722, 57768.71115644395, 57805.421945780006, 1330.9068365214537, 1347.1243691600341, 1386.334559411488, 1389.215093472185, 1392.4012674549838, 28959.276018098873, 30015.69984300129, 30326.84836575803, 30451.0, 30509.084727458212, 45068.64794056184, 50610.0, 51997.480025199264, 52384.738076309375, 52414.737926310125, 572742.0, 576804.0876321151, 576994.0, 577175.0, 578410.0, 41722.74831755052, 42059.0, 42150.36774448447, 42444.78777606092, 42670.57329426666, 45967.54032459766, 46705.598832035095, 47094.0, 47266.76366618145, 47438.05123897434, 38761.224775504896, 38959.805200974944, 39022.219555608164, 39723.00692482711, 40259.0, 37766.622333777406, 38302.808485957394, 38415.61584384232, 38977.80511097427, 39391.40912886251, 36760.63239367572, 36778.8161059193, 37772.86681399562, 38086.61913380831, 38787.61212387953, 30893.53659695151, 31807.36385272328, 32508.837455813515, 34063.0, 34568.96293111211, 24278.77353117426, 25345.239642810746, 25653.486930261664, 25853.965841366135, 26107.955681773277], "value": 19911.8786406041, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.5702623761141, 320.24422363222806, 328.985195666195, 352.91706448984485, 375.71445701267027, 17054.82945170548, 17999.730004049918, 20914.45132920247, 21063.94680265988, 21220.469488262803, 20080.397588072345, 20212.98935053245, 20293.0, 20569.38291851243, 20581.485462863435, 4906.730129842857, 5870.70646467677, 5915.698546319824, 6126.571140020178, 6135.141080248769, 5778.6243894146955, 6085.843689698965, 6153.969230153865, 6179.505639548848, 6195.039768835815, 6074.0, 6121.204243448346, 6158.507319414459, 6188.0, 6697.263301036882, 6795.354441328066, 6797.5921444712985, 6801.4558835293055, 6821.556598821086, 6845.315468453165, 5852.473277405012, 5942.702864856783, 5972.754108823991, 6023.066424704134, 6031.8793624127275, 12945.288009159493, 13180.6704832379, 13302.733945321137, 23456.0, 24599.770011499353, 2103.2112957640884, 2131.531063166101, 2250.4148921280585, 2252.662100684894, 2435.232901635979, 9921.454320012397, 10198.388096714221, 10345.482725863752, 12556.937215313956, 14468.421263149461, 1838.3565751986832, 1845.3910209630924, 1848.4362269507794, 1873.3068764557202, 1877.5963167918826, 89573.0, 105563.0, 111059.0, 111890.0, 113027.99999999917, 11275.94362028201, 11339.489722962486, 11510.36692981894, 11524.2509236901, 11550.249233799776, 14321.14073155614, 14337.494563070935, 14342.784858227134, 14345.139291642536, 14373.993820432679, 8233.629486673113, 8424.458936576502, 8428.157184281523, 8460.915390846136, 8541.444806087584, 8355.289800367036, 8384.371172161991, 8545.871811922827, 8563.443376180529, 8581.95709021451, 4090.1615168890307, 4199.601037901394, 4386.078923426053, 4420.226460369422, 4524.163029839425, 1895.4597939587152, 1926.922923083061, 1931.1889006617255, 1932.4106147624827, 1977.3573588583768, 835.703325319515, 856.4390324337569, 866.8526350520426, 903.1420150856712, 928.661038720862, 18982.525436863914, 20040.799592003892, 20753.066112024993, 20754.896225519078, 20768.0, 872.9432586881959, 880.6125304865839, 895.8880139982502, 933.6032186320922, 964.7052979309918, 10249.38503689781, 10467.476626168662, 10770.192235582363, 10986.835197472044, 11052.336859788438, 512180.0, 552789.3605319718, 554259.0, 563130.0, 563508.0, 109076.0, 127039.36480317725, 129968.0, 136441.0, 139070.3046484761, 826.4380221449352, 953.3850666320324, 955.3312681123242, 987.7728122531857, 1012.1649639047815, 18802.623947521246, 19236.23055077781, 19408.708869367252, 19558.0, 19660.115294812054, 55272.0, 55439.891202176535, 55869.720651396485, 56177.0, 56448.435515645964, 60330.0, 78051.60974195093, 82404.76392854232, 84303.0, 85088.5745571293, 6970.686319115754, 7718.729844455417, 7872.212778722311, 7922.405819563441, 8081.060545469162, 8969.50667713282, 9991.050850169513, 12556.49774009066, 12605.49578016869, 12666.240025598494, 9215.907840921773, 10674.946625266824, 10849.02358787713, 10936.507857146607, 11135.777284454427, 10443.321184123311, 10519.158467322748, 10829.945850270698, 10856.45717714127, 10948.0, 10631.468426578795, 11060.668179954615, 11097.889021110008, 11109.166812489257, 11197.328160310408, 7828.686852525835, 7896.68413263463, 7989.520628762293, 8012.158723333966, 8020.799480012813, 9110.817783644157, 10414.583416663248, 10787.946060269649, 11088.833667495155, 11091.500882460146], "value": 9362.135875206508, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.7871708602254, 1492.2240434973814, 1541.4219667624645, 1739.6607661506002, 1867.7011678131503, 7916.485428447147, 8428.283595894349, 8516.020657624375, 9007.864882026766, 9009.234215091717, 8682.262007729334, 8740.038595754479, 8755.737327880173, 8764.474131552111, 8776.561171941394, 2030.7766145723958, 2039.2556716798335, 2361.9409514762096, 2381.714194296678, 2412.0592968742203, 2061.4331058958833, 2368.751281115484, 2388.5103553771437, 2395.197608801054, 2412.9879350603223, 1935.419374187738, 2374.03851440167, 2392.796612287949, 2408.434018005767, 2411.385096800322, 2364.9527009459716, 2380.690510233676, 2381.166591692911, 2390.3546042568582, 2394.018452434511, 2366.988165059181, 2382.9285121446383, 2386.2364043506086, 2386.4153282445914, 2387.1048356866177, 8731.912680873236, 8755.912440875574, 8782.341324400631, 8782.956085219597, 8814.162654547808, 5204.531592156686, 5277.70972596507, 5346.144616861284, 5361.088614935431, 5368.489993450616, 3491.214476742738, 3578.481120237577, 3650.2152037312107, 3708.960071960411, 3712.2761061593, 1027.9023492768174, 1060.8567843341127, 1064.0689396777818, 1083.1334932054403, 1085.0234788690163, 11545.191836571443, 11559.884401156049, 11630.360330181837, 11649.76700465986, 11673.299602023906, 4551.704139230939, 4628.074385122989, 4807.351007613997, 4826.758662066883, 4832.710037397767, 9788.902110978941, 9853.50732463374, 9883.555240014217, 9895.3177959747, 9896.476398518333, 5330.987112448623, 5334.146536554133, 5336.653117547347, 5348.946510534923, 5382.757775900094, 4397.25246708054, 4703.741294228782, 4821.108095002436, 4886.315915771795, 4887.315775791392, 3894.357431023849, 3899.2591407633026, 3990.920181596352, 4004.4794176756836, 4011.0, 1294.9611511654477, 1312.3503865586595, 1318.973620527584, 1320.7820709583004, 1332.4603535567917, 749.6589051981335, 769.157772239397, 900.3922352412096, 903.4534106865383, 936.7704912296394, 4768.976155119202, 5596.188552659842, 5926.377730338339, 5944.821655350346, 6031.185789918392, 903.7650210945202, 954.8329042417549, 959.1511512311655, 973.9366941148803, 987.5753426026733, 3226.5160225965824, 3326.4511355626532, 3337.8497967591516, 3345.514900339437, 3715.368387374153, 10387.065164135112, 10697.946510267398, 10704.250702450754, 10705.1435885129, 10716.839247411295, 10550.630727924487, 10638.946805265925, 10677.89322106769, 10682.62610808618, 10695.144388448905, 7735.342495887912, 8065.233802788725, 8065.516069035877, 8143.75568732939, 8221.095679475373, 4972.627052970969, 5198.844034678966, 5846.912296315473, 5904.0, 6076.8784624308155, 7770.300672939463, 9197.172254497127, 9884.505774711091, 10212.285140040125, 10235.0, 9948.303618746908, 9991.950040249752, 10024.498775061364, 10066.8489972649, 10104.84842727345, 6806.693698783468, 7212.8918066228, 7371.262873712586, 7378.077740282465, 7481.251874812475, 6939.201991771011, 7741.651625676745, 8184.386171037077, 8209.507429554245, 8250.669973201246, 7314.158871729819, 7419.925800741924, 7473.476856619985, 7557.093148821957, 7577.8105547359555, 7346.11846578414, 7585.469017168745, 7607.695692172251, 7638.0, 7648.464607477423, 5641.323041235078, 5906.173135760911, 6831.009503621847, 6946.166460024628, 6957.930420695729, 5142.794288228429, 5142.845714628567, 5182.97408512955, 5229.712365819916, 5323.0950738373795, 4258.6593072553505, 4920.077314080984, 4957.429895562056, 5213.6350455467755, 5250.26496290512], "value": 4534.448733065629, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.7985410212851, 303.85111295465214, 311.4642814359302, 314.22700157612275, 315.7647552573333, 5411.83764487065, 5500.3949565547855, 5587.972060139698, 5714.514266287365, 5718.970585294651, 5552.611847038241, 5606.299212598426, 5631.746571404286, 5656.830295091144, 5690.089585666295, 4273.201053310071, 4305.225059489307, 4319.33050377192, 4334.829596009075, 4340.914771307173, 3262.771605987582, 4214.494260688706, 4214.704970652056, 4297.699161058727, 4385.4737431508265, 3147.9842600786965, 4144.626983571478, 4185.560516145806, 4204.0540878302445, 4229.6404805591565, 4211.789410529476, 4212.705110642256, 4236.6187043166265, 4264.594863487995, 4288.541895755458, 3508.245727168671, 3641.65404286595, 3642.562892452896, 3649.7445178837493, 3659.4876717259604, 5083.297095473021, 5363.490468405535, 5411.18832175173, 5423.915216956624, 5481.314835645544, 4451.59613808543, 4465.040016396458, 4613.976930115362, 4763.3569468121705, 4830.1064303103685, 5213.464286071105, 5554.527865131468, 5893.0, 5920.200772895647, 5958.5828991970575, 3760.9623903761158, 3973.602639736032, 3976.920461590781, 3982.26328129297, 4005.459262999487, 5741.368449470555, 6281.497480201573, 6339.746410143589, 6348.222497700651, 6348.396902294275, 3506.5441492605796, 3824.8571017097893, 3938.9015274618364, 4056.51321841375, 4065.3495440729343, 3432.467967465047, 4008.659263962596, 4051.6961227908023, 4053.8378464861667, 4061.13689848656, 4206.789660516962, 4714.245720684674, 4785.712857228577, 4825.9758701206265, 4833.3958255218095, 5503.944960550423, 5672.0, 6013.218281623361, 6032.668203248863, 6033.3061697905305, 1203.1818363512896, 1262.8003396773101, 1332.3937608388353, 1368.6236285021698, 1375.1474086066503, 736.6464097233358, 786.8859015442729, 827.5613924619961, 844.2233145506149, 855.4952577979022, 3981.5620281768984, 4158.9376159357635, 4683.524689722726, 4750.406199225097, 4796.400449943757, 4174.749515029047, 5120.924605832743, 5168.53483186515, 5222.276648705918, 5228.457605006456, 3815.8473661053804, 3862.9227415451533, 4469.7318160910445, 4720.787564559603, 4725.40932383452, 2400.3639035655565, 2427.831679658028, 2429.62340837167, 2707.458508298348, 2741.383188782508, 4664.416947881515, 4669.486356500782, 5050.04049230645, 5271.0, 5331.573474122061, 4222.831086756495, 4364.4980827204645, 4715.7877895494785, 4914.827981020647, 5173.4826517347965, 4353.49934757507, 4418.851098714357, 4705.717656940595, 4739.004808990082, 5316.670832291927, 4360.803763830571, 5176.663516871542, 5181.404138524118, 5199.974000129975, 5264.420913699567, 4439.735734775223, 4444.8444304449185, 5112.060565175114, 5133.8716532087, 5143.254228136824, 3908.5895980922733, 4586.931196032129, 5280.81517146898, 5289.576833853205, 5373.462653734595, 3198.2324242182176, 3499.5678003788144, 3514.5606799150105, 3534.851173368717, 3536.9469457957634, 4798.592119669727, 5193.68837869729, 5239.607029472881, 5252.290940723106, 5464.535514481314, 5811.94188058114, 5956.702164891652, 5967.671778052075, 5993.250843644544, 6003.669798161143, 5045.470225626256, 5119.312361010499, 5998.4601385875485, 6037.335893051849, 6060.363661815446, 5550.389457159628, 5778.479936805707, 5814.592978491465, 5821.476067153976, 5851.882962340645, 5896.852578685567, 5962.154410405177, 5981.7906373278465, 6024.849378765566, 6026.203491800138, 4642.350070990132, 5580.9162862557905, 5762.1068734346245, 5801.332846722512, 5841.678707671119], "value": 4024.0537474350035, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.7432212920158, 710.2684235237707, 716.3016059342141, 741.1995045351022, 817.7669364231195, 12212.511499540018, 15938.52184434466, 15957.12235827029, 15980.680386392265, 15999.760003599955, 11747.882521174806, 14357.49748758791, 14491.42034318626, 14503.202323872183, 14521.983461157697, 829.2702421868762, 848.7156802471179, 850.4684572142411, 851.2083762101244, 856.6402111113347, 672.3008071605525, 828.6354004238146, 848.8217474330398, 852.0074113657581, 854.3421565394642, 879.1779685993585, 885.2873436883339, 894.7584152278881, 916.8533034714447, 919.3610440743686, 906.9047749986288, 907.845666236738, 908.7546362482126, 909.6134142989204, 910.2035718746097, 663.5056882622429, 668.4719071933216, 672.9125213722234, 674.0092064664934, 676.5602358466987, 15207.619809504851, 15329.846701533064, 15332.0, 15352.616184595363, 15375.384984600603, 11821.822672659917, 14219.146851188858, 14393.92803035978, 14641.560753177422, 14915.179665118414, 12011.219270747373, 12052.216605920587, 12069.155159138863, 12084.830733396964, 12184.20802647834, 3801.7909015004166, 3807.619238076198, 3813.580506144322, 3858.498395208605, 3991.2815693175216, 123138.38430807878, 126176.36911815473, 130319.34840325832, 130338.3483082588, 131299.0, 10795.78408431827, 11048.502817373237, 11056.226064175431, 11246.212765106364, 11508.0, 23010.65484017741, 23076.0, 23092.191773288192, 23098.53802923966, 23157.768422315898, 7859.174786647434, 7875.763727088197, 7942.285194332538, 7955.880661790078, 8013.519188848688, 3405.761596688208, 3812.5321751126016, 3869.7678139311734, 3970.8014599269923, 3997.760134391946, 3569.0006798096574, 3643.9635603644156, 3673.3204357194004, 3681.5582130144016, 3683.981580092136, 648.7956293767448, 652.2108249018646, 668.6255696809802, 684.6816230452863, 700.8913618389158, 522.5506064784282, 575.8281896340926, 599.6252342286072, 652.7225928980259, 694.2536772969079, 9479.289053321028, 10087.546060427152, 10148.492575371201, 10252.538635761408, 10500.474976251156, 617.3147805935408, 641.2369280556123, 687.9140107486564, 692.6155983429245, 700.6251655364457, 4405.3612226227015, 4624.329472226508, 4727.432708075053, 4734.526547345238, 4754.857354279377, 156254.0, 162008.0, 164416.53375199382, 164700.17649911673, 166282.0, 89865.55067224622, 132361.33819331034, 136808.0, 142459.2877035629, 144865.0, 119594.40202799105, 120141.39929300298, 120418.0, 120634.39682801705, 122066.0, 8278.0, 8837.293016558788, 8859.71534127535, 9037.231835294073, 9312.348135630711, 47285.763571181924, 61291.693541533794, 61920.69039654773, 63664.68167659132, 66476.33523664702, 55461.0, 56277.43722562722, 86549.56725216334, 91308.71728206582, 98193.01806981838, 10752.892471075189, 12990.740185196055, 13116.409761560562, 13311.334433278103, 13880.305984700926, 11647.359395233005, 14599.708005840037, 14729.189894555902, 14834.406623735362, 15286.235688215322, 13778.104423212459, 14006.719865602427, 14026.438942442188, 14041.1575305482, 14678.77981830252, 13864.168149911038, 13922.791158132433, 14060.156390616186, 14133.010689251654, 14472.565823025327, 13628.523001694894, 13649.863501365257, 13720.588382348546, 14209.928950355183, 14312.284385780462, 11021.228514003942, 11193.384363860067, 11279.379634120201, 11854.510552783668, 12020.879791201976, 11006.229563930448, 11415.315081095161, 11533.769324613628, 11799.823002654795, 11824.172307938361], "value": 7884.25836294371, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1582.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 114.0, 118.0, 114.0, 117.0, 116.0, 118.0, 117.0, 117.0, 136.0], "value": 117.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 146.0, 126.0, 191.0, 145.0, 170.0, 156.0, 113.0, 158.0, 112.0], "value": 146.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 238.0, 214.0, 279.0, 212.0, 197.0, 202.0, 202.0, 193.0, 196.0], "value": 214.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 83.0, 76.0, 146.0, 59.0, 60.0, 59.0, 61.0, 149.0, 83.0], "value": 85.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 104.0, 158.0, 94.0, 71.0, 80.0, 113.0, 69.0, 72.0, 114.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 102.0, 90.0, 87.0, 89.0, 107.0, 91.0, 88.0, 91.0, 87.0], "value": 93.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 152.0, 97.0, 120.0, 95.0, 96.0, 98.0, 156.0, 127.0, 97.0], "value": 116.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 93.0, 93.0, 94.0, 91.0, 91.0, 87.0, 93.0, 98.0], "value": 92.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 58.0, 57.0, 59.0, 58.0, 57.0, 58.0, 61.0, 79.0], "value": 59.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 69.0, 77.0, 75.0, 77.0, 76.0, 76.0, 72.0, 74.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 86.0, 90.0, 88.0, 87.0, 86.0, 87.0, 87.0, 89.0, 87.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 147.0, 152.0, 132.0, 154.0, 132.0, 131.0, 143.0, 197.0, 166.0], "value": 149.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [237.0, 181.0, 176.0, 173.0, 175.0, 175.0, 174.0, 179.0, 170.0, 174.0], "value": 181.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 70.0, 71.0, 69.0, 69.0, 67.0, 69.0, 70.0], "value": 69.5, "unit": "score"}]}]} 17:29:42 INFO - Return code: 0 17:29:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:29:42 ERROR - # TBPL SUCCESS # 17:29:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:29:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:29:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:29:42 INFO - 2016-09-02 17:29:42.105 screenresolution[1969:14192] starting screenresolution argv=screenresolution get 17:29:42 INFO - 2016-09-02 17:29:42.108 screenresolution[1969:14192] Display 0: 1600x1200x32@60 17:29:42 INFO - 2016-09-02 17:29:42.115 screenresolution[1970:14195] starting screenresolution argv=screenresolution list 17:29:42 INFO - Available Modes on Display 0 17:29:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:29:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:29:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:29:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:29:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:29:42 INFO - Intel Iris: 17:29:42 INFO - Chipset Model: Intel Iris 17:29:42 INFO - Type: GPU 17:29:42 INFO - Bus: Built-In 17:29:42 INFO - VRAM (Dynamic, Max): 1536 MB 17:29:42 INFO - Vendor: Intel (0x8086) 17:29:42 INFO - Device ID: 0x0a2e 17:29:42 INFO - Revision ID: 0x0009 17:29:42 INFO - Displays: 17:29:42 INFO - Display: 17:29:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:29:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:29:42 INFO - Display Serial Number: 1600x1200 60 17:29:42 INFO - Main Display: Yes 17:29:42 INFO - Mirror: Off 17:29:42 INFO - Online: Yes 17:29:42 INFO - Rotation: Supported 17:29:42 INFO - Return code: 0 17:29:42 INFO - Running post-action listener: _resource_record_post_action 17:29:42 INFO - [mozharness: 2016-09-03 00:29:42.353456Z] Finished run-tests step (success) 17:29:42 INFO - Running post-run listener: _resource_record_post_run 17:29:42 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 1200128; Write bytes: 709261824; Read time: 15; Write time: 2001 17:29:42 INFO - TinderboxPrint: CPU usage
54.7% 17:29:42 INFO - TinderboxPrint: I/O read bytes / time
1,200,128 / 15 17:29:42 INFO - TinderboxPrint: I/O write bytes / time
709,261,824 / 2,001 17:29:42 INFO - TinderboxPrint: CPU idle
2,195.4 (45.3%) 17:29:42 INFO - TinderboxPrint: CPU system
980.5 (20.3%) 17:29:42 INFO - TinderboxPrint: CPU user
1,665.9 (34.4%) 17:29:42 INFO - TinderboxPrint: Swap in / out
406,904,832 / 0 17:29:42 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 395840000; Write bytes: 394203136; Read time: 29524; Write time: 748 17:29:42 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 1200128; Write bytes: 296364544; Read time: 15; Write time: 1215 17:29:42 INFO - Running post-run listener: _upload_blobber_files 17:29:42 INFO - Blob upload gear active. 17:29:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:29:42 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 17:29:42 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'] 17:29:42 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 17:29:43 INFO - (blobuploader) - INFO - Open directory for files ... 17:29:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:29:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:29:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:44 INFO - (blobuploader) - INFO - Done attempting. 17:29:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:29:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:29:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:44 INFO - (blobuploader) - INFO - Done attempting. 17:29:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:29:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:29:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:47 INFO - (blobuploader) - INFO - Done attempting. 17:29:47 INFO - (blobuploader) - INFO - Iteration through files over. 17:29:47 INFO - Return code: 0 17:29:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:29:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:29:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9fe1533ab904db6f1a599d1c59b1be0f5e8763f3db97b235577b2884d192d0a4eb4fe3aeed625030f6612297aa84fa45c2c09a05f9553148832f0bee7aca863", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af523206eacc59e7fa4b0c56e2c8de9584640e45ba4a3c67b97b73087e8a964b8714ec696d0dbe999d2f6a766326442d3183381e6cb37dcd332a49076c4eb68a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7de13b79d43cef48eb4c1a6dbb777cf6b6c2388dbc65de6668eb4aca20e8c86a9dd932211b35acc12f33a18b901b14c19803de5547dbabebbf8ad166141ec4e"} 17:29:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:29:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:29:47 INFO - Contents: 17:29:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9fe1533ab904db6f1a599d1c59b1be0f5e8763f3db97b235577b2884d192d0a4eb4fe3aeed625030f6612297aa84fa45c2c09a05f9553148832f0bee7aca863", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af523206eacc59e7fa4b0c56e2c8de9584640e45ba4a3c67b97b73087e8a964b8714ec696d0dbe999d2f6a766326442d3183381e6cb37dcd332a49076c4eb68a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7de13b79d43cef48eb4c1a6dbb777cf6b6c2388dbc65de6668eb4aca20e8c86a9dd932211b35acc12f33a18b901b14c19803de5547dbabebbf8ad166141ec4e"} 17:29:47 INFO - Running post-run listener: copy_logs_to_upload_dir 17:29:47 INFO - Copying logs to upload dir... 17:29:47 INFO - mkdir: /builds/slave/test/build/upload/logs 17:29:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.465294 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-09-02 17:29:47.215543) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 17:29:47.218885) ========= 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.owo2nUY4IM/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.OFD6qaEVjV/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9fe1533ab904db6f1a599d1c59b1be0f5e8763f3db97b235577b2884d192d0a4eb4fe3aeed625030f6612297aa84fa45c2c09a05f9553148832f0bee7aca863", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af523206eacc59e7fa4b0c56e2c8de9584640e45ba4a3c67b97b73087e8a964b8714ec696d0dbe999d2f6a766326442d3183381e6cb37dcd332a49076c4eb68a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7de13b79d43cef48eb4c1a6dbb777cf6b6c2388dbc65de6668eb4aca20e8c86a9dd932211b35acc12f33a18b901b14c19803de5547dbabebbf8ad166141ec4e"} build_url:https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011192 build_url: 'https://queue.taskcluster.net/v1/task/JY_8oXNbRmS2aBBFL2GMMA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9fe1533ab904db6f1a599d1c59b1be0f5e8763f3db97b235577b2884d192d0a4eb4fe3aeed625030f6612297aa84fa45c2c09a05f9553148832f0bee7aca863", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af523206eacc59e7fa4b0c56e2c8de9584640e45ba4a3c67b97b73087e8a964b8714ec696d0dbe999d2f6a766326442d3183381e6cb37dcd332a49076c4eb68a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7de13b79d43cef48eb4c1a6dbb777cf6b6c2388dbc65de6668eb4aca20e8c86a9dd932211b35acc12f33a18b901b14c19803de5547dbabebbf8ad166141ec4e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 17:29:47.252622) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 17:29:47.253048) ========= 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.owo2nUY4IM/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.OFD6qaEVjV/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.004672 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 17:29:47.301541) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 17:29:47.302266) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 17:29:47.302690) ========= ========= Total master_lag: 0.18 =========