builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0354 starttime: 1467388509.25 results: success (0) buildid: 20160701065031 builduid: c767f5fb4f57427c8722dbadfbf73505 revision: 5e6976a28642d4d159071e14fd3251d76b9c46fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:09.247256) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:09.247745) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:09.248062) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:09.272939) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:09.273303) ========= 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.TSsrTaZs7F/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.swlw1kqvdv/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 08:55:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 168M=0s 2016-07-01 08:55:09 (168 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119928 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:09.419855) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:09.420625) ========= 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.TSsrTaZs7F/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.swlw1kqvdv/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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.026543 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:09.473341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 08:55:09.474236) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5e6976a28642d4d159071e14fd3251d76b9c46fa --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 5e6976a28642d4d159071e14fd3251d76b9c46fa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TSsrTaZs7F/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.swlw1kqvdv/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 08:55:09,556 truncating revision to first 12 chars 2016-07-01 08:55:09,556 Setting DEBUG logging. 2016-07-01 08:55:09,557 attempt 1/10 2016-07-01 08:55:09,557 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5e6976a28642?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 08:55:10,245 unpacking tar archive at: mozilla-beta-5e6976a28642/testing/mozharness/ program finished with exit code 0 elapsedTime=0.981397 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 08:55:10.480142) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:10.480788) ========= script_repo_revision: 5e6976a28642d4d159071e14fd3251d76b9c46fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:10.481411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:10.481842) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:10.501400) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-07-01 08:55:10.501998) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.TSsrTaZs7F/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.swlw1kqvdv/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 08:55:10 INFO - MultiFileLogger online at 20160701 08:55:10 in /builds/slave/test 08:55:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:55:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:55:10 INFO - {'append_to_log': False, 08:55:10 INFO - 'base_work_dir': '/builds/slave/test', 08:55:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:55:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:55:10 INFO - 'branch': 'Mozilla-Beta', 08:55:10 INFO - 'buildbot_json_path': 'buildprops.json', 08:55:10 INFO - 'config_files': ('talos/mac_config.py',), 08:55:10 INFO - 'default_actions': ('clobber', 08:55:10 INFO - 'read-buildbot-config', 08:55:10 INFO - 'download-and-extract', 08:55:10 INFO - 'populate-webroot', 08:55:10 INFO - 'create-virtualenv', 08:55:10 INFO - 'install', 08:55:10 INFO - 'run-tests'), 08:55:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:55:10 INFO - 'download_minidump_stackwalk': True, 08:55:10 INFO - 'download_symbols': 'ondemand', 08:55:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:55:10 INFO - 'tooltool.py': '/tools/tooltool.py', 08:55:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:55:10 INFO - '/tools/misc-python/virtualenv.py')}, 08:55:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:55:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:55:10 INFO - 'installer_path': 'installer.exe', 08:55:10 INFO - 'log_level': 'info', 08:55:10 INFO - 'log_name': 'talos', 08:55:10 INFO - 'log_to_console': True, 08:55:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:55:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:55:10 INFO - 'opt_config_files': (), 08:55:10 INFO - 'pip_index': False, 08:55:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:55:10 INFO - 'cmd': ('bash', 08:55:10 INFO - '-c', 08:55:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:55:10 INFO - 'enabled': True, 08:55:10 INFO - 'halt_on_failure': False, 08:55:10 INFO - 'name': 'check_screen_resolution'},), 08:55:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:55:10 INFO - 'cmd': ('bash', 08:55:10 INFO - '-c', 08:55:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:55:10 INFO - 'enabled': True, 08:55:10 INFO - 'halt_on_failure': False, 08:55:10 INFO - 'name': 'check_screen_resolution'},), 08:55:10 INFO - 'run_cmd_checks_enabled': True, 08:55:10 INFO - 'sps_profile': False, 08:55:10 INFO - 'sps_profile_interval': 0, 08:55:10 INFO - 'suite': 'dromaeojs', 08:55:10 INFO - 'system_bits': '32', 08:55:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:55:10 INFO - 'title': 't-yosemite-r7-0354', 08:55:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:55:10 INFO - 'use_talos_json': True, 08:55:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:55:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:55:10 INFO - 'work_dir': 'build'} 08:55:10 INFO - ##### 08:55:10 INFO - ##### Running clobber step. 08:55:10 INFO - ##### 08:55:10 INFO - Running pre-action listener: _resource_record_pre_action 08:55:10 INFO - Running main action method: clobber 08:55:10 INFO - rmtree: /builds/slave/test/build 08:55:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:55:13 INFO - Running post-action listener: _resource_record_post_action 08:55:13 INFO - ##### 08:55:13 INFO - ##### Running read-buildbot-config step. 08:55:13 INFO - ##### 08:55:13 INFO - Running pre-action listener: _resource_record_pre_action 08:55:13 INFO - Running main action method: read_buildbot_config 08:55:13 INFO - Using buildbot properties: 08:55:13 INFO - { 08:55:13 INFO - "project": "", 08:55:13 INFO - "product": "firefox", 08:55:13 INFO - "script_repo_revision": "production", 08:55:13 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:55:13 INFO - "repository": "", 08:55:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:55:13 INFO - "buildid": "20160701065031", 08:55:13 INFO - "pgo_build": "False", 08:55:13 INFO - "basedir": "/builds/slave/test", 08:55:13 INFO - "buildnumber": 10, 08:55:13 INFO - "slavename": "t-yosemite-r7-0354", 08:55:13 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 08:55:13 INFO - "platform": "yosemite_r7", 08:55:13 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:55:13 INFO - "branch": "mozilla-beta", 08:55:13 INFO - "repo_path": "releases/mozilla-beta", 08:55:13 INFO - "revision": "5e6976a28642d4d159071e14fd3251d76b9c46fa", 08:55:13 INFO - "stage_platform": "macosx64", 08:55:13 INFO - "builduid": "c767f5fb4f57427c8722dbadfbf73505", 08:55:13 INFO - "slavebuilddir": "test" 08:55:13 INFO - } 08:55:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 08:55:13 INFO - Running post-action listener: _resource_record_post_action 08:55:13 INFO - ##### 08:55:13 INFO - ##### Running download-and-extract step. 08:55:13 INFO - ##### 08:55:13 INFO - Running pre-action listener: _resource_record_pre_action 08:55:13 INFO - Running main action method: download_and_extract 08:55:13 INFO - mkdir: /builds/slave/test/build/tests 08:55: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')]} 08:55:13 INFO - https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:55:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 08:55:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 08:55:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 08:55:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/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 08:55:15 INFO - Downloaded 1165 bytes. 08:55:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 08:55:15 INFO - Using the following test package requirements: 08:55:15 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 08:55:15 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:55:15 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 08:55:15 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:55:15 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 08:55:15 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:55:15 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:55:15 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 08:55:15 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 08:55:15 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:55:15 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 08:55:15 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:55:15 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 08:55:15 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:55:15 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 08:55:15 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:55:15 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 08:55:15 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 08:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:55:15 INFO - https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:55:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:55:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:55:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 08:55:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/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 08:55:16 INFO - Downloaded 18351381 bytes. 08:55:16 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'] 08:55:16 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 08:55:19 INFO - Return code: 0 08:55:19 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 08:55: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')]} 08:55:19 INFO - https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:55:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:55:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:55:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 08:55:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/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 08:55:29 INFO - Downloaded 18351381 bytes. 08:55:29 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'] 08:55:29 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 08:55:33 INFO - Return code: 0 08:55:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:55:33 INFO - https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:55:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 08:55:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 08:55:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 08:55:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/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 08:55:34 INFO - Downloaded 10840145 bytes. 08:55:34 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'] 08:55:34 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 08:55:34 INFO - Return code: 0 08:55:34 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')]} 08:55:34 INFO - https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 08:55:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:55:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:55:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 08:55:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 08:55:37 INFO - Downloaded 86192349 bytes. 08:55:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:55:37 INFO - mkdir: /builds/slave/test/properties 08:55:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:55:37 INFO - Writing to file /builds/slave/test/properties/build_url 08:55:37 INFO - Contents: 08:55:37 INFO - build_url:https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:55:38 INFO - Running post-action listener: _resource_record_post_action 08:55:38 INFO - Running post-action listener: set_extra_try_arguments 08:55:38 INFO - ##### 08:55:38 INFO - ##### Running populate-webroot step. 08:55:38 INFO - ##### 08:55:38 INFO - Running pre-action listener: _resource_record_pre_action 08:55:38 INFO - Running main action method: populate_webroot 08:55:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:55:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:55:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:55:38 INFO - '--tppagecycles', 08:55:38 INFO - '7'], 08:55:38 INFO - 'tests': ['tsvgm']}}, 08:55:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:55:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:55:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:55:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:55:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:55:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:55:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:38 INFO - 'talos_options': ['--disable-e10s'], 08:55:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:55:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:55:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:38 INFO - 'talos_options': ['--disable-e10s'], 08:55:38 INFO - 'tests': ['damp', 'tps']}, 08:55:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:38 INFO - 'tests': ['damp', 'tps']}, 08:55:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:55:38 INFO - 'tests': ['dromaeo_dom']}, 08:55:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:55:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:55:38 INFO - 'tests': ['a11yr', 08:55:38 INFO - 'ts_paint', 08:55:38 INFO - 'tpaint', 08:55:38 INFO - 'sessionrestore', 08:55:38 INFO - 'sessionrestore_no_auto_restore', 08:55:38 INFO - 'tabpaint']}, 08:55:38 INFO - 'other-e10s': {'tests': ['a11yr', 08:55:38 INFO - 'ts_paint', 08:55:38 INFO - 'tpaint', 08:55:38 INFO - 'sessionrestore', 08:55:38 INFO - 'sessionrestore_no_auto_restore', 08:55:38 INFO - 'tabpaint']}, 08:55:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:55:38 INFO - 'ts_paint', 08:55:38 INFO - 'tpaint', 08:55:38 INFO - 'sessionrestore', 08:55:38 INFO - 'sessionrestore_no_auto_restore', 08:55:38 INFO - 'tabpaint']}, 08:55:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:55:38 INFO - 'ts_paint', 08:55:38 INFO - 'tpaint', 08:55:38 INFO - 'sessionrestore', 08:55:38 INFO - 'sessionrestore_no_auto_restore', 08:55:38 INFO - 'tabpaint']}, 08:55:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:55:38 INFO - 'tests': ['a11yr', 08:55:38 INFO - 'ts_paint', 08:55:38 INFO - 'tpaint', 08:55:38 INFO - 'sessionrestore', 08:55:38 INFO - 'sessionrestore_no_auto_restore', 08:55:38 INFO - 'tabpaint']}, 08:55:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:55:38 INFO - 'tests': ['a11yr', 08:55:38 INFO - 'ts_paint', 08:55:38 INFO - 'tpaint', 08:55:38 INFO - 'sessionrestore', 08:55:38 INFO - 'sessionrestore_no_auto_restore', 08:55:38 INFO - 'tabpaint']}, 08:55:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:55:38 INFO - 'tests': ['tsvgx', 08:55:38 INFO - 'tsvgr_opacity', 08:55:38 INFO - 'tart', 08:55:38 INFO - 'tscrollx', 08:55:38 INFO - 'cart']}, 08:55:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:55:38 INFO - 'tsvgr_opacity', 08:55:38 INFO - 'tart', 08:55:38 INFO - 'tscrollx', 08:55:38 INFO - 'cart']}, 08:55:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:38 INFO - 'talos_options': ['--disable-e10s'], 08:55:38 INFO - 'tests': ['tp5o']}, 08:55:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:38 INFO - 'tests': ['tp5o']}, 08:55:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:38 INFO - 'talos_options': ['--disable-e10s', 08:55:38 INFO - '--xperf_path', 08:55:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:55:38 INFO - 'tests': ['tp5n']}, 08:55:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:38 INFO - 'talos_options': ['--xperf_path', 08:55:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:55:38 INFO - 'tests': ['tp5n']}}, 08:55:38 INFO - 'talos.zip': {'path': '', 08:55:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:55:38 INFO - Running post-action listener: _resource_record_post_action 08:55:38 INFO - ##### 08:55:38 INFO - ##### Running create-virtualenv step. 08:55:38 INFO - ##### 08:55:38 INFO - Running pre-action listener: _resource_record_pre_action 08:55:38 INFO - Running main action method: create_virtualenv 08:55:38 INFO - Creating virtualenv /builds/slave/test/build/venv 08:55:38 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 08:55:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:55:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:55:38 INFO - Using real prefix '/tools/python27' 08:55:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:55:39 INFO - Installing distribute.............................................................................................................................................................................................done. 08:55:41 INFO - Installing pip.................done. 08:55:41 INFO - Return code: 0 08:55:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:55: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')]} 08:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55: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')]} 08:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107a07a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a17420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0935dc550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a6e00>, '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 0x10770fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a1b20>, '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.TSsrTaZs7F/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.swlw1kqvdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 08:55: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', 'pip>=1.5'] in /builds/slave/test/build 08:55: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 pip>=1.5 08:55:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSsrTaZs7F/Render', 08:55:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:41 INFO - 'HOME': '/Users/cltbld', 08:55:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:41 INFO - 'LOGNAME': 'cltbld', 08:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:41 INFO - 'MOZ_NO_REMOTE': '1', 08:55:41 INFO - 'NO_EM_RESTART': '1', 08:55:41 INFO - 'PAGER': '/bin/cat', 08:55:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:41 INFO - 'PWD': '/builds/slave/test', 08:55:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:41 INFO - 'SHELL': '/bin/bash', 08:55:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.swlw1kqvdv/Listeners', 08:55:41 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 08:55:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:41 INFO - 'USER': 'cltbld', 08:55:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:41 INFO - 'XPC_FLAGS': '0x0', 08:55:41 INFO - 'XPC_SERVICE_NAME': '0', 08:55:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:42 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 08:55:42 INFO - Cleaning up... 08:55:42 INFO - Return code: 0 08:55:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:55:42 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')]} 08:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:42 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')]} 08:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:42 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 0x107a07a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a17420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0935dc550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a6e00>, '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 0x10770fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a1b20>, '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.TSsrTaZs7F/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.swlw1kqvdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 08:55:42 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 08:55:42 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 08:55:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSsrTaZs7F/Render', 08:55:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:42 INFO - 'HOME': '/Users/cltbld', 08:55:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:42 INFO - 'LOGNAME': 'cltbld', 08:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:42 INFO - 'MOZ_NO_REMOTE': '1', 08:55:42 INFO - 'NO_EM_RESTART': '1', 08:55:42 INFO - 'PAGER': '/bin/cat', 08:55:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:42 INFO - 'PWD': '/builds/slave/test', 08:55:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:42 INFO - 'SHELL': '/bin/bash', 08:55:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.swlw1kqvdv/Listeners', 08:55:42 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 08:55:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:42 INFO - 'USER': 'cltbld', 08:55:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:42 INFO - 'XPC_FLAGS': '0x0', 08:55:42 INFO - 'XPC_SERVICE_NAME': '0', 08:55:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:42 INFO - Downloading/unpacking psutil>=0.7.1 08:55: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 08:55: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 08:55: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 08:55: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 08:55: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 08:55: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 08:55:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:55:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:55:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:55:45 INFO - Installing collected packages: psutil 08:55:45 INFO - Running setup.py install for psutil 08:55:45 INFO - building 'psutil._psutil_osx' extension 08:55:45 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 08:55:45 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 08:55:45 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 08:55:45 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 08:55:45 INFO - building 'psutil._psutil_posix' extension 08:55:45 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 08:55:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:55:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:55:46 INFO - ^ 08:55:46 INFO - 1 warning generated. 08:55:46 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 08:55:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:55:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:55:46 INFO - Successfully installed psutil 08:55:46 INFO - Cleaning up... 08:55:46 INFO - Return code: 0 08:55:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:46 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 0x107a07a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a17420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0935dc550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a6e00>, '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 0x10770fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a1b20>, '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.TSsrTaZs7F/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.swlw1kqvdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 08:55:46 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 08:55:46 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 08:55:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSsrTaZs7F/Render', 08:55:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:46 INFO - 'HOME': '/Users/cltbld', 08:55:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:46 INFO - 'LOGNAME': 'cltbld', 08:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:46 INFO - 'MOZ_NO_REMOTE': '1', 08:55:46 INFO - 'NO_EM_RESTART': '1', 08:55:46 INFO - 'PAGER': '/bin/cat', 08:55:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:46 INFO - 'PWD': '/builds/slave/test', 08:55:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:46 INFO - 'SHELL': '/bin/bash', 08:55:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.swlw1kqvdv/Listeners', 08:55:46 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 08:55:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:46 INFO - 'USER': 'cltbld', 08:55:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:46 INFO - 'XPC_FLAGS': '0x0', 08:55:46 INFO - 'XPC_SERVICE_NAME': '0', 08:55:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:55:46 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 08:55:46 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 08:55:46 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 08:55:46 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 08:55:46 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 08:55:46 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 08:55:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:55:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:55:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:55:49 INFO - Installing collected packages: mozsystemmonitor 08:55:49 INFO - Running setup.py install for mozsystemmonitor 08:55:49 INFO - Successfully installed mozsystemmonitor 08:55:49 INFO - Cleaning up... 08:55:49 INFO - Return code: 0 08:55:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:55: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')]} 08:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55: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')]} 08:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:49 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 0x107a07a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a17420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0935dc550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a6e00>, '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 0x10770fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a1b20>, '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.TSsrTaZs7F/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.swlw1kqvdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 08:55:49 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 08:55:49 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 08:55:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSsrTaZs7F/Render', 08:55:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:49 INFO - 'HOME': '/Users/cltbld', 08:55:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:49 INFO - 'LOGNAME': 'cltbld', 08:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:49 INFO - 'MOZ_NO_REMOTE': '1', 08:55:49 INFO - 'NO_EM_RESTART': '1', 08:55:49 INFO - 'PAGER': '/bin/cat', 08:55:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:49 INFO - 'PWD': '/builds/slave/test', 08:55:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:49 INFO - 'SHELL': '/bin/bash', 08:55:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.swlw1kqvdv/Listeners', 08:55:49 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 08:55:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:49 INFO - 'USER': 'cltbld', 08:55:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:49 INFO - 'XPC_FLAGS': '0x0', 08:55:49 INFO - 'XPC_SERVICE_NAME': '0', 08:55:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:49 INFO - Downloading/unpacking blobuploader==1.2.4 08:55:49 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 08:55:49 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 08:55:49 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 08:55:49 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 08:55:49 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 08:55:49 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 08:55:52 INFO - Downloading blobuploader-1.2.4.tar.gz 08:55:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:55:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:55:52 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 08:55:52 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 08:55:52 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 08:55:52 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 08:55:52 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 08:55:52 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 08:55:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:55:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:55:52 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 08:55:52 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 08:55:52 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 08:55:52 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 08:55:52 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 08:55:52 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 08:55:53 INFO - Downloading docopt-0.6.1.tar.gz 08:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:55:53 INFO - Installing collected packages: blobuploader, requests, docopt 08:55:53 INFO - Running setup.py install for blobuploader 08:55:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:55:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:55:53 INFO - Running setup.py install for requests 08:55:53 INFO - Running setup.py install for docopt 08:55:54 INFO - Successfully installed blobuploader requests docopt 08:55:54 INFO - Cleaning up... 08:55:54 INFO - Return code: 0 08:55:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:55: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')]} 08:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55: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')]} 08:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:54 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 0x107a07a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a17420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0935dc550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a6e00>, '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 0x10770fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a1b20>, '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.TSsrTaZs7F/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.swlw1kqvdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 08:55:54 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 08:55:54 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 08:55:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSsrTaZs7F/Render', 08:55:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:54 INFO - 'HOME': '/Users/cltbld', 08:55:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:54 INFO - 'LOGNAME': 'cltbld', 08:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:54 INFO - 'MOZ_NO_REMOTE': '1', 08:55:54 INFO - 'NO_EM_RESTART': '1', 08:55:54 INFO - 'PAGER': '/bin/cat', 08:55:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:54 INFO - 'PWD': '/builds/slave/test', 08:55:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:54 INFO - 'SHELL': '/bin/bash', 08:55:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.swlw1kqvdv/Listeners', 08:55:54 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 08:55:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:54 INFO - 'USER': 'cltbld', 08:55:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:54 INFO - 'XPC_FLAGS': '0x0', 08:55:54 INFO - 'XPC_SERVICE_NAME': '0', 08:55:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:55:54 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-zQ3r77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:55:54 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-CJqU2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:55:54 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-saYGs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:55:54 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-RRBONN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:55:54 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-i465yN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:55:55 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-oZN3uo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:55:55 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-UzWhhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:55:55 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-2hV1V7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:55:55 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-sFkkhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:55:55 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-wAkrxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:55:55 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-825xto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:55:55 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-NrQHLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:55:55 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-0J4q8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:55:55 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-c70opj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:55 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-XSyp_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:55:56 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-DhFBNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:55:56 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-JbFrI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:55:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:55:56 INFO - Running setup.py install for manifestparser 08:55:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:55:56 INFO - Running setup.py install for mozcrash 08:55:56 INFO - Running setup.py install for mozdebug 08:55:56 INFO - Running setup.py install for mozdevice 08:55:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:55:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:55:56 INFO - Running setup.py install for mozfile 08:55:57 INFO - Running setup.py install for mozhttpd 08:55:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:55:57 INFO - Running setup.py install for mozinfo 08:55:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:55:57 INFO - Running setup.py install for mozInstall 08:55:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:55:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:55:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:55:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:55:57 INFO - Running setup.py install for mozleak 08:55:57 INFO - Running setup.py install for mozlog 08:55:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:55:57 INFO - Running setup.py install for moznetwork 08:55:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:55:57 INFO - Running setup.py install for mozprocess 08:55:58 INFO - Running setup.py install for mozprofile 08:55:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:55:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:55:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:55:58 INFO - Running setup.py install for mozrunner 08:55:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:55:58 INFO - Running setup.py install for mozscreenshot 08:55:58 INFO - Running setup.py install for moztest 08:55:58 INFO - Running setup.py install for mozversion 08:55:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:55:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:55:58 INFO - Cleaning up... 08:55:58 INFO - Return code: 0 08:55:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:58 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 0x107a07a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a17420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0935dc550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a6e00>, '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 0x10770fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a1b20>, '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.TSsrTaZs7F/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.swlw1kqvdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 08:55:58 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 08:55:58 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 08:55:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSsrTaZs7F/Render', 08:55:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:58 INFO - 'HOME': '/Users/cltbld', 08:55:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:58 INFO - 'LOGNAME': 'cltbld', 08:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:58 INFO - 'MOZ_NO_REMOTE': '1', 08:55:58 INFO - 'NO_EM_RESTART': '1', 08:55:58 INFO - 'PAGER': '/bin/cat', 08:55:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:58 INFO - 'PWD': '/builds/slave/test', 08:55:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:58 INFO - 'SHELL': '/bin/bash', 08:55:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.swlw1kqvdv/Listeners', 08:55:58 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 08:55:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:58 INFO - 'USER': 'cltbld', 08:55:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:58 INFO - 'XPC_FLAGS': '0x0', 08:55:58 INFO - 'XPC_SERVICE_NAME': '0', 08:55:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:55:59 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-8nnCWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:55:59 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)) 08:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:55:59 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-CngQED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:55:59 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)) 08:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:55:59 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-vQQCU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:55:59 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)) 08:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:55:59 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-UTWRaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:55:59 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)) 08:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:55:59 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-EiUBY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:55:59 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)) 08:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:55:59 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Dqg0zY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:55:59 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)) 08:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:55:59 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-PlxY_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:55:59 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)) 08:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:55:59 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-oq7x6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:55:59 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)) 08:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:55:59 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-VWGLTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:00 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)) 08:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:00 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-3YkhuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:00 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)) 08:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:00 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-1E6jAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:00 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)) 08:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:00 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-rrRaSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:00 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)) 08:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:00 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-eg8urV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:00 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)) 08:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:00 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-NrJ5vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:00 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)) 08:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:00 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Ag4pPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:00 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)) 08:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:00 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-yS31U2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:00 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)) 08:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:00 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-R8Qp_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:00 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)) 08:56:00 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)) 08:56:00 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)) 08:56:00 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)) 08:56:00 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)) 08:56:00 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)) 08:56:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:56: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 08:56: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 08:56: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 08:56: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 08:56: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 08:56: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 08:56:03 INFO - Downloading blessings-1.6.tar.gz 08:56:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:56:03 INFO - Installing collected packages: blessings 08:56:03 INFO - Running setup.py install for blessings 08:56:03 INFO - Successfully installed blessings 08:56:03 INFO - Cleaning up... 08:56:03 INFO - Return code: 0 08:56:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:56:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:03 INFO - Reading from file tmpfile_stdout 08:56:03 INFO - Current package versions: 08:56:03 INFO - blessings == 1.6 08:56:03 INFO - blobuploader == 1.2.4 08:56:03 INFO - docopt == 0.6.1 08:56:03 INFO - manifestparser == 1.1 08:56:03 INFO - mozInstall == 1.12 08:56:03 INFO - mozcrash == 0.17 08:56:03 INFO - mozdebug == 0.1 08:56:03 INFO - mozdevice == 0.48 08:56:03 INFO - mozfile == 1.2 08:56:03 INFO - mozhttpd == 0.7 08:56:03 INFO - mozinfo == 0.9 08:56:03 INFO - mozleak == 0.1 08:56:03 INFO - mozlog == 3.1 08:56:03 INFO - moznetwork == 0.27 08:56:03 INFO - mozprocess == 0.22 08:56:03 INFO - mozprofile == 0.28 08:56:03 INFO - mozrunner == 6.11 08:56:03 INFO - mozscreenshot == 0.1 08:56:03 INFO - mozsystemmonitor == 0.0 08:56:03 INFO - moztest == 0.7 08:56:03 INFO - mozversion == 1.4 08:56:03 INFO - psutil == 3.1.1 08:56:03 INFO - requests == 1.2.3 08:56:03 INFO - wsgiref == 0.1.2 08:56:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56: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')]} 08:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56: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')]} 08:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:03 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 0x107a07a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a17420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0935dc550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a6e00>, '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 0x10770fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a1b20>, '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.TSsrTaZs7F/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.swlw1kqvdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 08:56:03 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 08:56:03 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 08:56:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSsrTaZs7F/Render', 08:56:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:03 INFO - 'HOME': '/Users/cltbld', 08:56:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:03 INFO - 'LOGNAME': 'cltbld', 08:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:03 INFO - 'MOZ_NO_REMOTE': '1', 08:56:03 INFO - 'NO_EM_RESTART': '1', 08:56:03 INFO - 'PAGER': '/bin/cat', 08:56:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:03 INFO - 'PWD': '/builds/slave/test', 08:56:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:03 INFO - 'SHELL': '/bin/bash', 08:56:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.swlw1kqvdv/Listeners', 08:56:03 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 08:56:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:03 INFO - 'USER': 'cltbld', 08:56:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:03 INFO - 'XPC_FLAGS': '0x0', 08:56:03 INFO - 'XPC_SERVICE_NAME': '0', 08:56:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:04 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)) 08:56:04 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)) 08:56:04 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)) 08:56:04 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)) 08:56:04 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)) 08:56:04 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)) 08:56:04 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)) 08:56:04 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)) 08:56:04 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)) 08:56:04 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)) 08:56:04 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)) 08:56:04 INFO - Cleaning up... 08:56:04 INFO - Return code: 0 08:56:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107a07a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a17420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0935dc550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a6e00>, '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 0x10770fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a1b20>, '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.TSsrTaZs7F/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.swlw1kqvdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 08:56:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:56:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSsrTaZs7F/Render', 08:56:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:04 INFO - 'HOME': '/Users/cltbld', 08:56:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:04 INFO - 'LOGNAME': 'cltbld', 08:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:04 INFO - 'MOZ_NO_REMOTE': '1', 08:56:04 INFO - 'NO_EM_RESTART': '1', 08:56:04 INFO - 'PAGER': '/bin/cat', 08:56:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:04 INFO - 'PWD': '/builds/slave/test', 08:56:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:04 INFO - 'SHELL': '/bin/bash', 08:56:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.swlw1kqvdv/Listeners', 08:56:04 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 08:56:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:04 INFO - 'USER': 'cltbld', 08:56:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:04 INFO - 'XPC_FLAGS': '0x0', 08:56:04 INFO - 'XPC_SERVICE_NAME': '0', 08:56:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:04 INFO - Downloading/unpacking jsonschema 08:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:56:06 INFO - Downloading/unpacking functools32 (from jsonschema) 08:56: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 08:56: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 08:56: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 08:56: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 08:56: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 08:56: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 08:56:07 INFO - Downloading functools32-3.2.3-2.tar.gz 08:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:56:07 INFO - warning: no files found matching '*.txt' 08:56:07 INFO - no previously-included directories found matching 'build' 08:56:07 INFO - no previously-included directories found matching 'dist' 08:56:07 INFO - no previously-included directories found matching '.git*' 08:56:07 INFO - Installing collected packages: jsonschema, functools32 08:56:07 INFO - Running setup.py install for functools32 08:56:07 INFO - warning: no files found matching '*.txt' 08:56:07 INFO - no previously-included directories found matching 'build' 08:56:07 INFO - no previously-included directories found matching 'dist' 08:56:07 INFO - no previously-included directories found matching '.git*' 08:56:07 INFO - Successfully installed jsonschema functools32 08:56:07 INFO - Cleaning up... 08:56:07 INFO - Return code: 0 08:56:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:56: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')]} 08:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56: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')]} 08:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107a07a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a17420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0935dc550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078a6e00>, '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 0x10770fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a1b20>, '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.TSsrTaZs7F/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.swlw1kqvdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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 08:56:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:56:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:56:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSsrTaZs7F/Render', 08:56:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:07 INFO - 'HOME': '/Users/cltbld', 08:56:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:07 INFO - 'LOGNAME': 'cltbld', 08:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:07 INFO - 'MOZ_NO_REMOTE': '1', 08:56:07 INFO - 'NO_EM_RESTART': '1', 08:56:07 INFO - 'PAGER': '/bin/cat', 08:56:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:07 INFO - 'PWD': '/builds/slave/test', 08:56:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:07 INFO - 'SHELL': '/bin/bash', 08:56:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.swlw1kqvdv/Listeners', 08:56:07 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 08:56:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:07 INFO - 'USER': 'cltbld', 08:56:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:07 INFO - 'XPC_FLAGS': '0x0', 08:56:07 INFO - 'XPC_SERVICE_NAME': '0', 08:56:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:07 INFO - Downloading/unpacking flake8 08:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:56:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:56:10 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 08:56:10 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 08:56:10 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 08:56:10 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 08:56:10 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 08:56:10 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 08:56:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:56:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:56:10 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 08:56:10 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 08:56:10 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 08:56:10 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 08:56:10 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 08:56:10 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 08:56:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:56:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:56:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:56:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:56:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:56:11 INFO - no previously-included directories found matching 'docs/_build' 08:56:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:56:11 INFO - Running setup.py install for pep8 08:56:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:56:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:56:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:56:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:56:11 INFO - no previously-included directories found matching 'docs/_build' 08:56:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:56:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:56:12 INFO - Cleaning up... 08:56:12 INFO - Return code: 0 08:56:12 INFO - Running post-action listener: _resource_record_post_action 08:56:12 INFO - Running post-action listener: _start_resource_monitoring 08:56:12 INFO - Starting resource monitoring. 08:56:12 INFO - ##### 08:56:12 INFO - ##### Running install step. 08:56:12 INFO - ##### 08:56:12 INFO - Running pre-action listener: _resource_record_pre_action 08:56:12 INFO - Running main action method: install 08:56:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:12 INFO - Reading from file tmpfile_stdout 08:56:12 INFO - Detecting whether we're running mozinstall >=1.0... 08:56:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:56:12 INFO - Reading from file tmpfile_stdout 08:56:12 INFO - Output received: 08:56:12 INFO - Usage: mozinstall [options] installer 08:56:12 INFO - Options: 08:56:12 INFO - -h, --help show this help message and exit 08:56:12 INFO - -d DEST, --destination=DEST 08:56:12 INFO - Directory to install application into. [default: 08:56:12 INFO - "/builds/slave/test"] 08:56:12 INFO - --app=APP Application being installed. [default: firefox] 08:56:12 INFO - mkdir: /builds/slave/test/build/application 08:56:12 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'] 08:56:12 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 08:56:34 INFO - Reading from file tmpfile_stdout 08:56:34 INFO - Output received: 08:56:34 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:56:34 INFO - Running post-action listener: _resource_record_post_action 08:56:34 INFO - ##### 08:56:34 INFO - ##### Running run-tests step. 08:56:34 INFO - ##### 08:56:34 INFO - Running pre-action listener: _resource_record_pre_action 08:56:34 INFO - Running main action method: run_tests 08:56:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:56:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:56:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:56:34 INFO - 2016-07-01 08:56:34.264 screenresolution[1644:7612] starting screenresolution argv=screenresolution get 08:56:34 INFO - 2016-07-01 08:56:34.267 screenresolution[1644:7612] Display 0: 1600x1200x32@60 08:56:34 INFO - 2016-07-01 08:56:34.273 screenresolution[1645:7615] starting screenresolution argv=screenresolution list 08:56:34 INFO - Available Modes on Display 0 08:56:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:56:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:56:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:56:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:56:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:56:34 INFO - Intel Iris: 08:56:34 INFO - Chipset Model: Intel Iris 08:56:34 INFO - Type: GPU 08:56:34 INFO - Bus: Built-In 08:56:34 INFO - VRAM (Dynamic, Max): 1536 MB 08:56:34 INFO - Vendor: Intel (0x8086) 08:56:34 INFO - Device ID: 0x0a2e 08:56:34 INFO - Revision ID: 0x0009 08:56:34 INFO - Displays: 08:56:34 INFO - Display: 08:56:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:56:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:56:34 INFO - Display Serial Number: 1600x1200 60 08:56:34 INFO - Main Display: Yes 08:56:34 INFO - Mirror: Off 08:56:34 INFO - Online: Yes 08:56:34 INFO - Rotation: Supported 08:56:34 INFO - Return code: 0 08:56:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:56:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:56:34 INFO - Python 2.7.3 08:56:34 INFO - Return code: 0 08:56:34 INFO - grabbing minidump binary from tooltool 08:56:34 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')]} 08:56:34 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 0x1078a6e00>, '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 0x10770fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078a1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:56:34 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 08:56:34 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 08:56:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:56:34 INFO - Return code: 0 08:56:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:56:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:56:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:56:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:56:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:56:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:56:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:56:35 INFO - Return code: 0 08:56:35 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', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0354', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:56:35 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 --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0354 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:56:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSsrTaZs7F/Render', 08:56:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:35 INFO - 'HOME': '/Users/cltbld', 08:56:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:35 INFO - 'LOGNAME': 'cltbld', 08:56:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:56:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:35 INFO - 'MOZ_NO_REMOTE': '1', 08:56:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:56:35 INFO - 'NO_EM_RESTART': '1', 08:56:35 INFO - 'PAGER': '/bin/cat', 08:56:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:35 INFO - 'PWD': '/builds/slave/test', 08:56:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:56:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:35 INFO - 'SHELL': '/bin/bash', 08:56:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.swlw1kqvdv/Listeners', 08:56:35 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 08:56:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:35 INFO - 'USER': 'cltbld', 08:56:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:35 INFO - 'XPC_FLAGS': '0x0', 08:56:35 INFO - 'XPC_SERVICE_NAME': '0', 08:56:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0354', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:56:35 INFO - mozversion application_buildid: 20160701065031 08:56:35 INFO - mozversion application_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 08:56:35 INFO - mozversion application_display_name: Firefox 08:56:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:56:35 INFO - mozversion application_name: Firefox 08:56:35 INFO - mozversion application_remotingname: firefox 08:56:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:56:35 INFO - mozversion application_vendor: Mozilla 08:56:35 INFO - mozversion application_version: 48.0 08:56:35 INFO - mozversion platform_buildid: 20160701065031 08:56:35 INFO - mozversion platform_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 08:56:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:56:35 INFO - mozversion platform_version: 48.0 08:56:35 INFO - using testdate: 1467388595 08:56:35 INFO - actual date: 1467388595 08:56:35 INFO - starting webserver on 'localhost:49275' 08:56:35 INFO - SUITE-START | Running 2 tests 08:56:35 INFO - TEST-START | dromaeo_css 08:56:35 INFO - operating with platform_type : mac_ 08:56:35 INFO - Initialising browser for dromaeo_css test... 08:56:35 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmpLU43Os/profile http://localhost:49275/getInfo.html) 08:56:38 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 08:56:38 INFO - PROCESS | 1663 | colorDepth:24 08:56:38 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 08:56:38 INFO - PROCESS | 1663 | __metrics 08:56:38 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:56:38 ERROR - PROCESS | 1663 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:56:38 INFO - TEST-INFO | 1663: exit 0 08:56:38 INFO - Browser initialized. 08:56:38 INFO - Running cycle 1/1 for dromaeo_css test... 08:56:38 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmpLU43Os/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:56:50 INFO - PROCESS | 1666 | RSS: Main: 161611776 08:56:50 INFO - PROCESS | 1666 | 08:57:41 INFO - PROCESS | 1666 | 1467388661968 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] 08:59:52 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 08:59:53 INFO - PROCESS | 1666 | RSS: Main: 283316224 08:59:53 INFO - PROCESS | 1666 | 09:02:56 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 09:02:56 INFO - PROCESS | 1666 | RSS: Main: 300089344 09:02:56 INFO - PROCESS | 1666 | 09:05:58 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 09:05:59 INFO - PROCESS | 1666 | RSS: Main: 299663360 09:05:59 INFO - PROCESS | 1666 | 09:09:01 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 09:09:01 INFO - PROCESS | 1666 | RSS: Main: 300642304 09:09:01 INFO - PROCESS | 1666 | 09:12:04 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 09:12:05 INFO - PROCESS | 1666 | RSS: Main: 267378688 09:12:05 INFO - PROCESS | 1666 | 09:15:07 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 09:15:08 INFO - PROCESS | 1666 | RSS: Main: 310296576 09:15:08 INFO - PROCESS | 1666 | 09:15:08 INFO - PROCESS | 1666 | __start_tp_report 09:15:08 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 09:15:08 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 09:15:08 INFO - PROCESS | 1666 | |i|pagename|runs| 09:15:08 INFO - PROCESS | 1666 | |0;dojo.html;3565.1443653523156;3588.7846729196267;3627.9455808162884;3636.79997600132;3700.0749812546865;5840.766369345231;5845.236789904407;5865.296164460266;5876.206712093866;5952.136940143682;5903.380145084769;5957.52339812815;5968.432998865112;5982.401759824015;5987.401259874021;5209.921851172236;5228.8169914053115;5302.973485132569;5317.202419637047;5362.570994320465;4520.480144783342;5297.231901374298;5308.416074231832;5373.596980226479;5377.0321342158395;5293.550048245904;5338.519533242007;5341.4658534146465;5355.196720491938;5361.356637203521;5310.867228319304;5350.250964864883;5372.758225879845;5376.569874410038;5393.164059570773;5132.589392848563;5208.687478751287;5279.5512381447625;5281.155015197588;5297.761600727938;5334.946650533484;5743.253377060955;5755.740991655343;5780.624259423124;5790.623609465371;6246.406591373812;6285.497160227171;6287.654179020152;6301.558890877641;6336.081268216129;6214.627122372672;6222.62664240147;6247.219097612799;6250.656213908233;6290.87418251637;5926.02220633595;5969.253843269591;5974.133750606181;5998.610090344114;6032.27612686476;6316.842078948063;6355.491560675227;6360.459360954278;6361.968190159019;6382.329855365213;5230.63385563007;6133.946794548733;6261.123442718023;6277.905831412532;6306.148669929593;6164.3835616438;6225.501959843202;6281.152044474029;6281.434670879643;6294.181756371642;6304.621722696653;6310.968445157745;6321.304656487782;6332.588381755171;6346.365363463617;6236.875262494725;6251.6561589112125;6316.778912738032;6322.683865806691;6327.240731112296;4915.680480768739;4955.281484184773;5002.774875130628;5040.521150490697;5051.292819005343;4506.864794056118;4515.841945531891;4519.977400112978;4529.909401811945;4549.772511374418;5820.243368362086;6005.099235114681;6009.248843894513;6017.308009578955;6067.696615169224;6161.568690191643;6212.316645169028;6274.780382686584;6285.937140628626;6346.4605508532295;4680.134175177603;5192.091384007784;5383.703896285742;5508.366537848118;6001.63990160583;5402.054640437907;5492.340919089655;5497.857071663494;5513.9448605514235;5545.334559852843;6076.908846367308;6245.906966280882;6393.1688880445245;6429.80710578674;6454.19322584677;6122.5811271886105;6225;6240.375962403723;6310.400511951358;6315.494760419064;5719.8856022880145;6446.29090800021;6474;6516.674166291572;6611.471082313307;6100.176476175659;6124.173236613178;6207.068939659087;6214.658193799384;6250.9998400255745;6158;6159.260888693207;6227.688615569294;6246;6259.749610015549;6146.0473626587955;6183.412575805291;6190.938090619036;6198.81403557894;6213.285472170758;6108.706347747117;6125.326214116532;6205.410486003822;6212.751489940351;6256.874862502816;4856.78144483492;5887.41125887425;6146.5390095742105;6158;6175.289841668086;5277.20841873722;6288.9685551573775;6299.905501417391;6307.779227727007;6309.242890853127;5985.191999080243;6032.306284777132;6123.740204357105;6131.540134489842;6138.815835524942 09:15:08 INFO - PROCESS | 1666 | |1;ext.html;512.7923191107601;524.9370075590932;587.1563015605267;609.7987664070857;610.3621715307503;22754.772452275472;28885.70014349354;38422.8078859606;40458.59541404585;40461;43279;43647.56352436475;43728.12543749123;43801.56198438015;43865.780671096676;8942.731718048437;9101.544922753868;9720.61117555297;9989.100980911717;9993.350432221918;9232.26141908649;11848.822267665992;12122.696932576711;12144.574939877106;12157.57448489303;11913.880861191406;11989;11989.160758746892;11999.340036298001;12056.27662340258;11601.549806274215;11650.184487085908;11761.059115270758;11948.163628546004;11951.282923024602;11695.181337306392;11807.468663910146;11814.46834892432;11840.407979601072;12053.57812476559;34960.300793984235;42747.35878961818;43055.56944430547;43066.56933430657;43200.567994320285;3291.8024918504725;3316.4859446785786;3350.8659653613827;3386.3227354528944;3430.3139372125424;28924.27689307763;29206;30454.54318185207;30772.53841192384;31372.843135784176;2747.6565429321336;2756.462489814487;2762.350847550824;2816.788740844445;2846.587244849485;394736;396398;396743;396891;397957;37158.628413716055;37824.43263351052;37914.43128353077;62824.74350512964;64228.678856606355;36713.81643091821;36760;36883.4467482988;36884.262314753556;36972.630273696916;15891.364345426286;15915.442959496593;15944.883858130052;15967.600809979844;15973.961692489951;12386.5664701735;12712.046596505299;13290.867091329157;13463.12489688167;13496.190228586316;8494.575271236414;8508.234258916727;8509.617067231866;8582.914170858212;8592.140785921483;3532.894013179609;3562.786232826039;3568.678818906311;3573.1781690211396;3573.6247693992277;1004.1916257412706;1012.4633944009687;1068.278911734576;1111.033470756756;1134.9092072634169;29466.410671786445;30932;31014.844925775225;31367.529487057713;31541.842290788398;1146.0888593568134;1186.3890096600257;1234.3334599316447;1245.2839617220134;1309.0509380698918;13849.723005539832;15916.681666366609;15981.840181598267;16021.599460013593;16374.497013321432;752475;752689;753980;755937;758794;64500.67749661222;65718.34281657219;65719.67140164268;65736;65945;1344.5764584155959;1479.896407251482;1601.927913243907;1612;1628.096406494407;25971.870140649175;26109;29423.381714005936;30476.39047218999;30701.692983070778;53098.73450632722;53360.466395337105;53871;54112.45887541074;54116.18825717539;563698;580005;581282;581470;581500;36899.44650830186;47064.7646761764;47227.29159062685;47887.56337309886;48215;48659;48744.756276219814;49845;50590.49409506005;50635.49364506308;38717;39461;40273.59726402698;41229.1754164921;41497;39210.01974950649;40019.79990100031;40068;40350;41005.79497102495;39219;39791.40312895251;39962.00094997532;40455.78632640908;40467.595324046386;33605.83197083999;34532.82733586316;34928.47607285842;35199.296014080086;35287;25816.35459113462;26027.739722603288;26173.214803555922;26189.77680638455;26482.602760958987 09:15:08 INFO - PROCESS | 1666 | |2;jquery.html;411.13661311246386;412.0933945320296;413.42740304678017;414.2419372548236;422.5119986415691;20621.96890155492;21044.789552104474;21253.68119478207;21268.787312126875;21874.562508749816;12122.272663640188;12460.937695311512;16063.437779677684;21611.67582486264;21632.026558804853;5040.269160971657;5294.179402192657;5563.276774019372;5579.358373787026;6188.443040126388;5195.896082078356;6070.332263451017;6127.969360153193;6131.172291740625;6131.87736245277;6126.6017708849;6130.601510901799;6166.4450199482035;6772.08576842125;6775.62734049627;6685.699143538528;6706.497012724065;6728.730850765964;6735.494837887153;6740.359665831738;5833.591648584601;5977.2229610150835;5977.671228082454;6010.96994515029;6013.729382177812;13549;13754;13792.586222413343;16761.7485737714;26408.075717349802;2057.7942205779304;2115.904784284711;2167.4364665187163;2258.4241018540333;2262.400463877074;10044.849327260097;10055.849162262572;10201.979802019812;10219.437930913797;10317.948410257975;1550.8991915525567;1754.5438186071585;1783.3401641392638;1824.1244202782739;1844.7140693192578;116342.50545248155;120803.39598301952;123173;123694.38152809268;124515.9999999991;11703.88296117045;11841.526338946518;11852.170348075551;11857.762844743229;11862.466189021514;15267.923660381626;15299.770503442458;15341.232938353038;15357.001794883297;15357.155356455502;8994;8995.685151019683;9015.233705135006;9133.497657628894;9149.862752058725;7412.4440666950195;9023.954880225689;9039.728808135766;9051.81896362069;9159.450432974043;4569.405977223007;4645.349651048856;4655.557722016403;4706.717596944126;4724.71651700899;1887.4998125496754;1977.179470519747;1990.3033938121541;2006.8494862885343;2045.8363330933787;949;959.0361686505017;1005.2309982863115;1061.6814955513314;1078.4014871746099;18565.535861603566;19747.308844190386;20505.48736281575;20746.170153193703;20938.895305523678;964.7732782796037;972.7081875437341;977.4819345746765;1003.3177439341318;1027.9743006424899;10566.788664226673;10834.458277086114;10869.728256793644;10901.563937442572;10963.232573719923;611721;648936;657329;669213;674668.8932108781;64416.457094860234;113241.86758132478;125248.37375813062;131594;131908.34045829708;1011.8330475471612;1013.8175128476797;1040.2614143957724;1105.2318638546133;1110.6168371911679;18159.546011349823;18309.54226144357;18375.081245937916;18892.622147557246;19057.237710491427;55407;55579.16631250615;56413;57003;59390.703046484494;79909;80250.59874700589;85435.14564854272;85694;86371;8032.277095061472;8141.633626486704;8192.221738934792;8347.624356904076;8485.278751306209;9813.705588832347;12049.759004820029;12416.255024698547;12452;12636;10684.358938463716;10843.891561084289;10894.61868834587;10964.671059868217;11291.548338066714;10227.590896364061;10665.573377064831;10792.784144317227;10795.028447439769;11011.229213954946;11131.888681113409;11200.719982000515;11217.66347009591;11465.598704045651;11569.768604627692;7001.754938577125;7987.84024319522;8099.514029158269;8103.6758529658155;8240.1347858474;9940.055694708992;10625.574977001143;10997.670069897917;11121.221514494231;11200.551977920792 09:15:08 INFO - PROCESS | 1666 | |3;mootools.html;1477.15063838293;1601.9118948457835;1625.9756103658444;1905.6188762247555;2021.6967454881767;8161.959190204048;8746.037935827062;8898.911010889897;8908.28733701304;8912.242459390944;8645.049044605088;8899.68851090212;8900.821983560325;8906.064863189353;8942.374033817636;2496.550620888244;2515.610080437526;2525.6464095026713;2526.5325914705836;2528.8356256843244;2458.5943319352286;2541.466292078666;2542.5042116787235;2546.3379521324496;2555.463352695936;2494.164454907608;2504.812139089576;2528.9494210115786;2545.5163518931436;2547.350425641459;2508.49830033993;2530.3800568860656;2541.4281786598053;2547.9108231212003;2551.9234422967343;2486.689163854518;2519.0301733832425;2534.2017264561605;2535.1887396033276;2541.7331180225997;8645.394822362437;8890.288776897898;8975.28197744179;8981.550922453851;8991.505467199302;5344.465553444663;5503.752331145108;5508.586855985817;5535.501804837584;5540.833774986757;3455.6198818129988;3615.1865830188262;3679.0802299425145;3719.9442008369897;3734.8132593370497;1028.8045271398485;1029.8043371759343;1033.4006276359694;1072.1797824664138;1077.423578385568;10963.287386319784;11851.051915846712;11891;12033.916947474769;12320.5071797128;4001.599840015975;4450.043240703264;4511.977440112844;4745.1695953208055;4773.164696178155;9500.382475139093;9553.761155971157;9569.138777510057;9572.90427095734;9584.089511496397;5213.582913366921;5242.030224408497;5253.185756207794;5254.632175747661;5266.104762190437;4589.701669391479;4711.0342379812055;4876;4878.219484882473;5041.6722913010535;3890.396988466792;3893.5717071122153;3966.861159859449;3992.86024989124;4010.799460026987;1219.0978675779859;1227.404708716272;1230.44014973187;1236.2891337480985;1242.5092088624942;938.6198589571235;941.4257303045136;963.3352986439475;966.4732720667254;994.1996692662476;5906.586538942319;5962.701864906738;6065.514758819284;6066.181065556182;6105.603135796159;429.9914001719948;436.4566115186613;446.2057537583107;446.3617027650426;450.1042924580062;3978.781167035841;3987.5813039631003;4016.49793775778;4039.7374170678813;4056.411820286042;10767.030967212988;10997.285176463503;11046.889531104747;11156.219064665558;11174.888251117547;10491.842622360671;10846.67459976202;10853.457327133612;10981.450927453596;11045.502952367162;8449.788755281168;8552.486850788973;8556.914430855611;8630.741077767678;8646;5759.193712880116;5833.125031245348;5853.678047707417;5861.589688721749;5923.111533270044;9811.264155188532;9862.506874656096;9929.255305851946;9948.950255248677;9967.900320996987;9650.131488166098;10133.13868321201;10222.977702229717;10371.740706482096;10412.791744164922;6681.899771503528;6850.417714494324;6877.243503214742;7250.564966102051;7324.4140468763435;7951.522908625501;8580.65677372898;8602.569871506525;8614.870776938476;8645.827083458422;7432.814179645552;7539.660715267716;7620.390368770374;7620.746528210262;7664.923350766421;7493.850122997618;7504.324610784837;7530.774076777706;7642.770716878503;7653;7165.856682866418;7188.238881473863;7220;7240.167380751071;7242.927570724436;4479.417675702268;4573.611243044378;4906.21500559923;5111.923321150261;5135.794568217379;5070.366204224472;5081.568066714371;5097.108006098843;5163.122269214317;5299.5230429261555 09:15:08 INFO - PROCESS | 1666 | |4;prototype.html;325.83219641884426;332.8350772296961;338.8407448499206;342.2760860779452;344.33027761004854;6679.198496180459;6681.131452911127;6684.532082754209;6762.864742705156;6803.149606299213;6699.095622091017;6721.260661327262;6726.764563240287;6727.428168605675;6741.966290168542;4691.554302341289;4803.61571074315;4812.639052071091;4880.902381952359;4935.703857768527;4094.8943785177985;4870.4885986971385;4899.044686286175;4938.135826230396;4938.456769755324;4887.462379138292;4910.828121015765;4933.555979961803;4934.333864928225;4936.111499930011;4666.929996050062;4744.715317080969;4891.413030436335;4895.534924182197;4904.6321525885705;3509.4034014217646;4232.343986682069;4233.872983810491;4243.448351714288;4245.745255284662;6357.300696923335;6442.93557064428;6459.450946669539;6477.514186436036;6490.8052758417325;5901.675407852566;5904.852378690524;5919.5560332974765;5921.822345329604;5932.851678708023;6727;7154.928450715478;7156.747569175425;7163.89254161188;7176.282371762834;4576.885577860547;4605.65457590682;4614.884627884297;4617.353570500132;4624.653151013654;6076.756929722806;7336.963315183443;7437.8140546486775;7527.360174385184;7528.774136775851;4673.228917228687;4677.204875171229;4687.601553867891;4688.812447502061;4693.24908014716;4747.0505898820375;4752.122911449958;4754.976225118921;4757.762111894392;4763.095011947719;5662.490375866192;5666.150077488327;5671.574631902624;5676.318841738936;5679.204911312419;6836.418904393182;7083.185433675193;7135.857282854314;7155.3202445767565;7160.534565253241;1610.3961014619517;1648.7469523162242;1648.9776338669863;1649.3402638944517;1649.7113005224278;994.532569692258;1001.1590264178126;1032.6024480575034;1034.1261633919326;1058.4284486377271;6197.163382943335;6726.192856857208;6862.691178896962;6862.965685171642;6866.176058872968;7484.251574842472;7486.663100160506;7491.250874912575;7494.887576686354;7508.249175082448;6003.63978161303;6852.725890964405;6875.724971001204;6883.174019117638;6885.827854303582;3323.986184213838;3726.496922915426;3926.7447615904875;3970.50368703912;3981.5023122109737;7764.767056988299;7899.407544434191;7900.3284720799375;7911.28798408146;7915.485493442908;6372.808815735535;7636.618169091635;7722.3049925506975;7738.845223095506;7770.92229077702;7733.226677332222;7857.135715071452;7857.567833769198;7860.960695196602;7873.763787086167;7194.964025179841;7463.888041679488;7482.214367491552;7494.887576686245;7506.812329691801;7260.709571617076;7341.6329183541675;7349.6692648832;7352;7356.190819009797;5931.673757943355;7854.882176767467;7859.646315915683;7862.213778622092;7867.134615192439;4689.390379250675;4693.577578017995;4702.03608260299;4705.976470117627;4709.293605959134;7155.4633402496065;7389.298016688406;7416.6291685414435;7439.62801859894;7456.813579660552;6365.69503251823;6701.631410272482;7159.176694680178;7211.4230861532005;7223.1693355264815;7175.712971481291;7175.892361614684;7201.0278612386655;7211.783646490614;7216.097987751531;6053.75784968614;6682.599044057372;7052.259512751088;7059.541129826544;7067.187273463412;6910.792676219721;7166.53417527859;7177.712891484282;7185.640717963976;7214.783556493314;5462.808801691922;5579.776808927598;6862.348076932683;6984.755533556301;7025.875859862397 09:15:08 INFO - PROCESS | 1666 | |5;yui.html;723.4935545118417;748.0088882231046;772.8299774049707;783.9769101322771;803.1205829616572;15642.608934776623;15901.99999999997;15902.76145857813;15919.283632236547;15947.760783588226;14391.920605954543;14572;14574.562763117123;14580.927095364535;14584.708305833878;774.1948373691368;797.5653268968397;942.981140377192;979.3193730357405;982.4203719805349;966.7099870038995;974.1622204903778;974.8440249560072;977.0766625538869;977.3891317926297;824.0811495182858;1042.6924057403046;1044.5873879817468;1047.0942634621035;1047.4239168457357;827.7889138269763;837.1042984007145;837.5686521441462;990.7027891632481;1022.1771473963456;769.0924708843562;773.5165521549031;774.0865778381508;774.2103054884043;775.0273406874337;15607.45373911919;15649.29578168985;15668.059916404938;15671.451499197474;15677.608059798482;13062.412191451407;13167.209967401986;13269.601911942656;13307.467701291936;13349.86650133496;10257.794844103151;11196.832047519212;11299.209055366127;11387.259828111146;11693.883061169365;3621.203335266237;3640.1445660269815;3658.798766067865;3721.348763966295;3912.37402015679;89080;90581;91606.99999999933;93110;93398;9992.40045597252;10119.949400252952;10144.239182061227;10219.233557483218;10322.741931451774;19809.702854457195;23630.64554031691;23665.171718990096;23686.289411317688;23742;7741.535507869546;7761.9611901940125;7798.103218129874;7817.257360550739;8021.478603890729;3344.832758362121;3680.3191409589313;3853.4412510185866;4001.819463258346;4166.458360413127;3767.321882061255;3808.21931504041;3818.3508803503473;3821.980890095532;3827.158025234444;659.3011407907633;660.8909529927508;670.9765158219536;675.1054852320694;697.0902971621981;558.2184941082517;593.3739904400899;604.4892066204051;608.3976862905691;634.6667999300312;7369.373603243677;8537.231649151607;8546.31629469641;8640.956795216109;8647.400454864477;539.6654074473852;566.5382713088902;574.615007944678;615.8368032471399;617.3178637605471;3986.720825644061;4026.7583944963394;4035.152617950205;4093.5497095319492;4269.637080848162;97007.51496242615;97916;97918.02081979232;99684;99796;63409.659034097145;81979.59010204911;82615.586922065;83650.58174709088;83868.58065709754;69300.999999999;69955;71318;71712.64143679249;72131.2786872135;7863.174366691415;8114.229148230908;8132.837343252983;8173.836523269621;8290.33677305802;49105;49357.506424935294;49827.75086124546;51088.97822043464;51326.716832078004;65250.67374663286;69610.65194673995;69682.9095127147;71366.64316678383;72871.63564182357;9007.828982232268;9952.651657191964;10251.692449226535;10356.689299321033;10368.170546356425;9074.773130671787;11278.830817537579;11348.602798901999;11449.656510304705;11953.581624643095;11451.656450306504;11631.825522617337;11778.705532361759;11794.115441341763;12030.09774266951;11374.488148033193;11522.53909843597;11801.881981180079;11839.61794846277;11848.28910265387;10738.302010369302;11148.331100134017;11457.968782809587;11462.197646164688;11579.421028948687;9666.854997175189;9795.118439340493;9838.60645574169;9909.456489782284;10045.648402305884;9343.579538920629;9913.206943444651;9921.801563968536;9937.701868943943;9991.25065620067 09:15:08 INFO - PROCESS | 1666 | __end_tp_report 09:15:08 INFO - PROCESS | 1666 | __start_cc_report 09:15:08 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1089 09:15:08 INFO - PROCESS | 1666 | __end_cc_report 09:15:08 INFO - PROCESS | 1666 | __startTimestamp1467389708169__endTimestamp 09:15:08 INFO - PROCESS | 1666 | 09:15:08 INFO - PROCESS | 1666 | ------- Summary: start ------- 09:15:08 INFO - PROCESS | 1666 | Number of tests: 6 09:15:08 INFO - PROCESS | 1666 | 09:15:08 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5806.54 Median:6076.91 stddev:633.67 (10.4%) stddev-sans-first:610.73 09:15:08 INFO - PROCESS | 1666 | Values: 3565.1 3588.8 3627.9 3636.8 3700.1 5840.8 5845.2 5865.3 5876.2 5952.1 5903.4 5957.5 5968.4 5982.4 5987.4 5209.9 5228.8 5303.0 5317.2 5362.6 4520.5 5297.2 5308.4 5373.6 5377.0 5293.6 5338.5 5341.5 5355.2 5361.4 5310.9 5350.3 5372.8 5376.6 5393.2 5132.6 5208.7 5279.6 5281.2 5297.8 5334.9 5743.3 5755.7 5780.6 5790.6 6246.4 6285.5 6287.7 6301.6 6336.1 6214.6 6222.6 6247.2 6250.7 6290.9 5926.0 5969.3 5974.1 5998.6 6032.3 6316.8 6355.5 6360.5 6362.0 6382.3 5230.6 6133.9 6261.1 6277.9 6306.1 6164.4 6225.5 6281.2 6281.4 6294.2 6304.6 6311.0 6321.3 6332.6 6346.4 6236.9 6251.7 6316.8 6322.7 6327.2 4915.7 4955.3 5002.8 5040.5 5051.3 4506.9 4515.8 4520.0 4529.9 4549.8 5820.2 6005.1 6009.2 6017.3 6067.7 6161.6 6212.3 6274.8 6285.9 6346.5 4680.1 5192.1 5383.7 5508.4 6001.6 5402.1 5492.3 5497.9 5513.9 5545.3 6076.9 6245.9 6393.2 6429.8 6454.2 6122.6 6225.0 6240.4 6310.4 6315.5 5719.9 6446.3 6474.0 6516.7 6611.5 6100.2 6124.2 6207.1 6214.7 6251.0 6158.0 6159.3 6227.7 6246.0 6259.7 6146.0 6183.4 6190.9 6198.8 6213.3 6108.7 6125.3 6205.4 6212.8 6256.9 4856.8 5887.4 6146.5 6158.0 6175.3 5277.2 6289.0 6299.9 6307.8 6309.2 5985.2 6032.3 6123.7 6131.5 6138.8 09:15:08 INFO - PROCESS | 1666 | 09:15:08 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:70613.26 Median:3573.40 stddev:159637.36 (4467.4%) stddev-sans-first:159998.42 09:15:08 INFO - PROCESS | 1666 | Values: 512.8 524.9 587.2 609.8 610.4 22754.8 28885.7 38422.8 40458.6 40461.0 43279.0 43647.6 43728.1 43801.6 43865.8 8942.7 9101.5 9720.6 9989.1 9993.4 9232.3 11848.8 12122.7 12144.6 12157.6 11913.9 11989.0 11989.2 11999.3 12056.3 11601.5 11650.2 11761.1 11948.2 11951.3 11695.2 11807.5 11814.5 11840.4 12053.6 34960.3 42747.4 43055.6 43066.6 43200.6 3291.8 3316.5 3350.9 3386.3 3430.3 28924.3 29206.0 30454.5 30772.5 31372.8 2747.7 2756.5 2762.4 2816.8 2846.6 394736.0 396398.0 396743.0 396891.0 397957.0 37158.6 37824.4 37914.4 62824.7 64228.7 36713.8 36760.0 36883.4 36884.3 36972.6 15891.4 15915.4 15944.9 15967.6 15974.0 12386.6 12712.0 13290.9 13463.1 13496.2 8494.6 8508.2 8509.6 8582.9 8592.1 3532.9 3562.8 3568.7 3573.2 3573.6 1004.2 1012.5 1068.3 1111.0 1134.9 29466.4 30932.0 31014.8 31367.5 31541.8 1146.1 1186.4 1234.3 1245.3 1309.1 13849.7 15916.7 15981.8 16021.6 16374.5 752475.0 752689.0 753980.0 755937.0 758794.0 64500.7 65718.3 65719.7 65736.0 65945.0 1344.6 1479.9 1601.9 1612.0 1628.1 25971.9 26109.0 29423.4 30476.4 30701.7 53098.7 53360.5 53871.0 54112.5 54116.2 563698.0 580005.0 581282.0 581470.0 581500.0 36899.4 47064.8 47227.3 47887.6 48215.0 48659.0 48744.8 49845.0 50590.5 50635.5 38717.0 39461.0 40273.6 41229.2 41497.0 39210.0 40019.8 40068.0 40350.0 41005.8 39219.0 39791.4 39962.0 40455.8 40467.6 33605.8 34532.8 34928.5 35199.3 35287.0 25816.4 26027.7 26173.2 26189.8 26482.6 09:15:08 INFO - PROCESS | 1666 | 09:15:08 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:36205.54 Median:20991.84 stddev:108434.40 (516.6%) stddev-sans-first:108705.28 09:15:08 INFO - PROCESS | 1666 | Values: 411.1 412.1 413.4 414.2 422.5 20622.0 21044.8 21253.7 21268.8 21874.6 12122.3 12460.9 16063.4 21611.7 21632.0 5040.3 5294.2 5563.3 5579.4 6188.4 5195.9 6070.3 6128.0 6131.2 6131.9 6126.6 6130.6 6166.4 6772.1 6775.6 6685.7 6706.5 6728.7 6735.5 6740.4 5833.6 5977.2 5977.7 6011.0 6013.7 13549.0 13754.0 13792.6 16761.7 26408.1 2057.8 2115.9 2167.4 2258.4 2262.4 10044.8 10055.8 10202.0 10219.4 10317.9 1550.9 1754.5 1783.3 1824.1 1844.7 116342.5 120803.4 123173.0 123694.4 124516.0 11703.9 11841.5 11852.2 11857.8 11862.5 15267.9 15299.8 15341.2 15357.0 15357.2 8994.0 8995.7 9015.2 9133.5 9149.9 7412.4 9024.0 9039.7 9051.8 9159.5 4569.4 4645.3 4655.6 4706.7 4724.7 1887.5 1977.2 1990.3 2006.8 2045.8 949.0 959.0 1005.2 1061.7 1078.4 18565.5 19747.3 20505.5 20746.2 20938.9 964.8 972.7 977.5 1003.3 1028.0 10566.8 10834.5 10869.7 10901.6 10963.2 611721.0 648936.0 657329.0 669213.0 674668.9 64416.5 113241.9 125248.4 131594.0 131908.3 1011.8 1013.8 1040.3 1105.2 1110.6 18159.5 18309.5 18375.1 18892.6 19057.2 55407.0 55579.2 56413.0 57003.0 59390.7 79909.0 80250.6 85435.1 85694.0 86371.0 8032.3 8141.6 8192.2 8347.6 8485.3 9813.7 12049.8 12416.3 12452.0 12636.0 10684.4 10843.9 10894.6 10964.7 11291.5 10227.6 10665.6 10792.8 10795.0 11011.2 11131.9 11200.7 11217.7 11465.6 11569.8 7001.8 7987.8 8099.5 8103.7 8240.1 9940.1 10625.6 10997.7 11121.2 11200.6 09:15:08 INFO - PROCESS | 1666 | 09:15:08 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5770.15 Median:4973.94 stddev:3228.80 (64.9%) stddev-sans-first:3221.74 09:15:08 INFO - PROCESS | 1666 | Values: 1477.2 1601.9 1626.0 1905.6 2021.7 8162.0 8746.0 8898.9 8908.3 8912.2 8645.0 8899.7 8900.8 8906.1 8942.4 2496.6 2515.6 2525.6 2526.5 2528.8 2458.6 2541.5 2542.5 2546.3 2555.5 2494.2 2504.8 2528.9 2545.5 2547.4 2508.5 2530.4 2541.4 2547.9 2551.9 2486.7 2519.0 2534.2 2535.2 2541.7 8645.4 8890.3 8975.3 8981.6 8991.5 5344.5 5503.8 5508.6 5535.5 5540.8 3455.6 3615.2 3679.1 3719.9 3734.8 1028.8 1029.8 1033.4 1072.2 1077.4 10963.3 11851.1 11891.0 12033.9 12320.5 4001.6 4450.0 4512.0 4745.2 4773.2 9500.4 9553.8 9569.1 9572.9 9584.1 5213.6 5242.0 5253.2 5254.6 5266.1 4589.7 4711.0 4876.0 4878.2 5041.7 3890.4 3893.6 3966.9 3992.9 4010.8 1219.1 1227.4 1230.4 1236.3 1242.5 938.6 941.4 963.3 966.5 994.2 5906.6 5962.7 6065.5 6066.2 6105.6 430.0 436.5 446.2 446.4 450.1 3978.8 3987.6 4016.5 4039.7 4056.4 10767.0 10997.3 11046.9 11156.2 11174.9 10491.8 10846.7 10853.5 10981.5 11045.5 8449.8 8552.5 8556.9 8630.7 8646.0 5759.2 5833.1 5853.7 5861.6 5923.1 9811.3 9862.5 9929.3 9949.0 9967.9 9650.1 10133.1 10223.0 10371.7 10412.8 6681.9 6850.4 6877.2 7250.6 7324.4 7951.5 8580.7 8602.6 8614.9 8645.8 7432.8 7539.7 7620.4 7620.7 7664.9 7493.9 7504.3 7530.8 7642.8 7653.0 7165.9 7188.2 7220.0 7240.2 7242.9 4479.4 4573.6 4906.2 5111.9 5135.8 5070.4 5081.6 5097.1 5163.1 5299.5 09:15:08 INFO - PROCESS | 1666 | 09:15:08 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:5829.02 Median:6683.57 stddev:1888.98 (28.3%) stddev-sans-first:1848.56 09:15:08 INFO - PROCESS | 1666 | Values: 325.8 332.8 338.8 342.3 344.3 6679.2 6681.1 6684.5 6762.9 6803.1 6699.1 6721.3 6726.8 6727.4 6742.0 4691.6 4803.6 4812.6 4880.9 4935.7 4094.9 4870.5 4899.0 4938.1 4938.5 4887.5 4910.8 4933.6 4934.3 4936.1 4666.9 4744.7 4891.4 4895.5 4904.6 3509.4 4232.3 4233.9 4243.4 4245.7 6357.3 6442.9 6459.5 6477.5 6490.8 5901.7 5904.9 5919.6 5921.8 5932.9 6727.0 7154.9 7156.7 7163.9 7176.3 4576.9 4605.7 4614.9 4617.4 4624.7 6076.8 7337.0 7437.8 7527.4 7528.8 4673.2 4677.2 4687.6 4688.8 4693.2 4747.1 4752.1 4755.0 4757.8 4763.1 5662.5 5666.2 5671.6 5676.3 5679.2 6836.4 7083.2 7135.9 7155.3 7160.5 1610.4 1648.7 1649.0 1649.3 1649.7 994.5 1001.2 1032.6 1034.1 1058.4 6197.2 6726.2 6862.7 6863.0 6866.2 7484.3 7486.7 7491.3 7494.9 7508.2 6003.6 6852.7 6875.7 6883.2 6885.8 3324.0 3726.5 3926.7 3970.5 3981.5 7764.8 7899.4 7900.3 7911.3 7915.5 6372.8 7636.6 7722.3 7738.8 7770.9 7733.2 7857.1 7857.6 7861.0 7873.8 7195.0 7463.9 7482.2 7494.9 7506.8 7260.7 7341.6 7349.7 7352.0 7356.2 5931.7 7854.9 7859.6 7862.2 7867.1 4689.4 4693.6 4702.0 4706.0 4709.3 7155.5 7389.3 7416.6 7439.6 7456.8 6365.7 6701.6 7159.2 7211.4 7223.2 7175.7 7175.9 7201.0 7211.8 7216.1 6053.8 6682.6 7052.3 7059.5 7067.2 6910.8 7166.5 7177.7 7185.6 7214.8 5462.8 5579.8 6862.3 6984.8 7025.9 09:15:08 INFO - PROCESS | 1666 | 09:15:08 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:19046.46 Median:583.99 stddev:27193.22 (4656.4%) stddev-sans-first:27234.70 09:15:08 INFO - PROCESS | 1666 | Values: 723.5 748.0 772.8 784.0 803.1 15642.6 15902.0 15902.8 15919.3 15947.8 14391.9 14572.0 14574.6 14580.9 14584.7 774.2 797.6 943.0 979.3 982.4 966.7 974.2 974.8 977.1 977.4 824.1 1042.7 1044.6 1047.1 1047.4 827.8 837.1 837.6 990.7 1022.2 769.1 773.5 774.1 774.2 775.0 15607.5 15649.3 15668.1 15671.5 15677.6 13062.4 13167.2 13269.6 13307.5 13349.9 10257.8 11196.8 11299.2 11387.3 11693.9 3621.2 3640.1 3658.8 3721.3 3912.4 89080.0 90581.0 91607.0 93110.0 93398.0 9992.4 10119.9 10144.2 10219.2 10322.7 19809.7 23630.6 23665.2 23686.3 23742.0 7741.5 7762.0 7798.1 7817.3 8021.5 3344.8 3680.3 3853.4 4001.8 4166.5 3767.3 3808.2 3818.4 3822.0 3827.2 659.3 660.9 671.0 675.1 697.1 558.2 593.4 604.5 608.4 634.7 7369.4 8537.2 8546.3 8641.0 8647.4 539.7 566.5 574.6 615.8 617.3 3986.7 4026.8 4035.2 4093.5 4269.6 97007.5 97916.0 97918.0 99684.0 99796.0 63409.7 81979.6 82615.6 83650.6 83868.6 69301.0 69955.0 71318.0 71712.6 72131.3 7863.2 8114.2 8132.8 8173.8 8290.3 49105.0 49357.5 49827.8 51089.0 51326.7 65250.7 69610.7 69682.9 71366.6 72871.6 9007.8 9952.7 10251.7 10356.7 10368.2 9074.8 11278.8 11348.6 11449.7 11953.6 11451.7 11631.8 11778.7 11794.1 12030.1 11374.5 11522.5 11801.9 11839.6 11848.3 10738.3 11148.3 11458.0 11462.2 11579.4 9666.9 9795.1 9838.6 9909.5 10045.6 9343.6 9913.2 9921.8 9937.7 9991.3 09:15:08 INFO - PROCESS | 1666 | -------- Summary: end -------- 09:15:08 INFO - PROCESS | 1666 | 09:15:08 INFO - TEST-INFO | 1666: exit 0 09:15:08 INFO - TEST-OK | dromaeo_css | took 1112803ms 09:15:08 INFO - TEST-START | kraken 09:15:08 INFO - operating with platform_type : mac_ 09:15:08 INFO - Initialising browser for kraken test... 09:15:08 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmpE2KLqn/profile http://localhost:49275/getInfo.html) 09:15:10 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 09:15:10 INFO - PROCESS | 1677 | colorDepth:24 09:15:10 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 09:15:10 INFO - PROCESS | 1677 | __metrics 09:15:10 INFO - PROCESS | 1677 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:15:10 ERROR - PROCESS | 1677 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:15:11 INFO - TEST-INFO | 1677: exit 0 09:15:11 INFO - Browser initialized. 09:15:11 INFO - Running cycle 1/1 for kraken test... 09:15:11 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmpE2KLqn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:15:23 INFO - PROCESS | 1680 | RSS: Main: 161554432 09:15:23 INFO - PROCESS | 1680 | 09:15:25 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 09:15:26 INFO - PROCESS | 1680 | RSS: Main: 223416320 09:15:26 INFO - PROCESS | 1680 | 09:15:29 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 09:15:30 INFO - PROCESS | 1680 | RSS: Main: 238882816 09:15:30 INFO - PROCESS | 1680 | 09:15:33 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 09:15:33 INFO - PROCESS | 1680 | RSS: Main: 325148672 09:15:33 INFO - PROCESS | 1680 | 09:15:35 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 09:15:36 INFO - PROCESS | 1680 | RSS: Main: 230232064 09:15:36 INFO - PROCESS | 1680 | 09:15:38 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:15:39 INFO - PROCESS | 1680 | RSS: Main: 232050688 09:15:39 INFO - PROCESS | 1680 | 09:15:41 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 09:15:42 INFO - PROCESS | 1680 | RSS: Main: 269266944 09:15:42 INFO - PROCESS | 1680 | 09:15:45 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 09:15:46 INFO - PROCESS | 1680 | RSS: Main: 269996032 09:15:46 INFO - PROCESS | 1680 | 09:15:48 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 09:15:49 INFO - PROCESS | 1680 | RSS: Main: 268791808 09:15:49 INFO - PROCESS | 1680 | 09:15:50 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:15:51 INFO - PROCESS | 1680 | RSS: Main: 260403200 09:15:51 INFO - PROCESS | 1680 | 09:15:53 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:15:54 INFO - PROCESS | 1680 | RSS: Main: 267907072 09:15:54 INFO - PROCESS | 1680 | 09:15:56 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:15:56 INFO - PROCESS | 1680 | RSS: Main: 270921728 09:15:56 INFO - PROCESS | 1680 | 09:15:59 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:16:00 INFO - PROCESS | 1680 | RSS: Main: 277880832 09:16:00 INFO - PROCESS | 1680 | 09:16:03 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:16:03 INFO - PROCESS | 1680 | RSS: Main: 275107840 09:16:03 INFO - PROCESS | 1680 | 09:16:05 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 09:16:05 INFO - PROCESS | 1680 | RSS: Main: 335851520 09:16:05 INFO - PROCESS | 1680 | 09:16:05 INFO - PROCESS | 1680 | __start_tp_report 09:16:05 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 09:16:05 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 09:16:05 INFO - PROCESS | 1680 | |i|pagename|runs| 09:16:05 INFO - PROCESS | 1680 | |0;ai-astar;113;113;119;113;112;111;114;113;114;133 09:16:05 INFO - PROCESS | 1680 | |1;audio-beat-detection;154;121;140;168;142;170;166;140;171;117 09:16:05 INFO - PROCESS | 1680 | |2;audio-dft;185;187;184;185;186;183;185;187;184;184 09:16:05 INFO - PROCESS | 1680 | |3;audio-fft;69;80;72;159;73;78;78;62;131;58 09:16:05 INFO - PROCESS | 1680 | |4;audio-oscillator;93;91;141;80;77;80;122;76;78;127 09:16:05 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;88;84;89;85;87;86;89;85;87;83 09:16:05 INFO - PROCESS | 1680 | |6;imaging-darkroom;94;93;94;94;93;94;95;96;93;94 09:16:05 INFO - PROCESS | 1680 | |7;imaging-desaturate;85;84;84;84;84;88;84;83;83;84 09:16:05 INFO - PROCESS | 1680 | |8;json-parse-financial;61;63;63;63;58;64;62;77;59;57 09:16:05 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;62;64;62;72;69;70;72;67;67;66 09:16:05 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;80;80;80;79;81;79;80;79;79;84 09:16:05 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;129;129;124;126;137;139;123;126;167;163 09:16:05 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;160;164;160;166;164;165;207;150;197;206 09:16:05 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;66;67;68;66;67;68;67;66;70;68 09:16:05 INFO - PROCESS | 1680 | __end_tp_report 09:16:05 INFO - PROCESS | 1680 | __start_cc_report 09:16:05 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1891 09:16:05 INFO - PROCESS | 1680 | __end_cc_report 09:16:05 INFO - PROCESS | 1680 | __startTimestamp1467389765594__endTimestamp 09:16:05 INFO - PROCESS | 1680 | 09:16:05 INFO - PROCESS | 1680 | ------- Summary: start ------- 09:16:05 INFO - PROCESS | 1680 | Number of tests: 14 09:16:05 INFO - PROCESS | 1680 | 09:16:05 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:115.50 Median:113.50 stddev:6.50 (5.7%) stddev-sans-first:6.83 09:16:05 INFO - PROCESS | 1680 | Values: 113.0 113.0 119.0 113.0 112.0 111.0 114.0 113.0 114.0 133.0 09:16:05 INFO - PROCESS | 1680 | 09:16:05 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:160.00 stddev:20.05 (12.5%) stddev-sans-first:21.18 09:16:05 INFO - PROCESS | 1680 | Values: 154.0 121.0 140.0 168.0 142.0 170.0 166.0 140.0 171.0 117.0 09:16:05 INFO - PROCESS | 1680 | 09:16:05 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:185.00 Median:185.00 stddev:1.33 (0.7%) stddev-sans-first:1.41 09:16:05 INFO - PROCESS | 1680 | Values: 185.0 187.0 184.0 185.0 186.0 183.0 185.0 187.0 184.0 184.0 09:16:05 INFO - PROCESS | 1680 | 09:16:05 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:86.00 Median:72.50 stddev:32.54 (44.9%) stddev-sans-first:33.93 09:16:05 INFO - PROCESS | 1680 | Values: 69.0 80.0 72.0 159.0 73.0 78.0 78.0 62.0 131.0 58.0 09:16:05 INFO - PROCESS | 1680 | 09:16:05 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:79.00 stddev:24.25 (30.7%) stddev-sans-first:25.68 09:16:05 INFO - PROCESS | 1680 | Values: 93.0 91.0 141.0 80.0 77.0 80.0 122.0 76.0 78.0 127.0 09:16:05 INFO - PROCESS | 1680 | 09:16:05 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.00 stddev:2.06 (2.4%) stddev-sans-first:2.09 09:16:05 INFO - PROCESS | 1680 | Values: 88.0 84.0 89.0 85.0 87.0 86.0 89.0 85.0 87.0 83.0 09:16:05 INFO - PROCESS | 1680 | 09:16:05 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:0.94 (1.0%) stddev-sans-first:1.00 09:16:05 INFO - PROCESS | 1680 | Values: 94.0 93.0 94.0 94.0 93.0 94.0 95.0 96.0 93.0 94.0 09:16:05 INFO - PROCESS | 1680 | 09:16:05 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:1.42 (1.7%) stddev-sans-first:1.48 09:16:05 INFO - PROCESS | 1680 | Values: 85.0 84.0 84.0 84.0 84.0 88.0 84.0 83.0 83.0 84.0 09:16:05 INFO - PROCESS | 1680 | 09:16:05 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:5.56 (8.8%) stddev-sans-first:5.86 09:16:05 INFO - PROCESS | 1680 | Values: 61.0 63.0 63.0 63.0 58.0 64.0 62.0 77.0 59.0 57.0 09:16:05 INFO - PROCESS | 1680 | 09:16:05 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:68.00 stddev:3.70 (5.4%) stddev-sans-first:3.43 09:16:05 INFO - PROCESS | 1680 | Values: 62.0 64.0 62.0 72.0 69.0 70.0 72.0 67.0 67.0 66.0 09:16:05 INFO - PROCESS | 1680 | 09:16:05 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:1.52 (1.9%) stddev-sans-first:1.62 09:16:05 INFO - PROCESS | 1680 | Values: 80.0 80.0 80.0 79.0 81.0 79.0 80.0 79.0 79.0 84.0 09:16:05 INFO - PROCESS | 1680 | 09:16:05 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:136.30 Median:133.00 stddev:16.02 (12.0%) stddev-sans-first:16.77 09:16:05 INFO - PROCESS | 1680 | Values: 129.0 129.0 124.0 126.0 137.0 139.0 123.0 126.0 167.0 163.0 09:16:05 INFO - PROCESS | 1680 | 09:16:05 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:165.50 stddev:20.96 (12.7%) stddev-sans-first:21.62 09:16:05 INFO - PROCESS | 1680 | Values: 160.0 164.0 160.0 166.0 164.0 165.0 207.0 150.0 197.0 206.0 09:16:05 INFO - PROCESS | 1680 | 09:16:05 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.25 (1.9%) stddev-sans-first:1.24 09:16:05 INFO - PROCESS | 1680 | Values: 66.0 67.0 68.0 66.0 67.0 68.0 67.0 66.0 70.0 68.0 09:16:05 INFO - PROCESS | 1680 | -------- Summary: end -------- 09:16:05 INFO - PROCESS | 1680 | 09:16:06 INFO - TEST-INFO | 1680: exit 0 09:16:06 INFO - TEST-OK | kraken | took 57697ms 09:16:06 INFO - SUITE-END | took 1170s 09:16:06 INFO - Completed test suite (00:19:30) 09:16:06 INFO - javascript benchmark 09:16:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3565.1443653523156, 3588.7846729196267, 3627.9455808162884, 3636.79997600132, 3700.0749812546865, 5840.766369345231, 5845.236789904407, 5865.296164460266, 5876.206712093866, 5952.136940143682, 5903.380145084769, 5957.52339812815, 5968.432998865112, 5982.401759824015, 5987.401259874021, 5209.921851172236, 5228.8169914053115, 5302.973485132569, 5317.202419637047, 5362.570994320465, 4520.480144783342, 5297.231901374298, 5308.416074231832, 5373.596980226479, 5377.0321342158395, 5293.550048245904, 5338.519533242007, 5341.4658534146465, 5355.196720491938, 5361.356637203521, 5310.867228319304, 5350.250964864883, 5372.758225879845, 5376.569874410038, 5393.164059570773, 5132.589392848563, 5208.687478751287, 5279.5512381447625, 5281.155015197588, 5297.761600727938, 5334.946650533484, 5743.253377060955, 5755.740991655343, 5780.624259423124, 5790.623609465371, 6246.406591373812, 6285.497160227171, 6287.654179020152, 6301.558890877641, 6336.081268216129, 6214.627122372672, 6222.62664240147, 6247.219097612799, 6250.656213908233, 6290.87418251637, 5926.02220633595, 5969.253843269591, 5974.133750606181, 5998.610090344114, 6032.27612686476, 6316.842078948063, 6355.491560675227, 6360.459360954278, 6361.968190159019, 6382.329855365213, 5230.63385563007, 6133.946794548733, 6261.123442718023, 6277.905831412532, 6306.148669929593, 6164.3835616438, 6225.501959843202, 6281.152044474029, 6281.434670879643, 6294.181756371642, 6304.621722696653, 6310.968445157745, 6321.304656487782, 6332.588381755171, 6346.365363463617, 6236.875262494725, 6251.6561589112125, 6316.778912738032, 6322.683865806691, 6327.240731112296, 4915.680480768739, 4955.281484184773, 5002.774875130628, 5040.521150490697, 5051.292819005343, 4506.864794056118, 4515.841945531891, 4519.977400112978, 4529.909401811945, 4549.772511374418, 5820.243368362086, 6005.099235114681, 6009.248843894513, 6017.308009578955, 6067.696615169224, 6161.568690191643, 6212.316645169028, 6274.780382686584, 6285.937140628626, 6346.4605508532295, 4680.134175177603, 5192.091384007784, 5383.703896285742, 5508.366537848118, 6001.63990160583, 5402.054640437907, 5492.340919089655, 5497.857071663494, 5513.9448605514235, 5545.334559852843, 6076.908846367308, 6245.906966280882, 6393.1688880445245, 6429.80710578674, 6454.19322584677, 6122.5811271886105, 6225.0, 6240.375962403723, 6310.400511951358, 6315.494760419064, 5719.8856022880145, 6446.29090800021, 6474.0, 6516.674166291572, 6611.471082313307, 6100.176476175659, 6124.173236613178, 6207.068939659087, 6214.658193799384, 6250.9998400255745, 6158.0, 6159.260888693207, 6227.688615569294, 6246.0, 6259.749610015549, 6146.0473626587955, 6183.412575805291, 6190.938090619036, 6198.81403557894, 6213.285472170758, 6108.706347747117, 6125.326214116532, 6205.410486003822, 6212.751489940351, 6256.874862502816, 4856.78144483492, 5887.41125887425, 6146.5390095742105, 6158.0, 6175.289841668086, 5277.20841873722, 6288.9685551573775, 6299.905501417391, 6307.779227727007, 6309.242890853127, 5985.191999080243, 6032.306284777132, 6123.740204357105, 6131.540134489842, 6138.815835524942], "value": 5769.954458003932, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [512.7923191107601, 524.9370075590932, 587.1563015605267, 609.7987664070857, 610.3621715307503, 22754.772452275472, 28885.70014349354, 38422.8078859606, 40458.59541404585, 40461.0, 43279.0, 43647.56352436475, 43728.12543749123, 43801.56198438015, 43865.780671096676, 8942.731718048437, 9101.544922753868, 9720.61117555297, 9989.100980911717, 9993.350432221918, 9232.26141908649, 11848.822267665992, 12122.696932576711, 12144.574939877106, 12157.57448489303, 11913.880861191406, 11989.0, 11989.160758746892, 11999.340036298001, 12056.27662340258, 11601.549806274215, 11650.184487085908, 11761.059115270758, 11948.163628546004, 11951.282923024602, 11695.181337306392, 11807.468663910146, 11814.46834892432, 11840.407979601072, 12053.57812476559, 34960.300793984235, 42747.35878961818, 43055.56944430547, 43066.56933430657, 43200.567994320285, 3291.8024918504725, 3316.4859446785786, 3350.8659653613827, 3386.3227354528944, 3430.3139372125424, 28924.27689307763, 29206.0, 30454.54318185207, 30772.53841192384, 31372.843135784176, 2747.6565429321336, 2756.462489814487, 2762.350847550824, 2816.788740844445, 2846.587244849485, 394736.0, 396398.0, 396743.0, 396891.0, 397957.0, 37158.628413716055, 37824.43263351052, 37914.43128353077, 62824.74350512964, 64228.678856606355, 36713.81643091821, 36760.0, 36883.4467482988, 36884.262314753556, 36972.630273696916, 15891.364345426286, 15915.442959496593, 15944.883858130052, 15967.600809979844, 15973.961692489951, 12386.5664701735, 12712.046596505299, 13290.867091329157, 13463.12489688167, 13496.190228586316, 8494.575271236414, 8508.234258916727, 8509.617067231866, 8582.914170858212, 8592.140785921483, 3532.894013179609, 3562.786232826039, 3568.678818906311, 3573.1781690211396, 3573.6247693992277, 1004.1916257412706, 1012.4633944009687, 1068.278911734576, 1111.033470756756, 1134.9092072634169, 29466.410671786445, 30932.0, 31014.844925775225, 31367.529487057713, 31541.842290788398, 1146.0888593568134, 1186.3890096600257, 1234.3334599316447, 1245.2839617220134, 1309.0509380698918, 13849.723005539832, 15916.681666366609, 15981.840181598267, 16021.599460013593, 16374.497013321432, 752475.0, 752689.0, 753980.0, 755937.0, 758794.0, 64500.67749661222, 65718.34281657219, 65719.67140164268, 65736.0, 65945.0, 1344.5764584155959, 1479.896407251482, 1601.927913243907, 1612.0, 1628.096406494407, 25971.870140649175, 26109.0, 29423.381714005936, 30476.39047218999, 30701.692983070778, 53098.73450632722, 53360.466395337105, 53871.0, 54112.45887541074, 54116.18825717539, 563698.0, 580005.0, 581282.0, 581470.0, 581500.0, 36899.44650830186, 47064.7646761764, 47227.29159062685, 47887.56337309886, 48215.0, 48659.0, 48744.756276219814, 49845.0, 50590.49409506005, 50635.49364506308, 38717.0, 39461.0, 40273.59726402698, 41229.1754164921, 41497.0, 39210.01974950649, 40019.79990100031, 40068.0, 40350.0, 41005.79497102495, 39219.0, 39791.40312895251, 39962.00094997532, 40455.78632640908, 40467.595324046386, 33605.83197083999, 34532.82733586316, 34928.47607285842, 35199.296014080086, 35287.0, 25816.35459113462, 26027.739722603288, 26173.214803555922, 26189.77680638455, 26482.602760958987], "value": 19771.62477260197, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.13661311246386, 412.0933945320296, 413.42740304678017, 414.2419372548236, 422.5119986415691, 20621.96890155492, 21044.789552104474, 21253.68119478207, 21268.787312126875, 21874.562508749816, 12122.272663640188, 12460.937695311512, 16063.437779677684, 21611.67582486264, 21632.026558804853, 5040.269160971657, 5294.179402192657, 5563.276774019372, 5579.358373787026, 6188.443040126388, 5195.896082078356, 6070.332263451017, 6127.969360153193, 6131.172291740625, 6131.87736245277, 6126.6017708849, 6130.601510901799, 6166.4450199482035, 6772.08576842125, 6775.62734049627, 6685.699143538528, 6706.497012724065, 6728.730850765964, 6735.494837887153, 6740.359665831738, 5833.591648584601, 5977.2229610150835, 5977.671228082454, 6010.96994515029, 6013.729382177812, 13549.0, 13754.0, 13792.586222413343, 16761.7485737714, 26408.075717349802, 2057.7942205779304, 2115.904784284711, 2167.4364665187163, 2258.4241018540333, 2262.400463877074, 10044.849327260097, 10055.849162262572, 10201.979802019812, 10219.437930913797, 10317.948410257975, 1550.8991915525567, 1754.5438186071585, 1783.3401641392638, 1824.1244202782739, 1844.7140693192578, 116342.50545248155, 120803.39598301952, 123173.0, 123694.38152809268, 124515.9999999991, 11703.88296117045, 11841.526338946518, 11852.170348075551, 11857.762844743229, 11862.466189021514, 15267.923660381626, 15299.770503442458, 15341.232938353038, 15357.001794883297, 15357.155356455502, 8994.0, 8995.685151019683, 9015.233705135006, 9133.497657628894, 9149.862752058725, 7412.4440666950195, 9023.954880225689, 9039.728808135766, 9051.81896362069, 9159.450432974043, 4569.405977223007, 4645.349651048856, 4655.557722016403, 4706.717596944126, 4724.71651700899, 1887.4998125496754, 1977.179470519747, 1990.3033938121541, 2006.8494862885343, 2045.8363330933787, 949.0, 959.0361686505017, 1005.2309982863115, 1061.6814955513314, 1078.4014871746099, 18565.535861603566, 19747.308844190386, 20505.48736281575, 20746.170153193703, 20938.895305523678, 964.7732782796037, 972.7081875437341, 977.4819345746765, 1003.3177439341318, 1027.9743006424899, 10566.788664226673, 10834.458277086114, 10869.728256793644, 10901.563937442572, 10963.232573719923, 611721.0, 648936.0, 657329.0, 669213.0, 674668.8932108781, 64416.457094860234, 113241.86758132478, 125248.37375813062, 131594.0, 131908.34045829708, 1011.8330475471612, 1013.8175128476797, 1040.2614143957724, 1105.2318638546133, 1110.6168371911679, 18159.546011349823, 18309.54226144357, 18375.081245937916, 18892.622147557246, 19057.237710491427, 55407.0, 55579.16631250615, 56413.0, 57003.0, 59390.703046484494, 79909.0, 80250.59874700589, 85435.14564854272, 85694.0, 86371.0, 8032.277095061472, 8141.633626486704, 8192.221738934792, 8347.624356904076, 8485.278751306209, 9813.705588832347, 12049.759004820029, 12416.255024698547, 12452.0, 12636.0, 10684.358938463716, 10843.891561084289, 10894.61868834587, 10964.671059868217, 11291.548338066714, 10227.590896364061, 10665.573377064831, 10792.784144317227, 10795.028447439769, 11011.229213954946, 11131.888681113409, 11200.719982000515, 11217.66347009591, 11465.598704045651, 11569.768604627692, 7001.754938577125, 7987.84024319522, 8099.514029158269, 8103.6758529658155, 8240.1347858474, 9940.055694708992, 10625.574977001143, 10997.670069897917, 11121.221514494231, 11200.551977920792], "value": 9583.036879988094, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1477.15063838293, 1601.9118948457835, 1625.9756103658444, 1905.6188762247555, 2021.6967454881767, 8161.959190204048, 8746.037935827062, 8898.911010889897, 8908.28733701304, 8912.242459390944, 8645.049044605088, 8899.68851090212, 8900.821983560325, 8906.064863189353, 8942.374033817636, 2496.550620888244, 2515.610080437526, 2525.6464095026713, 2526.5325914705836, 2528.8356256843244, 2458.5943319352286, 2541.466292078666, 2542.5042116787235, 2546.3379521324496, 2555.463352695936, 2494.164454907608, 2504.812139089576, 2528.9494210115786, 2545.5163518931436, 2547.350425641459, 2508.49830033993, 2530.3800568860656, 2541.4281786598053, 2547.9108231212003, 2551.9234422967343, 2486.689163854518, 2519.0301733832425, 2534.2017264561605, 2535.1887396033276, 2541.7331180225997, 8645.394822362437, 8890.288776897898, 8975.28197744179, 8981.550922453851, 8991.505467199302, 5344.465553444663, 5503.752331145108, 5508.586855985817, 5535.501804837584, 5540.833774986757, 3455.6198818129988, 3615.1865830188262, 3679.0802299425145, 3719.9442008369897, 3734.8132593370497, 1028.8045271398485, 1029.8043371759343, 1033.4006276359694, 1072.1797824664138, 1077.423578385568, 10963.287386319784, 11851.051915846712, 11891.0, 12033.916947474769, 12320.5071797128, 4001.599840015975, 4450.043240703264, 4511.977440112844, 4745.1695953208055, 4773.164696178155, 9500.382475139093, 9553.761155971157, 9569.138777510057, 9572.90427095734, 9584.089511496397, 5213.582913366921, 5242.030224408497, 5253.185756207794, 5254.632175747661, 5266.104762190437, 4589.701669391479, 4711.0342379812055, 4876.0, 4878.219484882473, 5041.6722913010535, 3890.396988466792, 3893.5717071122153, 3966.861159859449, 3992.86024989124, 4010.799460026987, 1219.0978675779859, 1227.404708716272, 1230.44014973187, 1236.2891337480985, 1242.5092088624942, 938.6198589571235, 941.4257303045136, 963.3352986439475, 966.4732720667254, 994.1996692662476, 5906.586538942319, 5962.701864906738, 6065.514758819284, 6066.181065556182, 6105.603135796159, 429.9914001719948, 436.4566115186613, 446.2057537583107, 446.3617027650426, 450.1042924580062, 3978.781167035841, 3987.5813039631003, 4016.49793775778, 4039.7374170678813, 4056.411820286042, 10767.030967212988, 10997.285176463503, 11046.889531104747, 11156.219064665558, 11174.888251117547, 10491.842622360671, 10846.67459976202, 10853.457327133612, 10981.450927453596, 11045.502952367162, 8449.788755281168, 8552.486850788973, 8556.914430855611, 8630.741077767678, 8646.0, 5759.193712880116, 5833.125031245348, 5853.678047707417, 5861.589688721749, 5923.111533270044, 9811.264155188532, 9862.506874656096, 9929.255305851946, 9948.950255248677, 9967.900320996987, 9650.131488166098, 10133.13868321201, 10222.977702229717, 10371.740706482096, 10412.791744164922, 6681.899771503528, 6850.417714494324, 6877.243503214742, 7250.564966102051, 7324.4140468763435, 7951.522908625501, 8580.65677372898, 8602.569871506525, 8614.870776938476, 8645.827083458422, 7432.814179645552, 7539.660715267716, 7620.390368770374, 7620.746528210262, 7664.923350766421, 7493.850122997618, 7504.324610784837, 7530.774076777706, 7642.770716878503, 7653.0, 7165.856682866418, 7188.238881473863, 7220.0, 7240.167380751071, 7242.927570724436, 4479.417675702268, 4573.611243044378, 4906.21500559923, 5111.923321150261, 5135.794568217379, 5070.366204224472, 5081.568066714371, 5097.108006098843, 5163.122269214317, 5299.5230429261555], "value": 4577.2727098109235, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.83219641884426, 332.8350772296961, 338.8407448499206, 342.2760860779452, 344.33027761004854, 6679.198496180459, 6681.131452911127, 6684.532082754209, 6762.864742705156, 6803.149606299213, 6699.095622091017, 6721.260661327262, 6726.764563240287, 6727.428168605675, 6741.966290168542, 4691.554302341289, 4803.61571074315, 4812.639052071091, 4880.902381952359, 4935.703857768527, 4094.8943785177985, 4870.4885986971385, 4899.044686286175, 4938.135826230396, 4938.456769755324, 4887.462379138292, 4910.828121015765, 4933.555979961803, 4934.333864928225, 4936.111499930011, 4666.929996050062, 4744.715317080969, 4891.413030436335, 4895.534924182197, 4904.6321525885705, 3509.4034014217646, 4232.343986682069, 4233.872983810491, 4243.448351714288, 4245.745255284662, 6357.300696923335, 6442.93557064428, 6459.450946669539, 6477.514186436036, 6490.8052758417325, 5901.675407852566, 5904.852378690524, 5919.5560332974765, 5921.822345329604, 5932.851678708023, 6727.0, 7154.928450715478, 7156.747569175425, 7163.89254161188, 7176.282371762834, 4576.885577860547, 4605.65457590682, 4614.884627884297, 4617.353570500132, 4624.653151013654, 6076.756929722806, 7336.963315183443, 7437.8140546486775, 7527.360174385184, 7528.774136775851, 4673.228917228687, 4677.204875171229, 4687.601553867891, 4688.812447502061, 4693.24908014716, 4747.0505898820375, 4752.122911449958, 4754.976225118921, 4757.762111894392, 4763.095011947719, 5662.490375866192, 5666.150077488327, 5671.574631902624, 5676.318841738936, 5679.204911312419, 6836.418904393182, 7083.185433675193, 7135.857282854314, 7155.3202445767565, 7160.534565253241, 1610.3961014619517, 1648.7469523162242, 1648.9776338669863, 1649.3402638944517, 1649.7113005224278, 994.532569692258, 1001.1590264178126, 1032.6024480575034, 1034.1261633919326, 1058.4284486377271, 6197.163382943335, 6726.192856857208, 6862.691178896962, 6862.965685171642, 6866.176058872968, 7484.251574842472, 7486.663100160506, 7491.250874912575, 7494.887576686354, 7508.249175082448, 6003.63978161303, 6852.725890964405, 6875.724971001204, 6883.174019117638, 6885.827854303582, 3323.986184213838, 3726.496922915426, 3926.7447615904875, 3970.50368703912, 3981.5023122109737, 7764.767056988299, 7899.407544434191, 7900.3284720799375, 7911.28798408146, 7915.485493442908, 6372.808815735535, 7636.618169091635, 7722.3049925506975, 7738.845223095506, 7770.92229077702, 7733.226677332222, 7857.135715071452, 7857.567833769198, 7860.960695196602, 7873.763787086167, 7194.964025179841, 7463.888041679488, 7482.214367491552, 7494.887576686245, 7506.812329691801, 7260.709571617076, 7341.6329183541675, 7349.6692648832, 7352.0, 7356.190819009797, 5931.673757943355, 7854.882176767467, 7859.646315915683, 7862.213778622092, 7867.134615192439, 4689.390379250675, 4693.577578017995, 4702.03608260299, 4705.976470117627, 4709.293605959134, 7155.4633402496065, 7389.298016688406, 7416.6291685414435, 7439.62801859894, 7456.813579660552, 6365.69503251823, 6701.631410272482, 7159.176694680178, 7211.4230861532005, 7223.1693355264815, 7175.712971481291, 7175.892361614684, 7201.0278612386655, 7211.783646490614, 7216.097987751531, 6053.75784968614, 6682.599044057372, 7052.259512751088, 7059.541129826544, 7067.187273463412, 6910.792676219721, 7166.53417527859, 7177.712891484282, 7185.640717963976, 7214.783556493314, 5462.808801691922, 5579.776808927598, 6862.348076932683, 6984.755533556301, 7025.875859862397], "value": 5195.742433329453, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.4935545118417, 748.0088882231046, 772.8299774049707, 783.9769101322771, 803.1205829616572, 15642.608934776623, 15901.99999999997, 15902.76145857813, 15919.283632236547, 15947.760783588226, 14391.920605954543, 14572.0, 14574.562763117123, 14580.927095364535, 14584.708305833878, 774.1948373691368, 797.5653268968397, 942.981140377192, 979.3193730357405, 982.4203719805349, 966.7099870038995, 974.1622204903778, 974.8440249560072, 977.0766625538869, 977.3891317926297, 824.0811495182858, 1042.6924057403046, 1044.5873879817468, 1047.0942634621035, 1047.4239168457357, 827.7889138269763, 837.1042984007145, 837.5686521441462, 990.7027891632481, 1022.1771473963456, 769.0924708843562, 773.5165521549031, 774.0865778381508, 774.2103054884043, 775.0273406874337, 15607.45373911919, 15649.29578168985, 15668.059916404938, 15671.451499197474, 15677.608059798482, 13062.412191451407, 13167.209967401986, 13269.601911942656, 13307.467701291936, 13349.86650133496, 10257.794844103151, 11196.832047519212, 11299.209055366127, 11387.259828111146, 11693.883061169365, 3621.203335266237, 3640.1445660269815, 3658.798766067865, 3721.348763966295, 3912.37402015679, 89080.0, 90581.0, 91606.99999999933, 93110.0, 93398.0, 9992.40045597252, 10119.949400252952, 10144.239182061227, 10219.233557483218, 10322.741931451774, 19809.702854457195, 23630.64554031691, 23665.171718990096, 23686.289411317688, 23742.0, 7741.535507869546, 7761.9611901940125, 7798.103218129874, 7817.257360550739, 8021.478603890729, 3344.832758362121, 3680.3191409589313, 3853.4412510185866, 4001.819463258346, 4166.458360413127, 3767.321882061255, 3808.21931504041, 3818.3508803503473, 3821.980890095532, 3827.158025234444, 659.3011407907633, 660.8909529927508, 670.9765158219536, 675.1054852320694, 697.0902971621981, 558.2184941082517, 593.3739904400899, 604.4892066204051, 608.3976862905691, 634.6667999300312, 7369.373603243677, 8537.231649151607, 8546.31629469641, 8640.956795216109, 8647.400454864477, 539.6654074473852, 566.5382713088902, 574.615007944678, 615.8368032471399, 617.3178637605471, 3986.720825644061, 4026.7583944963394, 4035.152617950205, 4093.5497095319492, 4269.637080848162, 97007.51496242615, 97916.0, 97918.02081979232, 99684.0, 99796.0, 63409.659034097145, 81979.59010204911, 82615.586922065, 83650.58174709088, 83868.58065709754, 69300.999999999, 69955.0, 71318.0, 71712.64143679249, 72131.2786872135, 7863.174366691415, 8114.229148230908, 8132.837343252983, 8173.836523269621, 8290.33677305802, 49105.0, 49357.506424935294, 49827.75086124546, 51088.97822043464, 51326.716832078004, 65250.67374663286, 69610.65194673995, 69682.9095127147, 71366.64316678383, 72871.63564182357, 9007.828982232268, 9952.651657191964, 10251.692449226535, 10356.689299321033, 10368.170546356425, 9074.773130671787, 11278.830817537579, 11348.602798901999, 11449.656510304705, 11953.581624643095, 11451.656450306504, 11631.825522617337, 11778.705532361759, 11794.115441341763, 12030.09774266951, 11374.488148033193, 11522.53909843597, 11801.881981180079, 11839.61794846277, 11848.28910265387, 10738.302010369302, 11148.331100134017, 11457.968782809587, 11462.197646164688, 11579.421028948687, 9666.854997175189, 9795.118439340493, 9838.60645574169, 9909.456489782284, 10045.648402305884, 9343.579538920629, 9913.206943444651, 9921.801563968536, 9937.701868943943, 9991.25065620067], "value": 7110.911594117977, "unit": "score"}], "name": "dromaeo_css", "value": 7547.835148794299, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 119.0, 113.0, 112.0, 111.0, 114.0, 113.0, 114.0, 133.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 121.0, 140.0, 168.0, 142.0, 170.0, 166.0, 140.0, 171.0, 117.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 184.0, 185.0, 186.0, 183.0, 185.0, 187.0, 184.0, 184.0], "value": 185.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 80.0, 72.0, 159.0, 73.0, 78.0, 78.0, 62.0, 131.0, 58.0], "value": 86.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 141.0, 80.0, 77.0, 80.0, 122.0, 76.0, 78.0, 127.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 89.0, 85.0, 87.0, 86.0, 89.0, 85.0, 87.0, 83.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 95.0, 96.0, 93.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 84.0, 88.0, 84.0, 83.0, 83.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 63.0, 63.0, 58.0, 64.0, 62.0, 77.0, 59.0, 57.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 62.0, 72.0, 69.0, 70.0, 72.0, 67.0, 67.0, 66.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 79.0, 81.0, 79.0, 80.0, 79.0, 79.0, 84.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 129.0, 124.0, 126.0, 137.0, 139.0, 123.0, 126.0, 167.0, 163.0], "value": 136.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 164.0, 160.0, 166.0, 164.0, 165.0, 207.0, 150.0, 197.0, 206.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 66.0, 67.0, 68.0, 67.0, 66.0, 70.0, 68.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1483.8999999999999, "alertThreshold": 2.0}]} 09:16:06 INFO - Return code: 0 09:16:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:16:06 ERROR - # TBPL SUCCESS # 09:16:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:16:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:16:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:16:06 INFO - 2016-07-01 09:16:06.893 screenresolution[1684:10277] starting screenresolution argv=screenresolution get 09:16:06 INFO - 2016-07-01 09:16:06.896 screenresolution[1684:10277] Display 0: 1600x1200x32@60 09:16:06 INFO - 2016-07-01 09:16:06.902 screenresolution[1685:10280] starting screenresolution argv=screenresolution list 09:16:06 INFO - Available Modes on Display 0 09:16:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:16:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:16:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:16:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:16:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:16:07 INFO - Intel Iris: 09:16:07 INFO - Chipset Model: Intel Iris 09:16:07 INFO - Type: GPU 09:16:07 INFO - Bus: Built-In 09:16:07 INFO - VRAM (Dynamic, Max): 1536 MB 09:16:07 INFO - Vendor: Intel (0x8086) 09:16:07 INFO - Device ID: 0x0a2e 09:16:07 INFO - Revision ID: 0x0009 09:16:07 INFO - Displays: 09:16:07 INFO - Display: 09:16:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:16:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:16:07 INFO - Display Serial Number: 1600x1200 60 09:16:07 INFO - Main Display: Yes 09:16:07 INFO - Mirror: Off 09:16:07 INFO - Online: Yes 09:16:07 INFO - Rotation: Supported 09:16:07 INFO - Return code: 0 09:16:07 INFO - Running post-action listener: _resource_record_post_action 09:16:07 INFO - Running post-run listener: _resource_record_post_run 09:16:08 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 48298496; Write bytes: 504199680; Read time: 380; Write time: 1618 09:16:08 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194791936; Write bytes: 196147200; Read time: 17599; Write time: 448 09:16:08 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 46516736; Write bytes: 307032576; Read time: 366; Write time: 1166 09:16:08 INFO - Running post-run listener: _upload_blobber_files 09:16:08 INFO - Blob upload gear active. 09:16:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:16:08 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 09:16:08 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'] 09:16:08 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 09:16:08 INFO - (blobuploader) - INFO - Open directory for files ... 09:16:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:16:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:16:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:09 INFO - (blobuploader) - INFO - Done attempting. 09:16:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:16:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:16:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:10 INFO - (blobuploader) - INFO - Done attempting. 09:16:10 INFO - (blobuploader) - INFO - Iteration through files over. 09:16:10 INFO - Return code: 0 09:16:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:16:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:16:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a235fcf06e100a768a474dd2ba8d978fb62258478cb84bfc71ca029f7cebcda87a0081bd2296dd6f69cd4f6e5877b6401f6adcdfca88dffcb8ad8c57c87e17cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/371aff7690078722ceb7fb96053d64de93e14f46f7de10280bbdf0dfa3f58ea8cc2d19ff768dcd6bd8c26dbe295dedb1523a7fcef67efba24cf4284f0a1f1eb7"} 09:16:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:16:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:16:10 INFO - Contents: 09:16:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a235fcf06e100a768a474dd2ba8d978fb62258478cb84bfc71ca029f7cebcda87a0081bd2296dd6f69cd4f6e5877b6401f6adcdfca88dffcb8ad8c57c87e17cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/371aff7690078722ceb7fb96053d64de93e14f46f7de10280bbdf0dfa3f58ea8cc2d19ff768dcd6bd8c26dbe295dedb1523a7fcef67efba24cf4284f0a1f1eb7"} 09:16:10 INFO - Running post-run listener: copy_logs_to_upload_dir 09:16:10 INFO - Copying logs to upload dir... 09:16:10 INFO - mkdir: /builds/slave/test/build/upload/logs 09:16:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.304953 ========= master_lag: 1.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-07-01 09:16:11.942902) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 09:16:11.946145) ========= 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.TSsrTaZs7F/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.swlw1kqvdv/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a235fcf06e100a768a474dd2ba8d978fb62258478cb84bfc71ca029f7cebcda87a0081bd2296dd6f69cd4f6e5877b6401f6adcdfca88dffcb8ad8c57c87e17cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/371aff7690078722ceb7fb96053d64de93e14f46f7de10280bbdf0dfa3f58ea8cc2d19ff768dcd6bd8c26dbe295dedb1523a7fcef67efba24cf4284f0a1f1eb7"} build_url:https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a235fcf06e100a768a474dd2ba8d978fb62258478cb84bfc71ca029f7cebcda87a0081bd2296dd6f69cd4f6e5877b6401f6adcdfca88dffcb8ad8c57c87e17cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/371aff7690078722ceb7fb96053d64de93e14f46f7de10280bbdf0dfa3f58ea8cc2d19ff768dcd6bd8c26dbe295dedb1523a7fcef67efba24cf4284f0a1f1eb7"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 09:16:11.983078) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 09:16:11.983409) ========= 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.TSsrTaZs7F/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.swlw1kqvdv/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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.005255 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 09:16:12.036118) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 09:16:12.036869) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 09:16:12.037667) ========= ========= Total master_lag: 1.29 =========