builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0317 starttime: 1467356703.63 results: success (0) buildid: 20160630122358 builduid: 80403e70eb5745538d3c33d7ed4b17bf revision: 0b4f2a4e42295c2ef0e293b18ca3cade2b6949b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 00:05:03.626515) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 00:05:03.627182) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 00:05:03.628127) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 00:05:03.679828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 00:05:03.680246) ========= 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.br8Phv3BID/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.X9Ob3TeMCn/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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-07-01 00:05:03-- 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% 163M=0s 2016-07-01 00:05:04 (163 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.508394 ========= master_lag: 0.63 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 00:05:04.814418) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 00:05:04.814743) ========= 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.br8Phv3BID/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.X9Ob3TeMCn/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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.021122 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 00:05:04.865151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 00:05:04.865458) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0b4f2a4e42295c2ef0e293b18ca3cade2b6949b1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0b4f2a4e42295c2ef0e293b18ca3cade2b6949b1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.br8Phv3BID/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.X9Ob3TeMCn/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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-07-01 00:05:04,946 truncating revision to first 12 chars 2016-07-01 00:05:04,946 Setting DEBUG logging. 2016-07-01 00:05:04,946 attempt 1/10 2016-07-01 00:05:04,946 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0b4f2a4e4229?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 00:05:06,168 unpacking tar archive at: mozilla-beta-0b4f2a4e4229/testing/mozharness/ program finished with exit code 0 elapsedTime=1.471868 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 00:05:06.360252) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 00:05:06.360551) ========= script_repo_revision: 0b4f2a4e42295c2ef0e293b18ca3cade2b6949b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 00:05:06.360942) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 00:05:06.361264) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 00:05:06.378800) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-07-01 00:05:06.379151) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.br8Phv3BID/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.X9Ob3TeMCn/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 00:05:06 INFO - MultiFileLogger online at 20160701 00:05:06 in /builds/slave/test 00:05:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 00:05:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:05:06 INFO - {'append_to_log': False, 00:05:06 INFO - 'base_work_dir': '/builds/slave/test', 00:05:06 INFO - 'blob_upload_branch': 'Mozilla-Beta', 00:05:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:05:06 INFO - 'branch': 'Mozilla-Beta', 00:05:06 INFO - 'buildbot_json_path': 'buildprops.json', 00:05:06 INFO - 'config_files': ('talos/mac_config.py',), 00:05:06 INFO - 'default_actions': ('clobber', 00:05:06 INFO - 'read-buildbot-config', 00:05:06 INFO - 'download-and-extract', 00:05:06 INFO - 'populate-webroot', 00:05:06 INFO - 'create-virtualenv', 00:05:06 INFO - 'install', 00:05:06 INFO - 'run-tests'), 00:05:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:05:06 INFO - 'download_minidump_stackwalk': True, 00:05:06 INFO - 'download_symbols': 'ondemand', 00:05:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:05:06 INFO - 'tooltool.py': '/tools/tooltool.py', 00:05:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:05:06 INFO - '/tools/misc-python/virtualenv.py')}, 00:05:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:05:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:05:06 INFO - 'installer_path': 'installer.exe', 00:05:06 INFO - 'log_level': 'info', 00:05:06 INFO - 'log_name': 'talos', 00:05:06 INFO - 'log_to_console': True, 00:05:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:05:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:05:06 INFO - 'opt_config_files': (), 00:05:06 INFO - 'pip_index': False, 00:05:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:05:06 INFO - 'cmd': ('bash', 00:05:06 INFO - '-c', 00:05:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:05:06 INFO - 'enabled': True, 00:05:06 INFO - 'halt_on_failure': False, 00:05:06 INFO - 'name': 'check_screen_resolution'},), 00:05:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:05:06 INFO - 'cmd': ('bash', 00:05:06 INFO - '-c', 00:05:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:05:06 INFO - 'enabled': True, 00:05:06 INFO - 'halt_on_failure': False, 00:05:06 INFO - 'name': 'check_screen_resolution'},), 00:05:06 INFO - 'run_cmd_checks_enabled': True, 00:05:06 INFO - 'sps_profile': False, 00:05:06 INFO - 'sps_profile_interval': 0, 00:05:06 INFO - 'suite': 'dromaeojs-e10s', 00:05:06 INFO - 'system_bits': '32', 00:05:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:05:06 INFO - 'title': 't-yosemite-r7-0317', 00:05:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:05:06 INFO - 'use_talos_json': True, 00:05:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:05:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:05:06 INFO - 'work_dir': 'build'} 00:05:06 INFO - ##### 00:05:06 INFO - ##### Running clobber step. 00:05:06 INFO - ##### 00:05:06 INFO - Running pre-action listener: _resource_record_pre_action 00:05:06 INFO - Running main action method: clobber 00:05:06 INFO - rmtree: /builds/slave/test/build 00:05:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:05:06 INFO - Running post-action listener: _resource_record_post_action 00:05:06 INFO - ##### 00:05:06 INFO - ##### Running read-buildbot-config step. 00:05:06 INFO - ##### 00:05:06 INFO - Running pre-action listener: _resource_record_pre_action 00:05:06 INFO - Running main action method: read_buildbot_config 00:05:06 INFO - Using buildbot properties: 00:05:06 INFO - { 00:05:06 INFO - "project": "", 00:05:06 INFO - "product": "firefox", 00:05:06 INFO - "script_repo_revision": "production", 00:05:06 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 00:05:06 INFO - "repository": "", 00:05:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 00:05:06 INFO - "buildid": "20160630122358", 00:05:06 INFO - "pgo_build": "False", 00:05:06 INFO - "basedir": "/builds/slave/test", 00:05:06 INFO - "buildnumber": 16, 00:05:06 INFO - "slavename": "t-yosemite-r7-0317", 00:05:06 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 00:05:06 INFO - "platform": "yosemite_r7", 00:05:06 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 00:05:06 INFO - "branch": "mozilla-beta", 00:05:06 INFO - "repo_path": "releases/mozilla-beta", 00:05:06 INFO - "revision": "0b4f2a4e42295c2ef0e293b18ca3cade2b6949b1", 00:05:06 INFO - "stage_platform": "macosx64", 00:05:06 INFO - "builduid": "80403e70eb5745538d3c33d7ed4b17bf", 00:05:06 INFO - "slavebuilddir": "test" 00:05:06 INFO - } 00:05:06 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.dmg. 00:05:06 INFO - Running post-action listener: _resource_record_post_action 00:05:06 INFO - ##### 00:05:06 INFO - ##### Running download-and-extract step. 00:05:06 INFO - ##### 00:05:06 INFO - Running pre-action listener: _resource_record_pre_action 00:05:06 INFO - Running main action method: download_and_extract 00:05:06 INFO - mkdir: /builds/slave/test/build/tests 00:05: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:06 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.test_packages.json 00:05:06 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 00:05:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 00:05:07 INFO - Downloaded 1165 bytes. 00:05:07 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 00:05:07 INFO - Using the following test package requirements: 00:05:07 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 00:05:07 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 00:05:07 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 00:05:07 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 00:05:07 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 00:05:07 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 00:05:07 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 00:05:07 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 00:05:07 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 00:05:07 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 00:05:07 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 00:05:07 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 00:05:07 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 00:05:07 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 00:05:07 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 00:05:07 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 00:05:07 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 00:05:07 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 00:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:07 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.common.tests.zip 00:05:07 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 00:05:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 00:05:10 INFO - Downloaded 18351361 bytes. 00:05:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:05:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 00:05:13 INFO - Return code: 0 00:05:13 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 00:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:13 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.common.tests.zip 00:05:13 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 00:05:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 00:05:13 INFO - Downloaded 18351361 bytes. 00:05:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:05:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 00:05:17 INFO - Return code: 0 00:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:17 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.talos.tests.zip 00:05:17 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 00:05:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 00:05:19 INFO - Downloaded 10840145 bytes. 00:05:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:05:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 00:05:19 INFO - Return code: 0 00:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:19 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.dmg 00:05:19 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 00:05:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 00:05:33 INFO - Downloaded 86196250 bytes. 00:05:33 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.dmg 00:05:33 INFO - mkdir: /builds/slave/test/properties 00:05:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:05:33 INFO - Writing to file /builds/slave/test/properties/build_url 00:05:33 INFO - Contents: 00:05:33 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.dmg 00:05:33 INFO - Running post-action listener: _resource_record_post_action 00:05:33 INFO - Running post-action listener: set_extra_try_arguments 00:05:33 INFO - ##### 00:05:33 INFO - ##### Running populate-webroot step. 00:05:33 INFO - ##### 00:05:33 INFO - Running pre-action listener: _resource_record_pre_action 00:05:33 INFO - Running main action method: populate_webroot 00:05:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:05:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:05:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:05:33 INFO - '--tppagecycles', 00:05:33 INFO - '7'], 00:05:33 INFO - 'tests': ['tsvgm']}}, 00:05:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:05:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:05:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:05:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:05:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:05:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:05:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:33 INFO - 'talos_options': ['--disable-e10s'], 00:05:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:05:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:05:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:33 INFO - 'talos_options': ['--disable-e10s'], 00:05:33 INFO - 'tests': ['damp', 'tps']}, 00:05:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:33 INFO - 'tests': ['damp', 'tps']}, 00:05:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:05:33 INFO - 'tests': ['dromaeo_dom']}, 00:05:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:05:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:05:33 INFO - 'tests': ['a11yr', 00:05:33 INFO - 'ts_paint', 00:05:33 INFO - 'tpaint', 00:05:33 INFO - 'sessionrestore', 00:05:33 INFO - 'sessionrestore_no_auto_restore', 00:05:33 INFO - 'tabpaint']}, 00:05:33 INFO - 'other-e10s': {'tests': ['a11yr', 00:05:33 INFO - 'ts_paint', 00:05:33 INFO - 'tpaint', 00:05:33 INFO - 'sessionrestore', 00:05:33 INFO - 'sessionrestore_no_auto_restore', 00:05:33 INFO - 'tabpaint']}, 00:05:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:05:33 INFO - 'ts_paint', 00:05:33 INFO - 'tpaint', 00:05:33 INFO - 'sessionrestore', 00:05:33 INFO - 'sessionrestore_no_auto_restore', 00:05:33 INFO - 'tabpaint']}, 00:05:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:05:33 INFO - 'ts_paint', 00:05:33 INFO - 'tpaint', 00:05:33 INFO - 'sessionrestore', 00:05:33 INFO - 'sessionrestore_no_auto_restore', 00:05:33 INFO - 'tabpaint']}, 00:05:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:05:33 INFO - 'tests': ['a11yr', 00:05:33 INFO - 'ts_paint', 00:05:33 INFO - 'tpaint', 00:05:33 INFO - 'sessionrestore', 00:05:33 INFO - 'sessionrestore_no_auto_restore', 00:05:33 INFO - 'tabpaint']}, 00:05:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:05:33 INFO - 'tests': ['a11yr', 00:05:33 INFO - 'ts_paint', 00:05:33 INFO - 'tpaint', 00:05:33 INFO - 'sessionrestore', 00:05:33 INFO - 'sessionrestore_no_auto_restore', 00:05:33 INFO - 'tabpaint']}, 00:05:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:05:33 INFO - 'tests': ['tsvgx', 00:05:33 INFO - 'tsvgr_opacity', 00:05:33 INFO - 'tart', 00:05:33 INFO - 'tscrollx', 00:05:33 INFO - 'cart']}, 00:05:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:05:33 INFO - 'tsvgr_opacity', 00:05:33 INFO - 'tart', 00:05:33 INFO - 'tscrollx', 00:05:33 INFO - 'cart']}, 00:05:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:33 INFO - 'talos_options': ['--disable-e10s'], 00:05:33 INFO - 'tests': ['tp5o']}, 00:05:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:33 INFO - 'tests': ['tp5o']}, 00:05:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:33 INFO - 'talos_options': ['--disable-e10s', 00:05:33 INFO - '--xperf_path', 00:05:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:05:33 INFO - 'tests': ['tp5n']}, 00:05:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:33 INFO - 'talos_options': ['--xperf_path', 00:05:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:05:33 INFO - 'tests': ['tp5n']}}, 00:05:33 INFO - 'talos.zip': {'path': '', 00:05:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:05:33 INFO - Running post-action listener: _resource_record_post_action 00:05:33 INFO - ##### 00:05:33 INFO - ##### Running create-virtualenv step. 00:05:33 INFO - ##### 00:05:33 INFO - Running pre-action listener: _resource_record_pre_action 00:05:33 INFO - Running main action method: create_virtualenv 00:05:33 INFO - Creating virtualenv /builds/slave/test/build/venv 00:05:33 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 00:05:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:05:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:05:33 INFO - Using real prefix '/tools/python27' 00:05:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:05:34 INFO - Installing distribute.............................................................................................................................................................................................done. 00:05:37 INFO - Installing pip.................done. 00:05:37 INFO - Return code: 0 00:05:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1042f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104307420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb441cd40c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104196e00>, '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 0x103fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104191b20>, '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.br8Phv3BID/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.X9Ob3TeMCn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 00:05:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:05:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:05:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br8Phv3BID/Render', 00:05:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:37 INFO - 'HOME': '/Users/cltbld', 00:05:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:37 INFO - 'LOGNAME': 'cltbld', 00:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:37 INFO - 'MOZ_NO_REMOTE': '1', 00:05:37 INFO - 'NO_EM_RESTART': '1', 00:05:37 INFO - 'PAGER': '/bin/cat', 00:05:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:37 INFO - 'PWD': '/builds/slave/test', 00:05:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:37 INFO - 'SHELL': '/bin/bash', 00:05:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X9Ob3TeMCn/Listeners', 00:05:37 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 00:05:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:37 INFO - 'USER': 'cltbld', 00:05:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:37 INFO - 'XPC_FLAGS': '0x0', 00:05:37 INFO - 'XPC_SERVICE_NAME': '0', 00:05:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:37 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 00:05:37 INFO - Cleaning up... 00:05:37 INFO - Return code: 0 00:05:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1042f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104307420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb441cd40c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104196e00>, '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 0x103fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104191b20>, '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.br8Phv3BID/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.X9Ob3TeMCn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 00:05:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 00:05:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:05:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br8Phv3BID/Render', 00:05:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:37 INFO - 'HOME': '/Users/cltbld', 00:05:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:37 INFO - 'LOGNAME': 'cltbld', 00:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:37 INFO - 'MOZ_NO_REMOTE': '1', 00:05:37 INFO - 'NO_EM_RESTART': '1', 00:05:37 INFO - 'PAGER': '/bin/cat', 00:05:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:37 INFO - 'PWD': '/builds/slave/test', 00:05:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:37 INFO - 'SHELL': '/bin/bash', 00:05:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X9Ob3TeMCn/Listeners', 00:05:37 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 00:05:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:37 INFO - 'USER': 'cltbld', 00:05:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:37 INFO - 'XPC_FLAGS': '0x0', 00:05:37 INFO - 'XPC_SERVICE_NAME': '0', 00:05:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:37 INFO - Downloading/unpacking psutil>=0.7.1 00:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:05:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:05:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:05:40 INFO - Installing collected packages: psutil 00:05:40 INFO - Running setup.py install for psutil 00:05:41 INFO - building 'psutil._psutil_osx' extension 00:05:41 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 00:05:41 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 00:05:41 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 00:05:41 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 00:05:41 INFO - building 'psutil._psutil_posix' extension 00:05:41 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 00:05:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:05:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:05:41 INFO - ^ 00:05:41 INFO - 1 warning generated. 00:05:41 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 00:05:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:05:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:05:41 INFO - Successfully installed psutil 00:05:41 INFO - Cleaning up... 00:05:41 INFO - Return code: 0 00:05:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1042f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104307420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb441cd40c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104196e00>, '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 0x103fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104191b20>, '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.br8Phv3BID/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.X9Ob3TeMCn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 00:05:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 00:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 00:05:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br8Phv3BID/Render', 00:05:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:41 INFO - 'HOME': '/Users/cltbld', 00:05:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:41 INFO - 'LOGNAME': 'cltbld', 00:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:41 INFO - 'MOZ_NO_REMOTE': '1', 00:05:41 INFO - 'NO_EM_RESTART': '1', 00:05:41 INFO - 'PAGER': '/bin/cat', 00:05:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:41 INFO - 'PWD': '/builds/slave/test', 00:05:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:41 INFO - 'SHELL': '/bin/bash', 00:05:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X9Ob3TeMCn/Listeners', 00:05:41 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 00:05:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:41 INFO - 'USER': 'cltbld', 00:05:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:41 INFO - 'XPC_FLAGS': '0x0', 00:05:41 INFO - 'XPC_SERVICE_NAME': '0', 00:05:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:05:42 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 00:05:42 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 00:05:42 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 00:05:42 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 00:05:42 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 00:05:42 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 00:05:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:05:44 INFO - Installing collected packages: mozsystemmonitor 00:05:44 INFO - Running setup.py install for mozsystemmonitor 00:05:44 INFO - Successfully installed mozsystemmonitor 00:05:44 INFO - Cleaning up... 00:05:44 INFO - Return code: 0 00:05:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:44 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 0x1042f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104307420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb441cd40c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104196e00>, '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 0x103fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104191b20>, '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.br8Phv3BID/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.X9Ob3TeMCn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 00:05:44 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 00:05:44 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 00:05:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br8Phv3BID/Render', 00:05:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:44 INFO - 'HOME': '/Users/cltbld', 00:05:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:44 INFO - 'LOGNAME': 'cltbld', 00:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:44 INFO - 'MOZ_NO_REMOTE': '1', 00:05:44 INFO - 'NO_EM_RESTART': '1', 00:05:44 INFO - 'PAGER': '/bin/cat', 00:05:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:44 INFO - 'PWD': '/builds/slave/test', 00:05:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:44 INFO - 'SHELL': '/bin/bash', 00:05:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X9Ob3TeMCn/Listeners', 00:05:44 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 00:05:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:44 INFO - 'USER': 'cltbld', 00:05:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:44 INFO - 'XPC_FLAGS': '0x0', 00:05:44 INFO - 'XPC_SERVICE_NAME': '0', 00:05:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:45 INFO - Downloading/unpacking blobuploader==1.2.4 00:05:45 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 00:05:45 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 00:05:45 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 00:05:45 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 00:05:45 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 00:05:45 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 00:05:47 INFO - Downloading blobuploader-1.2.4.tar.gz 00:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:05:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:05:47 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 00:05:47 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 00:05:47 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 00:05:47 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 00:05:47 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 00:05:47 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 00:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:05:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:48 INFO - Downloading docopt-0.6.1.tar.gz 00:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:05:48 INFO - Installing collected packages: blobuploader, requests, docopt 00:05:48 INFO - Running setup.py install for blobuploader 00:05:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:05:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:05:48 INFO - Running setup.py install for requests 00:05:49 INFO - Running setup.py install for docopt 00:05:49 INFO - Successfully installed blobuploader requests docopt 00:05:49 INFO - Cleaning up... 00:05:49 INFO - Return code: 0 00:05:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:49 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 0x1042f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104307420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb441cd40c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104196e00>, '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 0x103fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104191b20>, '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.br8Phv3BID/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.X9Ob3TeMCn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 00:05:49 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 00:05:49 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 00:05:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br8Phv3BID/Render', 00:05:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:49 INFO - 'HOME': '/Users/cltbld', 00:05:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:49 INFO - 'LOGNAME': 'cltbld', 00:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:49 INFO - 'MOZ_NO_REMOTE': '1', 00:05:49 INFO - 'NO_EM_RESTART': '1', 00:05:49 INFO - 'PAGER': '/bin/cat', 00:05:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:49 INFO - 'PWD': '/builds/slave/test', 00:05:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:49 INFO - 'SHELL': '/bin/bash', 00:05:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X9Ob3TeMCn/Listeners', 00:05:49 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 00:05:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:49 INFO - 'USER': 'cltbld', 00:05:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:49 INFO - 'XPC_FLAGS': '0x0', 00:05:49 INFO - 'XPC_SERVICE_NAME': '0', 00:05:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:05:49 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-aTXO1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:05:50 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-lHxN5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:05:50 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-ijD13Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:05:50 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-MlGvR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:05:50 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-yi4ZFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:05:50 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-l8Khfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:05:50 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-hl4PIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:05:50 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-TtORz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:05:50 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-hqabrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:05:50 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-aDhZMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:05:50 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-5tyjAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:05:51 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-bu33iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:05:51 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-2pfeEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:05:51 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-QLjpdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:51 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-Pcl_8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:05:51 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-wyfCTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:05:51 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-jZd_UM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:05:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:05:51 INFO - Running setup.py install for manifestparser 00:05:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:05:51 INFO - Running setup.py install for mozcrash 00:05:52 INFO - Running setup.py install for mozdebug 00:05:52 INFO - Running setup.py install for mozdevice 00:05:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:05:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:05:52 INFO - Running setup.py install for mozfile 00:05:52 INFO - Running setup.py install for mozhttpd 00:05:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:05:52 INFO - Running setup.py install for mozinfo 00:05:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:05:52 INFO - Running setup.py install for mozInstall 00:05:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:05:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:05:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:05:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:05:52 INFO - Running setup.py install for mozleak 00:05:53 INFO - Running setup.py install for mozlog 00:05:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:05:53 INFO - Running setup.py install for moznetwork 00:05:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:05:53 INFO - Running setup.py install for mozprocess 00:05:53 INFO - Running setup.py install for mozprofile 00:05:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:05:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:05:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:05:53 INFO - Running setup.py install for mozrunner 00:05:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:05:53 INFO - Running setup.py install for mozscreenshot 00:05:54 INFO - Running setup.py install for moztest 00:05:54 INFO - Running setup.py install for mozversion 00:05:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:05:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:05:54 INFO - Cleaning up... 00:05:54 INFO - Return code: 0 00:05:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:54 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 0x1042f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104307420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb441cd40c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104196e00>, '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 0x103fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104191b20>, '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.br8Phv3BID/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.X9Ob3TeMCn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 00:05:54 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 00:05:54 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 00:05:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br8Phv3BID/Render', 00:05:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:54 INFO - 'HOME': '/Users/cltbld', 00:05:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:54 INFO - 'LOGNAME': 'cltbld', 00:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:54 INFO - 'MOZ_NO_REMOTE': '1', 00:05:54 INFO - 'NO_EM_RESTART': '1', 00:05:54 INFO - 'PAGER': '/bin/cat', 00:05:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:54 INFO - 'PWD': '/builds/slave/test', 00:05:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:54 INFO - 'SHELL': '/bin/bash', 00:05:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X9Ob3TeMCn/Listeners', 00:05:54 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 00:05:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:54 INFO - 'USER': 'cltbld', 00:05:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:54 INFO - 'XPC_FLAGS': '0x0', 00:05:54 INFO - 'XPC_SERVICE_NAME': '0', 00:05:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:05:54 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-V1dso5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:05:54 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)) 00:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:05:54 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-TepcWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:05:54 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)) 00:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:05:54 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-4LO7y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:05:54 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)) 00:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:05:54 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-Bepz55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:05:55 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)) 00:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:05:55 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-VEna8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:05:55 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)) 00:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:05:55 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-CP7MMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:05:55 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)) 00:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:05:55 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-iYd_aO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:05:55 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)) 00:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:05:55 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-O3LSKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:05:55 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)) 00:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:05:55 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-CkXQjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:05:55 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)) 00:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:05:55 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-9rILUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:05:55 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-Dq0896-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:05:55 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)) 00:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:05:55 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-b2oT6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:05:55 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-yhbhSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:05:55 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)) 00:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:05:55 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-tO3294-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:56 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-EaX3WW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:56 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)) 00:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:05:56 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-cz6wEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:05:56 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)) 00:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:05:56 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-GfVWjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:05:56 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)) 00:05:56 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)) 00:05:56 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)) 00:05:56 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)) 00:05:56 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)) 00:05:56 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)) 00:05:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:05:56 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 00:05:56 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 00:05:56 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 00:05:56 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 00:05:56 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 00:05:56 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 00:05:58 INFO - Downloading blessings-1.6.tar.gz 00:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:05:58 INFO - Installing collected packages: blessings 00:05:58 INFO - Running setup.py install for blessings 00:05:59 INFO - Successfully installed blessings 00:05:59 INFO - Cleaning up... 00:05:59 INFO - Return code: 0 00:05:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:05:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:05:59 INFO - Reading from file tmpfile_stdout 00:05:59 INFO - Current package versions: 00:05:59 INFO - blessings == 1.6 00:05:59 INFO - blobuploader == 1.2.4 00:05:59 INFO - docopt == 0.6.1 00:05:59 INFO - manifestparser == 1.1 00:05:59 INFO - mozInstall == 1.12 00:05:59 INFO - mozcrash == 0.17 00:05:59 INFO - mozdebug == 0.1 00:05:59 INFO - mozdevice == 0.48 00:05:59 INFO - mozfile == 1.2 00:05:59 INFO - mozhttpd == 0.7 00:05:59 INFO - mozinfo == 0.9 00:05:59 INFO - mozleak == 0.1 00:05:59 INFO - mozlog == 3.1 00:05:59 INFO - moznetwork == 0.27 00:05:59 INFO - mozprocess == 0.22 00:05:59 INFO - mozprofile == 0.28 00:05:59 INFO - mozrunner == 6.11 00:05:59 INFO - mozscreenshot == 0.1 00:05:59 INFO - mozsystemmonitor == 0.0 00:05:59 INFO - moztest == 0.7 00:05:59 INFO - mozversion == 1.4 00:05:59 INFO - psutil == 3.1.1 00:05:59 INFO - requests == 1.2.3 00:05:59 INFO - wsgiref == 0.1.2 00:05:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:59 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 0x1042f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104307420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb441cd40c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104196e00>, '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 0x103fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104191b20>, '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.br8Phv3BID/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.X9Ob3TeMCn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 00:05:59 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 00:05:59 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 00:05:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br8Phv3BID/Render', 00:05:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:59 INFO - 'HOME': '/Users/cltbld', 00:05:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:59 INFO - 'LOGNAME': 'cltbld', 00:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:59 INFO - 'MOZ_NO_REMOTE': '1', 00:05:59 INFO - 'NO_EM_RESTART': '1', 00:05:59 INFO - 'PAGER': '/bin/cat', 00:05:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:59 INFO - 'PWD': '/builds/slave/test', 00:05:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:59 INFO - 'SHELL': '/bin/bash', 00:05:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X9Ob3TeMCn/Listeners', 00:05:59 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 00:05:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:59 INFO - 'USER': 'cltbld', 00:05:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:59 INFO - 'XPC_FLAGS': '0x0', 00:05:59 INFO - 'XPC_SERVICE_NAME': '0', 00:05:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:59 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)) 00:05:59 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)) 00:05:59 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)) 00:05:59 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)) 00:05:59 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)) 00:05:59 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)) 00:05:59 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)) 00:05:59 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)) 00:05:59 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)) 00:05:59 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)) 00:05:59 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)) 00:05:59 INFO - Cleaning up... 00:05:59 INFO - Return code: 0 00:05:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1042f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104307420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb441cd40c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104196e00>, '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 0x103fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104191b20>, '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.br8Phv3BID/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.X9Ob3TeMCn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 00:05:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:05:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br8Phv3BID/Render', 00:05:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:59 INFO - 'HOME': '/Users/cltbld', 00:05:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:59 INFO - 'LOGNAME': 'cltbld', 00:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:59 INFO - 'MOZ_NO_REMOTE': '1', 00:05:59 INFO - 'NO_EM_RESTART': '1', 00:05:59 INFO - 'PAGER': '/bin/cat', 00:05:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:59 INFO - 'PWD': '/builds/slave/test', 00:05:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:59 INFO - 'SHELL': '/bin/bash', 00:05:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X9Ob3TeMCn/Listeners', 00:05:59 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 00:05:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:59 INFO - 'USER': 'cltbld', 00:05:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:59 INFO - 'XPC_FLAGS': '0x0', 00:05:59 INFO - 'XPC_SERVICE_NAME': '0', 00:05:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:06:00 INFO - Downloading/unpacking jsonschema 00:06:00 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 00:06:00 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 00:06:00 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 00:06:00 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 00:06:00 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 00:06:00 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 00:06:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:06:02 INFO - Downloading/unpacking functools32 (from jsonschema) 00:06:02 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 00:06:02 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 00:06:02 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 00:06:02 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 00:06:02 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 00:06:02 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 00:06:02 INFO - Downloading functools32-3.2.3-2.tar.gz 00:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:06:02 INFO - warning: no files found matching '*.txt' 00:06:02 INFO - no previously-included directories found matching 'build' 00:06:02 INFO - no previously-included directories found matching 'dist' 00:06:02 INFO - no previously-included directories found matching '.git*' 00:06:02 INFO - Installing collected packages: jsonschema, functools32 00:06:03 INFO - Running setup.py install for functools32 00:06:03 INFO - warning: no files found matching '*.txt' 00:06:03 INFO - no previously-included directories found matching 'build' 00:06:03 INFO - no previously-included directories found matching 'dist' 00:06:03 INFO - no previously-included directories found matching '.git*' 00:06:03 INFO - Successfully installed jsonschema functools32 00:06:03 INFO - Cleaning up... 00:06:03 INFO - Return code: 0 00:06:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1042f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104307420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb441cd40c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104196e00>, '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 0x103fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104191b20>, '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.br8Phv3BID/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.X9Ob3TeMCn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 00:06:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 00:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 00:06:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br8Phv3BID/Render', 00:06:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:06:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:06:03 INFO - 'HOME': '/Users/cltbld', 00:06:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:06:03 INFO - 'LOGNAME': 'cltbld', 00:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:06:03 INFO - 'MOZ_NO_REMOTE': '1', 00:06:03 INFO - 'NO_EM_RESTART': '1', 00:06:03 INFO - 'PAGER': '/bin/cat', 00:06:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:06:03 INFO - 'PWD': '/builds/slave/test', 00:06:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:06:03 INFO - 'SHELL': '/bin/bash', 00:06:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X9Ob3TeMCn/Listeners', 00:06:03 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 00:06:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:06:03 INFO - 'USER': 'cltbld', 00:06:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:06:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:06:03 INFO - 'XPC_FLAGS': '0x0', 00:06:03 INFO - 'XPC_SERVICE_NAME': '0', 00:06:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:06:03 INFO - Downloading/unpacking flake8 00:06:03 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 00:06:03 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 00:06:03 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 00:06:03 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 00:06:03 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 00:06:03 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 00:06:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:06:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:06: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 00:06: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 00:06: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 00:06: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 00:06: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 00:06: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 00:06:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:06:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:06:06 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 00:06:06 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 00:06:06 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 00:06:06 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 00:06:06 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 00:06:06 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 00:06:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:06:06 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 00:06:06 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 00:06:06 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 00:06:06 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 00:06:06 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 00:06:06 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 00:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:06:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:06:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:06:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:06:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:06:07 INFO - no previously-included directories found matching 'docs/_build' 00:06:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:06:07 INFO - Running setup.py install for pep8 00:06:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:06:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:06:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:06:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:06:07 INFO - no previously-included directories found matching 'docs/_build' 00:06:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:06:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:06:07 INFO - Cleaning up... 00:06:07 INFO - Return code: 0 00:06:07 INFO - Running post-action listener: _resource_record_post_action 00:06:07 INFO - Running post-action listener: _start_resource_monitoring 00:06:07 INFO - Starting resource monitoring. 00:06:07 INFO - ##### 00:06:07 INFO - ##### Running install step. 00:06:07 INFO - ##### 00:06:07 INFO - Running pre-action listener: _resource_record_pre_action 00:06:07 INFO - Running main action method: install 00:06:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:06:07 INFO - Reading from file tmpfile_stdout 00:06:07 INFO - Detecting whether we're running mozinstall >=1.0... 00:06:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:06:07 INFO - Reading from file tmpfile_stdout 00:06:07 INFO - Output received: 00:06:07 INFO - Usage: mozinstall [options] installer 00:06:07 INFO - Options: 00:06:07 INFO - -h, --help show this help message and exit 00:06:07 INFO - -d DEST, --destination=DEST 00:06:07 INFO - Directory to install application into. [default: 00:06:07 INFO - "/builds/slave/test"] 00:06:07 INFO - --app=APP Application being installed. [default: firefox] 00:06:07 INFO - mkdir: /builds/slave/test/build/application 00:06:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 00:06:29 INFO - Reading from file tmpfile_stdout 00:06:29 INFO - Output received: 00:06:29 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 00:06:29 INFO - Running post-action listener: _resource_record_post_action 00:06:29 INFO - ##### 00:06:29 INFO - ##### Running run-tests step. 00:06:29 INFO - ##### 00:06:29 INFO - Running pre-action listener: _resource_record_pre_action 00:06:29 INFO - Running main action method: run_tests 00:06:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:06:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:06:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:06:30 INFO - 2016-07-01 00:06:30.004 screenresolution[1919:10738] starting screenresolution argv=screenresolution get 00:06:30 INFO - 2016-07-01 00:06:30.007 screenresolution[1919:10738] Display 0: 1600x1200x32@60 00:06:30 INFO - 2016-07-01 00:06:30.012 screenresolution[1920:10740] starting screenresolution argv=screenresolution list 00:06:30 INFO - Available Modes on Display 0 00:06:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:06:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:06:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:06:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:06:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:06:30 INFO - Intel Iris: 00:06:30 INFO - Chipset Model: Intel Iris 00:06:30 INFO - Type: GPU 00:06:30 INFO - Bus: Built-In 00:06:30 INFO - VRAM (Dynamic, Max): 1536 MB 00:06:30 INFO - Vendor: Intel (0x8086) 00:06:30 INFO - Device ID: 0x0a2e 00:06:30 INFO - Revision ID: 0x0009 00:06:30 INFO - Displays: 00:06:30 INFO - Display: 00:06:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:06:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:06:30 INFO - Display Serial Number: 1600x1200 60 00:06:30 INFO - Main Display: Yes 00:06:30 INFO - Mirror: Off 00:06:30 INFO - Online: Yes 00:06:30 INFO - Rotation: Supported 00:06:30 INFO - Return code: 0 00:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:06:30 INFO - Python 2.7.3 00:06:30 INFO - Return code: 0 00:06:30 INFO - grabbing minidump binary from tooltool 00:06: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104196e00>, '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 0x103fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104191b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:06:30 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 00:06:30 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 00:06:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:06:30 INFO - Return code: 0 00:06:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:06:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:06:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:06:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:06:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:06:31 INFO - Return code: 0 00:06:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0317', '--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 00:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0317 --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 00:06:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.br8Phv3BID/Render', 00:06:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:06:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:06:31 INFO - 'HOME': '/Users/cltbld', 00:06:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:06:31 INFO - 'LOGNAME': 'cltbld', 00:06:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:06:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:06:31 INFO - 'MOZ_NO_REMOTE': '1', 00:06:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:06:31 INFO - 'NO_EM_RESTART': '1', 00:06:31 INFO - 'PAGER': '/bin/cat', 00:06:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:06:31 INFO - 'PWD': '/builds/slave/test', 00:06:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:06:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:06:31 INFO - 'SHELL': '/bin/bash', 00:06:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X9Ob3TeMCn/Listeners', 00:06:31 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 00:06:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:06:31 INFO - 'USER': 'cltbld', 00:06:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:06:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:06:31 INFO - 'XPC_FLAGS': '0x0', 00:06:31 INFO - 'XPC_SERVICE_NAME': '0', 00:06:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:06:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0317', '--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 00:06:31 INFO - mozversion application_buildid: 20160630122358 00:06:31 INFO - mozversion application_changeset: 0b4f2a4e42295c2ef0e293b18ca3cade2b6949b1 00:06:31 INFO - mozversion application_display_name: Firefox 00:06:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:06:31 INFO - mozversion application_name: Firefox 00:06:31 INFO - mozversion application_remotingname: firefox 00:06:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 00:06:31 INFO - mozversion application_vendor: Mozilla 00:06:31 INFO - mozversion application_version: 48.0 00:06:31 INFO - mozversion platform_buildid: 20160630122358 00:06:31 INFO - mozversion platform_changeset: 0b4f2a4e42295c2ef0e293b18ca3cade2b6949b1 00:06:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 00:06:31 INFO - mozversion platform_version: 48.0 00:06:31 INFO - using testdate: 1467356791 00:06:31 INFO - actual date: 1467356791 00:06:31 INFO - starting webserver on 'localhost:49444' 00:06:31 INFO - SUITE-START | Running 2 tests 00:06:31 INFO - TEST-START | dromaeo_css 00:06:31 INFO - operating with platform_type : mac_ 00:06:31 INFO - Initialising browser for dromaeo_css test... 00:06:31 INFO - TEST-INFO | started process 1938 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpGMFVhJ/profile http://localhost:49444/getInfo.html) 00:06:34 INFO - PROCESS | 1938 | __metrics Screen width/height:1600/1200 00:06:34 INFO - PROCESS | 1938 | colorDepth:24 00:06:34 INFO - PROCESS | 1938 | Browser inner width/height: 1024/689 00:06:34 INFO - PROCESS | 1938 | __metrics 00:06:34 ERROR - PROCESS | 1938 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 00:06:35 INFO - TEST-INFO | 1938: exit 0 00:06:35 INFO - Browser initialized. 00:06:35 INFO - Running cycle 1/1 for dromaeo_css test... 00:06:35 INFO - TEST-INFO | started process 1942 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpGMFVhJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:06:46 INFO - PROCESS | 1942 | RSS: Main: 171212800 00:06:46 INFO - PROCESS | 1942 | 00:07:36 INFO - PROCESS | 1942 | 1467356856506 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] 00:09:46 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49444/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49444/tests/dromaeo/cssquery-ext.html) 00:09:47 INFO - PROCESS | 1942 | RSS: Main: 184426496 00:09:47 INFO - PROCESS | 1942 | 00:12:49 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49444/tests/dromaeo/cssquery-ext.html (next: http://localhost:49444/tests/dromaeo/cssquery-jquery.html) 00:12:50 INFO - PROCESS | 1942 | RSS: Main: 195772416 00:12:50 INFO - PROCESS | 1942 | 00:15:52 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49444/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49444/tests/dromaeo/cssquery-mootools.html) 00:15:52 INFO - PROCESS | 1942 | RSS: Main: 197246976 00:15:52 INFO - PROCESS | 1942 | 00:18:54 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49444/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49444/tests/dromaeo/cssquery-prototype.html) 00:18:54 INFO - PROCESS | 1942 | RSS: Main: 201400320 00:18:54 INFO - PROCESS | 1942 | 00:21:57 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49444/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49444/tests/dromaeo/cssquery-yui.html) 00:21:58 INFO - PROCESS | 1942 | RSS: Main: 200904704 00:21:58 INFO - PROCESS | 1942 | 00:25:00 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49444/tests/dromaeo/cssquery-yui.html (next: http://localhost:49444/tests/dromaeo/cssquery-dojo.html) 00:25:00 INFO - PROCESS | 1942 | RSS: Main: 205312000 00:25:00 INFO - PROCESS | 1942 | 00:25:00 INFO - PROCESS | 1942 | __start_tp_report 00:25:00 INFO - PROCESS | 1942 | _x_x_mozilla_page_load 00:25:00 INFO - PROCESS | 1942 | _x_x_mozilla_page_load_details 00:25:00 INFO - PROCESS | 1942 | |i|pagename|runs| 00:25:00 INFO - PROCESS | 1942 | |0;dojo.html;2985.9850700746492;3615.1323682316242;3689.1883785567184;3693.833777480013;3726.06848287928;4878.8780280493;5952.375000624937;5988.101784732292;6012.518998480122;6021.2473440819895;5902.704864756755;5965.671888046156;5968.313643930949;6008.609440386372;6024.0662697282;5283;5315.468453154673;5354.607801971496;5360.91958620621;5433.1035379162395;5135.485031915575;5291.629585928968;5364.704941228231;5391.29913111295;5395.568354531648;4318.9784051079705;5367.75845086972;5377.300950876381;5383.67697938123;5393.083175860093;5239.5546378557865;5347.304850369466;5347.893042139155;5361.758720857571;5369.382521010075;5242.2136679498;5332.706701131437;5363.115086010804;5397.892042159174;5413.431589683105;5731.083026715705;5773.364929857712;5788.27646544182;5823.883522329572;5828.621139625953;6164.815055548341;6190.907136392958;6238.1266622672865;6238.407351301619;6250.468710159642;6229.127922090911;6246.281677607088;6258.499320054385;6273.529485288622;6277.2153480814895;5993.280806303272;6018.15745795589;6023.337432882379;6031.065184896304;6043.697815109227;5358.33020872391;6263.404976527223;6318;6387.201599800025;6431.163948686641;6211.192544969125;6257.561970662101;6278.0269058296035;6282.654454004982;6284.340144284875;6197.442230199304;6294.181756371642;6314.71583778731;6319.210098737658;6323.936760632335;6173.783917562864;6233.657148856766;6256.311805701369;6275.435210831047;6279.7488100476385;6217;6219.191505104308;6248.125262463259;6252.843678908063;6278.968605156945;4885.8045678172475;4996.4503904570465;5002.624803139779;5035.949640503622;5051.494850514919;3998.7200895937003;4535.546445355438;4543.5910768031035;4560.521145279764;4602.07958408313;6106.389361063858;6133.233345831771;6155.169052177898;6158.507319414436;6185.319614842364;6196.10156527301;6242.344553821874;6255.843603909939;6290;6301.558890877686;5872.119182122716;6112.786052488142;6169.722362493699;6177.289611694712;6201.224846894138;5495.313085864267;5559.416261292587;5570.832875013756;5582.553395728332;5597.44025597437;6357.332480089524;6465.870682586322;6539.247986481425;6578.144841170617;6586.6377349245295;6227.0970709246;6244.968775156277;6272.529560283088;6320.905186422116;6358.109864618865;6483.513736469689;6518.73925043012;6557.9344206557325;6559.639219842955;6563.409293163638;6207.720652570735;6213.130161777445;6220.844478888064;6258.561900666909;6278.937210627835;6226.62640241587;6228.875422491616;6237.844053898689;6256.843578910563;6322.778702745381;6054.152418661479;6123.938760612515;6226.066090086523;6227.906581401373;6229.003359462465;6139.43080903429;6143.539234557516;6161.84595385119;6180.47465965398;6236;4881.804727810848;5826.504747096545;6001.936108422015;6005.219321488178;6019.307779605227;6042.697865106815;6072.635641861502;6112.755489780359;6124.203853499017;6136.6011209271255;6116.755329786936;6161.229846269216;6204.3795620437595;6229.345918678655;6235.251769787655 00:25:00 INFO - PROCESS | 1942 | |1;ext.html;529.2061907139289;538.219558678331;550.1555112901697;562.1988666150735;605.5851741557033;40100;40984.79507602462;40999.38500922488;41197.58802411975;41198.794006029966;42455;42763.57236427635;42923.35614965778;43004.784976075156;43044.92387690309;9805.509724513764;9957.800843983116;10017.949910250438;10042.995700429972;10066.848997265048;9796.657117000907;10010.249231307645;10016.599336026551;10019.699409017741;10037.096661300482;9948.204143668489;9977.600895964153;10017.899821001805;10048.44733539655;10169.796604067915;9985.600575976952;10014.89985100147;10038.096571308617;10056.597736090547;10057.597696092183;9916;9952.353097048668;9976.002399760038;10006.499675016294;10048.246381521341;41151;41545.58454415447;41742.79128604338;41751.95620109491;41979;3293.8682452701864;3432.6052503962114;3449.87925422609;3467.791932484059;4007.3788562772816;28761;29025;29468.9371743978;29599;29798;2804.78964077695;2832.0229520815287;2843.900463483789;2844.5875348074414;2885.9134225973253;496207;496709;499156.9999999964;499410;500466;63173.368266317666;64725.02912456317;65250;65329.67335163294;65514;70325;72445.6377718108;73144.63427682828;75097;75160;18633.627327453374;18834.71747923782;18851.43445696631;19105.426837194907;19119.426417207505;14252.144871307755;14584.270786460635;14661.19363435;14695.412183512753;14754.852451475563;17053.806233563533;20800.583988320148;20953.68569471459;21051.78948210498;21116.155353785984;6047.395260473917;7044.6125463100025;7052.506324557232;7085.2206257311655;7118.074650295428;999.1058003087342;1006.8288390973552;1066.5253961986841;1145.8911403416662;1163.203205804027;30529.542056869166;30936.53595196029;31178.908738194055;31292.687073129433;31776.887808926578;1179.0626451970704;1184.9052075833913;1242.6582689760207;1243.1919252485957;1296.5786119511197;15694.686106278039;15959.281832317574;16011.839881601269;16117.516474505783;16287.59281017984;649344;656740;662427;665317;665403;63669.68165159145;64081.67959160174;64348.034779478345;64657.67671161614;64850.378740531865;1528.15187570897;1538.5384384684774;1550.3566020101532;1560.375849660145;1638.0990455249564;24248.048092993653;30597.847010764803;30812.53781193329;31046;31080;55633.443665564446;55990;56022;56024.15963760628;56630.43369566252;565573;573752;577502;577744;577789.1110544589;27531.587026194222;28105.71894281031;28426.005089821756;28738.425231495672;28849.855750721952;47662.76168619135;49211.75394123006;49223.75388123036;49248;49336.75331623319;34354;37893.62106378901;38826.6117338823;39581;40978;34944.82527587346;36739.816300918326;39358;39439;40295.79852100721;38768.80615596904;39631.40552891651;40827.38758918678;40892;41008;30460.84769576138;32821.83589082135;33054.834725826215;33661.99014029485;33789.66210337865;25725.871370643028;26034.869825650752;26077.478450431263;26159;26735.19794406171 00:25:00 INFO - PROCESS | 1942 | |2;jquery.html;411.2556273145607;413.0541060970378;414.8653432861126;419.18886953744504;423.86436340371074;17083.91458042708;20838.37484875454;21566.89216553917;21619.3514194574;22673;12560.623181304552;12676.112672112933;12716.046296527751;19734.90132549339;21877.343679689635;5571.554275657948;5760.308762948452;5767.336756273019;5803.622764520293;5828.892510423006;6137.263528376601;6305.905411418832;6335.5565110442285;6356.237251529823;6374.776882809103;5813.331466881321;6275.090111933767;6281.466075383598;6296.496280297588;6317.178766760338;5924.289085309791;5962.403759624046;5985.311689155759;6009.669468179249;6058.273007239115;5677.006523858308;5966.164736936832;5966.761329546813;6105.694715264263;6120.571559990803;13826.308684565833;13926.303684815719;13990.440382384693;14040.92979535106;14139.293035348293;2184.1154332495366;2192.572448372568;2291.3584196425027;2353.0470159585225;2539.276306252709;10115.140213081897;10259.640912568024;10490.31812932157;10593.417362045084;15047.796176305868;1792.9910350448165;1799.9370022049297;1805.232776070178;1857.0993068361834;1864.6084322292336;114695;116311.41844290809;119748.40125799316;123773;124160.37919810433;10101;11924.46339914706;12149.574764883188;12160.878391215974;12314;15591.376344946302;15828.129452880203;15833.68332633364;15847.920760396355;15890.728741700636;8073.39449541275;9585.84969803628;9612.615495380247;9631.662891798893;9667.758306042264;9630;9717.757056073655;9797.657082002239;9833.704988850346;9864.506774661239;4862.270659401118;4903.583195428358;4947.975260123676;4986.301917731521;4992.776769691449;1992.6612475879135;2055.9177632894816;2062.453449835795;2066.349100033485;2066.865653732533;908.8273228086642;980.1129977370491;988.7231575158967;1008.6368907193405;1043.3114144664485;20514.87168205763;21031.843248621473;21032.474188145417;21092.78907210908;21252.78747212508;970.9757256068655;999.9700008999596;1010.5604062232952;1038.408107378802;1048.8898665640152;11171;11252.407330196234;11305.039071678999;11307.462865536467;11323.716907077389;619864;634723;672315.6384218048;684248;684273;136937;139221;141610;142674;148725;947.7156852944227;983.0513554420019;992.5235886774389;1061.766411389493;1063.441693111123;15634.609134771721;16946;18113.36603218881;18157;18684.065796710383;48198.59007049703;49201.753991229816;49579.75210123926;53136.4686353147;54735.45264547304;75636.48727025319;80051.79922301053;80548;82524.58737706274;88884;8043.959780201061;8183.6726530938095;8451.45065570736;8454.36592255571;8768.123187681182;8315.667373305;9619.422834629944;11190.66428007161;13333.266670333225;13379.130356526795;11294;11402.315861048364;11427.142964277878;11514.021308188898;11698.005669518187;9883.901160988298;11405.201635885409;11430.1998860079;11454.599089031844;11703.356315402734;9489.240860731263;9607.327487075838;11825.231359961575;11852.822207667065;11974.820377694516;8630.309575234092;8654.264387527131;8816.206541411048;8821.514816685143;8874.112588741074;10656.467176641292;11875.406229688653;11889.702757431134;11925.224860384047;11982.940085299517 00:25:00 INFO - PROCESS | 1942 | |3;mootools.html;1601.5275493729348;1604.4304271983447;1618.2556024228859;1783.5451959750262;2021.4946263434142;7329.963350183255;8915.465072095663;9127.08729127087;9226.63093476261;9299.39553928994;9000.95499522503;9046.95476522618;9061.456312621247;9123.40697854639;9140.451572905631;2513.5726926422462;2524.7853932415765;2527.4439623282847;2541.390066384073;2544.1731437282865;2451.889664965072;2498.4378514834198;2509.0841842727364;2514.107491840398;2515.5975043992967;2097.213544920655;2386.1052105460453;2514.673092497973;2533.7972962163076;2535.4168541235526;2515.4843257132334;2525.6337831014494;2541.07250853439;2556.3736884463424;2562.948741025169;2505.2985164153883;2511.899524019037;2535.0873685473216;2552.7830134438595;2562.5643640581147;9327.860082098774;9351.812963740687;9353.39202951806;9359.25125989926;9386.95306523463;5727.255456790591;5734.627249228787;5747.396523365028;5805.564582656318;5825.504832089235;3681.631836816324;3731.179140589093;3761.322961866863;3804.410316400962;3808.352580061396;1038.5793753529833;1074.9247552671316;1076.8815430302739;1079.6167360586958;1082.5182793656747;12266.202696824677;12299.262044277371;12491.812622810665;12592.244465332018;12638.115331926769;4973.477784832613;5006.499350064964;5029.220470827027;5063.8987220255385;5074.974625126851;10506.949305069586;10552.366857988545;10588.205884558689;10628.840567391495;10633.46832658364;5628.71856407178;5633.943660563342;5701.8311246194435;5774.0761478163295;5802.47777700009;4610.861674149781;5099.413567439792;5171.689698618095;5182.196759502283;5235.816746413857;4001.7398869073418;4125.782894046263;4178.185253875465;4300.333448315516;4304.4834619845815;1321.8678132186897;1415.9292035398396;1417.2913543228385;1427.3362886257732;1432.8710416062604;978.9608415663436;991.7322322972757;992.4541502173776;1001.67946257197;1020.5151504560846;6050.878982420327;6060.787872424444;6087.147799308101;6092.7562897484495;6170.167027451326;942.8444306689456;998.9150922171697;1023.8003589300015;1061.395004847245;1066.317556763672;4011.618896204856;4113.794310284474;4185.932587190247;4186.455760751083;4216.51510076339;10675.985781350759;10806;10937.56249750001;10987.560497580167;11004.669859904216;10851.728706782395;10869.45652717361;10878.456077196108;10908.836367454494;11102.44487775608;8502.617382217815;8518.659253629909;8553.44402613828;8729.301655867643;8771.824563508693;5782.10377391505;5996.640201587918;6078.878422431615;6086.78696245647;6138.294096178996;9934.503274836085;10064.69805905824;10095.596176152872;10175.949120254352;10184.338018028804;9892.901070989197;10294.691159265234;10397.428141452292;10536.051755341749;10536.473176341306;6665.466762659073;7225.963870180615;7303.342699157101;7338.816529586589;7341.3392794648735;8559.22966932979;8642.35182361338;8643.265322447662;8654.524001179996;8660.48037117775;7531.209223031503;7752.728654497291;7757.806054848674;7763.767086987174;7834.373250139861;7505.587192704454;7561.924380756122;7578.621068946641;7603.429742769204;7679.462437629312;7249.275072492708;7260.636968151465;7272.600006999666;7280.526765760421;7333.083364579427;5050.898982020412;5065.822696205762;5160.561352285098;5211.400688920823;5254.080535906125;5158.819441319536;5186.662866913639;5256.421793602777;5354.330708661418;5408.7566059526625 00:25:00 INFO - PROCESS | 1942 | |4;prototype.html;277.9763720083793;318.87085730279233;339.92691571312173;340.3890017418733;342.4230172159911;6880.759173428931;6915.5850648961095;6984.476164287674;6993.090898183235;7004.8248793780185;6933.618650974195;6997.160340759104;7019.192792828826;7057.329553692391;7061.187963384213;5061.089003979282;5085.949140508603;5102.872428189288;5102.923456148161;5111.718855462957;5082.136036873721;5084.542391184793;5087.287779710843;5112.795488180468;5123.333966584339;5050.823221187259;5052.26742122392;5057.988402319533;5059.241113832936;5060.822871199509;4756.595689366425;4939.209726443788;4965.404151501807;5054.115529782292;5063.063333283354;3755.511783468159;3932.6235817463944;4177.97911010443;4187.078842654611;4196.979015104936;5001.424836143854;6559.8032059038305;6609.008648702733;6665.700043498055;6689;5798.217240672498;5952.434518720715;5955.434233747787;5975.223220981288;5979.22270104888;7373.225811289791;7374.63126843661;7392.482526223166;7403.407727381797;7412.666430010662;4605.286180642006;4630.374899388573;4730.243161094243;4766.261229509431;4766.475687674353;7852.725154619561;7861.646225919847;7931.44479886414;7945;7954.284114429671;4793.448753393334;4807.158747219222;4813.855584332476;4821.108095002436;4839.080574690797;4907.2393778964315;4908.901821963541;4914.164592019365;4914.65597408178;4925.408950925912;5883.352831188566;5904.3210030847;5907.675077870673;5909.822705318761;5920.674362910081;7151.821204469826;7465.888011679829;7475;7481.8877716834295;7500.324970752658;1673.5565075255067;1675.6062325353532;1686.9831301687072;1690.121137008773;1699.3287651377636;881.2817553693719;1010.6412223660642;1059.1685526861531;1062.4156713807374;1082.3289560472558;7007.649617519103;7090.4327653788605;7111.146662400545;7111.751088711871;7113.075300211043;7719.65261563231;7719.922800772033;7751.534907905544;7755.92244077552;7761.6119194040075;7062.929370706227;7084.326988936043;7085.610291433917;7100.112485939258;7102.431805455654;3960.821763020671;4055.7566546007333;4086.3257562501853;4088.652464540488;4103.302438585448;8063.758087257392;8080.959595201986;8085.393595480363;8089.110197878229;8146.307563857138;7928.088269849041;7933.404994625426;7941.444098913136;7943.511915767573;7950.801229969182;8039.437239393186;8056.355491560661;8092.190780921978;8109.229623185788;8118.025836899728;7370.299821516947;7676.193999629959;7682.270184332703;7712.228777122243;7715.112762032438;7521.623918803928;7552;7554.886676699964;7560.470767046254;7562.924370756222;8074.434789564674;8074.475159114639;8099.595020248846;8113.107558168715;8123.7156699515235;4821.421429428491;4832.685875418087;4834.59796658979;4838.225883858566;4845.6123510118405;7458.552486850806;7687.5387476751575;7812.84374312522;7820.921790782247;7821.765347039371;6288.622682639057;7350.375218106307;7463.365613922877;7527;7548.811279717831;7503.849923001619;7523.548587084792;7528.171901090986;7547.660355283915;7573;7130.215676275502;7342.926570734438;7355.926440735524;7362.6686799093095;7383.8154046149275;6061.787837425669;7455.142658594331;7485.0643669541305;7489.400847932044;7528.4353673473615;7092.113485814273;7192.640367981685;7268.67290971897;7335.926640733524;7384.37232835215 00:25:00 INFO - PROCESS | 1942 | |5;yui.html;612.6844674992379;762.5505177290513;767.2787579675102;794.6940427935243;807.975760727178;12162.391880405978;15231;15232.543023709306;15454.536363909087;15488.225588720561;14377.496787612436;14405.783913241283;14432.350544225508;14454.277286135677;14467.565973020826;915.8900931888182;975.2539307429839;983.5180761426885;999.5102399824107;1001.1990407673868;970.4904924914406;970.5147426286857;975.0882924465612;979.211734553684;979.3927764785843;1012.1649639047778;1021.7854250607344;1026.7895081508311;1028.6554004408495;1032.6695457453618;980.2060331131735;993.4039576254225;1010.706895000449;1025.364274150028;1029.5727273181697;752.1801236652076;763.5800309829627;765.3723946363983;765.4144579396766;765.5368502056232;15486.457973970857;15730.292136853868;16036.599085022852;16045.957012794132;16177.59556011109;10994.615188468446;12879.969602431784;13064.150830196008;13104.934475327658;13196.736065278737;7929.960350198212;10405.323653962469;10497.055265026109;10686.145108391387;10793.730156746144;3550.946735798965;3555.839987200582;3589.4436362363876;3608.2422691234874;3677.1542545214484;74069.51860962804;85832.57083714541;86550.56724716398;86811.56594217052;86907.13092869053;9572.234221262283;9776.560054797408;9859.950700246596;10003.749906252257;10327.173826093895;21234.681479777817;21622.027008784644;21902.45243868884;21927.67108493374;21952;7776.261255180749;7793.415493837985;7807.180246074194;7937.603119843985;8127.268545830785;4267.551907049778;4307.246231909403;4340.587644173862;4343.913121737548;4385.539518350591;3708.592054873962;3772.75477093988;3773.660370566662;3775.452559378875;3776.5656949450618;688.5008368932483;690.4372936057198;692.7540723043347;693.0816667915033;694.5971336624746;536.4796147736689;593.7239183779564;609.4667166229549;627.8367624417684;646.3181343682367;8385.790355241168;8543.786405339917;8730.956345218361;8751.693690720795;8769.693060742971;519.2419068160452;571.8341680912572;578.6614830324307;613.5613036678707;629.3077614623877;3981.5222173338807;4039.818208180639;4044.8179831907637;4177.540470548237;4217.894552636209;73103;82220;91448;94479.58280625797;96378;76023.85964210541;82905;84983.57508212543;86587;89395;73737.99999999892;75395;75888;79075.60462197653;80333.59833200797;8702.738917832476;8846.424982376126;8931.866022009544;8987.19115279628;8999.595018224065;40115.59884401118;49980.750096249285;51566;51568.74215628898;53159.73420132875;55945.720271398386;63830.04254936087;68045;69571.95642065271;73743;9791.804163916539;11969.461374238354;12212.57255996036;12283.75432491363;12297.93851030775;12199.878001219875;12327.815082773586;12584.937075314565;12659.556915507914;13014.089013768946;11632.18574699763;11827.881721182677;11924.344161070878;12051.638450846489;12224.327661978321;11850.051995840484;11949.76100478003;11964.010051607005;12017.63947081589;12033.338166400932;11679.708007299885;11752.353620550952;11776.411179440822;11988.520459181884;12057.57798477049;7409.481336306407;7778.611069446391;9704.805903881741;9943.950280248553;10293.897061029593;9829.754256143367;10113.897492257027;10153.39079655223;10199.67351489106;10206.693799186036 00:25:00 INFO - PROCESS | 1942 | __end_tp_report 00:25:00 INFO - PROCESS | 1942 | __start_cc_report 00:25:00 INFO - PROCESS | 1942 | _x_x_mozilla_cycle_collect,381 00:25:00 INFO - PROCESS | 1942 | __end_cc_report 00:25:00 INFO - PROCESS | 1942 | __startTimestamp1467357900476__endTimestamp 00:25:00 INFO - PROCESS | 1942 | 00:25:00 INFO - PROCESS | 1942 | ------- Summary: start ------- 00:25:00 INFO - PROCESS | 1942 | Number of tests: 6 00:25:00 INFO - PROCESS | 1942 | 00:25:00 INFO - PROCESS | 1942 | [#0] dojo.html Cycles:165 Average:5848.17 Median:6136.60 stddev:648.55 (10.6%) stddev-sans-first:610.43 00:25:00 INFO - PROCESS | 1942 | Values: 2986.0 3615.1 3689.2 3693.8 3726.1 4878.9 5952.4 5988.1 6012.5 6021.2 5902.7 5965.7 5968.3 6008.6 6024.1 5283.0 5315.5 5354.6 5360.9 5433.1 5135.5 5291.6 5364.7 5391.3 5395.6 4319.0 5367.8 5377.3 5383.7 5393.1 5239.6 5347.3 5347.9 5361.8 5369.4 5242.2 5332.7 5363.1 5397.9 5413.4 5731.1 5773.4 5788.3 5823.9 5828.6 6164.8 6190.9 6238.1 6238.4 6250.5 6229.1 6246.3 6258.5 6273.5 6277.2 5993.3 6018.2 6023.3 6031.1 6043.7 5358.3 6263.4 6318.0 6387.2 6431.2 6211.2 6257.6 6278.0 6282.7 6284.3 6197.4 6294.2 6314.7 6319.2 6323.9 6173.8 6233.7 6256.3 6275.4 6279.7 6217.0 6219.2 6248.1 6252.8 6279.0 4885.8 4996.5 5002.6 5035.9 5051.5 3998.7 4535.5 4543.6 4560.5 4602.1 6106.4 6133.2 6155.2 6158.5 6185.3 6196.1 6242.3 6255.8 6290.0 6301.6 5872.1 6112.8 6169.7 6177.3 6201.2 5495.3 5559.4 5570.8 5582.6 5597.4 6357.3 6465.9 6539.2 6578.1 6586.6 6227.1 6245.0 6272.5 6320.9 6358.1 6483.5 6518.7 6557.9 6559.6 6563.4 6207.7 6213.1 6220.8 6258.6 6278.9 6226.6 6228.9 6237.8 6256.8 6322.8 6054.2 6123.9 6226.1 6227.9 6229.0 6139.4 6143.5 6161.8 6180.5 6236.0 4881.8 5826.5 6001.9 6005.2 6019.3 6042.7 6072.6 6112.8 6124.2 6136.6 6116.8 6161.2 6204.4 6229.3 6235.3 00:25:00 INFO - PROCESS | 1942 | 00:25:00 INFO - PROCESS | 1942 | [#1] ext.html Cycles:180 Average:72132.58 Median:35842.32 stddev:155232.41 (433.1%) stddev-sans-first:155574.79 00:25:00 INFO - PROCESS | 1942 | Values: 529.2 538.2 550.2 562.2 605.6 40100.0 40984.8 40999.4 41197.6 41198.8 42455.0 42763.6 42923.4 43004.8 43044.9 9805.5 9957.8 10017.9 10043.0 10066.8 9796.7 10010.2 10016.6 10019.7 10037.1 9948.2 9977.6 10017.9 10048.4 10169.8 9985.6 10014.9 10038.1 10056.6 10057.6 9916.0 9952.4 9976.0 10006.5 10048.2 41151.0 41545.6 41742.8 41752.0 41979.0 3293.9 3432.6 3449.9 3467.8 4007.4 28761.0 29025.0 29468.9 29599.0 29798.0 2804.8 2832.0 2843.9 2844.6 2885.9 496207.0 496709.0 499157.0 499410.0 500466.0 63173.4 64725.0 65250.0 65329.7 65514.0 70325.0 72445.6 73144.6 75097.0 75160.0 18633.6 18834.7 18851.4 19105.4 19119.4 14252.1 14584.3 14661.2 14695.4 14754.9 17053.8 20800.6 20953.7 21051.8 21116.2 6047.4 7044.6 7052.5 7085.2 7118.1 999.1 1006.8 1066.5 1145.9 1163.2 30529.5 30936.5 31178.9 31292.7 31776.9 1179.1 1184.9 1242.7 1243.2 1296.6 15694.7 15959.3 16011.8 16117.5 16287.6 649344.0 656740.0 662427.0 665317.0 665403.0 63669.7 64081.7 64348.0 64657.7 64850.4 1528.2 1538.5 1550.4 1560.4 1638.1 24248.0 30597.8 30812.5 31046.0 31080.0 55633.4 55990.0 56022.0 56024.2 56630.4 565573.0 573752.0 577502.0 577744.0 577789.1 27531.6 28105.7 28426.0 28738.4 28849.9 47662.8 49211.8 49223.8 49248.0 49336.8 34354.0 37893.6 38826.6 39581.0 40978.0 34944.8 36739.8 39358.0 39439.0 40295.8 38768.8 39631.4 40827.4 40892.0 41008.0 30460.8 32821.8 33054.8 33662.0 33789.7 25725.9 26034.9 26077.5 26159.0 26735.2 00:25:00 INFO - PROCESS | 1942 | 00:25:00 INFO - PROCESS | 1942 | [#2] jquery.html Cycles:180 Average:36938.91 Median:12030.73 stddev:110006.38 (914.4%) stddev-sans-first:110280.78 00:25:00 INFO - PROCESS | 1942 | Values: 411.3 413.1 414.9 419.2 423.9 17083.9 20838.4 21566.9 21619.4 22673.0 12560.6 12676.1 12716.0 19734.9 21877.3 5571.6 5760.3 5767.3 5803.6 5828.9 6137.3 6305.9 6335.6 6356.2 6374.8 5813.3 6275.1 6281.5 6296.5 6317.2 5924.3 5962.4 5985.3 6009.7 6058.3 5677.0 5966.2 5966.8 6105.7 6120.6 13826.3 13926.3 13990.4 14040.9 14139.3 2184.1 2192.6 2291.4 2353.0 2539.3 10115.1 10259.6 10490.3 10593.4 15047.8 1793.0 1799.9 1805.2 1857.1 1864.6 114695.0 116311.4 119748.4 123773.0 124160.4 10101.0 11924.5 12149.6 12160.9 12314.0 15591.4 15828.1 15833.7 15847.9 15890.7 8073.4 9585.8 9612.6 9631.7 9667.8 9630.0 9717.8 9797.7 9833.7 9864.5 4862.3 4903.6 4948.0 4986.3 4992.8 1992.7 2055.9 2062.5 2066.3 2066.9 908.8 980.1 988.7 1008.6 1043.3 20514.9 21031.8 21032.5 21092.8 21252.8 971.0 1000.0 1010.6 1038.4 1048.9 11171.0 11252.4 11305.0 11307.5 11323.7 619864.0 634723.0 672315.6 684248.0 684273.0 136937.0 139221.0 141610.0 142674.0 148725.0 947.7 983.1 992.5 1061.8 1063.4 15634.6 16946.0 18113.4 18157.0 18684.1 48198.6 49201.8 49579.8 53136.5 54735.5 75636.5 80051.8 80548.0 82524.6 88884.0 8044.0 8183.7 8451.5 8454.4 8768.1 8315.7 9619.4 11190.7 13333.3 13379.1 11294.0 11402.3 11427.1 11514.0 11698.0 9883.9 11405.2 11430.2 11454.6 11703.4 9489.2 9607.3 11825.2 11852.8 11974.8 8630.3 8654.3 8816.2 8821.5 8874.1 10656.5 11875.4 11889.7 11925.2 11982.9 00:25:00 INFO - PROCESS | 1942 | 00:25:00 INFO - PROCESS | 1942 | [#3] mootools.html Cycles:180 Average:5955.59 Median:5017.86 stddev:3290.19 (65.6%) stddev-sans-first:3283.15 00:25:00 INFO - PROCESS | 1942 | Values: 1601.5 1604.4 1618.3 1783.5 2021.5 7330.0 8915.5 9127.1 9226.6 9299.4 9001.0 9047.0 9061.5 9123.4 9140.5 2513.6 2524.8 2527.4 2541.4 2544.2 2451.9 2498.4 2509.1 2514.1 2515.6 2097.2 2386.1 2514.7 2533.8 2535.4 2515.5 2525.6 2541.1 2556.4 2562.9 2505.3 2511.9 2535.1 2552.8 2562.6 9327.9 9351.8 9353.4 9359.3 9387.0 5727.3 5734.6 5747.4 5805.6 5825.5 3681.6 3731.2 3761.3 3804.4 3808.4 1038.6 1074.9 1076.9 1079.6 1082.5 12266.2 12299.3 12491.8 12592.2 12638.1 4973.5 5006.5 5029.2 5063.9 5075.0 10506.9 10552.4 10588.2 10628.8 10633.5 5628.7 5633.9 5701.8 5774.1 5802.5 4610.9 5099.4 5171.7 5182.2 5235.8 4001.7 4125.8 4178.2 4300.3 4304.5 1321.9 1415.9 1417.3 1427.3 1432.9 979.0 991.7 992.5 1001.7 1020.5 6050.9 6060.8 6087.1 6092.8 6170.2 942.8 998.9 1023.8 1061.4 1066.3 4011.6 4113.8 4185.9 4186.5 4216.5 10676.0 10806.0 10937.6 10987.6 11004.7 10851.7 10869.5 10878.5 10908.8 11102.4 8502.6 8518.7 8553.4 8729.3 8771.8 5782.1 5996.6 6078.9 6086.8 6138.3 9934.5 10064.7 10095.6 10175.9 10184.3 9892.9 10294.7 10397.4 10536.1 10536.5 6665.5 7226.0 7303.3 7338.8 7341.3 8559.2 8642.4 8643.3 8654.5 8660.5 7531.2 7752.7 7757.8 7763.8 7834.4 7505.6 7561.9 7578.6 7603.4 7679.5 7249.3 7260.6 7272.6 7280.5 7333.1 5050.9 5065.8 5160.6 5211.4 5254.1 5158.8 5186.7 5256.4 5354.3 5408.8 00:25:00 INFO - PROCESS | 1942 | 00:25:00 INFO - PROCESS | 1942 | [#4] prototype.html Cycles:180 Average:6083.48 Median:7059.26 stddev:1990.99 (28.2%) stddev-sans-first:1948.31 00:25:00 INFO - PROCESS | 1942 | Values: 278.0 318.9 339.9 340.4 342.4 6880.8 6915.6 6984.5 6993.1 7004.8 6933.6 6997.2 7019.2 7057.3 7061.2 5061.1 5085.9 5102.9 5102.9 5111.7 5082.1 5084.5 5087.3 5112.8 5123.3 5050.8 5052.3 5058.0 5059.2 5060.8 4756.6 4939.2 4965.4 5054.1 5063.1 3755.5 3932.6 4178.0 4187.1 4197.0 5001.4 6559.8 6609.0 6665.7 6689.0 5798.2 5952.4 5955.4 5975.2 5979.2 7373.2 7374.6 7392.5 7403.4 7412.7 4605.3 4630.4 4730.2 4766.3 4766.5 7852.7 7861.6 7931.4 7945.0 7954.3 4793.4 4807.2 4813.9 4821.1 4839.1 4907.2 4908.9 4914.2 4914.7 4925.4 5883.4 5904.3 5907.7 5909.8 5920.7 7151.8 7465.9 7475.0 7481.9 7500.3 1673.6 1675.6 1687.0 1690.1 1699.3 881.3 1010.6 1059.2 1062.4 1082.3 7007.6 7090.4 7111.1 7111.8 7113.1 7719.7 7719.9 7751.5 7755.9 7761.6 7062.9 7084.3 7085.6 7100.1 7102.4 3960.8 4055.8 4086.3 4088.7 4103.3 8063.8 8081.0 8085.4 8089.1 8146.3 7928.1 7933.4 7941.4 7943.5 7950.8 8039.4 8056.4 8092.2 8109.2 8118.0 7370.3 7676.2 7682.3 7712.2 7715.1 7521.6 7552.0 7554.9 7560.5 7562.9 8074.4 8074.5 8099.6 8113.1 8123.7 4821.4 4832.7 4834.6 4838.2 4845.6 7458.6 7687.5 7812.8 7820.9 7821.8 6288.6 7350.4 7463.4 7527.0 7548.8 7503.8 7523.5 7528.2 7547.7 7573.0 7130.2 7342.9 7355.9 7362.7 7383.8 6061.8 7455.1 7485.1 7489.4 7528.4 7092.1 7192.6 7268.7 7335.9 7384.4 00:25:00 INFO - PROCESS | 1942 | 00:25:00 INFO - PROCESS | 1942 | [#5] yui.html Cycles:180 Average:18750.62 Median:50773.38 stddev:26284.43 (51.8%) stddev-sans-first:26322.88 00:25:00 INFO - PROCESS | 1942 | Values: 612.7 762.6 767.3 794.7 808.0 12162.4 15231.0 15232.5 15454.5 15488.2 14377.5 14405.8 14432.4 14454.3 14467.6 915.9 975.3 983.5 999.5 1001.2 970.5 970.5 975.1 979.2 979.4 1012.2 1021.8 1026.8 1028.7 1032.7 980.2 993.4 1010.7 1025.4 1029.6 752.2 763.6 765.4 765.4 765.5 15486.5 15730.3 16036.6 16046.0 16177.6 10994.6 12880.0 13064.2 13104.9 13196.7 7930.0 10405.3 10497.1 10686.1 10793.7 3550.9 3555.8 3589.4 3608.2 3677.2 74069.5 85832.6 86550.6 86811.6 86907.1 9572.2 9776.6 9860.0 10003.7 10327.2 21234.7 21622.0 21902.5 21927.7 21952.0 7776.3 7793.4 7807.2 7937.6 8127.3 4267.6 4307.2 4340.6 4343.9 4385.5 3708.6 3772.8 3773.7 3775.5 3776.6 688.5 690.4 692.8 693.1 694.6 536.5 593.7 609.5 627.8 646.3 8385.8 8543.8 8731.0 8751.7 8769.7 519.2 571.8 578.7 613.6 629.3 3981.5 4039.8 4044.8 4177.5 4217.9 73103.0 82220.0 91448.0 94479.6 96378.0 76023.9 82905.0 84983.6 86587.0 89395.0 73738.0 75395.0 75888.0 79075.6 80333.6 8702.7 8846.4 8931.9 8987.2 8999.6 40115.6 49980.8 51566.0 51568.7 53159.7 55945.7 63830.0 68045.0 69572.0 73743.0 9791.8 11969.5 12212.6 12283.8 12297.9 12199.9 12327.8 12584.9 12659.6 13014.1 11632.2 11827.9 11924.3 12051.6 12224.3 11850.1 11949.8 11964.0 12017.6 12033.3 11679.7 11752.4 11776.4 11988.5 12057.6 7409.5 7778.6 9704.8 9944.0 10293.9 9829.8 10113.9 10153.4 10199.7 10206.7 00:25:00 INFO - PROCESS | 1942 | -------- Summary: end -------- 00:25:00 INFO - PROCESS | 1942 | 00:25:00 INFO - TEST-INFO | 1942: exit 0 00:25:00 INFO - TEST-OK | dromaeo_css | took 1109320ms 00:25:00 INFO - TEST-START | kraken 00:25:00 INFO - operating with platform_type : mac_ 00:25:00 INFO - Initialising browser for kraken test... 00:25:00 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpK71SOV/profile http://localhost:49444/getInfo.html) 00:25:03 INFO - PROCESS | 1948 | __metrics Screen width/height:1600/1200 00:25:03 INFO - PROCESS | 1948 | colorDepth:24 00:25:03 INFO - PROCESS | 1948 | Browser inner width/height: 1024/689 00:25:03 INFO - PROCESS | 1948 | __metrics 00:25:03 ERROR - PROCESS | 1948 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 00:25:04 INFO - TEST-INFO | 1948: exit 0 00:25:04 INFO - Browser initialized. 00:25:04 INFO - Running cycle 1/1 for kraken test... 00:25:04 INFO - TEST-INFO | started process 1952 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpK71SOV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:25:16 INFO - PROCESS | 1952 | RSS: Main: 171065344 00:25:16 INFO - PROCESS | 1952 | 00:25:18 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49444/tests/kraken/driver.html?testName=audio-beat-detection) 00:25:19 INFO - PROCESS | 1952 | RSS: Main: 183791616 00:25:19 INFO - PROCESS | 1952 | 00:25:22 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49444/tests/kraken/driver.html?testName=audio-dft) 00:25:23 INFO - PROCESS | 1952 | RSS: Main: 192430080 00:25:23 INFO - PROCESS | 1952 | 00:25:26 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49444/tests/kraken/driver.html?testName=audio-fft) 00:25:26 INFO - PROCESS | 1952 | RSS: Main: 195846144 00:25:26 INFO - PROCESS | 1952 | 00:25:28 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49444/tests/kraken/driver.html?testName=audio-oscillator) 00:25:29 INFO - PROCESS | 1952 | RSS: Main: 196108288 00:25:29 INFO - PROCESS | 1952 | 00:25:31 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49444/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:25:32 INFO - PROCESS | 1952 | RSS: Main: 197615616 00:25:32 INFO - PROCESS | 1952 | 00:25:35 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49444/tests/kraken/driver.html?testName=imaging-darkroom) 00:25:35 INFO - PROCESS | 1952 | RSS: Main: 198479872 00:25:35 INFO - PROCESS | 1952 | 00:25:38 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49444/tests/kraken/driver.html?testName=imaging-desaturate) 00:25:39 INFO - PROCESS | 1952 | RSS: Main: 198406144 00:25:39 INFO - PROCESS | 1952 | 00:25:42 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49444/tests/kraken/driver.html?testName=json-parse-financial) 00:25:43 INFO - PROCESS | 1952 | RSS: Main: 198443008 00:25:43 INFO - PROCESS | 1952 | 00:25:44 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49444/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:25:45 INFO - PROCESS | 1952 | RSS: Main: 197562368 00:25:45 INFO - PROCESS | 1952 | 00:25:47 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:25:47 INFO - PROCESS | 1952 | RSS: Main: 197791744 00:25:47 INFO - PROCESS | 1952 | 00:25:49 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:25:50 INFO - PROCESS | 1952 | RSS: Main: 198483968 00:25:50 INFO - PROCESS | 1952 | 00:25:53 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:25:54 INFO - PROCESS | 1952 | RSS: Main: 198152192 00:25:54 INFO - PROCESS | 1952 | 00:25:56 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:25:57 INFO - PROCESS | 1952 | RSS: Main: 198213632 00:25:57 INFO - PROCESS | 1952 | 00:25:59 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49444/tests/kraken/driver.html?testName=ai-astar) 00:25:59 INFO - PROCESS | 1952 | RSS: Main: 199983104 00:25:59 INFO - PROCESS | 1952 | 00:25:59 INFO - PROCESS | 1952 | __start_tp_report 00:25:59 INFO - PROCESS | 1952 | _x_x_mozilla_page_load 00:25:59 INFO - PROCESS | 1952 | _x_x_mozilla_page_load_details 00:25:59 INFO - PROCESS | 1952 | |i|pagename|runs| 00:25:59 INFO - PROCESS | 1952 | |0;ai-astar;113;120;113;167;119;118;108;116;116;116 00:25:59 INFO - PROCESS | 1952 | |1;audio-beat-detection;156;121;140;158;122;133;148;193;195;110 00:25:59 INFO - PROCESS | 1952 | |2;audio-dft;199;200;199;202;194;192;199;193;197;204 00:25:59 INFO - PROCESS | 1952 | |3;audio-fft;62;70;80;140;59;56;59;69;137;59 00:25:59 INFO - PROCESS | 1952 | |4;audio-oscillator;78;81;124;77;81;102;158;82;78;134 00:25:59 INFO - PROCESS | 1952 | |5;imaging-gaussian-blur;91;88;79;130;133;90;108;88;79;130 00:25:59 INFO - PROCESS | 1952 | |6;imaging-darkroom;94;95;122;108;153;101;136;149;94;95 00:25:59 INFO - PROCESS | 1952 | |7;imaging-desaturate;90;85;137;140;117;90;114;142;120;91 00:25:59 INFO - PROCESS | 1952 | |8;json-parse-financial;61;64;65;65;65;65;65;80;61;60 00:25:59 INFO - PROCESS | 1952 | |9;json-stringify-tinderbox;60;61;65;71;66;72;69;68;67;69 00:25:59 INFO - PROCESS | 1952 | |10;stanford-crypto-aes;81;79;78;106;82;71;94;108;109;80 00:25:59 INFO - PROCESS | 1952 | |11;stanford-crypto-ccm;142;119;152;148;118;106;137;163;171;166 00:25:59 INFO - PROCESS | 1952 | |12;stanford-crypto-pbkdf2;167;164;163;167;165;166;156;219;153;220 00:25:59 INFO - PROCESS | 1952 | |13;stanford-crypto-sha256-iterative;68;70;93;95;102;55;75;96;100;98 00:25:59 INFO - PROCESS | 1952 | __end_tp_report 00:25:59 INFO - PROCESS | 1952 | __start_cc_report 00:25:59 INFO - PROCESS | 1952 | _x_x_mozilla_cycle_collect,1058 00:25:59 INFO - PROCESS | 1952 | __end_cc_report 00:25:59 INFO - PROCESS | 1952 | __startTimestamp1467357959699__endTimestamp 00:25:59 INFO - PROCESS | 1952 | 00:25:59 INFO - PROCESS | 1952 | ------- Summary: start ------- 00:25:59 INFO - PROCESS | 1952 | Number of tests: 14 00:25:59 INFO - PROCESS | 1952 | 00:25:59 INFO - PROCESS | 1952 | [#0] ai-astar Cycles:10 Average:120.60 Median:117.00 stddev:16.67 (14.2%) stddev-sans-first:17.45 00:25:59 INFO - PROCESS | 1952 | Values: 113.0 120.0 113.0 167.0 119.0 118.0 108.0 116.0 116.0 116.0 00:25:59 INFO - PROCESS | 1952 | 00:25:59 INFO - PROCESS | 1952 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:152.00 stddev:28.93 (19.0%) stddev-sans-first:30.53 00:25:59 INFO - PROCESS | 1952 | Values: 156.0 121.0 140.0 158.0 122.0 133.0 148.0 193.0 195.0 110.0 00:25:59 INFO - PROCESS | 1952 | 00:25:59 INFO - PROCESS | 1952 | [#2] audio-dft Cycles:10 Average:197.90 Median:199.00 stddev:3.90 (2.0%) stddev-sans-first:4.12 00:25:59 INFO - PROCESS | 1952 | Values: 199.0 200.0 199.0 202.0 194.0 192.0 199.0 193.0 197.0 204.0 00:25:59 INFO - PROCESS | 1952 | 00:25:59 INFO - PROCESS | 1952 | [#3] audio-fft Cycles:10 Average:79.10 Median:60.50 stddev:32.12 (53.1%) stddev-sans-first:33.47 00:25:59 INFO - PROCESS | 1952 | Values: 62.0 70.0 80.0 140.0 59.0 56.0 59.0 69.0 137.0 59.0 00:25:59 INFO - PROCESS | 1952 | 00:25:59 INFO - PROCESS | 1952 | [#4] audio-oscillator Cycles:10 Average:99.50 Median:78.00 stddev:29.14 (37.4%) stddev-sans-first:29.85 00:25:59 INFO - PROCESS | 1952 | Values: 78.0 81.0 124.0 77.0 81.0 102.0 158.0 82.0 78.0 134.0 00:25:59 INFO - PROCESS | 1952 | 00:25:59 INFO - PROCESS | 1952 | [#5] imaging-gaussian-blur Cycles:10 Average:101.60 Median:83.50 stddev:21.80 (26.1%) stddev-sans-first:22.79 00:25:59 INFO - PROCESS | 1952 | Values: 91.0 88.0 79.0 130.0 133.0 90.0 108.0 88.0 79.0 130.0 00:25:59 INFO - PROCESS | 1952 | 00:25:59 INFO - PROCESS | 1952 | [#6] imaging-darkroom Cycles:10 Average:114.70 Median:123.50 stddev:23.61 (19.1%) stddev-sans-first:23.82 00:25:59 INFO - PROCESS | 1952 | Values: 94.0 95.0 122.0 108.0 153.0 101.0 136.0 149.0 94.0 95.0 00:25:59 INFO - PROCESS | 1952 | 00:25:59 INFO - PROCESS | 1952 | [#7] imaging-desaturate Cycles:10 Average:112.60 Median:113.50 stddev:22.45 (19.8%) stddev-sans-first:22.27 00:25:59 INFO - PROCESS | 1952 | Values: 90.0 85.0 137.0 140.0 117.0 90.0 114.0 142.0 120.0 91.0 00:25:59 INFO - PROCESS | 1952 | 00:25:59 INFO - PROCESS | 1952 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.00 stddev:5.61 (8.6%) stddev-sans-first:5.75 00:25:59 INFO - PROCESS | 1952 | Values: 61.0 64.0 65.0 65.0 65.0 65.0 65.0 80.0 61.0 60.0 00:25:59 INFO - PROCESS | 1952 | 00:25:59 INFO - PROCESS | 1952 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:68.50 stddev:3.94 (5.7%) stddev-sans-first:3.32 00:25:59 INFO - PROCESS | 1952 | Values: 60.0 61.0 65.0 71.0 66.0 72.0 69.0 68.0 67.0 69.0 00:25:59 INFO - PROCESS | 1952 | 00:25:59 INFO - PROCESS | 1952 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:79.50 stddev:14.20 (17.9%) stddev-sans-first:14.77 00:25:59 INFO - PROCESS | 1952 | Values: 81.0 79.0 78.0 106.0 82.0 71.0 94.0 108.0 109.0 80.0 00:25:59 INFO - PROCESS | 1952 | 00:25:59 INFO - PROCESS | 1952 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:150.00 stddev:22.16 (14.8%) stddev-sans-first:23.50 00:25:59 INFO - PROCESS | 1952 | Values: 142.0 119.0 152.0 148.0 118.0 106.0 137.0 163.0 171.0 166.0 00:25:59 INFO - PROCESS | 1952 | 00:25:59 INFO - PROCESS | 1952 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:166.50 stddev:24.43 (14.7%) stddev-sans-first:25.78 00:25:59 INFO - PROCESS | 1952 | Values: 167.0 164.0 163.0 167.0 165.0 166.0 156.0 219.0 153.0 220.0 00:25:59 INFO - PROCESS | 1952 | 00:25:59 INFO - PROCESS | 1952 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:85.20 Median:84.00 stddev:16.61 (19.8%) stddev-sans-first:16.40 00:25:59 INFO - PROCESS | 1952 | Values: 68.0 70.0 93.0 95.0 102.0 55.0 75.0 96.0 100.0 98.0 00:25:59 INFO - PROCESS | 1952 | -------- Summary: end -------- 00:25:59 INFO - PROCESS | 1952 | 00:26:00 INFO - TEST-INFO | 1952: exit 0 00:26:00 INFO - TEST-OK | kraken | took 59438ms 00:26:00 INFO - SUITE-END | took 1168s 00:26:00 INFO - Completed test suite (00:19:29) 00:26:00 INFO - javascript benchmark 00:26:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2985.9850700746492, 3615.1323682316242, 3689.1883785567184, 3693.833777480013, 3726.06848287928, 4878.8780280493, 5952.375000624937, 5988.101784732292, 6012.518998480122, 6021.2473440819895, 5902.704864756755, 5965.671888046156, 5968.313643930949, 6008.609440386372, 6024.0662697282, 5283.0, 5315.468453154673, 5354.607801971496, 5360.91958620621, 5433.1035379162395, 5135.485031915575, 5291.629585928968, 5364.704941228231, 5391.29913111295, 5395.568354531648, 4318.9784051079705, 5367.75845086972, 5377.300950876381, 5383.67697938123, 5393.083175860093, 5239.5546378557865, 5347.304850369466, 5347.893042139155, 5361.758720857571, 5369.382521010075, 5242.2136679498, 5332.706701131437, 5363.115086010804, 5397.892042159174, 5413.431589683105, 5731.083026715705, 5773.364929857712, 5788.27646544182, 5823.883522329572, 5828.621139625953, 6164.815055548341, 6190.907136392958, 6238.1266622672865, 6238.407351301619, 6250.468710159642, 6229.127922090911, 6246.281677607088, 6258.499320054385, 6273.529485288622, 6277.2153480814895, 5993.280806303272, 6018.15745795589, 6023.337432882379, 6031.065184896304, 6043.697815109227, 5358.33020872391, 6263.404976527223, 6318.0, 6387.201599800025, 6431.163948686641, 6211.192544969125, 6257.561970662101, 6278.0269058296035, 6282.654454004982, 6284.340144284875, 6197.442230199304, 6294.181756371642, 6314.71583778731, 6319.210098737658, 6323.936760632335, 6173.783917562864, 6233.657148856766, 6256.311805701369, 6275.435210831047, 6279.7488100476385, 6217.0, 6219.191505104308, 6248.125262463259, 6252.843678908063, 6278.968605156945, 4885.8045678172475, 4996.4503904570465, 5002.624803139779, 5035.949640503622, 5051.494850514919, 3998.7200895937003, 4535.546445355438, 4543.5910768031035, 4560.521145279764, 4602.07958408313, 6106.389361063858, 6133.233345831771, 6155.169052177898, 6158.507319414436, 6185.319614842364, 6196.10156527301, 6242.344553821874, 6255.843603909939, 6290.0, 6301.558890877686, 5872.119182122716, 6112.786052488142, 6169.722362493699, 6177.289611694712, 6201.224846894138, 5495.313085864267, 5559.416261292587, 5570.832875013756, 5582.553395728332, 5597.44025597437, 6357.332480089524, 6465.870682586322, 6539.247986481425, 6578.144841170617, 6586.6377349245295, 6227.0970709246, 6244.968775156277, 6272.529560283088, 6320.905186422116, 6358.109864618865, 6483.513736469689, 6518.73925043012, 6557.9344206557325, 6559.639219842955, 6563.409293163638, 6207.720652570735, 6213.130161777445, 6220.844478888064, 6258.561900666909, 6278.937210627835, 6226.62640241587, 6228.875422491616, 6237.844053898689, 6256.843578910563, 6322.778702745381, 6054.152418661479, 6123.938760612515, 6226.066090086523, 6227.906581401373, 6229.003359462465, 6139.43080903429, 6143.539234557516, 6161.84595385119, 6180.47465965398, 6236.0, 4881.804727810848, 5826.504747096545, 6001.936108422015, 6005.219321488178, 6019.307779605227, 6042.697865106815, 6072.635641861502, 6112.755489780359, 6124.203853499017, 6136.6011209271255, 6116.755329786936, 6161.229846269216, 6204.3795620437595, 6229.345918678655, 6235.251769787655], "value": 5808.725534753303, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.2061907139289, 538.219558678331, 550.1555112901697, 562.1988666150735, 605.5851741557033, 40100.0, 40984.79507602462, 40999.38500922488, 41197.58802411975, 41198.794006029966, 42455.0, 42763.57236427635, 42923.35614965778, 43004.784976075156, 43044.92387690309, 9805.509724513764, 9957.800843983116, 10017.949910250438, 10042.995700429972, 10066.848997265048, 9796.657117000907, 10010.249231307645, 10016.599336026551, 10019.699409017741, 10037.096661300482, 9948.204143668489, 9977.600895964153, 10017.899821001805, 10048.44733539655, 10169.796604067915, 9985.600575976952, 10014.89985100147, 10038.096571308617, 10056.597736090547, 10057.597696092183, 9916.0, 9952.353097048668, 9976.002399760038, 10006.499675016294, 10048.246381521341, 41151.0, 41545.58454415447, 41742.79128604338, 41751.95620109491, 41979.0, 3293.8682452701864, 3432.6052503962114, 3449.87925422609, 3467.791932484059, 4007.3788562772816, 28761.0, 29025.0, 29468.9371743978, 29599.0, 29798.0, 2804.78964077695, 2832.0229520815287, 2843.900463483789, 2844.5875348074414, 2885.9134225973253, 496207.0, 496709.0, 499156.9999999964, 499410.0, 500466.0, 63173.368266317666, 64725.02912456317, 65250.0, 65329.67335163294, 65514.0, 70325.0, 72445.6377718108, 73144.63427682828, 75097.0, 75160.0, 18633.627327453374, 18834.71747923782, 18851.43445696631, 19105.426837194907, 19119.426417207505, 14252.144871307755, 14584.270786460635, 14661.19363435, 14695.412183512753, 14754.852451475563, 17053.806233563533, 20800.583988320148, 20953.68569471459, 21051.78948210498, 21116.155353785984, 6047.395260473917, 7044.6125463100025, 7052.506324557232, 7085.2206257311655, 7118.074650295428, 999.1058003087342, 1006.8288390973552, 1066.5253961986841, 1145.8911403416662, 1163.203205804027, 30529.542056869166, 30936.53595196029, 31178.908738194055, 31292.687073129433, 31776.887808926578, 1179.0626451970704, 1184.9052075833913, 1242.6582689760207, 1243.1919252485957, 1296.5786119511197, 15694.686106278039, 15959.281832317574, 16011.839881601269, 16117.516474505783, 16287.59281017984, 649344.0, 656740.0, 662427.0, 665317.0, 665403.0, 63669.68165159145, 64081.67959160174, 64348.034779478345, 64657.67671161614, 64850.378740531865, 1528.15187570897, 1538.5384384684774, 1550.3566020101532, 1560.375849660145, 1638.0990455249564, 24248.048092993653, 30597.847010764803, 30812.53781193329, 31046.0, 31080.0, 55633.443665564446, 55990.0, 56022.0, 56024.15963760628, 56630.43369566252, 565573.0, 573752.0, 577502.0, 577744.0, 577789.1110544589, 27531.587026194222, 28105.71894281031, 28426.005089821756, 28738.425231495672, 28849.855750721952, 47662.76168619135, 49211.75394123006, 49223.75388123036, 49248.0, 49336.75331623319, 34354.0, 37893.62106378901, 38826.6117338823, 39581.0, 40978.0, 34944.82527587346, 36739.816300918326, 39358.0, 39439.0, 40295.79852100721, 38768.80615596904, 39631.40552891651, 40827.38758918678, 40892.0, 41008.0, 30460.84769576138, 32821.83589082135, 33054.834725826215, 33661.99014029485, 33789.66210337865, 25725.871370643028, 26034.869825650752, 26077.478450431263, 26159.0, 26735.19794406171], "value": 20866.48267802013, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.2556273145607, 413.0541060970378, 414.8653432861126, 419.18886953744504, 423.86436340371074, 17083.91458042708, 20838.37484875454, 21566.89216553917, 21619.3514194574, 22673.0, 12560.623181304552, 12676.112672112933, 12716.046296527751, 19734.90132549339, 21877.343679689635, 5571.554275657948, 5760.308762948452, 5767.336756273019, 5803.622764520293, 5828.892510423006, 6137.263528376601, 6305.905411418832, 6335.5565110442285, 6356.237251529823, 6374.776882809103, 5813.331466881321, 6275.090111933767, 6281.466075383598, 6296.496280297588, 6317.178766760338, 5924.289085309791, 5962.403759624046, 5985.311689155759, 6009.669468179249, 6058.273007239115, 5677.006523858308, 5966.164736936832, 5966.761329546813, 6105.694715264263, 6120.571559990803, 13826.308684565833, 13926.303684815719, 13990.440382384693, 14040.92979535106, 14139.293035348293, 2184.1154332495366, 2192.572448372568, 2291.3584196425027, 2353.0470159585225, 2539.276306252709, 10115.140213081897, 10259.640912568024, 10490.31812932157, 10593.417362045084, 15047.796176305868, 1792.9910350448165, 1799.9370022049297, 1805.232776070178, 1857.0993068361834, 1864.6084322292336, 114695.0, 116311.41844290809, 119748.40125799316, 123773.0, 124160.37919810433, 10101.0, 11924.46339914706, 12149.574764883188, 12160.878391215974, 12314.0, 15591.376344946302, 15828.129452880203, 15833.68332633364, 15847.920760396355, 15890.728741700636, 8073.39449541275, 9585.84969803628, 9612.615495380247, 9631.662891798893, 9667.758306042264, 9630.0, 9717.757056073655, 9797.657082002239, 9833.704988850346, 9864.506774661239, 4862.270659401118, 4903.583195428358, 4947.975260123676, 4986.301917731521, 4992.776769691449, 1992.6612475879135, 2055.9177632894816, 2062.453449835795, 2066.349100033485, 2066.865653732533, 908.8273228086642, 980.1129977370491, 988.7231575158967, 1008.6368907193405, 1043.3114144664485, 20514.87168205763, 21031.843248621473, 21032.474188145417, 21092.78907210908, 21252.78747212508, 970.9757256068655, 999.9700008999596, 1010.5604062232952, 1038.408107378802, 1048.8898665640152, 11171.0, 11252.407330196234, 11305.039071678999, 11307.462865536467, 11323.716907077389, 619864.0, 634723.0, 672315.6384218048, 684248.0, 684273.0, 136937.0, 139221.0, 141610.0, 142674.0, 148725.0, 947.7156852944227, 983.0513554420019, 992.5235886774389, 1061.766411389493, 1063.441693111123, 15634.609134771721, 16946.0, 18113.36603218881, 18157.0, 18684.065796710383, 48198.59007049703, 49201.753991229816, 49579.75210123926, 53136.4686353147, 54735.45264547304, 75636.48727025319, 80051.79922301053, 80548.0, 82524.58737706274, 88884.0, 8043.959780201061, 8183.6726530938095, 8451.45065570736, 8454.36592255571, 8768.123187681182, 8315.667373305, 9619.422834629944, 11190.66428007161, 13333.266670333225, 13379.130356526795, 11294.0, 11402.315861048364, 11427.142964277878, 11514.021308188898, 11698.005669518187, 9883.901160988298, 11405.201635885409, 11430.1998860079, 11454.599089031844, 11703.356315402734, 9489.240860731263, 9607.327487075838, 11825.231359961575, 11852.822207667065, 11974.820377694516, 8630.309575234092, 8654.264387527131, 8816.206541411048, 8821.514816685143, 8874.112588741074, 10656.467176641292, 11875.406229688653, 11889.702757431134, 11925.224860384047, 11982.940085299517], "value": 9695.943353990062, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1601.5275493729348, 1604.4304271983447, 1618.2556024228859, 1783.5451959750262, 2021.4946263434142, 7329.963350183255, 8915.465072095663, 9127.08729127087, 9226.63093476261, 9299.39553928994, 9000.95499522503, 9046.95476522618, 9061.456312621247, 9123.40697854639, 9140.451572905631, 2513.5726926422462, 2524.7853932415765, 2527.4439623282847, 2541.390066384073, 2544.1731437282865, 2451.889664965072, 2498.4378514834198, 2509.0841842727364, 2514.107491840398, 2515.5975043992967, 2097.213544920655, 2386.1052105460453, 2514.673092497973, 2533.7972962163076, 2535.4168541235526, 2515.4843257132334, 2525.6337831014494, 2541.07250853439, 2556.3736884463424, 2562.948741025169, 2505.2985164153883, 2511.899524019037, 2535.0873685473216, 2552.7830134438595, 2562.5643640581147, 9327.860082098774, 9351.812963740687, 9353.39202951806, 9359.25125989926, 9386.95306523463, 5727.255456790591, 5734.627249228787, 5747.396523365028, 5805.564582656318, 5825.504832089235, 3681.631836816324, 3731.179140589093, 3761.322961866863, 3804.410316400962, 3808.352580061396, 1038.5793753529833, 1074.9247552671316, 1076.8815430302739, 1079.6167360586958, 1082.5182793656747, 12266.202696824677, 12299.262044277371, 12491.812622810665, 12592.244465332018, 12638.115331926769, 4973.477784832613, 5006.499350064964, 5029.220470827027, 5063.8987220255385, 5074.974625126851, 10506.949305069586, 10552.366857988545, 10588.205884558689, 10628.840567391495, 10633.46832658364, 5628.71856407178, 5633.943660563342, 5701.8311246194435, 5774.0761478163295, 5802.47777700009, 4610.861674149781, 5099.413567439792, 5171.689698618095, 5182.196759502283, 5235.816746413857, 4001.7398869073418, 4125.782894046263, 4178.185253875465, 4300.333448315516, 4304.4834619845815, 1321.8678132186897, 1415.9292035398396, 1417.2913543228385, 1427.3362886257732, 1432.8710416062604, 978.9608415663436, 991.7322322972757, 992.4541502173776, 1001.67946257197, 1020.5151504560846, 6050.878982420327, 6060.787872424444, 6087.147799308101, 6092.7562897484495, 6170.167027451326, 942.8444306689456, 998.9150922171697, 1023.8003589300015, 1061.395004847245, 1066.317556763672, 4011.618896204856, 4113.794310284474, 4185.932587190247, 4186.455760751083, 4216.51510076339, 10675.985781350759, 10806.0, 10937.56249750001, 10987.560497580167, 11004.669859904216, 10851.728706782395, 10869.45652717361, 10878.456077196108, 10908.836367454494, 11102.44487775608, 8502.617382217815, 8518.659253629909, 8553.44402613828, 8729.301655867643, 8771.824563508693, 5782.10377391505, 5996.640201587918, 6078.878422431615, 6086.78696245647, 6138.294096178996, 9934.503274836085, 10064.69805905824, 10095.596176152872, 10175.949120254352, 10184.338018028804, 9892.901070989197, 10294.691159265234, 10397.428141452292, 10536.051755341749, 10536.473176341306, 6665.466762659073, 7225.963870180615, 7303.342699157101, 7338.816529586589, 7341.3392794648735, 8559.22966932979, 8642.35182361338, 8643.265322447662, 8654.524001179996, 8660.48037117775, 7531.209223031503, 7752.728654497291, 7757.806054848674, 7763.767086987174, 7834.373250139861, 7505.587192704454, 7561.924380756122, 7578.621068946641, 7603.429742769204, 7679.462437629312, 7249.275072492708, 7260.636968151465, 7272.600006999666, 7280.526765760421, 7333.083364579427, 5050.898982020412, 5065.822696205762, 5160.561352285098, 5211.400688920823, 5254.080535906125, 5158.819441319536, 5186.662866913639, 5256.421793602777, 5354.330708661418, 5408.7566059526625], "value": 4820.422989368462, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.9763720083793, 318.87085730279233, 339.92691571312173, 340.3890017418733, 342.4230172159911, 6880.759173428931, 6915.5850648961095, 6984.476164287674, 6993.090898183235, 7004.8248793780185, 6933.618650974195, 6997.160340759104, 7019.192792828826, 7057.329553692391, 7061.187963384213, 5061.089003979282, 5085.949140508603, 5102.872428189288, 5102.923456148161, 5111.718855462957, 5082.136036873721, 5084.542391184793, 5087.287779710843, 5112.795488180468, 5123.333966584339, 5050.823221187259, 5052.26742122392, 5057.988402319533, 5059.241113832936, 5060.822871199509, 4756.595689366425, 4939.209726443788, 4965.404151501807, 5054.115529782292, 5063.063333283354, 3755.511783468159, 3932.6235817463944, 4177.97911010443, 4187.078842654611, 4196.979015104936, 5001.424836143854, 6559.8032059038305, 6609.008648702733, 6665.700043498055, 6689.0, 5798.217240672498, 5952.434518720715, 5955.434233747787, 5975.223220981288, 5979.22270104888, 7373.225811289791, 7374.63126843661, 7392.482526223166, 7403.407727381797, 7412.666430010662, 4605.286180642006, 4630.374899388573, 4730.243161094243, 4766.261229509431, 4766.475687674353, 7852.725154619561, 7861.646225919847, 7931.44479886414, 7945.0, 7954.284114429671, 4793.448753393334, 4807.158747219222, 4813.855584332476, 4821.108095002436, 4839.080574690797, 4907.2393778964315, 4908.901821963541, 4914.164592019365, 4914.65597408178, 4925.408950925912, 5883.352831188566, 5904.3210030847, 5907.675077870673, 5909.822705318761, 5920.674362910081, 7151.821204469826, 7465.888011679829, 7475.0, 7481.8877716834295, 7500.324970752658, 1673.5565075255067, 1675.6062325353532, 1686.9831301687072, 1690.121137008773, 1699.3287651377636, 881.2817553693719, 1010.6412223660642, 1059.1685526861531, 1062.4156713807374, 1082.3289560472558, 7007.649617519103, 7090.4327653788605, 7111.146662400545, 7111.751088711871, 7113.075300211043, 7719.65261563231, 7719.922800772033, 7751.534907905544, 7755.92244077552, 7761.6119194040075, 7062.929370706227, 7084.326988936043, 7085.610291433917, 7100.112485939258, 7102.431805455654, 3960.821763020671, 4055.7566546007333, 4086.3257562501853, 4088.652464540488, 4103.302438585448, 8063.758087257392, 8080.959595201986, 8085.393595480363, 8089.110197878229, 8146.307563857138, 7928.088269849041, 7933.404994625426, 7941.444098913136, 7943.511915767573, 7950.801229969182, 8039.437239393186, 8056.355491560661, 8092.190780921978, 8109.229623185788, 8118.025836899728, 7370.299821516947, 7676.193999629959, 7682.270184332703, 7712.228777122243, 7715.112762032438, 7521.623918803928, 7552.0, 7554.886676699964, 7560.470767046254, 7562.924370756222, 8074.434789564674, 8074.475159114639, 8099.595020248846, 8113.107558168715, 8123.7156699515235, 4821.421429428491, 4832.685875418087, 4834.59796658979, 4838.225883858566, 4845.6123510118405, 7458.552486850806, 7687.5387476751575, 7812.84374312522, 7820.921790782247, 7821.765347039371, 6288.622682639057, 7350.375218106307, 7463.365613922877, 7527.0, 7548.811279717831, 7503.849923001619, 7523.548587084792, 7528.171901090986, 7547.660355283915, 7573.0, 7130.215676275502, 7342.926570734438, 7355.926440735524, 7362.6686799093095, 7383.8154046149275, 6061.787837425669, 7455.142658594331, 7485.0643669541305, 7489.400847932044, 7528.4353673473615, 7092.113485814273, 7192.640367981685, 7268.67290971897, 7335.926640733524, 7384.37232835215], "value": 5396.651963658989, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.6844674992379, 762.5505177290513, 767.2787579675102, 794.6940427935243, 807.975760727178, 12162.391880405978, 15231.0, 15232.543023709306, 15454.536363909087, 15488.225588720561, 14377.496787612436, 14405.783913241283, 14432.350544225508, 14454.277286135677, 14467.565973020826, 915.8900931888182, 975.2539307429839, 983.5180761426885, 999.5102399824107, 1001.1990407673868, 970.4904924914406, 970.5147426286857, 975.0882924465612, 979.211734553684, 979.3927764785843, 1012.1649639047778, 1021.7854250607344, 1026.7895081508311, 1028.6554004408495, 1032.6695457453618, 980.2060331131735, 993.4039576254225, 1010.706895000449, 1025.364274150028, 1029.5727273181697, 752.1801236652076, 763.5800309829627, 765.3723946363983, 765.4144579396766, 765.5368502056232, 15486.457973970857, 15730.292136853868, 16036.599085022852, 16045.957012794132, 16177.59556011109, 10994.615188468446, 12879.969602431784, 13064.150830196008, 13104.934475327658, 13196.736065278737, 7929.960350198212, 10405.323653962469, 10497.055265026109, 10686.145108391387, 10793.730156746144, 3550.946735798965, 3555.839987200582, 3589.4436362363876, 3608.2422691234874, 3677.1542545214484, 74069.51860962804, 85832.57083714541, 86550.56724716398, 86811.56594217052, 86907.13092869053, 9572.234221262283, 9776.560054797408, 9859.950700246596, 10003.749906252257, 10327.173826093895, 21234.681479777817, 21622.027008784644, 21902.45243868884, 21927.67108493374, 21952.0, 7776.261255180749, 7793.415493837985, 7807.180246074194, 7937.603119843985, 8127.268545830785, 4267.551907049778, 4307.246231909403, 4340.587644173862, 4343.913121737548, 4385.539518350591, 3708.592054873962, 3772.75477093988, 3773.660370566662, 3775.452559378875, 3776.5656949450618, 688.5008368932483, 690.4372936057198, 692.7540723043347, 693.0816667915033, 694.5971336624746, 536.4796147736689, 593.7239183779564, 609.4667166229549, 627.8367624417684, 646.3181343682367, 8385.790355241168, 8543.786405339917, 8730.956345218361, 8751.693690720795, 8769.693060742971, 519.2419068160452, 571.8341680912572, 578.6614830324307, 613.5613036678707, 629.3077614623877, 3981.5222173338807, 4039.818208180639, 4044.8179831907637, 4177.540470548237, 4217.894552636209, 73103.0, 82220.0, 91448.0, 94479.58280625797, 96378.0, 76023.85964210541, 82905.0, 84983.57508212543, 86587.0, 89395.0, 73737.99999999892, 75395.0, 75888.0, 79075.60462197653, 80333.59833200797, 8702.738917832476, 8846.424982376126, 8931.866022009544, 8987.19115279628, 8999.595018224065, 40115.59884401118, 49980.750096249285, 51566.0, 51568.74215628898, 53159.73420132875, 55945.720271398386, 63830.04254936087, 68045.0, 69571.95642065271, 73743.0, 9791.804163916539, 11969.461374238354, 12212.57255996036, 12283.75432491363, 12297.93851030775, 12199.878001219875, 12327.815082773586, 12584.937075314565, 12659.556915507914, 13014.089013768946, 11632.18574699763, 11827.881721182677, 11924.344161070878, 12051.638450846489, 12224.327661978321, 11850.051995840484, 11949.76100478003, 11964.010051607005, 12017.63947081589, 12033.338166400932, 11679.708007299885, 11752.353620550952, 11776.411179440822, 11988.520459181884, 12057.57798477049, 7409.481336306407, 7778.611069446391, 9704.805903881741, 9943.950280248553, 10293.897061029593, 9829.754256143367, 10113.897492257027, 10153.39079655223, 10199.67351489106, 10206.693799186036], "value": 7176.028727485987, "unit": "score"}], "name": "dromaeo_css", "value": 7766.195244704444, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 120.0, 113.0, 167.0, 119.0, 118.0, 108.0, 116.0, 116.0, 116.0], "value": 120.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 121.0, 140.0, 158.0, 122.0, 133.0, 148.0, 193.0, 195.0, 110.0], "value": 147.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 200.0, 199.0, 202.0, 194.0, 192.0, 199.0, 193.0, 197.0, 204.0], "value": 197.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 70.0, 80.0, 140.0, 59.0, 56.0, 59.0, 69.0, 137.0, 59.0], "value": 79.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 124.0, 77.0, 81.0, 102.0, 158.0, 82.0, 78.0, 134.0], "value": 99.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 79.0, 130.0, 133.0, 90.0, 108.0, 88.0, 79.0, 130.0], "value": 101.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 122.0, 108.0, 153.0, 101.0, 136.0, 149.0, 94.0, 95.0], "value": 114.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 85.0, 137.0, 140.0, 117.0, 90.0, 114.0, 142.0, 120.0, 91.0], "value": 112.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 80.0, 61.0, 60.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 65.0, 71.0, 66.0, 72.0, 69.0, 68.0, 67.0, 69.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 78.0, 106.0, 82.0, 71.0, 94.0, 108.0, 109.0, 80.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 119.0, 152.0, 148.0, 118.0, 106.0, 137.0, 163.0, 171.0, 166.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 163.0, 167.0, 165.0, 166.0, 156.0, 219.0, 153.0, 220.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 93.0, 95.0, 102.0, 55.0, 75.0, 96.0, 100.0, 98.0], "value": 85.2, "unit": "score"}], "name": "kraken", "value": 1595.7, "alertThreshold": 2.0}]} 00:26:00 INFO - Return code: 0 00:26:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:26:00 ERROR - # TBPL SUCCESS # 00:26:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:26:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:26:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:26:01 INFO - 2016-07-01 00:26:01.001 screenresolution[1957:13475] starting screenresolution argv=screenresolution get 00:26:01 INFO - 2016-07-01 00:26:01.003 screenresolution[1957:13475] Display 0: 1600x1200x32@60 00:26:01 INFO - 2016-07-01 00:26:01.009 screenresolution[1958:13478] starting screenresolution argv=screenresolution list 00:26:01 INFO - Available Modes on Display 0 00:26:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:26:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:26:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:26:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:26:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:26:01 INFO - Intel Iris: 00:26:01 INFO - Chipset Model: Intel Iris 00:26:01 INFO - Type: GPU 00:26:01 INFO - Bus: Built-In 00:26:01 INFO - VRAM (Dynamic, Max): 1536 MB 00:26:01 INFO - Vendor: Intel (0x8086) 00:26:01 INFO - Device ID: 0x0a2e 00:26:01 INFO - Revision ID: 0x0009 00:26:01 INFO - Displays: 00:26:01 INFO - Display: 00:26:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:26:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:26:01 INFO - Display Serial Number: 1600x1200 60 00:26:01 INFO - Main Display: Yes 00:26:01 INFO - Mirror: Off 00:26:01 INFO - Online: Yes 00:26:01 INFO - Rotation: Supported 00:26:01 INFO - Return code: 0 00:26:01 INFO - Running post-action listener: _resource_record_post_action 00:26:01 INFO - Running post-run listener: _resource_record_post_run 00:26:02 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 1945600; Write bytes: 496012288; Read time: 17; Write time: 1563 00:26:02 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 191111680; Write bytes: 188356608; Read time: 17381; Write time: 415 00:26:02 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 1085440; Write bytes: 296862720; Read time: 13; Write time: 1118 00:26:02 INFO - Running post-run listener: _upload_blobber_files 00:26:02 INFO - Blob upload gear active. 00:26:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:26:02 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 00:26:02 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:26:02 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:26:02 INFO - (blobuploader) - INFO - Open directory for files ... 00:26:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:26:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:26:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:26:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:26:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:26:03 INFO - (blobuploader) - INFO - Done attempting. 00:26:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:26:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:26:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:26:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:26:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:26:04 INFO - (blobuploader) - INFO - Done attempting. 00:26:04 INFO - (blobuploader) - INFO - Iteration through files over. 00:26:04 INFO - Return code: 0 00:26:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:26:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:26:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef5d274f344c48afa2a6b707cfc2ac035b8fb2c3f0cddd3abc954734104e4ac892a88e782a12ac1a284f3ec8e039bd223715868dd2e9215c71d4af9a7dcc22a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/542f5ff3f9a8e74ae3970c150f56a346ba9271434db5235d995bd066447d6bec2a4d0aa79427b8e38840ce9f2faa23c40c9ddd93d8ee2a7206d2508cbb5f1a30"} 00:26:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:26:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:26:04 INFO - Contents: 00:26:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef5d274f344c48afa2a6b707cfc2ac035b8fb2c3f0cddd3abc954734104e4ac892a88e782a12ac1a284f3ec8e039bd223715868dd2e9215c71d4af9a7dcc22a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/542f5ff3f9a8e74ae3970c150f56a346ba9271434db5235d995bd066447d6bec2a4d0aa79427b8e38840ce9f2faa23c40c9ddd93d8ee2a7206d2508cbb5f1a30"} 00:26:04 INFO - Running post-run listener: copy_logs_to_upload_dir 00:26:04 INFO - Copying logs to upload dir... 00:26:04 INFO - mkdir: /builds/slave/test/build/upload/logs 00:26:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.035651 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-07-01 00:26:04.471475) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-07-01 00:26:04.479437) ========= 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.br8Phv3BID/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.X9Ob3TeMCn/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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/Mozilla-Beta/sha512/ef5d274f344c48afa2a6b707cfc2ac035b8fb2c3f0cddd3abc954734104e4ac892a88e782a12ac1a284f3ec8e039bd223715868dd2e9215c71d4af9a7dcc22a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/542f5ff3f9a8e74ae3970c150f56a346ba9271434db5235d995bd066447d6bec2a4d0aa79427b8e38840ce9f2faa23c40c9ddd93d8ee2a7206d2508cbb5f1a30"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011166 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467314638/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef5d274f344c48afa2a6b707cfc2ac035b8fb2c3f0cddd3abc954734104e4ac892a88e782a12ac1a284f3ec8e039bd223715868dd2e9215c71d4af9a7dcc22a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/542f5ff3f9a8e74ae3970c150f56a346ba9271434db5235d995bd066447d6bec2a4d0aa79427b8e38840ce9f2faa23c40c9ddd93d8ee2a7206d2508cbb5f1a30"}' ========= master_lag: 2.83 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-07-01 00:26:07.321731) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 00:26:07.322902) ========= 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.br8Phv3BID/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.X9Ob3TeMCn/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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.005359 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 00:26:07.349599) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 00:26:07.349898) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 00:26:07.350209) ========= ========= Total master_lag: 3.59 =========