builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0238 starttime: 1465235108.14 results: success (0) buildid: 20160601172046 builduid: e9d26e5e91854a5abc1e9b81ef0712cd revision: 96437abde2ecbab4f3ac771320c213debde6b43c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:08.139115) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:08.139525) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:08.139790) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:08.210611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:08.210886) ========= 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.6CdwB9H2ZR/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.DEfmS8QSbx/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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-06-06 10:45:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 165M=0s 2016-06-06 10:45:08 (165 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.591114 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:08.826670) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:08.826976) ========= 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.6CdwB9H2ZR/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.DEfmS8QSbx/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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.024464 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:08.875198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 10:45:08.875717) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 96437abde2ecbab4f3ac771320c213debde6b43c --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 96437abde2ecbab4f3ac771320c213debde6b43c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6CdwB9H2ZR/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.DEfmS8QSbx/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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-06-06 10:45:08,955 truncating revision to first 12 chars 2016-06-06 10:45:08,956 Setting DEBUG logging. 2016-06-06 10:45:08,956 attempt 1/10 2016-06-06 10:45:08,956 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/96437abde2ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 10:45:09,993 unpacking tar archive at: mozilla-beta-96437abde2ec/testing/mozharness/ program finished with exit code 0 elapsedTime=1.314436 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 10:45:10.212035) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:10.212329) ========= script_repo_revision: 96437abde2ecbab4f3ac771320c213debde6b43c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:10.212693) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:10.212947) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:10.230496) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 44 secs) (at 2016-06-06 10:45:10.230761) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6CdwB9H2ZR/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.DEfmS8QSbx/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 10:45:10 INFO - MultiFileLogger online at 20160606 10:45:10 in /builds/slave/test 10:45:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:45:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:45:10 INFO - {'append_to_log': False, 10:45:10 INFO - 'base_work_dir': '/builds/slave/test', 10:45:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:45:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:45:10 INFO - 'branch': 'Mozilla-Beta', 10:45:10 INFO - 'buildbot_json_path': 'buildprops.json', 10:45:10 INFO - 'config_files': ('talos/mac_config.py',), 10:45:10 INFO - 'default_actions': ('clobber', 10:45:10 INFO - 'read-buildbot-config', 10:45:10 INFO - 'download-and-extract', 10:45:10 INFO - 'populate-webroot', 10:45:10 INFO - 'create-virtualenv', 10:45:10 INFO - 'install', 10:45:10 INFO - 'run-tests'), 10:45:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:45:10 INFO - 'download_minidump_stackwalk': True, 10:45:10 INFO - 'download_symbols': 'ondemand', 10:45:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:45:10 INFO - 'tooltool.py': '/tools/tooltool.py', 10:45:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:45:10 INFO - '/tools/misc-python/virtualenv.py')}, 10:45:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:45:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:45:10 INFO - 'installer_path': 'installer.exe', 10:45:10 INFO - 'log_level': 'info', 10:45:10 INFO - 'log_name': 'talos', 10:45:10 INFO - 'log_to_console': True, 10:45:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:45:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:45:10 INFO - 'opt_config_files': (), 10:45:10 INFO - 'pip_index': False, 10:45:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:45:10 INFO - 'cmd': ('bash', 10:45:10 INFO - '-c', 10:45:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:45:10 INFO - 'enabled': True, 10:45:10 INFO - 'halt_on_failure': False, 10:45:10 INFO - 'name': 'check_screen_resolution'},), 10:45:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:45:10 INFO - 'cmd': ('bash', 10:45:10 INFO - '-c', 10:45:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:45:10 INFO - 'enabled': True, 10:45:10 INFO - 'halt_on_failure': False, 10:45:10 INFO - 'name': 'check_screen_resolution'},), 10:45:10 INFO - 'run_cmd_checks_enabled': True, 10:45:10 INFO - 'sps_profile': False, 10:45:10 INFO - 'sps_profile_interval': 0, 10:45:10 INFO - 'suite': 'dromaeojs-e10s', 10:45:10 INFO - 'system_bits': '32', 10:45:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:45:10 INFO - 'title': 't-yosemite-r7-0238', 10:45:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:45:10 INFO - 'use_talos_json': True, 10:45:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:45:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:45:10 INFO - 'work_dir': 'build'} 10:45:10 INFO - ##### 10:45:10 INFO - ##### Running clobber step. 10:45:10 INFO - ##### 10:45:10 INFO - Running pre-action listener: _resource_record_pre_action 10:45:10 INFO - Running main action method: clobber 10:45:10 INFO - rmtree: /builds/slave/test/build 10:45:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:45:12 INFO - Running post-action listener: _resource_record_post_action 10:45:12 INFO - ##### 10:45:12 INFO - ##### Running read-buildbot-config step. 10:45:12 INFO - ##### 10:45:12 INFO - Running pre-action listener: _resource_record_pre_action 10:45:12 INFO - Running main action method: read_buildbot_config 10:45:12 INFO - Using buildbot properties: 10:45:12 INFO - { 10:45:12 INFO - "project": "", 10:45:12 INFO - "product": "firefox", 10:45:12 INFO - "script_repo_revision": "production", 10:45:12 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 10:45:12 INFO - "repository": "", 10:45:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 10:45:12 INFO - "buildid": "20160601172046", 10:45:12 INFO - "pgo_build": "False", 10:45:12 INFO - "basedir": "/builds/slave/test", 10:45:12 INFO - "buildnumber": 0, 10:45:12 INFO - "slavename": "t-yosemite-r7-0238", 10:45:12 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:45:12 INFO - "platform": "yosemite_r7", 10:45:12 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:45:12 INFO - "branch": "mozilla-beta", 10:45:12 INFO - "repo_path": "releases/mozilla-beta", 10:45:12 INFO - "revision": "96437abde2ecbab4f3ac771320c213debde6b43c", 10:45:12 INFO - "stage_platform": "macosx64", 10:45:12 INFO - "builduid": "e9d26e5e91854a5abc1e9b81ef0712cd", 10:45:12 INFO - "slavebuilddir": "test" 10:45:12 INFO - } 10:45:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 10:45:12 INFO - Running post-action listener: _resource_record_post_action 10:45:12 INFO - ##### 10:45:12 INFO - ##### Running download-and-extract step. 10:45:12 INFO - ##### 10:45:12 INFO - Running pre-action listener: _resource_record_pre_action 10:45:12 INFO - Running main action method: download_and_extract 10:45:12 INFO - mkdir: /builds/slave/test/build/tests 10:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:45:12 INFO - https://queue.taskcluster.net/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:45:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 10:45:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 10:45:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 10:45:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 10:45:34 INFO - Downloaded 1241 bytes. 10:45:34 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 10:45:34 INFO - Using the following test package requirements: 10:45:34 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:45:34 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:34 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 10:45:34 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:34 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 10:45:34 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:45:34 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:34 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 10:45:34 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:45:34 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:34 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 10:45:34 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:34 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 10:45:34 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:34 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 10:45:34 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:45:34 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:34 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 10:45:34 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 10:45: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')]} 10:45:34 INFO - https://queue.taskcluster.net/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:45:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:45:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:45:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 10:45:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 10:45:37 INFO - Downloaded 17816937 bytes. 10:45:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:45:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:45:40 INFO - Return code: 0 10:45:40 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:45:40 INFO - https://queue.taskcluster.net/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:45:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:45:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:45:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 10:45:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 10:46:14 INFO - Downloaded 17816937 bytes. 10:46:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:46:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:46:18 INFO - Return code: 0 10:46:18 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')]} 10:46:18 INFO - https://queue.taskcluster.net/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:46:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 10:46:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 10:46:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 10:46:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 10:46:19 INFO - Downloaded 10845194 bytes. 10:46:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:46:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:46:20 INFO - Return code: 0 10:46:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:46:20 INFO - https://queue.taskcluster.net/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 10:46:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:46:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:46:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 10:46:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 10:46:22 INFO - Downloaded 88466286 bytes. 10:46:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:46:22 INFO - mkdir: /builds/slave/test/properties 10:46:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:46:22 INFO - Writing to file /builds/slave/test/properties/build_url 10:46:22 INFO - Contents: 10:46:22 INFO - build_url:https://queue.taskcluster.net/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:46:23 INFO - Running post-action listener: _resource_record_post_action 10:46:23 INFO - Running post-action listener: set_extra_try_arguments 10:46:23 INFO - ##### 10:46:23 INFO - ##### Running populate-webroot step. 10:46:23 INFO - ##### 10:46:23 INFO - Running pre-action listener: _resource_record_pre_action 10:46:23 INFO - Running main action method: populate_webroot 10:46:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:46:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:46:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:46:23 INFO - '--tppagecycles', 10:46:23 INFO - '7'], 10:46:23 INFO - 'tests': ['tsvgm']}}, 10:46:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:46:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:46:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:46:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:46:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:46:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:46:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:46:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:23 INFO - 'talos_options': ['--e10s'], 10:46:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:46:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:23 INFO - 'tests': ['damp', 'tps']}, 10:46:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:23 INFO - 'talos_options': ['--e10s'], 10:46:23 INFO - 'tests': ['damp', 'tps']}, 10:46:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:46:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:46:23 INFO - 'other': {'tests': ['a11yr', 10:46:23 INFO - 'ts_paint', 10:46:23 INFO - 'tpaint', 10:46:23 INFO - 'sessionrestore', 10:46:23 INFO - 'sessionrestore_no_auto_restore', 10:46:23 INFO - 'tabpaint']}, 10:46:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:46:23 INFO - 'tests': ['a11yr', 10:46:23 INFO - 'ts_paint', 10:46:23 INFO - 'tpaint', 10:46:23 INFO - 'sessionrestore', 10:46:23 INFO - 'sessionrestore_no_auto_restore', 10:46:23 INFO - 'tabpaint']}, 10:46:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:46:23 INFO - 'tests': ['a11yr', 10:46:23 INFO - 'ts_paint', 10:46:23 INFO - 'tpaint', 10:46:23 INFO - 'sessionrestore', 10:46:23 INFO - 'sessionrestore_no_auto_restore', 10:46:23 INFO - 'tabpaint']}, 10:46:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:46:23 INFO - 'tests': ['a11yr', 10:46:23 INFO - 'ts_paint', 10:46:23 INFO - 'tpaint', 10:46:23 INFO - 'sessionrestore', 10:46:23 INFO - 'sessionrestore_no_auto_restore', 10:46:23 INFO - 'tabpaint']}, 10:46:23 INFO - 'other_l64': {'tests': ['a11yr', 10:46:23 INFO - 'ts_paint', 10:46:23 INFO - 'tpaint', 10:46:23 INFO - 'sessionrestore', 10:46:23 INFO - 'sessionrestore_no_auto_restore', 10:46:23 INFO - 'tabpaint']}, 10:46:23 INFO - 'other_nol64': {'tests': ['a11yr', 10:46:23 INFO - 'ts_paint', 10:46:23 INFO - 'tpaint', 10:46:23 INFO - 'sessionrestore', 10:46:23 INFO - 'sessionrestore_no_auto_restore', 10:46:23 INFO - 'tabpaint']}, 10:46:23 INFO - 'svgr': {'tests': ['tsvgx', 10:46:23 INFO - 'tsvgr_opacity', 10:46:23 INFO - 'tart', 10:46:23 INFO - 'tscrollx', 10:46:23 INFO - 'cart']}, 10:46:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:46:23 INFO - 'tests': ['tsvgx', 10:46:23 INFO - 'tsvgr_opacity', 10:46:23 INFO - 'tart', 10:46:23 INFO - 'tscrollx', 10:46:23 INFO - 'cart']}, 10:46:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:23 INFO - 'tests': ['tp5o']}, 10:46:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:23 INFO - 'talos_options': ['--e10s'], 10:46:23 INFO - 'tests': ['tp5o']}, 10:46:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:23 INFO - 'talos_options': ['--xperf_path', 10:46:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:46:23 INFO - 'tests': ['tp5n']}, 10:46:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:23 INFO - 'talos_options': ['--e10s', 10:46:23 INFO - '--xperf_path', 10:46:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:46:23 INFO - 'tests': ['tp5n']}}, 10:46:23 INFO - 'talos.zip': {'path': '', 10:46:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:46:23 INFO - Running post-action listener: _resource_record_post_action 10:46:23 INFO - ##### 10:46:23 INFO - ##### Running create-virtualenv step. 10:46:23 INFO - ##### 10:46:23 INFO - Running pre-action listener: _resource_record_pre_action 10:46:23 INFO - Running main action method: create_virtualenv 10:46:23 INFO - Creating virtualenv /builds/slave/test/build/venv 10:46:23 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 10:46:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:46:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:46:23 INFO - Using real prefix '/tools/python27' 10:46:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:46:24 INFO - Installing distribute.............................................................................................................................................................................................done. 10:46:27 INFO - Installing pip.................done. 10:46:27 INFO - Return code: 0 10:46:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:46:27 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')]} 10:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:27 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')]} 10:46:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:27 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 0x1081cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081d44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9aa8494ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108071d30>, '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 0x107ed5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108068b20>, '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.6CdwB9H2ZR/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.DEfmS8QSbx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 10:46:27 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 10:46:27 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 10:46:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6CdwB9H2ZR/Render', 10:46:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:27 INFO - 'HOME': '/Users/cltbld', 10:46:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:27 INFO - 'LOGNAME': 'cltbld', 10:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:27 INFO - 'MOZ_NO_REMOTE': '1', 10:46:27 INFO - 'NO_EM_RESTART': '1', 10:46:27 INFO - 'PAGER': '/bin/cat', 10:46:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:27 INFO - 'PWD': '/builds/slave/test', 10:46:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:27 INFO - 'SHELL': '/bin/bash', 10:46:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEfmS8QSbx/Listeners', 10:46:27 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 10:46:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:27 INFO - 'USER': 'cltbld', 10:46:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:27 INFO - 'XPC_FLAGS': '0x0', 10:46:27 INFO - 'XPC_SERVICE_NAME': '0', 10:46:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:27 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 10:46:27 INFO - Cleaning up... 10:46:27 INFO - Return code: 0 10:46:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:46:27 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')]} 10:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:27 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')]} 10:46:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:27 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 0x1081cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081d44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9aa8494ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108071d30>, '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 0x107ed5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108068b20>, '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.6CdwB9H2ZR/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.DEfmS8QSbx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 10:46:27 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 10:46:27 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 10:46:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6CdwB9H2ZR/Render', 10:46:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:27 INFO - 'HOME': '/Users/cltbld', 10:46:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:27 INFO - 'LOGNAME': 'cltbld', 10:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:27 INFO - 'MOZ_NO_REMOTE': '1', 10:46:27 INFO - 'NO_EM_RESTART': '1', 10:46:27 INFO - 'PAGER': '/bin/cat', 10:46:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:27 INFO - 'PWD': '/builds/slave/test', 10:46:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:27 INFO - 'SHELL': '/bin/bash', 10:46:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEfmS8QSbx/Listeners', 10:46:27 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 10:46:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:27 INFO - 'USER': 'cltbld', 10:46:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:27 INFO - 'XPC_FLAGS': '0x0', 10:46:27 INFO - 'XPC_SERVICE_NAME': '0', 10:46:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:27 INFO - Downloading/unpacking psutil>=0.7.1 10:46:28 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 10:46:28 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 10:46:28 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 10:46:28 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 10:46:28 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 10:46:28 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 10:46:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:46:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:46:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:46:30 INFO - Installing collected packages: psutil 10:46:30 INFO - Running setup.py install for psutil 10:46:31 INFO - building 'psutil._psutil_osx' extension 10:46:31 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 10:46:31 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 10:46:31 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 10:46:31 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 10:46:31 INFO - building 'psutil._psutil_posix' extension 10:46:31 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 10:46:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:46:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:46:31 INFO - ^ 10:46:31 INFO - 1 warning generated. 10:46:31 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 10:46:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:46:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:46:32 INFO - Successfully installed psutil 10:46:32 INFO - Cleaning up... 10:46:32 INFO - Return code: 0 10:46:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:46:32 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')]} 10:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:32 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')]} 10:46:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:32 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 0x1081cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081d44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9aa8494ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108071d30>, '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 0x107ed5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108068b20>, '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.6CdwB9H2ZR/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.DEfmS8QSbx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 10:46:32 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 10:46:32 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 10:46:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6CdwB9H2ZR/Render', 10:46:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:32 INFO - 'HOME': '/Users/cltbld', 10:46:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:32 INFO - 'LOGNAME': 'cltbld', 10:46:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:32 INFO - 'MOZ_NO_REMOTE': '1', 10:46:32 INFO - 'NO_EM_RESTART': '1', 10:46:32 INFO - 'PAGER': '/bin/cat', 10:46:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:32 INFO - 'PWD': '/builds/slave/test', 10:46:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:32 INFO - 'SHELL': '/bin/bash', 10:46:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEfmS8QSbx/Listeners', 10:46:32 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 10:46:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:32 INFO - 'USER': 'cltbld', 10:46:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:32 INFO - 'XPC_FLAGS': '0x0', 10:46:32 INFO - 'XPC_SERVICE_NAME': '0', 10:46:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:46:32 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 10:46:32 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 10:46:32 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 10:46:32 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 10:46:32 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 10:46:32 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 10:46:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:46:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:46:34 INFO - Installing collected packages: mozsystemmonitor 10:46:34 INFO - Running setup.py install for mozsystemmonitor 10:46:35 INFO - Successfully installed mozsystemmonitor 10:46:35 INFO - Cleaning up... 10:46:35 INFO - Return code: 0 10:46:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:46:35 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')]} 10:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:35 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')]} 10:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:35 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 0x1081cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081d44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9aa8494ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108071d30>, '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 0x107ed5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108068b20>, '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.6CdwB9H2ZR/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.DEfmS8QSbx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 10:46:35 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 10:46:35 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 10:46:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6CdwB9H2ZR/Render', 10:46:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:35 INFO - 'HOME': '/Users/cltbld', 10:46:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:35 INFO - 'LOGNAME': 'cltbld', 10:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:35 INFO - 'MOZ_NO_REMOTE': '1', 10:46:35 INFO - 'NO_EM_RESTART': '1', 10:46:35 INFO - 'PAGER': '/bin/cat', 10:46:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:35 INFO - 'PWD': '/builds/slave/test', 10:46:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:35 INFO - 'SHELL': '/bin/bash', 10:46:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEfmS8QSbx/Listeners', 10:46:35 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 10:46:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:35 INFO - 'USER': 'cltbld', 10:46:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:35 INFO - 'XPC_FLAGS': '0x0', 10:46:35 INFO - 'XPC_SERVICE_NAME': '0', 10:46:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:35 INFO - Downloading/unpacking blobuploader==1.2.4 10:46:35 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 10:46:35 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 10:46:35 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 10:46:35 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 10:46:35 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 10:46:35 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 10:46:37 INFO - Downloading blobuploader-1.2.4.tar.gz 10:46:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:46:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:46:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:39 INFO - Downloading docopt-0.6.1.tar.gz 10:46:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:46:39 INFO - Installing collected packages: blobuploader, requests, docopt 10:46:39 INFO - Running setup.py install for blobuploader 10:46:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:46:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:46:39 INFO - Running setup.py install for requests 10:46:39 INFO - Running setup.py install for docopt 10:46:39 INFO - Successfully installed blobuploader requests docopt 10:46:39 INFO - Cleaning up... 10:46:40 INFO - Return code: 0 10:46:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:40 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 0x1081cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081d44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9aa8494ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108071d30>, '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 0x107ed5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108068b20>, '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.6CdwB9H2ZR/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.DEfmS8QSbx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 10:46:40 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 10:46:40 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 10:46:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6CdwB9H2ZR/Render', 10:46:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:40 INFO - 'HOME': '/Users/cltbld', 10:46:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:40 INFO - 'LOGNAME': 'cltbld', 10:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:40 INFO - 'MOZ_NO_REMOTE': '1', 10:46:40 INFO - 'NO_EM_RESTART': '1', 10:46:40 INFO - 'PAGER': '/bin/cat', 10:46:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:40 INFO - 'PWD': '/builds/slave/test', 10:46:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:40 INFO - 'SHELL': '/bin/bash', 10:46:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEfmS8QSbx/Listeners', 10:46:40 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 10:46:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:40 INFO - 'USER': 'cltbld', 10:46:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:40 INFO - 'XPC_FLAGS': '0x0', 10:46:40 INFO - 'XPC_SERVICE_NAME': '0', 10:46:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:46:40 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-COdt5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:46:40 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-qbqk3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:46:40 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-rM37a6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:46:40 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-T38ZbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:46:40 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-VjQp4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:46:40 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-dedNx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:46:40 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-0ynmXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:46:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-C0k7tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:46:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-3OfYOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:46:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-P8CAVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:46:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-q0HnqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:46:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-0Qp7jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:46:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-z9pg8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:46:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-IKjwIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:46:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-NVOQRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:46:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-bogWQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:46:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-IK5Td3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:46:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:46:42 INFO - Running setup.py install for manifestparser 10:46:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:46:42 INFO - Running setup.py install for mozcrash 10:46:42 INFO - Running setup.py install for mozdebug 10:46:42 INFO - Running setup.py install for mozdevice 10:46:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:46:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:46:42 INFO - Running setup.py install for mozfile 10:46:42 INFO - Running setup.py install for mozhttpd 10:46:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:46:42 INFO - Running setup.py install for mozinfo 10:46:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:46:43 INFO - Running setup.py install for mozInstall 10:46:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:46:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:46:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:46:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:46:43 INFO - Running setup.py install for mozleak 10:46:43 INFO - Running setup.py install for mozlog 10:46:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:46:43 INFO - Running setup.py install for moznetwork 10:46:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:46:43 INFO - Running setup.py install for mozprocess 10:46:43 INFO - Running setup.py install for mozprofile 10:46:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:46:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:46:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:46:43 INFO - Running setup.py install for mozrunner 10:46:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:46:44 INFO - Running setup.py install for mozscreenshot 10:46:44 INFO - Running setup.py install for moztest 10:46:44 INFO - Running setup.py install for mozversion 10:46:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:46:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:46:44 INFO - Cleaning up... 10:46:44 INFO - Return code: 0 10:46:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:44 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 0x1081cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081d44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9aa8494ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108071d30>, '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 0x107ed5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108068b20>, '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.6CdwB9H2ZR/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.DEfmS8QSbx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 10:46:44 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 10:46:44 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 10:46:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6CdwB9H2ZR/Render', 10:46:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:44 INFO - 'HOME': '/Users/cltbld', 10:46:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:44 INFO - 'LOGNAME': 'cltbld', 10:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:44 INFO - 'MOZ_NO_REMOTE': '1', 10:46:44 INFO - 'NO_EM_RESTART': '1', 10:46:44 INFO - 'PAGER': '/bin/cat', 10:46:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:44 INFO - 'PWD': '/builds/slave/test', 10:46:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:44 INFO - 'SHELL': '/bin/bash', 10:46:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEfmS8QSbx/Listeners', 10:46:44 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 10:46:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:44 INFO - 'USER': 'cltbld', 10:46:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:44 INFO - 'XPC_FLAGS': '0x0', 10:46:44 INFO - 'XPC_SERVICE_NAME': '0', 10:46:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:46:44 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-lzy75H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:46:44 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)) 10:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:46:44 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-XceoPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:46:45 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)) 10:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:46:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-EVi4Yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:46:45 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)) 10:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:46:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-m1LbxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:46:45 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)) 10:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:46:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-xOVzLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:46:45 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)) 10:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:46:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-7Uz3jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:46:45 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)) 10:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:46:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-1LZaPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:46:45 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)) 10:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:46:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-7ZlFos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:46:45 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)) 10:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:46:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-NckZes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:46:45 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)) 10:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:46:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-U76GYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:46:45 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)) 10:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:46:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-ZaN1rU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:46:45 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)) 10:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:46:46 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-BlctHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:46:46 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)) 10:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:46:46 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-yEURY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:46:46 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)) 10:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:46:46 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-MKrNBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:46:46 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)) 10:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:46:46 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-iq2Yoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:46:46 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)) 10:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:46:46 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-9e5gKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:46:46 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)) 10:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:46:46 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-sUieBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:46:46 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)) 10:46:46 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)) 10:46:46 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)) 10:46:46 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)) 10:46:46 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)) 10:46:46 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)) 10:46:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:46: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 10:46: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 10:46: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 10:46: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 10:46: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 10:46: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 10:46:49 INFO - Downloading blessings-1.6.tar.gz 10:46:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:46:49 INFO - Installing collected packages: blessings 10:46:49 INFO - Running setup.py install for blessings 10:46:49 INFO - Successfully installed blessings 10:46:49 INFO - Cleaning up... 10:46:49 INFO - Return code: 0 10:46:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:46:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:46:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:46:49 INFO - Reading from file tmpfile_stdout 10:46:49 INFO - Current package versions: 10:46:49 INFO - blessings == 1.6 10:46:49 INFO - blobuploader == 1.2.4 10:46:49 INFO - docopt == 0.6.1 10:46:49 INFO - manifestparser == 1.1 10:46:49 INFO - mozInstall == 1.12 10:46:49 INFO - mozcrash == 0.17 10:46:49 INFO - mozdebug == 0.1 10:46:49 INFO - mozdevice == 0.48 10:46:49 INFO - mozfile == 1.2 10:46:49 INFO - mozhttpd == 0.7 10:46:49 INFO - mozinfo == 0.9 10:46:49 INFO - mozleak == 0.1 10:46:49 INFO - mozlog == 3.1 10:46:49 INFO - moznetwork == 0.27 10:46:49 INFO - mozprocess == 0.22 10:46:49 INFO - mozprofile == 0.28 10:46:49 INFO - mozrunner == 6.11 10:46:49 INFO - mozscreenshot == 0.1 10:46:49 INFO - mozsystemmonitor == 0.0 10:46:49 INFO - moztest == 0.7 10:46:49 INFO - mozversion == 1.4 10:46:49 INFO - psutil == 3.1.1 10:46:49 INFO - requests == 1.2.3 10:46:49 INFO - wsgiref == 0.1.2 10:46:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:46: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')]} 10:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46: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')]} 10:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:49 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 0x1081cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081d44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9aa8494ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108071d30>, '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 0x107ed5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108068b20>, '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.6CdwB9H2ZR/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.DEfmS8QSbx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 10:46:49 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 10:46:49 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 10:46:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6CdwB9H2ZR/Render', 10:46:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:49 INFO - 'HOME': '/Users/cltbld', 10:46:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:49 INFO - 'LOGNAME': 'cltbld', 10:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:49 INFO - 'MOZ_NO_REMOTE': '1', 10:46:49 INFO - 'NO_EM_RESTART': '1', 10:46:49 INFO - 'PAGER': '/bin/cat', 10:46:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:49 INFO - 'PWD': '/builds/slave/test', 10:46:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:49 INFO - 'SHELL': '/bin/bash', 10:46:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEfmS8QSbx/Listeners', 10:46:49 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 10:46:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:49 INFO - 'USER': 'cltbld', 10:46:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:49 INFO - 'XPC_FLAGS': '0x0', 10:46:49 INFO - 'XPC_SERVICE_NAME': '0', 10:46:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:49 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)) 10:46:49 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)) 10:46:49 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)) 10:46:49 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)) 10:46:49 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)) 10:46:49 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)) 10:46:49 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)) 10:46:49 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)) 10:46:49 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)) 10:46:49 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)) 10:46:49 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)) 10:46:49 INFO - Cleaning up... 10:46:49 INFO - Return code: 0 10:46:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:46: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')]} 10:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46: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')]} 10:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1081cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081d44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9aa8494ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108071d30>, '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 0x107ed5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108068b20>, '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.6CdwB9H2ZR/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.DEfmS8QSbx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 10:46: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', 'jsonschema'] in /builds/slave/test/build 10:46: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 jsonschema 10:46:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6CdwB9H2ZR/Render', 10:46:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:49 INFO - 'HOME': '/Users/cltbld', 10:46:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:49 INFO - 'LOGNAME': 'cltbld', 10:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:49 INFO - 'MOZ_NO_REMOTE': '1', 10:46:49 INFO - 'NO_EM_RESTART': '1', 10:46:49 INFO - 'PAGER': '/bin/cat', 10:46:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:49 INFO - 'PWD': '/builds/slave/test', 10:46:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:49 INFO - 'SHELL': '/bin/bash', 10:46:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEfmS8QSbx/Listeners', 10:46:49 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 10:46:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:49 INFO - 'USER': 'cltbld', 10:46:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:49 INFO - 'XPC_FLAGS': '0x0', 10:46:49 INFO - 'XPC_SERVICE_NAME': '0', 10:46:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:50 INFO - Downloading/unpacking jsonschema 10:46:50 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 10:46:50 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 10:46:50 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 10:46:50 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 10:46:50 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 10:46:50 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 10:46:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:46:52 INFO - Downloading/unpacking functools32 (from jsonschema) 10:46: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 10:46: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 10:46: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 10:46: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 10:46: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 10:46: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 10:46:53 INFO - Downloading functools32-3.2.3-2.tar.gz 10:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:46:53 INFO - warning: no files found matching '*.txt' 10:46:53 INFO - no previously-included directories found matching 'build' 10:46:53 INFO - no previously-included directories found matching 'dist' 10:46:53 INFO - no previously-included directories found matching '.git*' 10:46:53 INFO - Installing collected packages: jsonschema, functools32 10:46:53 INFO - Running setup.py install for functools32 10:46:53 INFO - warning: no files found matching '*.txt' 10:46:53 INFO - no previously-included directories found matching 'build' 10:46:53 INFO - no previously-included directories found matching 'dist' 10:46:53 INFO - no previously-included directories found matching '.git*' 10:46:53 INFO - Successfully installed jsonschema functools32 10:46:53 INFO - Cleaning up... 10:46:53 INFO - Return code: 0 10:46:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:46:53 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')]} 10:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:53 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')]} 10:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:53 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 0x1081cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081d44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9aa8494ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108071d30>, '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 0x107ed5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108068b20>, '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.6CdwB9H2ZR/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.DEfmS8QSbx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 10:46:53 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 10:46:53 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 10:46:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6CdwB9H2ZR/Render', 10:46:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:53 INFO - 'HOME': '/Users/cltbld', 10:46:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:53 INFO - 'LOGNAME': 'cltbld', 10:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:53 INFO - 'MOZ_NO_REMOTE': '1', 10:46:53 INFO - 'NO_EM_RESTART': '1', 10:46:53 INFO - 'PAGER': '/bin/cat', 10:46:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:53 INFO - 'PWD': '/builds/slave/test', 10:46:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:53 INFO - 'SHELL': '/bin/bash', 10:46:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEfmS8QSbx/Listeners', 10:46:53 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 10:46:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:53 INFO - 'USER': 'cltbld', 10:46:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:53 INFO - 'XPC_FLAGS': '0x0', 10:46:53 INFO - 'XPC_SERVICE_NAME': '0', 10:46:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:53 INFO - Downloading/unpacking flake8 10:46:53 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 10:46:53 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 10:46:53 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 10:46:53 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 10:46:53 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 10:46:53 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 10:46:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:46:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:46:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:46:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:46:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:46:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:46:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:46:57 INFO - no previously-included directories found matching 'docs/_build' 10:46:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:46:57 INFO - Running setup.py install for pep8 10:46:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:46:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:46:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:46:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:46:57 INFO - no previously-included directories found matching 'docs/_build' 10:46:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:46:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:46:57 INFO - Cleaning up... 10:46:57 INFO - Return code: 0 10:46:57 INFO - Running post-action listener: _resource_record_post_action 10:46:57 INFO - Running post-action listener: _start_resource_monitoring 10:46:57 INFO - Starting resource monitoring. 10:46:57 INFO - ##### 10:46:57 INFO - ##### Running install step. 10:46:57 INFO - ##### 10:46:57 INFO - Running pre-action listener: _resource_record_pre_action 10:46:57 INFO - Running main action method: install 10:46:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:46:57 INFO - Reading from file tmpfile_stdout 10:46:57 INFO - Detecting whether we're running mozinstall >=1.0... 10:46:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:46:58 INFO - Reading from file tmpfile_stdout 10:46:58 INFO - Output received: 10:46:58 INFO - Usage: mozinstall [options] installer 10:46:58 INFO - Options: 10:46:58 INFO - -h, --help show this help message and exit 10:46:58 INFO - -d DEST, --destination=DEST 10:46:58 INFO - Directory to install application into. [default: 10:46:58 INFO - "/builds/slave/test"] 10:46:58 INFO - --app=APP Application being installed. [default: firefox] 10:46:58 INFO - mkdir: /builds/slave/test/build/application 10:46:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:47:20 INFO - Reading from file tmpfile_stdout 10:47:20 INFO - Output received: 10:47:20 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:47:20 INFO - Running post-action listener: _resource_record_post_action 10:47:20 INFO - ##### 10:47:20 INFO - ##### Running run-tests step. 10:47:20 INFO - ##### 10:47:20 INFO - Running pre-action listener: _resource_record_pre_action 10:47:20 INFO - Running main action method: run_tests 10:47:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:47:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:47:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:47:20 INFO - 2016-06-06 10:47:20.598 screenresolution[1646:8678] starting screenresolution argv=screenresolution get 10:47:20 INFO - 2016-06-06 10:47:20.601 screenresolution[1646:8678] Display 0: 1600x1200x32@60 10:47:20 INFO - 2016-06-06 10:47:20.607 screenresolution[1647:8680] starting screenresolution argv=screenresolution list 10:47:20 INFO - Available Modes on Display 0 10:47:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:47:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:47:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:47:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:47:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:47:20 INFO - Intel Iris: 10:47:20 INFO - Chipset Model: Intel Iris 10:47:20 INFO - Type: GPU 10:47:20 INFO - Bus: Built-In 10:47:20 INFO - VRAM (Dynamic, Max): 1536 MB 10:47:20 INFO - Vendor: Intel (0x8086) 10:47:20 INFO - Device ID: 0x0a2e 10:47:20 INFO - Revision ID: 0x0009 10:47:20 INFO - Displays: 10:47:20 INFO - Display: 10:47:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:47:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:47:20 INFO - Display Serial Number: 1600x1200 60 10:47:20 INFO - Main Display: Yes 10:47:20 INFO - Mirror: Off 10:47:20 INFO - Online: Yes 10:47:20 INFO - Rotation: Supported 10:47:20 INFO - Return code: 0 10:47:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:47:20 INFO - Python 2.7.3 10:47:20 INFO - Return code: 0 10:47:20 INFO - grabbing minidump binary from tooltool 10:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:47:20 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 0x108071d30>, '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 0x107ed5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108068b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:47:20 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 10:47:20 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 10:47:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:47:20 INFO - Return code: 0 10:47:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:47:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:47:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:47:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:47:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:47:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:47:22 INFO - Return code: 0 10:47:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0238', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0238 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:47:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6CdwB9H2ZR/Render', 10:47:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:22 INFO - 'HOME': '/Users/cltbld', 10:47:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:22 INFO - 'LOGNAME': 'cltbld', 10:47:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:47:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:22 INFO - 'MOZ_NO_REMOTE': '1', 10:47:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:47:22 INFO - 'NO_EM_RESTART': '1', 10:47:22 INFO - 'PAGER': '/bin/cat', 10:47:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:22 INFO - 'PWD': '/builds/slave/test', 10:47:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:47:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:22 INFO - 'SHELL': '/bin/bash', 10:47:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEfmS8QSbx/Listeners', 10:47:22 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 10:47:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:22 INFO - 'USER': 'cltbld', 10:47:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:22 INFO - 'XPC_FLAGS': '0x0', 10:47:22 INFO - 'XPC_SERVICE_NAME': '0', 10:47:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0238', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:47:22 INFO - mozversion application_buildid: 20160601172046 10:47:22 INFO - mozversion application_changeset: 96437abde2ecbab4f3ac771320c213debde6b43c 10:47:22 INFO - mozversion application_display_name: Firefox 10:47:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:47:22 INFO - mozversion application_name: Firefox 10:47:22 INFO - mozversion application_remotingname: firefox 10:47:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:47:22 INFO - mozversion application_vendor: Mozilla 10:47:22 INFO - mozversion application_version: 47.0 10:47:22 INFO - mozversion platform_buildid: 20160601172046 10:47:22 INFO - mozversion platform_changeset: 96437abde2ecbab4f3ac771320c213debde6b43c 10:47:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:47:22 INFO - mozversion platform_version: 47.0 10:47:22 INFO - using testdate: 1465235242 10:47:22 INFO - actual date: 1465235242 10:47:22 INFO - starting webserver on 'localhost:49270' 10:47:22 INFO - SUITE-START | Running 2 tests 10:47:22 INFO - TEST-START | dromaeo_css 10:47:22 INFO - operating with platform_type : mac_ 10:47:22 INFO - Initialising browser for dromaeo_css test... 10:47:22 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpsqcdKy/profile http://localhost:49270/getInfo.html) 10:47:25 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 10:47:25 INFO - PROCESS | 1665 | colorDepth:24 10:47:25 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 10:47:25 INFO - PROCESS | 1665 | __metrics 10:47:25 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 10:47:26 INFO - TEST-INFO | 1665: exit 0 10:47:26 INFO - Browser initialized. 10:47:26 INFO - Running cycle 1/1 for dromaeo_css test... 10:47:26 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpsqcdKy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:47:38 INFO - PROCESS | 1671 | RSS: Main: 167854080 10:47:38 INFO - PROCESS | 1671 | 10:48:27 INFO - PROCESS | 1671 | 1465235307649 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] 10:50:38 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 10:50:39 INFO - PROCESS | 1671 | RSS: Main: 178917376 10:50:39 INFO - PROCESS | 1671 | 10:53:41 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 10:53:41 INFO - PROCESS | 1671 | RSS: Main: 190169088 10:53:41 INFO - PROCESS | 1671 | 10:56:43 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 10:56:44 INFO - PROCESS | 1671 | RSS: Main: 192421888 10:56:44 INFO - PROCESS | 1671 | 10:59:45 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 10:59:46 INFO - PROCESS | 1671 | RSS: Main: 195502080 10:59:46 INFO - PROCESS | 1671 | 11:02:48 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 11:02:49 INFO - PROCESS | 1671 | RSS: Main: 194584576 11:02:49 INFO - PROCESS | 1671 | 11:05:51 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 11:05:51 INFO - PROCESS | 1671 | RSS: Main: 199946240 11:05:51 INFO - PROCESS | 1671 | 11:05:51 INFO - PROCESS | 1671 | __start_tp_report 11:05:51 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 11:05:51 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 11:05:51 INFO - PROCESS | 1671 | |i|pagename|runs| 11:05:51 INFO - PROCESS | 1671 | |0;dojo.html;3690.3910854708975;3693.981530092349;3704.407294832827;3705.240425712729;3725.869594564189;5925.703714814258;5968.462838344548;6011.308699499559;6031.487323577496;6038.969805150968;5336.946630533694;5718.71406429679;5979.641221526712;6066.484348830355;6110.480609148217;5400.378956420013;5442.074847275972;5477.4796394342475;5506.421825708303;5580.553555715533;5371.113766228587;5513.42109078547;5522.861928451801;5533.750981205835;5534.308211473566;5395.487428694268;5502.119660854264;5518.227448157241;5519.199716041172;5528.723563821813;4573.085382923396;5549.916751248715;5568.136938774496;5579.358373787006;5591.077472217079;5278.41937386891;5383.569314454834;5439.449756819287;5507.256520369739;5597.160425936101;4560.8859778505475;5501.174823776426;5829.708514574297;5884.6469211847425;5912.940870591282;6256.249250090018;6287.1198032275515;6314.463270622003;6314.93685063148;6340.144080549113;6274.937250627481;6364.936350636527;6385.744570217185;6406.647634380107;6434.388733070397;6141.662208578527;6149.401155699506;6193.256809182927;6193.597416167935;6194.256689197235;5524.309461317335;6466.8682980478225;6520.0871877937125;6554.377334153248;6559.639219842859;6199.132121502993;6224.221972253468;6258.906116408258;6276.246850377984;6286.402791734778;6377.385272038535;6402;6424.196975378078;6424.261209960914;6424.935750642528;6272.3100458949475;6287.2140982377205;6313.494920406357;6316.210473690789;6319.3364696706185;6235.844103897439;6275.341089185661;6280.591761535486;6284.402981716729;6291.433770960635;5101.69389836611;5135.229715542699;5149.124648809711;5151.021305951857;5151.2530683050745;4501.842435514741;4656.8602941911795;4665.2768820832825;4670.972386075058;4696.272077827942;6106.084087386838;6150.384961503813;6169.629822210682;6215.720292586844;6234.3453937336835;6387.914054610727;6420.582662126947;6433.517486188461;6435.388638079375;6472.190976127984;6113.449789518964;6202.0696895465135;6231.719572619243;6235.937640623536;6239.407256310643;5640.633358831663;5651;5659.745311460912;5682.261306030189;5727.77088916447;6609.966950165219;6662.467002639874;6674.2658307586125;6678.532502724763;6687.933120668731;6189.96905015472;6368.395002474757;6408.583442076437;6429.967850160906;6439.034144878306;6546.083548303146;6624.370684784938;6624.735010599522;6629.502787291069;6655.068290439439;6292.119103325446;6308.179936608211;6312.084747711464;6317.210348706411;6319;5358.115910874662;5561.360443549043;6352.237731472253;6383.265924418752;6386.16979792624;5169.431362550041;5960.195373624505;6187.133801267736;6187.16473276102;6209.658468784261;6218.129461875251;6219.533534984985;6228.159198508143;6234.906476402948;6245.68771561411;4750.406199225097;6039.5470339723815;6080.027195648675;6132.263729246545;6153.84615384619;4996.800127994839;6268.592541484789;6284.937150628618;6302.84242893913;6434.581752186093;6222.803958694541;6240.375962403723;6253.030780229072;6259.186305780219;6269.717862696099 11:05:51 INFO - PROCESS | 1671 | |1;ext.html;546.295279089974;577.4946921443736;617.7467238432243;655.0698008827464;674.6188403551994;38222.23555528888;38968.610313896854;39035.414468782954;39081.41377879331;39151.804240978825;35612.46581301282;38847.83456496303;41282.7935860321;41283.380749288706;41329.17341653165;9610.951945240264;9827.164691001273;9835.213182945346;9842.60629574816;9847.16299114576;9639.903600964006;9938.701838944808;9957.253206009542;9961.750956226117;9999.2000639949;9920.503974801268;9927.851082233772;9942.154916832042;9942.304038717293;10022.699319020441;9878.357906736075;9886.307958442912;9891.060349266809;9947.701568952943;10028.44843533609;9713.22294216461;9848.507574621312;9850.9507452463;9859.901400986042;9874.456904870229;34630.653693463246;39672.60327396718;40008;40445;40457;3139.3564319314487;3345.6821601947777;3407.0800883761494;3411.624721280657;3560.7507474476797;27256.727432725816;27357.726422735916;28242;28415.71584284172;28867.855660721772;2747.9450410991867;2765;2781.0683421053973;2794.4271424357958;2832.277769168849;455299;455479;457672.9999999967;457686;462930;46043.539564604594;47070.76464617724;63648.36351636517;64066.359336406036;64416.67791661106;41927.742167735014;43213.135737285076;45604;45842;46402.303965440544;15044.623884402978;15124.924375378052;16916.49250522486;16951.915240423965;17372.3051077958;13609.387577558835;13714.65713357174;13858.653533661538;13926.791098133535;14099.929500352639;13363.864071553833;14339.99620026609;15193.86046046551;15298.617534561503;15325.693486130214;6456.418922297016;6542.640154791532;6575.605463672195;6580.243272023683;6601.2738598754095;969.1519920069939;983.2085171437062;1044.6865940217904;1085.0614218700766;1094.458243169636;30513.847430762704;30897.69102308993;30922.690773092432;31483.685163148533;32216.83891580574;1101.8457415961773;1141.1897552737648;1167.96496105117;1172.3200543684643;1238.1827993524412;14465.85534144666;15054.698906022037;15100.697986040437;15118.924405378122;15449.768253476206;654157;660828;663475;667413;668097;60269.698651506464;60627.69686151629;61054.38945610487;61241.38758612446;61411.771764565354;1555.922203889801;1559.4152192927652;1575.1100628145061;1584.8890577659683;1587.5634200594698;24611.821779904756;30062.098137055924;30191.068197338718;30409;30730.539041914835;52013.7399313001;58470.4152958482;59420.405795941486;59607.1058934125;60231.39768602258;524169;525202;526663;530757;533282;45042.549574505145;45264.32103518384;45363.54636453725;46753.29870051884;46769.29846052244;48227.517724822304;48332;48850.511494884595;48964;50720.492795073056;39080.609193907694;40494.79752601336;40897.795511022254;40924.590754092074;41246.38130427986;38445.807770960964;39001;39547.604523955546;39729.40405893856;40346.59653403428;39481.80259098686;39882.60117398789;40052.399214012396;40680.98297542467;40949.795251023555;31290;33112;33112.668873310955;33253.667463326026;33382.83308583441;25115.99536018539;25385.746142539076;25411.110611128523;25733;25832.741672583787 11:05:51 INFO - PROCESS | 1671 | |2;jquery.html;375.4031090566001;380.88763814674667;384.5942530630185;385.09118480386303;387.2004311097585;20271.290504832334;21685.566288674218;21925.561488770236;22445.21441749535;22592.43518912026;21625.567488650257;21753.347399577997;21757.347279581598;21812.781872181273;22069.227577034806;5809.331926828416;5889.352171261158;6052.092186172087;6105.633661980273;6148.292946311187;5881.382454842244;5883.911741323884;5937.168796368512;6042.093685947099;6044.214252147237;5734.541236701054;5957.195778569902;5973.790917317895;5985.042393217086;6053;4960.131976904027;5787.102999035135;5836.708164591774;5854.648721076749;5915.053591425394;5097.23541468779;5127.077126117298;5180.093483640348;5192.350956130484;5197.8440646780655;25995.61006584903;25999.74000259992;26282.21153365383;26361.472770544675;26579.867100664567;2178.9782102178933;2202.2292197730826;2236.1614394602025;2356.587597170488;2702.9729702702916;11746.471408786625;15467.226638668022;15605.907586468951;15679.608009799733;15854.890157688966;1517.8026856508693;1549.5893588199135;1763.8941663500102;1875.943721688338;1939.7779398978694;71895;74098.62950685267;74187.62906185434;110095.44952275268;112357;11212.383318917375;11514.942425287987;11558.711032224262;11916.46375913086;11997.760044799055;14646.63383415423;14646.707065858836;14684.41262349494;14694.926525367304;14728.926355368154;8388.958055209807;8970.23752981004;9105.726828195166;9123.133302336268;9149;7034.6834392452465;7823.843523129505;7945.64244608994;9290.210332121846;9350.064993500595;3718.888433347004;4614.861554153381;4650.558196971282;4684.273937539687;4684.74233917131;1886.6604011278102;1944.893030883315;1951.6858184135401;1966.852486063551;1968.4586738646988;904.1862323908404;979.6669132494843;983.6016413352604;998.0767789794411;1006.0492834271689;19015.42953711391;21154.894225528773;22121.778782212295;22395.10419583231;22438.88780556087;993.9762045093565;1003.7540802503433;1013.5489707080278;1016.1718199667248;1035.8601588785568;10967.341959482457;11422.828657570142;11466.827997580043;11473.71315717097;11478.598249061242;700853;707888;709319;713281;716272;111748;127480;129971.7507062312;135178;135513;1011.4588695048114;1070.1171533484905;1124.1288001798507;1125.1167833250859;1126.2566705974018;19260.518487037934;19390.903045484683;19869.205231790565;19882.639955083338;19908.60182796365;50630.74684626701;52235.73882130565;53374;53599.46400535945;53804.46195537994;72683.54632907418;75995.62002189954;77594.6120269395;77802;79924.20075799168;8433.87349189775;8473.152684731478;8495.192956669107;8582.699605513777;8772.429792063496;12857.292848893401;13495.122817016863;13629.86370136286;13659.38532766008;13998.580042598738;9750.951245243728;11252.93097155769;11464.828027579426;11517.596884109016;11705.707357316136;11186.384748838893;11765.754876804398;11826.645200643994;11840.467178976794;12050.75898482043;11535.307881527135;11705;11717.359569660084;11860.94069529647;12062.819057714318;8340.374471914753;8364.916350836414;8493.490390576586;8528.403011789114;8659.263962563253;7083.858322833411;10551.366917984946;10752.40861752611;10758.408287543947;12036.75926481483 11:05:51 INFO - PROCESS | 1671 | |3;mootools.html;1667.599776053747;1673.2386764022372;2000.5698774763423;2054.198862443648;2075.2425364741875;7987.241212084858;8375.664973401072;9018.32362572808;9090.045545217748;9115.316351273648;9003.684871029514;9028.954855225731;9050.864237036434;9114.817703645924;9142.45145291283;2557.846529208244;2578.6776652918384;2591.0413147135587;2598.9610155847677;2605.439830436456;2517.2196619048063;2522.848629082261;2524.3815265260037;2525.0783464035585;2533.3033415810614;2558.219742978391;2580.3678098865803;2588.5987671910884;2618.4239467317257;2628.0933078088124;2537.429078457351;2544.185860524633;2545.16009716793;2559.424129570841;2589.197348821862;2449.0938352809576;2473.75262473753;2475.1337032038823;2489.539435204475;2534.4044149624824;9197.632094716204;9209.309301802325;9247.583858726373;9255.444673319622;9294.581743821544;5694.6867922264255;5726.169705392695;5736.196932429463;5781.971090144564;5805.01314776489;3491.3890069238037;3704.148045949447;3806.333891568964;3851.345271303885;3873.360895452247;1075.0485820049234;1081.302559848893;1089.3844977587637;1097.9615713449991;1107.6234080412619;12307.630771076882;12390.31853248062;12503.187292825936;12562.74874502514;12740.80888786669;5065.772040258197;5101;5182.378114626269;5233.581313494911;5264.368275806928;10598.894011059945;10644.308119972176;10662.520186591622;10670.893291067145;10689.83965240522;5803.361630220672;5868.853278667982;5872.412758724094;5878.470937615635;5947.137665038632;4744.074905393415;5078.669886457368;5137.691738495702;5206.062908676399;5306.363236411578;3875.96124038756;3934.626210509997;3947.210557888434;3976.741511801724;4005.5393629732953;1381.1574939287027;1381.2886363522794;1385.778275475919;1395.5743498233137;1406.4303956897472;1188.1564089496383;1205.6744678936814;1211.1703483114095;1235.2218102595486;1242.8135779632946;8455.196756308264;8545.658173673108;8569.957150214334;8581.570921453902;8723.258523025614;1158.4381574936149;1201.9218750781347;1226.7975783995719;1281.0968267371481;1296.7665820152274;6473.2232132144445;6513.316101809337;6563.081168636395;6625.4037136657935;6757.932420675828;9718.319717619841;11286.66140015801;11379.658610241706;11391.373474458984;11473.426328683532;10957.726056848642;11076.224664273423;11269.887301127048;11336.979671829575;11379.317240965403;8666.306695464347;8702.39083264178;8771.342149338698;8827.646894124291;8911.643534258686;8166.224208700164;8340.416170868224;8345;8379.162083791573;8423.157684231528;9469.91096023966;9792.80414391694;10051.99480051989;10088.69733907984;10330.535125919501;8622;10107.595696172364;10352.016558426938;10379.325343852626;10426.165906727596;5533.529649979797;5609.943900560942;7224.711011559479;7283.8543229136185;7386.778396648109;7154.713811447692;8608.78478038054;8624.65501379963;8643.611037503453;8687.305015598864;6583.440407565219;7473.51422157558;7617.390608751176;7646.65590048438;7727.536347818924;7523.930983490288;7602.771916842504;7676.923230767621;7705.537667739954;7810.531368117931;7989.600519974094;8095.02859656845;8109.675612975415;8148.83702325962;8156;7261.164966028763;7336.1930187678245;7346.485745997729;7361.227071157451;7376.815579610553;7476.177620461854;7480.887786683313;7493.213212612815;7525.172231054689;7532.472726909064 11:05:51 INFO - PROCESS | 1671 | |4;prototype.html;340.4875662128497;340.57258141033014;342.5734959974832;342.9074149979506;344.88086160409466;6817.727290908358;6833.487488438368;6861.245263021064;6863.931360686392;6864.382205601495;6202.596831205969;6804.18349798025;6814.114165158535;6839.726410943556;6871.725130994754;3882.417637354405;4795.112904112733;4986.301917731521;5023.095842748304;5093.6943783372935;4969.676970996874;5015.5736762375245;5016.172331565287;5032.320636714052;5039.647224694255;4920.60635149189;4927.950720492803;4935.950640493603;4955.08330958772;4956;4464.73211607303;4488.551144885518;4961.305417241607;4974.179260422026;4995.300657907896;4317.4819021717285;4353.455818022747;4353.586409291112;4353.717008394444;4354.281543545311;6241.843953901143;6396.93603063968;6513.381228783258;6561.835954101138;6589.044588534635;5918.526517878559;5973.1040343948325;5980.102984552308;5991.970040149771;5994.13085102662;7254.911763235504;7261.818454538626;7273.127224733013;7285.125784905792;7292.927070729278;4859.343988561534;4867.148249056401;4868.732219727914;4877.268409738532;4877.780499877514;7549.207333229987;7727;7727.806804829868;7749.4187935904465;7797.532148071134;4415.911681766347;4854.781534830941;4911.803527858917;4941.925871111936;4957.0085982803585;5095.694258344512;5101.234814777738;5102.183650615958;5105.106606343875;5106.361704786902;4824.396950381202;5945.643261404243;5973.641581505123;5988.820335389858;6017.247844019497;7387.409007279405;7393.667284972189;7444.59054751983;7448.031755871702;7476.3271305581675;1651.7522371644109;1703.1314029844868;1708.4276767282852;1735.9913200433916;1763.8853474524115;1112.1158678850334;1131.281636161027;1132.6035887439496;1133;1136.7442325476702;6857;6895;6903.827404314832;6914.585124892523;6923.376896079377;6193.81418557444;7303.269673032654;7473.738419155304;7508.136564295067;7535.663944177322;5813.476787089182;5974.625836057731;6591.077249185022;6816.659167041628;6850;3645;3934.055826601595;3954.268460334847;3959.6832253419657;3979.820908059144;7897.289243968071;7915.920840791634;7997.240262175084;8023.117457079717;8028.357731381476;7860.9213907860185;7872.291493765474;7879.684812607432;7981.1220765715725;8027.719029833927;8080.353571714249;8123.3095186908595;8125.674973001013;8139.75580732579;8173.5504547250475;7477.14012888503;7715.922840771745;7738.8452230953935;7747.070351557623;7788.571628560484;6842.521023528504;7529.435292352986;7571.507851989603;7596.316331530189;7623.69505219785;7908.881366779618;8105.878411823709;8120.106788253169;8125.75622731319;8132.634031468717;4459.308807134899;5010.899782004412;5011.047900898818;5027.974860125676;5040.470750571138;7403.555786652818;7704.30661240491;7739.18738532446;7744.7676569703;7753.147153813189;7376.889346659912;7418;7447.180810110992;7452.701891924262;7455.850882982419;7406.7037318506655;7421.332080112816;7438;7457.921793738086;7480.3641690456925;7007.795322806275;7223.747168849065;7229.204787473479;7254.600996945219;7274.4907856451655;7402.148752893271;7439;7450.813729656585;7476.663550140148;7480.887786683095;7261.419086473175;7275.963620181865;7283.198848126808;7286.085565773733;7300.196978332273 11:05:51 INFO - PROCESS | 1671 | |5;yui.html;712.2201189697283;772.6368606754827;781.1407451803013;789.1950210784998;810.7040930060527;15309.081455112673;15389.1535965522;15393;15492.380304787808;15516.922415387935;14378.568642940729;14518.709625807478;14518.854811451882;14533.273336333168;14540.127592344441;787.193127044778;950.3775027357092;966.2366730283068;985.8324084905584;987.2940847294183;955.9378640388387;965.8068386322728;966.1304825656895;967.2310513142069;967.9661211857587;991.1179050644931;991.861139440479;996.9401835889834;1029.6036026129957;1032.705678881519;983.6360546597733;1005.969820905374;1021.4790456866978;1024.8872624011353;1031.2265800649513;644.5262731892055;651.7653644687908;709.4785332780402;743.7954562495303;747.215423805008;13934.93032534841;14019.929900350535;14032.08791428554;14055.437782488689;14082.225477598728;11451.568553930758;13255.138416003025;13313.933430332883;13424.93287533556;13459.12515686487;10210.234232432524;10291.79416411675;10465.790684186273;10502.264841461101;10518.684439466828;3618.8419705694187;3621.728370372233;3638.07229156566;3662.8901132966053;3829.4064420014943;60941;80570.59714701447;82608.17391826065;84811.57594212051;92027.99999999933;9613.903860961302;9769.853452198222;9817.116459518678;10135.898641013642;10145.898541014643;21655.02552385115;21891.452713681967;21983.670244946337;22022.229221977475;22022.33932982013;7485.962570187223;7625.542467451971;7674.55739009354;7723.343515801107;7757.72847950319;4171.728837625545;4255.6169944705125;4271.10306835568;4307.612314891612;4328.723026707129;3797.9620203798163;3841;3844.4809950656304;3848.942265866014;3850.249201405699;695.3984803145242;695.8086526205334;697.6372286411038;701.6491754122939;703.8240439890028;503.2727708461238;581.9466765155083;604.3015554067163;612.1277180018456;629.6473974574253;8484.236418722221;8533.402661813738;8655.6537738491;8675.739727808175;8839.41090482406;519.4338171393199;620.5811077522654;623.7816764132517;633.5311869216838;634.0710858592184;4030.5969403059457;4050.7974601270407;4112.547619761824;4113.362428823537;4129.359949207877;92910;93534;94839.62900927532;103846.48076759568;104697.38256543495;82348.58825705953;82407.17592824115;83769;83819.58090209632;84176.15823841683;71152;72952.63523682348;72998.63500682462;73487.63256183792;74902.62548687331;6971.721131154697;7921.128675845537;8263.710770123016;8292.83414331722;8394.866692996367;49140.50859491359;50138.74930625324;50760.74619626878;51769.22346164735;52364;72286.63856680683;73803.6309818469;73859.63070184615;74212.25787742053;75602;10331.741706457398;10429.843552346569;10555.52500137511;10607;10672.679819605424;10843.186760993114;11450.427478626201;11489.885101149215;11702.473388697359;11744.647660570197;10714.464276785973;10745.677629671123;10823.242373033812;10993.670189894316;11279.84367715748;10306.690799276033;10312.432816195182;10469.68590942273;10592.258541901992;11205.719857003314;8501.319894408556;10502.842457362993;10551.155907527225;10658.786824263627;11622.418879056182;9697.806043879224;9756.317057805885;9814.762097398296;9884.159846413135;10190.694279171637;8406.243438090602;8566.48601083937;9455.858162127435;9660.806783864424;9912.058354456316 11:05:51 INFO - PROCESS | 1671 | __end_tp_report 11:05:51 INFO - PROCESS | 1671 | __start_cc_report 11:05:51 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,357 11:05:51 INFO - PROCESS | 1671 | __end_cc_report 11:05:51 INFO - PROCESS | 1671 | __startTimestamp1465236351735__endTimestamp 11:05:51 INFO - PROCESS | 1671 | 11:05:51 INFO - PROCESS | 1671 | ------- Summary: start ------- 11:05:51 INFO - PROCESS | 1671 | Number of tests: 6 11:05:51 INFO - PROCESS | 1671 | 11:05:51 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5918.30 Median:6194.26 stddev:638.21 (10.3%) stddev-sans-first:615.77 11:05:51 INFO - PROCESS | 1671 | Values: 3690.4 3694.0 3704.4 3705.2 3725.9 5925.7 5968.5 6011.3 6031.5 6039.0 5336.9 5718.7 5979.6 6066.5 6110.5 5400.4 5442.1 5477.5 5506.4 5580.6 5371.1 5513.4 5522.9 5533.8 5534.3 5395.5 5502.1 5518.2 5519.2 5528.7 4573.1 5549.9 5568.1 5579.4 5591.1 5278.4 5383.6 5439.4 5507.3 5597.2 4560.9 5501.2 5829.7 5884.6 5912.9 6256.2 6287.1 6314.5 6314.9 6340.1 6274.9 6364.9 6385.7 6406.6 6434.4 6141.7 6149.4 6193.3 6193.6 6194.3 5524.3 6466.9 6520.1 6554.4 6559.6 6199.1 6224.2 6258.9 6276.2 6286.4 6377.4 6402.0 6424.2 6424.3 6424.9 6272.3 6287.2 6313.5 6316.2 6319.3 6235.8 6275.3 6280.6 6284.4 6291.4 5101.7 5135.2 5149.1 5151.0 5151.3 4501.8 4656.9 4665.3 4671.0 4696.3 6106.1 6150.4 6169.6 6215.7 6234.3 6387.9 6420.6 6433.5 6435.4 6472.2 6113.4 6202.1 6231.7 6235.9 6239.4 5640.6 5651.0 5659.7 5682.3 5727.8 6610.0 6662.5 6674.3 6678.5 6687.9 6190.0 6368.4 6408.6 6430.0 6439.0 6546.1 6624.4 6624.7 6629.5 6655.1 6292.1 6308.2 6312.1 6317.2 6319.0 5358.1 5561.4 6352.2 6383.3 6386.2 5169.4 5960.2 6187.1 6187.2 6209.7 6218.1 6219.5 6228.2 6234.9 6245.7 4750.4 6039.5 6080.0 6132.3 6153.8 4996.8 6268.6 6284.9 6302.8 6434.6 6222.8 6240.4 6253.0 6259.2 6269.7 11:05:51 INFO - PROCESS | 1671 | 11:05:51 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:68746.55 Median:40475.90 stddev:148525.01 (366.9%) stddev-sans-first:148853.40 11:05:51 INFO - PROCESS | 1671 | Values: 546.3 577.5 617.7 655.1 674.6 38222.2 38968.6 39035.4 39081.4 39151.8 35612.5 38847.8 41282.8 41283.4 41329.2 9611.0 9827.2 9835.2 9842.6 9847.2 9639.9 9938.7 9957.3 9961.8 9999.2 9920.5 9927.9 9942.2 9942.3 10022.7 9878.4 9886.3 9891.1 9947.7 10028.4 9713.2 9848.5 9851.0 9859.9 9874.5 34630.7 39672.6 40008.0 40445.0 40457.0 3139.4 3345.7 3407.1 3411.6 3560.8 27256.7 27357.7 28242.0 28415.7 28867.9 2747.9 2765.0 2781.1 2794.4 2832.3 455299.0 455479.0 457673.0 457686.0 462930.0 46043.5 47070.8 63648.4 64066.4 64416.7 41927.7 43213.1 45604.0 45842.0 46402.3 15044.6 15124.9 16916.5 16951.9 17372.3 13609.4 13714.7 13858.7 13926.8 14099.9 13363.9 14340.0 15193.9 15298.6 15325.7 6456.4 6542.6 6575.6 6580.2 6601.3 969.2 983.2 1044.7 1085.1 1094.5 30513.8 30897.7 30922.7 31483.7 32216.8 1101.8 1141.2 1168.0 1172.3 1238.2 14465.9 15054.7 15100.7 15118.9 15449.8 654157.0 660828.0 663475.0 667413.0 668097.0 60269.7 60627.7 61054.4 61241.4 61411.8 1555.9 1559.4 1575.1 1584.9 1587.6 24611.8 30062.1 30191.1 30409.0 30730.5 52013.7 58470.4 59420.4 59607.1 60231.4 524169.0 525202.0 526663.0 530757.0 533282.0 45042.5 45264.3 45363.5 46753.3 46769.3 48227.5 48332.0 48850.5 48964.0 50720.5 39080.6 40494.8 40897.8 40924.6 41246.4 38445.8 39001.0 39547.6 39729.4 40346.6 39481.8 39882.6 40052.4 40681.0 40949.8 31290.0 33112.0 33112.7 33253.7 33382.8 25116.0 25385.7 25411.1 25733.0 25832.7 11:05:51 INFO - PROCESS | 1671 | 11:05:51 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:37621.56 Median:22442.05 stddev:117015.46 (521.4%) stddev-sans-first:117310.30 11:05:51 INFO - PROCESS | 1671 | Values: 375.4 380.9 384.6 385.1 387.2 20271.3 21685.6 21925.6 22445.2 22592.4 21625.6 21753.3 21757.3 21812.8 22069.2 5809.3 5889.4 6052.1 6105.6 6148.3 5881.4 5883.9 5937.2 6042.1 6044.2 5734.5 5957.2 5973.8 5985.0 6053.0 4960.1 5787.1 5836.7 5854.6 5915.1 5097.2 5127.1 5180.1 5192.4 5197.8 25995.6 25999.7 26282.2 26361.5 26579.9 2179.0 2202.2 2236.2 2356.6 2703.0 11746.5 15467.2 15605.9 15679.6 15854.9 1517.8 1549.6 1763.9 1875.9 1939.8 71895.0 74098.6 74187.6 110095.4 112357.0 11212.4 11514.9 11558.7 11916.5 11997.8 14646.6 14646.7 14684.4 14694.9 14728.9 8389.0 8970.2 9105.7 9123.1 9149.0 7034.7 7823.8 7945.6 9290.2 9350.1 3718.9 4614.9 4650.6 4684.3 4684.7 1886.7 1944.9 1951.7 1966.9 1968.5 904.2 979.7 983.6 998.1 1006.0 19015.4 21154.9 22121.8 22395.1 22438.9 994.0 1003.8 1013.5 1016.2 1035.9 10967.3 11422.8 11466.8 11473.7 11478.6 700853.0 707888.0 709319.0 713281.0 716272.0 111748.0 127480.0 129971.8 135178.0 135513.0 1011.5 1070.1 1124.1 1125.1 1126.3 19260.5 19390.9 19869.2 19882.6 19908.6 50630.7 52235.7 53374.0 53599.5 53804.5 72683.5 75995.6 77594.6 77802.0 79924.2 8433.9 8473.2 8495.2 8582.7 8772.4 12857.3 13495.1 13629.9 13659.4 13998.6 9751.0 11252.9 11464.8 11517.6 11705.7 11186.4 11765.8 11826.6 11840.5 12050.8 11535.3 11705.0 11717.4 11860.9 12062.8 8340.4 8364.9 8493.5 8528.4 8659.3 7083.9 10551.4 10752.4 10758.4 12036.8 11:05:51 INFO - PROCESS | 1671 | 11:05:51 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:6298.32 Median:5160.03 stddev:3309.46 (64.1%) stddev-sans-first:3300.45 11:05:51 INFO - PROCESS | 1671 | Values: 1667.6 1673.2 2000.6 2054.2 2075.2 7987.2 8375.7 9018.3 9090.0 9115.3 9003.7 9029.0 9050.9 9114.8 9142.5 2557.8 2578.7 2591.0 2599.0 2605.4 2517.2 2522.8 2524.4 2525.1 2533.3 2558.2 2580.4 2588.6 2618.4 2628.1 2537.4 2544.2 2545.2 2559.4 2589.2 2449.1 2473.8 2475.1 2489.5 2534.4 9197.6 9209.3 9247.6 9255.4 9294.6 5694.7 5726.2 5736.2 5782.0 5805.0 3491.4 3704.1 3806.3 3851.3 3873.4 1075.0 1081.3 1089.4 1098.0 1107.6 12307.6 12390.3 12503.2 12562.7 12740.8 5065.8 5101.0 5182.4 5233.6 5264.4 10598.9 10644.3 10662.5 10670.9 10689.8 5803.4 5868.9 5872.4 5878.5 5947.1 4744.1 5078.7 5137.7 5206.1 5306.4 3876.0 3934.6 3947.2 3976.7 4005.5 1381.2 1381.3 1385.8 1395.6 1406.4 1188.2 1205.7 1211.2 1235.2 1242.8 8455.2 8545.7 8570.0 8581.6 8723.3 1158.4 1201.9 1226.8 1281.1 1296.8 6473.2 6513.3 6563.1 6625.4 6757.9 9718.3 11286.7 11379.7 11391.4 11473.4 10957.7 11076.2 11269.9 11337.0 11379.3 8666.3 8702.4 8771.3 8827.6 8911.6 8166.2 8340.4 8345.0 8379.2 8423.2 9469.9 9792.8 10052.0 10088.7 10330.5 8622.0 10107.6 10352.0 10379.3 10426.2 5533.5 5609.9 7224.7 7283.9 7386.8 7154.7 8608.8 8624.7 8643.6 8687.3 6583.4 7473.5 7617.4 7646.7 7727.5 7523.9 7602.8 7676.9 7705.5 7810.5 7989.6 8095.0 8109.7 8148.8 8156.0 7261.2 7336.2 7346.5 7361.2 7376.8 7476.2 7480.9 7493.2 7525.2 7532.5 11:05:51 INFO - PROCESS | 1671 | 11:05:51 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:6026.97 Median:6841.12 stddev:1951.22 (28.5%) stddev-sans-first:1909.44 11:05:51 INFO - PROCESS | 1671 | Values: 340.5 340.6 342.6 342.9 344.9 6817.7 6833.5 6861.2 6863.9 6864.4 6202.6 6804.2 6814.1 6839.7 6871.7 3882.4 4795.1 4986.3 5023.1 5093.7 4969.7 5015.6 5016.2 5032.3 5039.6 4920.6 4928.0 4936.0 4955.1 4956.0 4464.7 4488.6 4961.3 4974.2 4995.3 4317.5 4353.5 4353.6 4353.7 4354.3 6241.8 6396.9 6513.4 6561.8 6589.0 5918.5 5973.1 5980.1 5992.0 5994.1 7254.9 7261.8 7273.1 7285.1 7292.9 4859.3 4867.1 4868.7 4877.3 4877.8 7549.2 7727.0 7727.8 7749.4 7797.5 4415.9 4854.8 4911.8 4941.9 4957.0 5095.7 5101.2 5102.2 5105.1 5106.4 4824.4 5945.6 5973.6 5988.8 6017.2 7387.4 7393.7 7444.6 7448.0 7476.3 1651.8 1703.1 1708.4 1736.0 1763.9 1112.1 1131.3 1132.6 1133.0 1136.7 6857.0 6895.0 6903.8 6914.6 6923.4 6193.8 7303.3 7473.7 7508.1 7535.7 5813.5 5974.6 6591.1 6816.7 6850.0 3645.0 3934.1 3954.3 3959.7 3979.8 7897.3 7915.9 7997.2 8023.1 8028.4 7860.9 7872.3 7879.7 7981.1 8027.7 8080.4 8123.3 8125.7 8139.8 8173.6 7477.1 7715.9 7738.8 7747.1 7788.6 6842.5 7529.4 7571.5 7596.3 7623.7 7908.9 8105.9 8120.1 8125.8 8132.6 4459.3 5010.9 5011.0 5028.0 5040.5 7403.6 7704.3 7739.2 7744.8 7753.1 7376.9 7418.0 7447.2 7452.7 7455.9 7406.7 7421.3 7438.0 7457.9 7480.4 7007.8 7223.7 7229.2 7254.6 7274.5 7402.1 7439.0 7450.8 7476.7 7480.9 7261.4 7276.0 7283.2 7286.1 7300.2 11:05:51 INFO - PROCESS | 1671 | 11:05:51 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:18855.06 Median:26441.72 stddev:27070.67 (102.4%) stddev-sans-first:27112.34 11:05:51 INFO - PROCESS | 1671 | Values: 712.2 772.6 781.1 789.2 810.7 15309.1 15389.2 15393.0 15492.4 15516.9 14378.6 14518.7 14518.9 14533.3 14540.1 787.2 950.4 966.2 985.8 987.3 955.9 965.8 966.1 967.2 968.0 991.1 991.9 996.9 1029.6 1032.7 983.6 1006.0 1021.5 1024.9 1031.2 644.5 651.8 709.5 743.8 747.2 13934.9 14019.9 14032.1 14055.4 14082.2 11451.6 13255.1 13313.9 13424.9 13459.1 10210.2 10291.8 10465.8 10502.3 10518.7 3618.8 3621.7 3638.1 3662.9 3829.4 60941.0 80570.6 82608.2 84811.6 92028.0 9613.9 9769.9 9817.1 10135.9 10145.9 21655.0 21891.5 21983.7 22022.2 22022.3 7486.0 7625.5 7674.6 7723.3 7757.7 4171.7 4255.6 4271.1 4307.6 4328.7 3798.0 3841.0 3844.5 3848.9 3850.2 695.4 695.8 697.6 701.6 703.8 503.3 581.9 604.3 612.1 629.6 8484.2 8533.4 8655.7 8675.7 8839.4 519.4 620.6 623.8 633.5 634.1 4030.6 4050.8 4112.5 4113.4 4129.4 92910.0 93534.0 94839.6 103846.5 104697.4 82348.6 82407.2 83769.0 83819.6 84176.2 71152.0 72952.6 72998.6 73487.6 74902.6 6971.7 7921.1 8263.7 8292.8 8394.9 49140.5 50138.7 50760.7 51769.2 52364.0 72286.6 73803.6 73859.6 74212.3 75602.0 10331.7 10429.8 10555.5 10607.0 10672.7 10843.2 11450.4 11489.9 11702.5 11744.6 10714.5 10745.7 10823.2 10993.7 11279.8 10306.7 10312.4 10469.7 10592.3 11205.7 8501.3 10502.8 10551.2 10658.8 11622.4 9697.8 9756.3 9814.8 9884.2 10190.7 8406.2 8566.5 9455.9 9660.8 9912.1 11:05:51 INFO - PROCESS | 1671 | -------- Summary: end -------- 11:05:51 INFO - PROCESS | 1671 | 11:05:52 INFO - TEST-INFO | 1671: exit 0 11:05:52 INFO - TEST-OK | dromaeo_css | took 1109914ms 11:05:52 INFO - TEST-START | kraken 11:05:52 INFO - operating with platform_type : mac_ 11:05:52 INFO - Initialising browser for kraken test... 11:05:52 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpddmMag/profile http://localhost:49270/getInfo.html) 11:05:54 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 11:05:54 INFO - PROCESS | 1681 | colorDepth:24 11:05:54 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 11:05:54 INFO - PROCESS | 1681 | __metrics 11:05:55 ERROR - PROCESS | 1681 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 11:05:55 INFO - TEST-INFO | 1681: exit 0 11:05:55 INFO - Browser initialized. 11:05:55 INFO - Running cycle 1/1 for kraken test... 11:05:55 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpddmMag/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:06:07 INFO - PROCESS | 1685 | RSS: Main: 168013824 11:06:07 INFO - PROCESS | 1685 | 11:06:10 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 11:06:10 INFO - PROCESS | 1685 | RSS: Main: 179871744 11:06:10 INFO - PROCESS | 1685 | 11:06:13 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 11:06:14 INFO - PROCESS | 1685 | RSS: Main: 189317120 11:06:14 INFO - PROCESS | 1685 | 11:06:17 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 11:06:18 INFO - PROCESS | 1685 | RSS: Main: 192774144 11:06:18 INFO - PROCESS | 1685 | 11:06:20 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 11:06:20 INFO - PROCESS | 1685 | RSS: Main: 194351104 11:06:20 INFO - PROCESS | 1685 | 11:06:22 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:06:23 INFO - PROCESS | 1685 | RSS: Main: 194899968 11:06:23 INFO - PROCESS | 1685 | 11:06:26 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 11:06:26 INFO - PROCESS | 1685 | RSS: Main: 194953216 11:06:26 INFO - PROCESS | 1685 | 11:06:29 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 11:06:30 INFO - PROCESS | 1685 | RSS: Main: 194793472 11:06:30 INFO - PROCESS | 1685 | 11:06:33 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 11:06:33 INFO - PROCESS | 1685 | RSS: Main: 195117056 11:06:33 INFO - PROCESS | 1685 | 11:06:35 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:06:35 INFO - PROCESS | 1685 | RSS: Main: 194826240 11:06:35 INFO - PROCESS | 1685 | 11:06:37 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:06:38 INFO - PROCESS | 1685 | RSS: Main: 194494464 11:06:38 INFO - PROCESS | 1685 | 11:06:40 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:06:40 INFO - PROCESS | 1685 | RSS: Main: 194592768 11:06:40 INFO - PROCESS | 1685 | 11:06:43 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:06:44 INFO - PROCESS | 1685 | RSS: Main: 194797568 11:06:44 INFO - PROCESS | 1685 | 11:06:46 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:06:47 INFO - PROCESS | 1685 | RSS: Main: 194805760 11:06:47 INFO - PROCESS | 1685 | 11:06:48 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 11:06:49 INFO - PROCESS | 1685 | RSS: Main: 196382720 11:06:49 INFO - PROCESS | 1685 | 11:06:49 INFO - PROCESS | 1685 | __start_tp_report 11:06:49 INFO - PROCESS | 1685 | _x_x_mozilla_page_load 11:06:49 INFO - PROCESS | 1685 | _x_x_mozilla_page_load_details 11:06:49 INFO - PROCESS | 1685 | |i|pagename|runs| 11:06:49 INFO - PROCESS | 1685 | |0;ai-astar;114;111;115;112;115;130;130;167;118;114 11:06:49 INFO - PROCESS | 1685 | |1;audio-beat-detection;176;151;145;182;151;168;138;121;158;123 11:06:49 INFO - PROCESS | 1685 | |2;audio-dft;196;199;199;197;195;192;200;195;194;192 11:06:49 INFO - PROCESS | 1685 | |3;audio-fft;63;91;98;156;85;64;56;60;117;57 11:06:49 INFO - PROCESS | 1685 | |4;audio-oscillator;88;83;116;81;79;83;116;78;78;119 11:06:49 INFO - PROCESS | 1685 | |5;imaging-gaussian-blur;96;129;135;86;88;85;111;110;89;86 11:06:49 INFO - PROCESS | 1685 | |6;imaging-darkroom;95;95;125;150;102;94;95;96;94;94 11:06:49 INFO - PROCESS | 1685 | |7;imaging-desaturate;124;123;91;91;94;91;97;94;93;94 11:06:49 INFO - PROCESS | 1685 | |8;json-parse-financial;56;58;61;60;59;58;58;59;60;57 11:06:49 INFO - PROCESS | 1685 | |9;json-stringify-tinderbox;67;71;67;79;69;70;65;65;57;81 11:06:49 INFO - PROCESS | 1685 | |10;stanford-crypto-aes;80;95;110;86;82;80;82;82;83;86 11:06:49 INFO - PROCESS | 1685 | |11;stanford-crypto-ccm;133;134;134;112;117;119;139;138;128;120 11:06:49 INFO - PROCESS | 1685 | |12;stanford-crypto-pbkdf2;133;136;135;157;173;133;140;152;137;130 11:06:49 INFO - PROCESS | 1685 | |13;stanford-crypto-sha256-iterative;65;69;90;101;66;58;98;99;96;94 11:06:49 INFO - PROCESS | 1685 | __end_tp_report 11:06:49 INFO - PROCESS | 1685 | __start_cc_report 11:06:49 INFO - PROCESS | 1685 | _x_x_mozilla_cycle_collect,908 11:06:49 INFO - PROCESS | 1685 | __end_cc_report 11:06:49 INFO - PROCESS | 1685 | __startTimestamp1465236409228__endTimestamp 11:06:49 INFO - PROCESS | 1685 | 11:06:49 INFO - PROCESS | 1685 | ------- Summary: start ------- 11:06:49 INFO - PROCESS | 1685 | Number of tests: 14 11:06:49 INFO - PROCESS | 1685 | 11:06:49 INFO - PROCESS | 1685 | [#0] ai-astar Cycles:10 Average:122.60 Median:116.50 stddev:17.04 (14.6%) stddev-sans-first:17.78 11:06:49 INFO - PROCESS | 1685 | Values: 114.0 111.0 115.0 112.0 115.0 130.0 130.0 167.0 118.0 114.0 11:06:49 INFO - PROCESS | 1685 | 11:06:49 INFO - PROCESS | 1685 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:154.50 stddev:20.58 (13.3%) stddev-sans-first:19.79 11:06:49 INFO - PROCESS | 1685 | Values: 176.0 151.0 145.0 182.0 151.0 168.0 138.0 121.0 158.0 123.0 11:06:49 INFO - PROCESS | 1685 | 11:06:49 INFO - PROCESS | 1685 | [#2] audio-dft Cycles:10 Average:195.90 Median:196.50 stddev:2.85 (1.4%) stddev-sans-first:3.02 11:06:49 INFO - PROCESS | 1685 | Values: 196.0 199.0 199.0 197.0 195.0 192.0 200.0 195.0 194.0 192.0 11:06:49 INFO - PROCESS | 1685 | 11:06:49 INFO - PROCESS | 1685 | [#3] audio-fft Cycles:10 Average:84.70 Median:63.50 stddev:32.39 (51.0%) stddev-sans-first:33.39 11:06:49 INFO - PROCESS | 1685 | Values: 63.0 91.0 98.0 156.0 85.0 64.0 56.0 60.0 117.0 57.0 11:06:49 INFO - PROCESS | 1685 | 11:06:49 INFO - PROCESS | 1685 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:80.00 stddev:17.45 (21.8%) stddev-sans-first:18.45 11:06:49 INFO - PROCESS | 1685 | Values: 88.0 83.0 116.0 81.0 79.0 83.0 116.0 78.0 78.0 119.0 11:06:49 INFO - PROCESS | 1685 | 11:06:49 INFO - PROCESS | 1685 | [#5] imaging-gaussian-blur Cycles:10 Average:101.50 Median:86.00 stddev:18.75 (21.8%) stddev-sans-first:19.78 11:06:49 INFO - PROCESS | 1685 | Values: 96.0 129.0 135.0 86.0 88.0 85.0 111.0 110.0 89.0 86.0 11:06:49 INFO - PROCESS | 1685 | 11:06:49 INFO - PROCESS | 1685 | [#6] imaging-darkroom Cycles:10 Average:104.00 Median:94.50 stddev:18.76 (19.9%) stddev-sans-first:19.62 11:06:49 INFO - PROCESS | 1685 | Values: 95.0 95.0 125.0 150.0 102.0 94.0 95.0 96.0 94.0 94.0 11:06:49 INFO - PROCESS | 1685 | 11:06:49 INFO - PROCESS | 1685 | [#7] imaging-desaturate Cycles:10 Average:99.20 Median:93.50 stddev:12.94 (13.8%) stddev-sans-first:10.15 11:06:49 INFO - PROCESS | 1685 | Values: 124.0 123.0 91.0 91.0 94.0 91.0 97.0 94.0 93.0 94.0 11:06:49 INFO - PROCESS | 1685 | 11:06:49 INFO - PROCESS | 1685 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:59.00 stddev:1.51 (2.6%) stddev-sans-first:1.27 11:06:49 INFO - PROCESS | 1685 | Values: 56.0 58.0 61.0 60.0 59.0 58.0 58.0 59.0 60.0 57.0 11:06:49 INFO - PROCESS | 1685 | 11:06:49 INFO - PROCESS | 1685 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.50 stddev:6.94 (10.0%) stddev-sans-first:7.31 11:06:49 INFO - PROCESS | 1685 | Values: 67.0 71.0 67.0 79.0 69.0 70.0 65.0 65.0 57.0 81.0 11:06:49 INFO - PROCESS | 1685 | 11:06:49 INFO - PROCESS | 1685 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:82.50 stddev:9.32 (11.3%) stddev-sans-first:9.58 11:06:49 INFO - PROCESS | 1685 | Values: 80.0 95.0 110.0 86.0 82.0 80.0 82.0 82.0 83.0 86.0 11:06:49 INFO - PROCESS | 1685 | 11:06:49 INFO - PROCESS | 1685 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:133.50 stddev:9.64 (7.2%) stddev-sans-first:10.01 11:06:49 INFO - PROCESS | 1685 | Values: 133.0 134.0 134.0 112.0 117.0 119.0 139.0 138.0 128.0 120.0 11:06:49 INFO - PROCESS | 1685 | 11:06:49 INFO - PROCESS | 1685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.60 Median:138.50 stddev:13.75 (9.9%) stddev-sans-first:14.14 11:06:49 INFO - PROCESS | 1685 | Values: 133.0 136.0 135.0 157.0 173.0 133.0 140.0 152.0 137.0 130.0 11:06:49 INFO - PROCESS | 1685 | 11:06:49 INFO - PROCESS | 1685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:83.60 Median:92.00 stddev:16.91 (18.4%) stddev-sans-first:16.55 11:06:49 INFO - PROCESS | 1685 | Values: 65.0 69.0 90.0 101.0 66.0 58.0 98.0 99.0 96.0 94.0 11:06:49 INFO - PROCESS | 1685 | -------- Summary: end -------- 11:06:49 INFO - PROCESS | 1685 | 11:06:49 INFO - TEST-INFO | 1685: exit 0 11:06:49 INFO - TEST-OK | kraken | took 57679ms 11:06:49 INFO - SUITE-END | took 1167s 11:06:50 INFO - Completed test suite (00:19:28) 11:06:50 INFO - javascript benchmark 11:06:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3690.3910854708975, 3693.981530092349, 3704.407294832827, 3705.240425712729, 3725.869594564189, 5925.703714814258, 5968.462838344548, 6011.308699499559, 6031.487323577496, 6038.969805150968, 5336.946630533694, 5718.71406429679, 5979.641221526712, 6066.484348830355, 6110.480609148217, 5400.378956420013, 5442.074847275972, 5477.4796394342475, 5506.421825708303, 5580.553555715533, 5371.113766228587, 5513.42109078547, 5522.861928451801, 5533.750981205835, 5534.308211473566, 5395.487428694268, 5502.119660854264, 5518.227448157241, 5519.199716041172, 5528.723563821813, 4573.085382923396, 5549.916751248715, 5568.136938774496, 5579.358373787006, 5591.077472217079, 5278.41937386891, 5383.569314454834, 5439.449756819287, 5507.256520369739, 5597.160425936101, 4560.8859778505475, 5501.174823776426, 5829.708514574297, 5884.6469211847425, 5912.940870591282, 6256.249250090018, 6287.1198032275515, 6314.463270622003, 6314.93685063148, 6340.144080549113, 6274.937250627481, 6364.936350636527, 6385.744570217185, 6406.647634380107, 6434.388733070397, 6141.662208578527, 6149.401155699506, 6193.256809182927, 6193.597416167935, 6194.256689197235, 5524.309461317335, 6466.8682980478225, 6520.0871877937125, 6554.377334153248, 6559.639219842859, 6199.132121502993, 6224.221972253468, 6258.906116408258, 6276.246850377984, 6286.402791734778, 6377.385272038535, 6402.0, 6424.196975378078, 6424.261209960914, 6424.935750642528, 6272.3100458949475, 6287.2140982377205, 6313.494920406357, 6316.210473690789, 6319.3364696706185, 6235.844103897439, 6275.341089185661, 6280.591761535486, 6284.402981716729, 6291.433770960635, 5101.69389836611, 5135.229715542699, 5149.124648809711, 5151.021305951857, 5151.2530683050745, 4501.842435514741, 4656.8602941911795, 4665.2768820832825, 4670.972386075058, 4696.272077827942, 6106.084087386838, 6150.384961503813, 6169.629822210682, 6215.720292586844, 6234.3453937336835, 6387.914054610727, 6420.582662126947, 6433.517486188461, 6435.388638079375, 6472.190976127984, 6113.449789518964, 6202.0696895465135, 6231.719572619243, 6235.937640623536, 6239.407256310643, 5640.633358831663, 5651.0, 5659.745311460912, 5682.261306030189, 5727.77088916447, 6609.966950165219, 6662.467002639874, 6674.2658307586125, 6678.532502724763, 6687.933120668731, 6189.96905015472, 6368.395002474757, 6408.583442076437, 6429.967850160906, 6439.034144878306, 6546.083548303146, 6624.370684784938, 6624.735010599522, 6629.502787291069, 6655.068290439439, 6292.119103325446, 6308.179936608211, 6312.084747711464, 6317.210348706411, 6319.0, 5358.115910874662, 5561.360443549043, 6352.237731472253, 6383.265924418752, 6386.16979792624, 5169.431362550041, 5960.195373624505, 6187.133801267736, 6187.16473276102, 6209.658468784261, 6218.129461875251, 6219.533534984985, 6228.159198508143, 6234.906476402948, 6245.68771561411, 4750.406199225097, 6039.5470339723815, 6080.027195648675, 6132.263729246545, 6153.84615384619, 4996.800127994839, 6268.592541484789, 6284.937150628618, 6302.84242893913, 6434.581752186093, 6222.803958694541, 6240.375962403723, 6253.030780229072, 6259.186305780219, 6269.717862696099], "unit": "score", "name": "dojo.html", "value": 5883.44048169468}, {"lowerIsBetter": false, "replicates": [546.295279089974, 577.4946921443736, 617.7467238432243, 655.0698008827464, 674.6188403551994, 38222.23555528888, 38968.610313896854, 39035.414468782954, 39081.41377879331, 39151.804240978825, 35612.46581301282, 38847.83456496303, 41282.7935860321, 41283.380749288706, 41329.17341653165, 9610.951945240264, 9827.164691001273, 9835.213182945346, 9842.60629574816, 9847.16299114576, 9639.903600964006, 9938.701838944808, 9957.253206009542, 9961.750956226117, 9999.2000639949, 9920.503974801268, 9927.851082233772, 9942.154916832042, 9942.304038717293, 10022.699319020441, 9878.357906736075, 9886.307958442912, 9891.060349266809, 9947.701568952943, 10028.44843533609, 9713.22294216461, 9848.507574621312, 9850.9507452463, 9859.901400986042, 9874.456904870229, 34630.653693463246, 39672.60327396718, 40008.0, 40445.0, 40457.0, 3139.3564319314487, 3345.6821601947777, 3407.0800883761494, 3411.624721280657, 3560.7507474476797, 27256.727432725816, 27357.726422735916, 28242.0, 28415.71584284172, 28867.855660721772, 2747.9450410991867, 2765.0, 2781.0683421053973, 2794.4271424357958, 2832.277769168849, 455299.0, 455479.0, 457672.9999999967, 457686.0, 462930.0, 46043.539564604594, 47070.76464617724, 63648.36351636517, 64066.359336406036, 64416.67791661106, 41927.742167735014, 43213.135737285076, 45604.0, 45842.0, 46402.303965440544, 15044.623884402978, 15124.924375378052, 16916.49250522486, 16951.915240423965, 17372.3051077958, 13609.387577558835, 13714.65713357174, 13858.653533661538, 13926.791098133535, 14099.929500352639, 13363.864071553833, 14339.99620026609, 15193.86046046551, 15298.617534561503, 15325.693486130214, 6456.418922297016, 6542.640154791532, 6575.605463672195, 6580.243272023683, 6601.2738598754095, 969.1519920069939, 983.2085171437062, 1044.6865940217904, 1085.0614218700766, 1094.458243169636, 30513.847430762704, 30897.69102308993, 30922.690773092432, 31483.685163148533, 32216.83891580574, 1101.8457415961773, 1141.1897552737648, 1167.96496105117, 1172.3200543684643, 1238.1827993524412, 14465.85534144666, 15054.698906022037, 15100.697986040437, 15118.924405378122, 15449.768253476206, 654157.0, 660828.0, 663475.0, 667413.0, 668097.0, 60269.698651506464, 60627.69686151629, 61054.38945610487, 61241.38758612446, 61411.771764565354, 1555.922203889801, 1559.4152192927652, 1575.1100628145061, 1584.8890577659683, 1587.5634200594698, 24611.821779904756, 30062.098137055924, 30191.068197338718, 30409.0, 30730.539041914835, 52013.7399313001, 58470.4152958482, 59420.405795941486, 59607.1058934125, 60231.39768602258, 524169.0, 525202.0, 526663.0, 530757.0, 533282.0, 45042.549574505145, 45264.32103518384, 45363.54636453725, 46753.29870051884, 46769.29846052244, 48227.517724822304, 48332.0, 48850.511494884595, 48964.0, 50720.492795073056, 39080.609193907694, 40494.79752601336, 40897.795511022254, 40924.590754092074, 41246.38130427986, 38445.807770960964, 39001.0, 39547.604523955546, 39729.40405893856, 40346.59653403428, 39481.80259098686, 39882.60117398789, 40052.399214012396, 40680.98297542467, 40949.795251023555, 31290.0, 33112.0, 33112.668873310955, 33253.667463326026, 33382.83308583441, 25115.99536018539, 25385.746142539076, 25411.110611128523, 25733.0, 25832.741672583787], "unit": "score", "name": "ext.html", "value": 20152.06631029302}, {"lowerIsBetter": false, "replicates": [375.4031090566001, 380.88763814674667, 384.5942530630185, 385.09118480386303, 387.2004311097585, 20271.290504832334, 21685.566288674218, 21925.561488770236, 22445.21441749535, 22592.43518912026, 21625.567488650257, 21753.347399577997, 21757.347279581598, 21812.781872181273, 22069.227577034806, 5809.331926828416, 5889.352171261158, 6052.092186172087, 6105.633661980273, 6148.292946311187, 5881.382454842244, 5883.911741323884, 5937.168796368512, 6042.093685947099, 6044.214252147237, 5734.541236701054, 5957.195778569902, 5973.790917317895, 5985.042393217086, 6053.0, 4960.131976904027, 5787.102999035135, 5836.708164591774, 5854.648721076749, 5915.053591425394, 5097.23541468779, 5127.077126117298, 5180.093483640348, 5192.350956130484, 5197.8440646780655, 25995.61006584903, 25999.74000259992, 26282.21153365383, 26361.472770544675, 26579.867100664567, 2178.9782102178933, 2202.2292197730826, 2236.1614394602025, 2356.587597170488, 2702.9729702702916, 11746.471408786625, 15467.226638668022, 15605.907586468951, 15679.608009799733, 15854.890157688966, 1517.8026856508693, 1549.5893588199135, 1763.8941663500102, 1875.943721688338, 1939.7779398978694, 71895.0, 74098.62950685267, 74187.62906185434, 110095.44952275268, 112357.0, 11212.383318917375, 11514.942425287987, 11558.711032224262, 11916.46375913086, 11997.760044799055, 14646.63383415423, 14646.707065858836, 14684.41262349494, 14694.926525367304, 14728.926355368154, 8388.958055209807, 8970.23752981004, 9105.726828195166, 9123.133302336268, 9149.0, 7034.6834392452465, 7823.843523129505, 7945.64244608994, 9290.210332121846, 9350.064993500595, 3718.888433347004, 4614.861554153381, 4650.558196971282, 4684.273937539687, 4684.74233917131, 1886.6604011278102, 1944.893030883315, 1951.6858184135401, 1966.852486063551, 1968.4586738646988, 904.1862323908404, 979.6669132494843, 983.6016413352604, 998.0767789794411, 1006.0492834271689, 19015.42953711391, 21154.894225528773, 22121.778782212295, 22395.10419583231, 22438.88780556087, 993.9762045093565, 1003.7540802503433, 1013.5489707080278, 1016.1718199667248, 1035.8601588785568, 10967.341959482457, 11422.828657570142, 11466.827997580043, 11473.71315717097, 11478.598249061242, 700853.0, 707888.0, 709319.0, 713281.0, 716272.0, 111748.0, 127480.0, 129971.7507062312, 135178.0, 135513.0, 1011.4588695048114, 1070.1171533484905, 1124.1288001798507, 1125.1167833250859, 1126.2566705974018, 19260.518487037934, 19390.903045484683, 19869.205231790565, 19882.639955083338, 19908.60182796365, 50630.74684626701, 52235.73882130565, 53374.0, 53599.46400535945, 53804.46195537994, 72683.54632907418, 75995.62002189954, 77594.6120269395, 77802.0, 79924.20075799168, 8433.87349189775, 8473.152684731478, 8495.192956669107, 8582.699605513777, 8772.429792063496, 12857.292848893401, 13495.122817016863, 13629.86370136286, 13659.38532766008, 13998.580042598738, 9750.951245243728, 11252.93097155769, 11464.828027579426, 11517.596884109016, 11705.707357316136, 11186.384748838893, 11765.754876804398, 11826.645200643994, 11840.467178976794, 12050.75898482043, 11535.307881527135, 11705.0, 11717.359569660084, 11860.94069529647, 12062.819057714318, 8340.374471914753, 8364.916350836414, 8493.490390576586, 8528.403011789114, 8659.263962563253, 7083.858322833411, 10551.366917984946, 10752.40861752611, 10758.408287543947, 12036.75926481483], "unit": "score", "name": "jquery.html", "value": 9815.3483000272}, {"lowerIsBetter": false, "replicates": [1667.599776053747, 1673.2386764022372, 2000.5698774763423, 2054.198862443648, 2075.2425364741875, 7987.241212084858, 8375.664973401072, 9018.32362572808, 9090.045545217748, 9115.316351273648, 9003.684871029514, 9028.954855225731, 9050.864237036434, 9114.817703645924, 9142.45145291283, 2557.846529208244, 2578.6776652918384, 2591.0413147135587, 2598.9610155847677, 2605.439830436456, 2517.2196619048063, 2522.848629082261, 2524.3815265260037, 2525.0783464035585, 2533.3033415810614, 2558.219742978391, 2580.3678098865803, 2588.5987671910884, 2618.4239467317257, 2628.0933078088124, 2537.429078457351, 2544.185860524633, 2545.16009716793, 2559.424129570841, 2589.197348821862, 2449.0938352809576, 2473.75262473753, 2475.1337032038823, 2489.539435204475, 2534.4044149624824, 9197.632094716204, 9209.309301802325, 9247.583858726373, 9255.444673319622, 9294.581743821544, 5694.6867922264255, 5726.169705392695, 5736.196932429463, 5781.971090144564, 5805.01314776489, 3491.3890069238037, 3704.148045949447, 3806.333891568964, 3851.345271303885, 3873.360895452247, 1075.0485820049234, 1081.302559848893, 1089.3844977587637, 1097.9615713449991, 1107.6234080412619, 12307.630771076882, 12390.31853248062, 12503.187292825936, 12562.74874502514, 12740.80888786669, 5065.772040258197, 5101.0, 5182.378114626269, 5233.581313494911, 5264.368275806928, 10598.894011059945, 10644.308119972176, 10662.520186591622, 10670.893291067145, 10689.83965240522, 5803.361630220672, 5868.853278667982, 5872.412758724094, 5878.470937615635, 5947.137665038632, 4744.074905393415, 5078.669886457368, 5137.691738495702, 5206.062908676399, 5306.363236411578, 3875.96124038756, 3934.626210509997, 3947.210557888434, 3976.741511801724, 4005.5393629732953, 1381.1574939287027, 1381.2886363522794, 1385.778275475919, 1395.5743498233137, 1406.4303956897472, 1188.1564089496383, 1205.6744678936814, 1211.1703483114095, 1235.2218102595486, 1242.8135779632946, 8455.196756308264, 8545.658173673108, 8569.957150214334, 8581.570921453902, 8723.258523025614, 1158.4381574936149, 1201.9218750781347, 1226.7975783995719, 1281.0968267371481, 1296.7665820152274, 6473.2232132144445, 6513.316101809337, 6563.081168636395, 6625.4037136657935, 6757.932420675828, 9718.319717619841, 11286.66140015801, 11379.658610241706, 11391.373474458984, 11473.426328683532, 10957.726056848642, 11076.224664273423, 11269.887301127048, 11336.979671829575, 11379.317240965403, 8666.306695464347, 8702.39083264178, 8771.342149338698, 8827.646894124291, 8911.643534258686, 8166.224208700164, 8340.416170868224, 8345.0, 8379.162083791573, 8423.157684231528, 9469.91096023966, 9792.80414391694, 10051.99480051989, 10088.69733907984, 10330.535125919501, 8622.0, 10107.595696172364, 10352.016558426938, 10379.325343852626, 10426.165906727596, 5533.529649979797, 5609.943900560942, 7224.711011559479, 7283.8543229136185, 7386.778396648109, 7154.713811447692, 8608.78478038054, 8624.65501379963, 8643.611037503453, 8687.305015598864, 6583.440407565219, 7473.51422157558, 7617.390608751176, 7646.65590048438, 7727.536347818924, 7523.930983490288, 7602.771916842504, 7676.923230767621, 7705.537667739954, 7810.531368117931, 7989.600519974094, 8095.02859656845, 8109.675612975415, 8148.83702325962, 8156.0, 7261.164966028763, 7336.1930187678245, 7346.485745997729, 7361.227071157451, 7376.815579610553, 7476.177620461854, 7480.887786683313, 7493.213212612815, 7525.172231054689, 7532.472726909064], "unit": "score", "name": "mootools.html", "value": 5149.577854212748}, {"lowerIsBetter": false, "replicates": [340.4875662128497, 340.57258141033014, 342.5734959974832, 342.9074149979506, 344.88086160409466, 6817.727290908358, 6833.487488438368, 6861.245263021064, 6863.931360686392, 6864.382205601495, 6202.596831205969, 6804.18349798025, 6814.114165158535, 6839.726410943556, 6871.725130994754, 3882.417637354405, 4795.112904112733, 4986.301917731521, 5023.095842748304, 5093.6943783372935, 4969.676970996874, 5015.5736762375245, 5016.172331565287, 5032.320636714052, 5039.647224694255, 4920.60635149189, 4927.950720492803, 4935.950640493603, 4955.08330958772, 4956.0, 4464.73211607303, 4488.551144885518, 4961.305417241607, 4974.179260422026, 4995.300657907896, 4317.4819021717285, 4353.455818022747, 4353.586409291112, 4353.717008394444, 4354.281543545311, 6241.843953901143, 6396.93603063968, 6513.381228783258, 6561.835954101138, 6589.044588534635, 5918.526517878559, 5973.1040343948325, 5980.102984552308, 5991.970040149771, 5994.13085102662, 7254.911763235504, 7261.818454538626, 7273.127224733013, 7285.125784905792, 7292.927070729278, 4859.343988561534, 4867.148249056401, 4868.732219727914, 4877.268409738532, 4877.780499877514, 7549.207333229987, 7727.0, 7727.806804829868, 7749.4187935904465, 7797.532148071134, 4415.911681766347, 4854.781534830941, 4911.803527858917, 4941.925871111936, 4957.0085982803585, 5095.694258344512, 5101.234814777738, 5102.183650615958, 5105.106606343875, 5106.361704786902, 4824.396950381202, 5945.643261404243, 5973.641581505123, 5988.820335389858, 6017.247844019497, 7387.409007279405, 7393.667284972189, 7444.59054751983, 7448.031755871702, 7476.3271305581675, 1651.7522371644109, 1703.1314029844868, 1708.4276767282852, 1735.9913200433916, 1763.8853474524115, 1112.1158678850334, 1131.281636161027, 1132.6035887439496, 1133.0, 1136.7442325476702, 6857.0, 6895.0, 6903.827404314832, 6914.585124892523, 6923.376896079377, 6193.81418557444, 7303.269673032654, 7473.738419155304, 7508.136564295067, 7535.663944177322, 5813.476787089182, 5974.625836057731, 6591.077249185022, 6816.659167041628, 6850.0, 3645.0, 3934.055826601595, 3954.268460334847, 3959.6832253419657, 3979.820908059144, 7897.289243968071, 7915.920840791634, 7997.240262175084, 8023.117457079717, 8028.357731381476, 7860.9213907860185, 7872.291493765474, 7879.684812607432, 7981.1220765715725, 8027.719029833927, 8080.353571714249, 8123.3095186908595, 8125.674973001013, 8139.75580732579, 8173.5504547250475, 7477.14012888503, 7715.922840771745, 7738.8452230953935, 7747.070351557623, 7788.571628560484, 6842.521023528504, 7529.435292352986, 7571.507851989603, 7596.316331530189, 7623.69505219785, 7908.881366779618, 8105.878411823709, 8120.106788253169, 8125.75622731319, 8132.634031468717, 4459.308807134899, 5010.899782004412, 5011.047900898818, 5027.974860125676, 5040.470750571138, 7403.555786652818, 7704.30661240491, 7739.18738532446, 7744.7676569703, 7753.147153813189, 7376.889346659912, 7418.0, 7447.180810110992, 7452.701891924262, 7455.850882982419, 7406.7037318506655, 7421.332080112816, 7438.0, 7457.921793738086, 7480.3641690456925, 7007.795322806275, 7223.747168849065, 7229.204787473479, 7254.600996945219, 7274.4907856451655, 7402.148752893271, 7439.0, 7450.813729656585, 7476.663550140148, 7480.887786683095, 7261.419086473175, 7275.963620181865, 7283.198848126808, 7286.085565773733, 7300.196978332273], "unit": "score", "name": "prototype.html", "value": 5375.525041795847}, {"lowerIsBetter": false, "replicates": [712.2201189697283, 772.6368606754827, 781.1407451803013, 789.1950210784998, 810.7040930060527, 15309.081455112673, 15389.1535965522, 15393.0, 15492.380304787808, 15516.922415387935, 14378.568642940729, 14518.709625807478, 14518.854811451882, 14533.273336333168, 14540.127592344441, 787.193127044778, 950.3775027357092, 966.2366730283068, 985.8324084905584, 987.2940847294183, 955.9378640388387, 965.8068386322728, 966.1304825656895, 967.2310513142069, 967.9661211857587, 991.1179050644931, 991.861139440479, 996.9401835889834, 1029.6036026129957, 1032.705678881519, 983.6360546597733, 1005.969820905374, 1021.4790456866978, 1024.8872624011353, 1031.2265800649513, 644.5262731892055, 651.7653644687908, 709.4785332780402, 743.7954562495303, 747.215423805008, 13934.93032534841, 14019.929900350535, 14032.08791428554, 14055.437782488689, 14082.225477598728, 11451.568553930758, 13255.138416003025, 13313.933430332883, 13424.93287533556, 13459.12515686487, 10210.234232432524, 10291.79416411675, 10465.790684186273, 10502.264841461101, 10518.684439466828, 3618.8419705694187, 3621.728370372233, 3638.07229156566, 3662.8901132966053, 3829.4064420014943, 60941.0, 80570.59714701447, 82608.17391826065, 84811.57594212051, 92027.99999999933, 9613.903860961302, 9769.853452198222, 9817.116459518678, 10135.898641013642, 10145.898541014643, 21655.02552385115, 21891.452713681967, 21983.670244946337, 22022.229221977475, 22022.33932982013, 7485.962570187223, 7625.542467451971, 7674.55739009354, 7723.343515801107, 7757.72847950319, 4171.728837625545, 4255.6169944705125, 4271.10306835568, 4307.612314891612, 4328.723026707129, 3797.9620203798163, 3841.0, 3844.4809950656304, 3848.942265866014, 3850.249201405699, 695.3984803145242, 695.8086526205334, 697.6372286411038, 701.6491754122939, 703.8240439890028, 503.2727708461238, 581.9466765155083, 604.3015554067163, 612.1277180018456, 629.6473974574253, 8484.236418722221, 8533.402661813738, 8655.6537738491, 8675.739727808175, 8839.41090482406, 519.4338171393199, 620.5811077522654, 623.7816764132517, 633.5311869216838, 634.0710858592184, 4030.5969403059457, 4050.7974601270407, 4112.547619761824, 4113.362428823537, 4129.359949207877, 92910.0, 93534.0, 94839.62900927532, 103846.48076759568, 104697.38256543495, 82348.58825705953, 82407.17592824115, 83769.0, 83819.58090209632, 84176.15823841683, 71152.0, 72952.63523682348, 72998.63500682462, 73487.63256183792, 74902.62548687331, 6971.721131154697, 7921.128675845537, 8263.710770123016, 8292.83414331722, 8394.866692996367, 49140.50859491359, 50138.74930625324, 50760.74619626878, 51769.22346164735, 52364.0, 72286.63856680683, 73803.6309818469, 73859.63070184615, 74212.25787742053, 75602.0, 10331.741706457398, 10429.843552346569, 10555.52500137511, 10607.0, 10672.679819605424, 10843.186760993114, 11450.427478626201, 11489.885101149215, 11702.473388697359, 11744.647660570197, 10714.464276785973, 10745.677629671123, 10823.242373033812, 10993.670189894316, 11279.84367715748, 10306.690799276033, 10312.432816195182, 10469.68590942273, 10592.258541901992, 11205.719857003314, 8501.319894408556, 10502.842457362993, 10551.155907527225, 10658.786824263627, 11622.418879056182, 9697.806043879224, 9756.317057805885, 9814.762097398296, 9884.159846413135, 10190.694279171637, 8406.243438090602, 8566.48601083937, 9455.858162127435, 9660.806783864424, 9912.058354456316], "unit": "score", "name": "yui.html", "value": 7053.920259994161}], "name": "dromaeo_css", "value": 7811.817284250789}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 111.0, 115.0, 112.0, 115.0, 130.0, 130.0, 167.0, 118.0, 114.0], "unit": "score", "name": "ai-astar", "value": 122.6}, {"lowerIsBetter": true, "replicates": [176.0, 151.0, 145.0, 182.0, 151.0, 168.0, 138.0, 121.0, 158.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 151.3}, {"lowerIsBetter": true, "replicates": [196.0, 199.0, 199.0, 197.0, 195.0, 192.0, 200.0, 195.0, 194.0, 192.0], "unit": "score", "name": "audio-dft", "value": 195.9}, {"lowerIsBetter": true, "replicates": [63.0, 91.0, 98.0, 156.0, 85.0, 64.0, 56.0, 60.0, 117.0, 57.0], "unit": "score", "name": "audio-fft", "value": 84.7}, {"lowerIsBetter": true, "replicates": [88.0, 83.0, 116.0, 81.0, 79.0, 83.0, 116.0, 78.0, 78.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 92.1}, {"lowerIsBetter": true, "replicates": [96.0, 129.0, 135.0, 86.0, 88.0, 85.0, 111.0, 110.0, 89.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 101.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 125.0, 150.0, 102.0, 94.0, 95.0, 96.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 104.0}, {"lowerIsBetter": true, "replicates": [124.0, 123.0, 91.0, 91.0, 94.0, 91.0, 97.0, 94.0, 93.0, 94.0], "unit": "score", "name": "imaging-desaturate", "value": 99.2}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 61.0, 60.0, 59.0, 58.0, 58.0, 59.0, 60.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 67.0, 79.0, 69.0, 70.0, 65.0, 65.0, 57.0, 81.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [80.0, 95.0, 110.0, 86.0, 82.0, 80.0, 82.0, 82.0, 83.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.6}, {"lowerIsBetter": true, "replicates": [133.0, 134.0, 134.0, 112.0, 117.0, 119.0, 139.0, 138.0, 128.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.4}, {"lowerIsBetter": true, "replicates": [133.0, 136.0, 135.0, 157.0, 173.0, 133.0, 140.0, 152.0, 137.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.6}, {"lowerIsBetter": true, "replicates": [65.0, 69.0, 90.0, 101.0, 66.0, 58.0, 98.0, 99.0, 96.0, 94.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 83.6}], "name": "kraken", "value": 1519.1999999999998}]} 11:06:50 INFO - Return code: 0 11:06:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:06:50 ERROR - # TBPL SUCCESS # 11:06:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:06:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:06:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:06:50 INFO - 2016-06-06 11:06:50.528 screenresolution[1690:11504] starting screenresolution argv=screenresolution get 11:06:50 INFO - 2016-06-06 11:06:50.530 screenresolution[1690:11504] Display 0: 1600x1200x32@60 11:06:50 INFO - 2016-06-06 11:06:50.536 screenresolution[1691:11507] starting screenresolution argv=screenresolution list 11:06:50 INFO - Available Modes on Display 0 11:06:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:06:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:06:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:06:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:06:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:06:50 INFO - Intel Iris: 11:06:50 INFO - Chipset Model: Intel Iris 11:06:50 INFO - Type: GPU 11:06:50 INFO - Bus: Built-In 11:06:50 INFO - VRAM (Dynamic, Max): 1536 MB 11:06:50 INFO - Vendor: Intel (0x8086) 11:06:50 INFO - Device ID: 0x0a2e 11:06:50 INFO - Revision ID: 0x0009 11:06:50 INFO - Displays: 11:06:50 INFO - Display: 11:06:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:06:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:06:50 INFO - Display Serial Number: 1600x1200 60 11:06:50 INFO - Main Display: Yes 11:06:50 INFO - Mirror: Off 11:06:50 INFO - Online: Yes 11:06:50 INFO - Rotation: Supported 11:06:50 INFO - Return code: 0 11:06:50 INFO - Running post-action listener: _resource_record_post_action 11:06:50 INFO - Running post-run listener: _resource_record_post_run 11:06:51 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 31854080; Write bytes: 513660416; Read time: 212; Write time: 1600 11:06:51 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 197112320; Write bytes: 197797376; Read time: 17936; Write time: 420 11:06:51 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 30932480; Write bytes: 305901568; Read time: 199; Write time: 1146 11:06:51 INFO - Running post-run listener: _upload_blobber_files 11:06:51 INFO - Blob upload gear active. 11:06:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:06:51 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 11:06:51 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'] 11:06:51 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 11:06:52 INFO - (blobuploader) - INFO - Open directory for files ... 11:06:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:06:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:06:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:06:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:06:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:06:53 INFO - (blobuploader) - INFO - Done attempting. 11:06:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:06:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:06:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:06:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:06:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:06:54 INFO - (blobuploader) - INFO - Done attempting. 11:06:54 INFO - (blobuploader) - INFO - Iteration through files over. 11:06:54 INFO - Return code: 0 11:06:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:06:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:06:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d0a05f5d3c4612fbd2d43e694872f7aedd1e8cc7f4ff930b5f3c99faeb9dcfc91bb0a22ceae480caa2081ffd2a4675edbe262ba6d1a4689b4f998f28c6771f8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/81564ec68a65f2bab9bf22f7df3b23c6104c29f5eec71789f514ec40c96e514d4558b8adf7535c20d88035661ee243ccc16d06bcc5d837ecba8db48815667bdf"} 11:06:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:06:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:06:54 INFO - Contents: 11:06:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d0a05f5d3c4612fbd2d43e694872f7aedd1e8cc7f4ff930b5f3c99faeb9dcfc91bb0a22ceae480caa2081ffd2a4675edbe262ba6d1a4689b4f998f28c6771f8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/81564ec68a65f2bab9bf22f7df3b23c6104c29f5eec71789f514ec40c96e514d4558b8adf7535c20d88035661ee243ccc16d06bcc5d837ecba8db48815667bdf"} 11:06:54 INFO - Running post-run listener: copy_logs_to_upload_dir 11:06:54 INFO - Copying logs to upload dir... 11:06:54 INFO - mkdir: /builds/slave/test/build/upload/logs 11:06:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1304.187334 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 44 secs) (at 2016-06-06 11:06:54.468964) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 11:06:54.473024) ========= 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.6CdwB9H2ZR/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.DEfmS8QSbx/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d0a05f5d3c4612fbd2d43e694872f7aedd1e8cc7f4ff930b5f3c99faeb9dcfc91bb0a22ceae480caa2081ffd2a4675edbe262ba6d1a4689b4f998f28c6771f8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/81564ec68a65f2bab9bf22f7df3b23c6104c29f5eec71789f514ec40c96e514d4558b8adf7535c20d88035661ee243ccc16d06bcc5d837ecba8db48815667bdf"} build_url:https://queue.taskcluster.net/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010413 build_url: 'https://queue.taskcluster.net/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d0a05f5d3c4612fbd2d43e694872f7aedd1e8cc7f4ff930b5f3c99faeb9dcfc91bb0a22ceae480caa2081ffd2a4675edbe262ba6d1a4689b4f998f28c6771f8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/81564ec68a65f2bab9bf22f7df3b23c6104c29f5eec71789f514ec40c96e514d4558b8adf7535c20d88035661ee243ccc16d06bcc5d837ecba8db48815667bdf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 11:06:54.505531) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:06:54.505853) ========= 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.6CdwB9H2ZR/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.DEfmS8QSbx/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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.005128 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:06:54.624083) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 11:06:54.624404) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 11:06:54.624910) ========= ========= Total master_lag: 0.26 =========