builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0302 starttime: 1465235104.88 results: success (0) buildid: 20160601172046 builduid: e9d26e5e91854a5abc1e9b81ef0712cd revision: 96437abde2ecbab4f3ac771320c213debde6b43c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:04.879857) ========= 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:04.880189) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:04.880462) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:04.924164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:04.924442) ========= 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.rw7enFw8TW/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.vNQ57N8lBj/Listeners TMPDIR=/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.5M=0.001s 2016-06-06 10:45:05 (18.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142825 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:05.099070) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:05.099524) ========= 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.rw7enFw8TW/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.vNQ57N8lBj/Listeners TMPDIR=/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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.025990 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:05.151473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 10:45:05.152035) ========= 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.rw7enFw8TW/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.vNQ57N8lBj/Listeners TMPDIR=/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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:05,238 truncating revision to first 12 chars 2016-06-06 10:45:05,238 Setting DEBUG logging. 2016-06-06 10:45:05,238 attempt 1/10 2016-06-06 10:45:05,239 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:06,236 unpacking tar archive at: mozilla-beta-96437abde2ec/testing/mozharness/ program finished with exit code 0 elapsedTime=1.277636 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 10:45:06.453175) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:06.453498) ========= script_repo_revision: 96437abde2ecbab4f3ac771320c213debde6b43c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:06.453870) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:06.454169) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 10:45:06.471661) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-06 10:45:06.472049) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rw7enFw8TW/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.vNQ57N8lBj/Listeners TMPDIR=/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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:06 INFO - MultiFileLogger online at 20160606 10:45:06 in /builds/slave/test 10:45:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:45:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:45:06 INFO - {'append_to_log': False, 10:45:06 INFO - 'base_work_dir': '/builds/slave/test', 10:45:06 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:45:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:45:06 INFO - 'branch': 'Mozilla-Beta', 10:45:06 INFO - 'buildbot_json_path': 'buildprops.json', 10:45:06 INFO - 'config_files': ('talos/mac_config.py',), 10:45:06 INFO - 'default_actions': ('clobber', 10:45:06 INFO - 'read-buildbot-config', 10:45:06 INFO - 'download-and-extract', 10:45:06 INFO - 'populate-webroot', 10:45:06 INFO - 'create-virtualenv', 10:45:06 INFO - 'install', 10:45:06 INFO - 'run-tests'), 10:45:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:45:06 INFO - 'download_minidump_stackwalk': True, 10:45:06 INFO - 'download_symbols': 'ondemand', 10:45:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:45:06 INFO - 'tooltool.py': '/tools/tooltool.py', 10:45:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:45:06 INFO - '/tools/misc-python/virtualenv.py')}, 10:45:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:45:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:45:06 INFO - 'installer_path': 'installer.exe', 10:45:06 INFO - 'log_level': 'info', 10:45:06 INFO - 'log_name': 'talos', 10:45:06 INFO - 'log_to_console': True, 10:45:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:45:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:45:06 INFO - 'opt_config_files': (), 10:45:06 INFO - 'pip_index': False, 10:45:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:45:06 INFO - 'cmd': ('bash', 10:45:06 INFO - '-c', 10:45:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:45:06 INFO - 'enabled': True, 10:45:06 INFO - 'halt_on_failure': False, 10:45:06 INFO - 'name': 'check_screen_resolution'},), 10:45:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:45:06 INFO - 'cmd': ('bash', 10:45:06 INFO - '-c', 10:45:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:45:06 INFO - 'enabled': True, 10:45:06 INFO - 'halt_on_failure': False, 10:45:06 INFO - 'name': 'check_screen_resolution'},), 10:45:06 INFO - 'run_cmd_checks_enabled': True, 10:45:06 INFO - 'sps_profile': False, 10:45:06 INFO - 'sps_profile_interval': 0, 10:45:06 INFO - 'suite': 'dromaeojs', 10:45:06 INFO - 'system_bits': '32', 10:45:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:45:06 INFO - 'title': 't-yosemite-r7-0302', 10:45:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:45:06 INFO - 'use_talos_json': True, 10:45:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:45:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:45:06 INFO - 'work_dir': 'build'} 10:45:06 INFO - ##### 10:45:06 INFO - ##### Running clobber step. 10:45:06 INFO - ##### 10:45:06 INFO - Running pre-action listener: _resource_record_pre_action 10:45:06 INFO - Running main action method: clobber 10:45:06 INFO - rmtree: /builds/slave/test/build 10:45:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:45:09 INFO - Running post-action listener: _resource_record_post_action 10:45:09 INFO - ##### 10:45:09 INFO - ##### Running read-buildbot-config step. 10:45:09 INFO - ##### 10:45:09 INFO - Running pre-action listener: _resource_record_pre_action 10:45:09 INFO - Running main action method: read_buildbot_config 10:45:09 INFO - Using buildbot properties: 10:45:09 INFO - { 10:45:09 INFO - "project": "", 10:45:09 INFO - "product": "firefox", 10:45:09 INFO - "script_repo_revision": "production", 10:45:09 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 10:45:09 INFO - "repository": "", 10:45:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 10:45:09 INFO - "buildid": "20160601172046", 10:45:09 INFO - "pgo_build": "False", 10:45:09 INFO - "basedir": "/builds/slave/test", 10:45:09 INFO - "buildnumber": 2, 10:45:09 INFO - "slavename": "t-yosemite-r7-0302", 10:45:09 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:45:09 INFO - "platform": "yosemite_r7", 10:45:09 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:45:09 INFO - "branch": "mozilla-beta", 10:45:09 INFO - "repo_path": "releases/mozilla-beta", 10:45:09 INFO - "revision": "96437abde2ecbab4f3ac771320c213debde6b43c", 10:45:09 INFO - "stage_platform": "macosx64", 10:45:09 INFO - "builduid": "e9d26e5e91854a5abc1e9b81ef0712cd", 10:45:09 INFO - "slavebuilddir": "test" 10:45:09 INFO - } 10:45:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 10:45:09 INFO - Running post-action listener: _resource_record_post_action 10:45:09 INFO - ##### 10:45:09 INFO - ##### Running download-and-extract step. 10:45:09 INFO - ##### 10:45:09 INFO - Running pre-action listener: _resource_record_pre_action 10:45:09 INFO - Running main action method: download_and_extract 10:45:09 INFO - mkdir: /builds/slave/test/build/tests 10:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:09 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:09 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:09 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:09 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:09 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:10 INFO - Downloaded 1241 bytes. 10:45:10 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 10:45:10 INFO - Using the following test package requirements: 10:45:10 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:45:10 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:10 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 10:45:10 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:10 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 10:45:10 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:45:10 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:10 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 10:45:10 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:45:10 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:10 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 10:45:10 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:10 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 10:45:10 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:10 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 10:45:10 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:45:10 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:10 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 10:45:10 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 10:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:10 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:10 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:10 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:10 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:10 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:12 INFO - Downloaded 17816937 bytes. 10:45:12 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:12 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:15 INFO - Return code: 0 10:45:15 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:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:15 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:15 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:15 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:15 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:15 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:17 INFO - Downloaded 17816937 bytes. 10:45:17 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:17 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:20 INFO - Return code: 0 10:45: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:45:20 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:45: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.talos.tests.zip 10:45: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.talos.tests.zip 10:45: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.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 10:45:20 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:45:22 INFO - Downloaded 10845194 bytes. 10:45:22 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:45:22 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:45:23 INFO - Return code: 0 10:45:23 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:23 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:45:23 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:45:23 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:45:23 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:45:23 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:45:26 INFO - Downloaded 88466286 bytes. 10:45:26 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:45:26 INFO - mkdir: /builds/slave/test/properties 10:45:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:45:26 INFO - Writing to file /builds/slave/test/properties/build_url 10:45:26 INFO - Contents: 10:45:26 INFO - build_url:https://queue.taskcluster.net/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:45:27 INFO - Running post-action listener: _resource_record_post_action 10:45:27 INFO - Running post-action listener: set_extra_try_arguments 10:45:27 INFO - ##### 10:45:27 INFO - ##### Running populate-webroot step. 10:45:27 INFO - ##### 10:45:27 INFO - Running pre-action listener: _resource_record_pre_action 10:45:27 INFO - Running main action method: populate_webroot 10:45:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:45:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:45:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:45:27 INFO - '--tppagecycles', 10:45:27 INFO - '7'], 10:45:27 INFO - 'tests': ['tsvgm']}}, 10:45:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:45:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:45:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:45:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:45:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:45:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:45:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:45:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:27 INFO - 'talos_options': ['--e10s'], 10:45:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:45:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:27 INFO - 'tests': ['damp', 'tps']}, 10:45:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:27 INFO - 'talos_options': ['--e10s'], 10:45:27 INFO - 'tests': ['damp', 'tps']}, 10:45:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:45:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:45:27 INFO - 'other': {'tests': ['a11yr', 10:45:27 INFO - 'ts_paint', 10:45:27 INFO - 'tpaint', 10:45:27 INFO - 'sessionrestore', 10:45:27 INFO - 'sessionrestore_no_auto_restore', 10:45:27 INFO - 'tabpaint']}, 10:45:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:45:27 INFO - 'tests': ['a11yr', 10:45:27 INFO - 'ts_paint', 10:45:27 INFO - 'tpaint', 10:45:27 INFO - 'sessionrestore', 10:45:27 INFO - 'sessionrestore_no_auto_restore', 10:45:27 INFO - 'tabpaint']}, 10:45:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:45:27 INFO - 'tests': ['a11yr', 10:45:27 INFO - 'ts_paint', 10:45:27 INFO - 'tpaint', 10:45:27 INFO - 'sessionrestore', 10:45:27 INFO - 'sessionrestore_no_auto_restore', 10:45:27 INFO - 'tabpaint']}, 10:45:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:45:27 INFO - 'tests': ['a11yr', 10:45:27 INFO - 'ts_paint', 10:45:27 INFO - 'tpaint', 10:45:27 INFO - 'sessionrestore', 10:45:27 INFO - 'sessionrestore_no_auto_restore', 10:45:27 INFO - 'tabpaint']}, 10:45:27 INFO - 'other_l64': {'tests': ['a11yr', 10:45:27 INFO - 'ts_paint', 10:45:27 INFO - 'tpaint', 10:45:27 INFO - 'sessionrestore', 10:45:27 INFO - 'sessionrestore_no_auto_restore', 10:45:27 INFO - 'tabpaint']}, 10:45:27 INFO - 'other_nol64': {'tests': ['a11yr', 10:45:27 INFO - 'ts_paint', 10:45:27 INFO - 'tpaint', 10:45:27 INFO - 'sessionrestore', 10:45:27 INFO - 'sessionrestore_no_auto_restore', 10:45:27 INFO - 'tabpaint']}, 10:45:27 INFO - 'svgr': {'tests': ['tsvgx', 10:45:27 INFO - 'tsvgr_opacity', 10:45:27 INFO - 'tart', 10:45:27 INFO - 'tscrollx', 10:45:27 INFO - 'cart']}, 10:45:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:45:27 INFO - 'tests': ['tsvgx', 10:45:27 INFO - 'tsvgr_opacity', 10:45:27 INFO - 'tart', 10:45:27 INFO - 'tscrollx', 10:45:27 INFO - 'cart']}, 10:45:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:27 INFO - 'tests': ['tp5o']}, 10:45:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:27 INFO - 'talos_options': ['--e10s'], 10:45:27 INFO - 'tests': ['tp5o']}, 10:45:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:27 INFO - 'talos_options': ['--xperf_path', 10:45:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:45:27 INFO - 'tests': ['tp5n']}, 10:45:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:27 INFO - 'talos_options': ['--e10s', 10:45:27 INFO - '--xperf_path', 10:45:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:45:27 INFO - 'tests': ['tp5n']}}, 10:45:27 INFO - 'talos.zip': {'path': '', 10:45:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:45:27 INFO - Running post-action listener: _resource_record_post_action 10:45:27 INFO - ##### 10:45:27 INFO - ##### Running create-virtualenv step. 10:45:27 INFO - ##### 10:45:27 INFO - Running pre-action listener: _resource_record_pre_action 10:45:27 INFO - Running main action method: create_virtualenv 10:45:27 INFO - Creating virtualenv /builds/slave/test/build/venv 10:45:27 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:45:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:45:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:45:27 INFO - Using real prefix '/tools/python27' 10:45:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:45:28 INFO - Installing distribute.............................................................................................................................................................................................done. 10:45:31 INFO - Installing pip.................done. 10:45:31 INFO - Return code: 0 10:45:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:45:31 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:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:31 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:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:31 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 0x10af05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af0c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe952d9a930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada9d30>, '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 0x10ac0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ada0b20>, '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.rw7enFw8TW/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.vNQ57N8lBj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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:45:31 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:45:31 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:45:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rw7enFw8TW/Render', 10:45:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:31 INFO - 'HOME': '/Users/cltbld', 10:45:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:31 INFO - 'LOGNAME': 'cltbld', 10:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:31 INFO - 'MOZ_NO_REMOTE': '1', 10:45:31 INFO - 'NO_EM_RESTART': '1', 10:45:31 INFO - 'PAGER': '/bin/cat', 10:45:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:31 INFO - 'PWD': '/builds/slave/test', 10:45:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:31 INFO - 'SHELL': '/bin/bash', 10:45:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vNQ57N8lBj/Listeners', 10:45:31 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 10:45:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:31 INFO - 'USER': 'cltbld', 10:45:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:31 INFO - 'XPC_FLAGS': '0x0', 10:45:31 INFO - 'XPC_SERVICE_NAME': '0', 10:45:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:31 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:45:31 INFO - Cleaning up... 10:45:31 INFO - Return code: 0 10:45:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:45:31 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:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:31 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:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:31 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 0x10af05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af0c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe952d9a930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada9d30>, '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 0x10ac0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ada0b20>, '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.rw7enFw8TW/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.vNQ57N8lBj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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:45:31 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:45:31 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:45:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rw7enFw8TW/Render', 10:45:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:31 INFO - 'HOME': '/Users/cltbld', 10:45:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:31 INFO - 'LOGNAME': 'cltbld', 10:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:31 INFO - 'MOZ_NO_REMOTE': '1', 10:45:31 INFO - 'NO_EM_RESTART': '1', 10:45:31 INFO - 'PAGER': '/bin/cat', 10:45:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:31 INFO - 'PWD': '/builds/slave/test', 10:45:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:31 INFO - 'SHELL': '/bin/bash', 10:45:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vNQ57N8lBj/Listeners', 10:45:31 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 10:45:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:31 INFO - 'USER': 'cltbld', 10:45:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:31 INFO - 'XPC_FLAGS': '0x0', 10:45:31 INFO - 'XPC_SERVICE_NAME': '0', 10:45:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:31 INFO - Downloading/unpacking psutil>=0.7.1 10:45:31 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:45:31 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:45:31 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:45:31 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:45:31 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:45:31 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:45:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:45:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:45:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:45:34 INFO - Installing collected packages: psutil 10:45:34 INFO - Running setup.py install for psutil 10:45:35 INFO - building 'psutil._psutil_osx' extension 10:45:35 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:45:35 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:45:35 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:45:35 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:45:35 INFO - building 'psutil._psutil_posix' extension 10:45:35 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:45:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:45:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:45:35 INFO - ^ 10:45:35 INFO - 1 warning generated. 10:45:35 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:45:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:45:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:45:36 INFO - Successfully installed psutil 10:45:36 INFO - Cleaning up... 10:45:36 INFO - Return code: 0 10:45:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:45:36 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:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:36 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:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:36 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 0x10af05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af0c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe952d9a930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada9d30>, '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 0x10ac0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ada0b20>, '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.rw7enFw8TW/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.vNQ57N8lBj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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:45:36 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:45:36 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:45:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rw7enFw8TW/Render', 10:45:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:36 INFO - 'HOME': '/Users/cltbld', 10:45:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:36 INFO - 'LOGNAME': 'cltbld', 10:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:36 INFO - 'MOZ_NO_REMOTE': '1', 10:45:36 INFO - 'NO_EM_RESTART': '1', 10:45:36 INFO - 'PAGER': '/bin/cat', 10:45:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:36 INFO - 'PWD': '/builds/slave/test', 10:45:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:36 INFO - 'SHELL': '/bin/bash', 10:45:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vNQ57N8lBj/Listeners', 10:45:36 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 10:45:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:36 INFO - 'USER': 'cltbld', 10:45:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:36 INFO - 'XPC_FLAGS': '0x0', 10:45:36 INFO - 'XPC_SERVICE_NAME': '0', 10:45:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:45:36 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:45:36 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:45:36 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:45:36 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:45:36 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:45:36 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:45:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:45:38 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:45:38 INFO - Installing collected packages: mozsystemmonitor 10:45:38 INFO - Running setup.py install for mozsystemmonitor 10:45:39 INFO - Successfully installed mozsystemmonitor 10:45:39 INFO - Cleaning up... 10:45:39 INFO - Return code: 0 10:45:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:39 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 0x10af05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af0c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe952d9a930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada9d30>, '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 0x10ac0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ada0b20>, '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.rw7enFw8TW/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.vNQ57N8lBj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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:45:39 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:45:39 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:45:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rw7enFw8TW/Render', 10:45:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:39 INFO - 'HOME': '/Users/cltbld', 10:45:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:39 INFO - 'LOGNAME': 'cltbld', 10:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:39 INFO - 'MOZ_NO_REMOTE': '1', 10:45:39 INFO - 'NO_EM_RESTART': '1', 10:45:39 INFO - 'PAGER': '/bin/cat', 10:45:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:39 INFO - 'PWD': '/builds/slave/test', 10:45:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:39 INFO - 'SHELL': '/bin/bash', 10:45:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vNQ57N8lBj/Listeners', 10:45:39 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 10:45:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:39 INFO - 'USER': 'cltbld', 10:45:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:39 INFO - 'XPC_FLAGS': '0x0', 10:45:39 INFO - 'XPC_SERVICE_NAME': '0', 10:45:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:39 INFO - Downloading/unpacking blobuploader==1.2.4 10:45:39 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:45:39 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:45:39 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:45:39 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:45:39 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:45:39 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:45:41 INFO - Downloading blobuploader-1.2.4.tar.gz 10:45:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:45:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:45:41 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:45:41 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:45:41 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:45:41 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:45:41 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:45:41 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:45:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:45:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:42 INFO - Downloading docopt-0.6.1.tar.gz 10:45:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:45:43 INFO - Installing collected packages: blobuploader, requests, docopt 10:45:43 INFO - Running setup.py install for blobuploader 10:45:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:45:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:45:43 INFO - Running setup.py install for requests 10:45:43 INFO - Running setup.py install for docopt 10:45:43 INFO - Successfully installed blobuploader requests docopt 10:45:43 INFO - Cleaning up... 10:45:43 INFO - Return code: 0 10:45:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:45:43 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:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:43 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:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:43 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 0x10af05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af0c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe952d9a930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada9d30>, '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 0x10ac0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ada0b20>, '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.rw7enFw8TW/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.vNQ57N8lBj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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:45:43 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:45:43 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:45:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rw7enFw8TW/Render', 10:45:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:43 INFO - 'HOME': '/Users/cltbld', 10:45:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:43 INFO - 'LOGNAME': 'cltbld', 10:45:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:43 INFO - 'MOZ_NO_REMOTE': '1', 10:45:44 INFO - 'NO_EM_RESTART': '1', 10:45:44 INFO - 'PAGER': '/bin/cat', 10:45:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:44 INFO - 'PWD': '/builds/slave/test', 10:45:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:44 INFO - 'SHELL': '/bin/bash', 10:45:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vNQ57N8lBj/Listeners', 10:45:44 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 10:45:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:44 INFO - 'USER': 'cltbld', 10:45:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:44 INFO - 'XPC_FLAGS': '0x0', 10:45:44 INFO - 'XPC_SERVICE_NAME': '0', 10:45:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:45:44 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-Oaiaun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:45:44 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-EwIgqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:45:44 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-03HXQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:45:44 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-aMf9MI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:45:44 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-NocwgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:45:44 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-ECSvML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:45:44 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-GJX2jU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:45:44 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-QVhP47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:45:45 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-7ZPfzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:45:45 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-P06kPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:45:45 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-nk_c86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:45:45 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-TgjfMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:45:45 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-BACf8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:45:45 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-9xo8yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:45 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-k__o4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:45:45 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-FKqbeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:45:45 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-a6BGDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:45:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:45:46 INFO - Running setup.py install for manifestparser 10:45:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:45:46 INFO - Running setup.py install for mozcrash 10:45:46 INFO - Running setup.py install for mozdebug 10:45:46 INFO - Running setup.py install for mozdevice 10:45:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:45:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:45:46 INFO - Running setup.py install for mozfile 10:45:46 INFO - Running setup.py install for mozhttpd 10:45:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:45:46 INFO - Running setup.py install for mozinfo 10:45:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Running setup.py install for mozInstall 10:45:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Running setup.py install for mozleak 10:45:47 INFO - Running setup.py install for mozlog 10:45:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Running setup.py install for moznetwork 10:45:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Running setup.py install for mozprocess 10:45:47 INFO - Running setup.py install for mozprofile 10:45:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:45:48 INFO - Running setup.py install for mozrunner 10:45:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:45:48 INFO - Running setup.py install for mozscreenshot 10:45:48 INFO - Running setup.py install for moztest 10:45:48 INFO - Running setup.py install for mozversion 10:45:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:45:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:45:48 INFO - Cleaning up... 10:45:48 INFO - Return code: 0 10:45:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:48 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 0x10af05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af0c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe952d9a930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada9d30>, '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 0x10ac0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ada0b20>, '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.rw7enFw8TW/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.vNQ57N8lBj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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:45:48 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:45:48 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:45:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rw7enFw8TW/Render', 10:45:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:48 INFO - 'HOME': '/Users/cltbld', 10:45:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:48 INFO - 'LOGNAME': 'cltbld', 10:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:48 INFO - 'MOZ_NO_REMOTE': '1', 10:45:48 INFO - 'NO_EM_RESTART': '1', 10:45:48 INFO - 'PAGER': '/bin/cat', 10:45:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:48 INFO - 'PWD': '/builds/slave/test', 10:45:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:48 INFO - 'SHELL': '/bin/bash', 10:45:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vNQ57N8lBj/Listeners', 10:45:48 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 10:45:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:48 INFO - 'USER': 'cltbld', 10:45:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:48 INFO - 'XPC_FLAGS': '0x0', 10:45:48 INFO - 'XPC_SERVICE_NAME': '0', 10:45:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:45:48 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-aEbPHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:45:49 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:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:45:49 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-GW7vGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:45:49 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:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:45:49 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-mANHET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:45:49 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:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:45:49 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-92BVeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:45:49 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:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:45:49 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-_jgC7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:45:49 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:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:45:49 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-CaSEs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:45:49 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:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:45:49 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-AARxeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:45:49 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:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:45:49 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-eQXdtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:45:49 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:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:45:49 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-oJpSzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:45:49 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:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:45:49 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-aciIaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:45:49 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:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:45:49 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-kABWBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:45:50 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:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:45:50 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-8tmonR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:45:50 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:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:45:50 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-MOt65s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:45:50 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:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:45:50 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-pWg0e_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:45:50 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:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:50 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-u1s_lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:50 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:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:45:50 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-M5JOI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:45:50 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:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:45:50 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-ng5SHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:45:50 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:45:50 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:45:50 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:45:50 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:45:50 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:45:50 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:45:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:45: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:45: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:45: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:45: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:45: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:45: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:45:53 INFO - Downloading blessings-1.6.tar.gz 10:45:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:45:53 INFO - Installing collected packages: blessings 10:45:53 INFO - Running setup.py install for blessings 10:45:53 INFO - Successfully installed blessings 10:45:53 INFO - Cleaning up... 10:45:53 INFO - Return code: 0 10:45:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:45:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:45:53 INFO - Reading from file tmpfile_stdout 10:45:53 INFO - Current package versions: 10:45:53 INFO - blessings == 1.6 10:45:53 INFO - blobuploader == 1.2.4 10:45:53 INFO - docopt == 0.6.1 10:45:53 INFO - manifestparser == 1.1 10:45:53 INFO - mozInstall == 1.12 10:45:53 INFO - mozcrash == 0.17 10:45:53 INFO - mozdebug == 0.1 10:45:53 INFO - mozdevice == 0.48 10:45:53 INFO - mozfile == 1.2 10:45:53 INFO - mozhttpd == 0.7 10:45:53 INFO - mozinfo == 0.9 10:45:53 INFO - mozleak == 0.1 10:45:53 INFO - mozlog == 3.1 10:45:53 INFO - moznetwork == 0.27 10:45:53 INFO - mozprocess == 0.22 10:45:53 INFO - mozprofile == 0.28 10:45:53 INFO - mozrunner == 6.11 10:45:53 INFO - mozscreenshot == 0.1 10:45:53 INFO - mozsystemmonitor == 0.0 10:45:53 INFO - moztest == 0.7 10:45:53 INFO - mozversion == 1.4 10:45:53 INFO - psutil == 3.1.1 10:45:53 INFO - requests == 1.2.3 10:45:53 INFO - wsgiref == 0.1.2 10:45:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:45: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:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45: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:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:53 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 0x10af05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af0c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe952d9a930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada9d30>, '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 0x10ac0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ada0b20>, '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.rw7enFw8TW/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.vNQ57N8lBj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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:45:53 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:45:53 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:45:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rw7enFw8TW/Render', 10:45:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:53 INFO - 'HOME': '/Users/cltbld', 10:45:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:53 INFO - 'LOGNAME': 'cltbld', 10:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:53 INFO - 'MOZ_NO_REMOTE': '1', 10:45:53 INFO - 'NO_EM_RESTART': '1', 10:45:53 INFO - 'PAGER': '/bin/cat', 10:45:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:53 INFO - 'PWD': '/builds/slave/test', 10:45:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:53 INFO - 'SHELL': '/bin/bash', 10:45:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vNQ57N8lBj/Listeners', 10:45:53 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 10:45:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:53 INFO - 'USER': 'cltbld', 10:45:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:53 INFO - 'XPC_FLAGS': '0x0', 10:45:53 INFO - 'XPC_SERVICE_NAME': '0', 10:45:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:54 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:45:54 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:45:54 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:45:54 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:45:54 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:45:54 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:45:54 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:45:54 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:45:54 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:45:54 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:45:54 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:45:54 INFO - Cleaning up... 10:45:54 INFO - Return code: 0 10:45:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:54 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 0x10af05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af0c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe952d9a930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada9d30>, '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 0x10ac0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ada0b20>, '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.rw7enFw8TW/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.vNQ57N8lBj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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:45:54 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:45:54 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:45:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rw7enFw8TW/Render', 10:45:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:54 INFO - 'HOME': '/Users/cltbld', 10:45:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:54 INFO - 'LOGNAME': 'cltbld', 10:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:54 INFO - 'MOZ_NO_REMOTE': '1', 10:45:54 INFO - 'NO_EM_RESTART': '1', 10:45:54 INFO - 'PAGER': '/bin/cat', 10:45:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:54 INFO - 'PWD': '/builds/slave/test', 10:45:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:54 INFO - 'SHELL': '/bin/bash', 10:45:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vNQ57N8lBj/Listeners', 10:45:54 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 10:45:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:54 INFO - 'USER': 'cltbld', 10:45:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:54 INFO - 'XPC_FLAGS': '0x0', 10:45:54 INFO - 'XPC_SERVICE_NAME': '0', 10:45:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:54 INFO - Downloading/unpacking jsonschema 10:45:54 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:45:54 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:45:54 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:45:54 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:45:54 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:45:54 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:45:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:45:56 INFO - Downloading/unpacking functools32 (from jsonschema) 10:45: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:45: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:45: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:45: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:45: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:45: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:45:57 INFO - Downloading functools32-3.2.3-2.tar.gz 10:45:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:45:57 INFO - warning: no files found matching '*.txt' 10:45:57 INFO - no previously-included directories found matching 'build' 10:45:57 INFO - no previously-included directories found matching 'dist' 10:45:57 INFO - no previously-included directories found matching '.git*' 10:45:57 INFO - Installing collected packages: jsonschema, functools32 10:45:57 INFO - Running setup.py install for functools32 10:45:57 INFO - warning: no files found matching '*.txt' 10:45:57 INFO - no previously-included directories found matching 'build' 10:45:57 INFO - no previously-included directories found matching 'dist' 10:45:57 INFO - no previously-included directories found matching '.git*' 10:45:57 INFO - Successfully installed jsonschema functools32 10:45:57 INFO - Cleaning up... 10:45:57 INFO - Return code: 0 10:45:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:57 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 0x10af05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af0c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe952d9a930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada9d30>, '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 0x10ac0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ada0b20>, '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.rw7enFw8TW/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.vNQ57N8lBj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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:45:57 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:45:57 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:45:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rw7enFw8TW/Render', 10:45:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:57 INFO - 'HOME': '/Users/cltbld', 10:45:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:57 INFO - 'LOGNAME': 'cltbld', 10:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:57 INFO - 'MOZ_NO_REMOTE': '1', 10:45:57 INFO - 'NO_EM_RESTART': '1', 10:45:57 INFO - 'PAGER': '/bin/cat', 10:45:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:57 INFO - 'PWD': '/builds/slave/test', 10:45:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:57 INFO - 'SHELL': '/bin/bash', 10:45:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vNQ57N8lBj/Listeners', 10:45:57 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 10:45:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:57 INFO - 'USER': 'cltbld', 10:45:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:57 INFO - 'XPC_FLAGS': '0x0', 10:45:57 INFO - 'XPC_SERVICE_NAME': '0', 10:45:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:57 INFO - Downloading/unpacking flake8 10:45:57 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:45:57 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:45:57 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:45:57 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:45:57 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:45:57 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:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:46:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:46:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:46:01 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:01 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:01 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:01 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:01 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:01 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:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:46:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:46:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:46:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:46:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:46:01 INFO - no previously-included directories found matching 'docs/_build' 10:46:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:46:01 INFO - Running setup.py install for pep8 10:46:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:46:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:46:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:46:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:46:01 INFO - no previously-included directories found matching 'docs/_build' 10:46:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:46:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:46:01 INFO - Cleaning up... 10:46:01 INFO - Return code: 0 10:46:01 INFO - Running post-action listener: _resource_record_post_action 10:46:01 INFO - Running post-action listener: _start_resource_monitoring 10:46:01 INFO - Starting resource monitoring. 10:46:01 INFO - ##### 10:46:01 INFO - ##### Running install step. 10:46:01 INFO - ##### 10:46:01 INFO - Running pre-action listener: _resource_record_pre_action 10:46:01 INFO - Running main action method: install 10:46:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:46:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:46:02 INFO - Reading from file tmpfile_stdout 10:46:02 INFO - Detecting whether we're running mozinstall >=1.0... 10:46:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:46:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:46:02 INFO - Reading from file tmpfile_stdout 10:46:02 INFO - Output received: 10:46:02 INFO - Usage: mozinstall [options] installer 10:46:02 INFO - Options: 10:46:02 INFO - -h, --help show this help message and exit 10:46:02 INFO - -d DEST, --destination=DEST 10:46:02 INFO - Directory to install application into. [default: 10:46:02 INFO - "/builds/slave/test"] 10:46:02 INFO - --app=APP Application being installed. [default: firefox] 10:46:02 INFO - mkdir: /builds/slave/test/build/application 10:46:02 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:02 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:46:24 INFO - Reading from file tmpfile_stdout 10:46:24 INFO - Output received: 10:46:24 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:46:24 INFO - Running post-action listener: _resource_record_post_action 10:46:24 INFO - ##### 10:46:24 INFO - ##### Running run-tests step. 10:46:24 INFO - ##### 10:46:24 INFO - Running pre-action listener: _resource_record_pre_action 10:46:24 INFO - Running main action method: run_tests 10:46:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:46:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:46:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:46:24 INFO - 2016-06-06 10:46:24.862 screenresolution[1738:8490] starting screenresolution argv=screenresolution get 10:46:24 INFO - 2016-06-06 10:46:24.864 screenresolution[1738:8490] Display 0: 1600x1200x32@60 10:46:24 INFO - 2016-06-06 10:46:24.869 screenresolution[1739:8497] starting screenresolution argv=screenresolution list 10:46:24 INFO - Available Modes on Display 0 10:46:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:46:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:46:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:46:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:46:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:46:25 INFO - Intel Iris: 10:46:25 INFO - Chipset Model: Intel Iris 10:46:25 INFO - Type: GPU 10:46:25 INFO - Bus: Built-In 10:46:25 INFO - VRAM (Dynamic, Max): 1536 MB 10:46:25 INFO - Vendor: Intel (0x8086) 10:46:25 INFO - Device ID: 0x0a2e 10:46:25 INFO - Revision ID: 0x0009 10:46:25 INFO - Displays: 10:46:25 INFO - Display: 10:46:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:46:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:46:25 INFO - Display Serial Number: 1600x1200 60 10:46:25 INFO - Main Display: Yes 10:46:25 INFO - Mirror: Off 10:46:25 INFO - Online: Yes 10:46:25 INFO - Rotation: Supported 10:46:25 INFO - Return code: 0 10:46:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:46:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:46:25 INFO - Python 2.7.3 10:46:25 INFO - Return code: 0 10:46:25 INFO - grabbing minidump binary from tooltool 10:46:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:25 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 0x10ada9d30>, '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 0x10ac0ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ada0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:46:25 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:46:25 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:46:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:46:25 INFO - Return code: 0 10:46:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:46:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:46:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:46:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:46:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:46:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:46:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:46:26 INFO - Return code: 0 10:46:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0302', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:46:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0302 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:46:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rw7enFw8TW/Render', 10:46:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:26 INFO - 'HOME': '/Users/cltbld', 10:46:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:26 INFO - 'LOGNAME': 'cltbld', 10:46:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:46:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:26 INFO - 'MOZ_NO_REMOTE': '1', 10:46:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:46:26 INFO - 'NO_EM_RESTART': '1', 10:46:26 INFO - 'PAGER': '/bin/cat', 10:46:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:26 INFO - 'PWD': '/builds/slave/test', 10:46:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:46:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:26 INFO - 'SHELL': '/bin/bash', 10:46:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vNQ57N8lBj/Listeners', 10:46:26 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 10:46:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:26 INFO - 'USER': 'cltbld', 10:46:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:26 INFO - 'XPC_FLAGS': '0x0', 10:46:26 INFO - 'XPC_SERVICE_NAME': '0', 10:46:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0302', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:46:26 INFO - mozversion application_buildid: 20160601172046 10:46:26 INFO - mozversion application_changeset: 96437abde2ecbab4f3ac771320c213debde6b43c 10:46:26 INFO - mozversion application_display_name: Firefox 10:46:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:46:26 INFO - mozversion application_name: Firefox 10:46:26 INFO - mozversion application_remotingname: firefox 10:46:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:46:26 INFO - mozversion application_vendor: Mozilla 10:46:26 INFO - mozversion application_version: 47.0 10:46:26 INFO - mozversion platform_buildid: 20160601172046 10:46:26 INFO - mozversion platform_changeset: 96437abde2ecbab4f3ac771320c213debde6b43c 10:46:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:46:26 INFO - mozversion platform_version: 47.0 10:46:26 INFO - using testdate: 1465235186 10:46:26 INFO - actual date: 1465235186 10:46:26 INFO - starting webserver on 'localhost:49279' 10:46:26 INFO - SUITE-START | Running 2 tests 10:46:26 INFO - TEST-START | dromaeo_css 10:46:26 INFO - operating with platform_type : mac_ 10:46:26 INFO - Initialising browser for dromaeo_css test... 10:46:26 INFO - TEST-INFO | started process 1757 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/tmpHY8Zin/profile http://localhost:49279/getInfo.html) 10:46:28 INFO - PROCESS | 1757 | __metrics Screen width/height:1600/1200 10:46:28 INFO - PROCESS | 1757 | colorDepth:24 10:46:28 INFO - PROCESS | 1757 | Browser inner width/height: 1024/689 10:46:28 INFO - PROCESS | 1757 | __metrics 10:46:29 INFO - PROCESS | 1757 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:46:29 INFO - PROCESS | 1757 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:46:29 INFO - TEST-INFO | 1757: exit 0 10:46:29 INFO - Browser initialized. 10:46:29 INFO - Running cycle 1/1 for dromaeo_css test... 10:46:29 INFO - TEST-INFO | started process 1762 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/tmpHY8Zin/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:46:41 INFO - PROCESS | 1762 | RSS: Main: 157274112 10:46:41 INFO - PROCESS | 1762 | 10:47:32 INFO - PROCESS | 1762 | 1465235252393 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:49:42 INFO - PROCESS | 1762 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 10:49:43 INFO - PROCESS | 1762 | RSS: Main: 281993216 10:49:43 INFO - PROCESS | 1762 | 10:52:45 INFO - PROCESS | 1762 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 10:52:46 INFO - PROCESS | 1762 | RSS: Main: 293384192 10:52:46 INFO - PROCESS | 1762 | 10:55:48 INFO - PROCESS | 1762 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 10:55:48 INFO - PROCESS | 1762 | RSS: Main: 294830080 10:55:48 INFO - PROCESS | 1762 | 10:58:50 INFO - PROCESS | 1762 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 10:58:51 INFO - PROCESS | 1762 | RSS: Main: 255700992 10:58:51 INFO - PROCESS | 1762 | 11:01:54 INFO - PROCESS | 1762 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 11:01:55 INFO - PROCESS | 1762 | RSS: Main: 257253376 11:01:55 INFO - PROCESS | 1762 | 11:04:57 INFO - PROCESS | 1762 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 11:04:57 INFO - PROCESS | 1762 | RSS: Main: 301588480 11:04:57 INFO - PROCESS | 1762 | 11:04:57 INFO - PROCESS | 1762 | __start_tp_report 11:04:57 INFO - PROCESS | 1762 | _x_x_mozilla_page_load 11:04:57 INFO - PROCESS | 1762 | _x_x_mozilla_page_load_details 11:04:57 INFO - PROCESS | 1762 | |i|pagename|runs| 11:04:57 INFO - PROCESS | 1762 | |0;dojo.html;3502.4921386398973;3587.977426433467;3589.6769290763827;3610.476480910268;3655.7440979131457;5824.9338979344375;5828.475437210661;5838.153467747175;5865.413458654132;5912.970435147824;5848.941510584893;5879.941200587993;5889.116632505126;5906;5909.143174239733;5127.077126117298;5232.032074066291;5279.577633789288;5296.1261391870485;5311.097113490697;5355.544778693816;5396.460353964611;5399.730013499309;5406.945930540704;5411.675299482044;5295.629305948566;5337.5463085637575;5350.759215835296;5360.115580929142;5381.892362152755;5380.21986811912;5382.313978238529;5400.945990540084;5432.293801805779;5451.700156491392;5155.974220128913;5316.973415132899;5334.653247538898;5351.946480535184;5357.357117145929;5691.430856914276;5737.168110623936;5738.741756620962;5746.994276001725;5772.3938986406665;6138.541671868701;6241.968790156066;6256.624602523818;6257.155284036642;6260.655663938482;6219.813405597839;6229.6573688447115;6274.937250627481;6298.086777417295;6298.842528936768;6028.638281703112;6037.818865434044;6052.485538729214;6061.242344706911;6087.726052327655;6233.688315584202;6294.685265736694;6416.294207637156;6457.741690332428;6458.709358078898;6223.408776166257;6233.719482623293;6237.656928868956;6241.7191226394925;6251.781187658501;6265.749370025148;6286.119943207955;6291.402316779899;6305.558610897285;6311.084892690626;6134.614040518015;6143.235544005215;6156.322804491502;6203.31763506014;6237.688115594202;6189.442950134509;6212.378762123752;6232.065190221412;6248.375162483715;6248.4688801452385;5025.195968645073;5032.521910418504;5040.092783299041;5047.545720885138;5053.974730126326;4450.977745111254;4535.659825513099;4562.954370456319;4581.816727330869;4604.562566556172;5859.589828712034;5913.142594323885;5931.58478906481;5931.703414829241;5942.762289508371;6198.411150940653;6206.534509911775;6207.193064901534;6209.379062093845;6227.19046523949;5859.882802344015;5878.882422351529;5903;5942.6731529766275;5969.641821490724;5475.7262136893;5477.1510415885605;5493.972530137324;5495.340559132929;5517.862053448696;6476.417122459001;6513.2509761377105;6520.608763474207;6529.183852018497;6549.443297319686;6143.757528502154;6199;6254;6260.186175797117;6265.342139075514;6471.676416179266;6480.935190648033;6503.382178693017;6504.056911747675;6520.641364724986;6317.936820631919;6317.96841015792;6334.841628959129;6341.302456729663;6350.809475715736;6239.7504099837315;6263.843403914939;6291.433770960635;6336.7465301389275;6339.461145802658;6255.343188965093;6263.060540918898;6278.372162783685;6279.780207692709;6293.024581189923;6254.061890716429;6277.2153480814895;6279.497640188682;6282.371762823681;6287.559870809182;5974.1636170935235;6069.484093852072;6134.294556125924;6153;6155.538334625011;6211.65835879031;6221.346758590283;6259.62442253448;6276.905846412216;6285.088662144055;5942.286925568959;5961;6073;6119.908201376894;6135.355787642234 11:04:57 INFO - PROCESS | 1762 | |1;ext.html;494.8985457981114;593.8034859757587;596.958307752971;598.7755040941274;661.851083506211;39825.4026189607;39995.60004399955;40041.59958400419;40112;40142.99285035748;43415.348769768476;44025.8993525162;44026.779866100704;44092.55907440925;44099.338509922374;9658.179054780352;9892.90107098927;9906.405615663083;9906.702798916043;9938.403695778277;9698.078682525183;9829.066238707312;9847.950760246189;9850.113489785917;9858.112769850712;9901.207903367713;9967.152792012688;9969.351992120526;9978.052085051908;9995.050470205355;9860.605575776995;9930.354526955725;9936.453495057805;9963.90036099637;9987;9739;9868.60525578976;9873.753156171082;9874.9506252469;9875.506224688737;36294.81852590747;39532.802335988425;41561.79219103915;42281.78859105716;42337.15325693469;3547.8580856765698;3878.728489005771;3947.3486874665646;3964.266610677034;4000.5599384067727;29101.981430649827;29958.85020574905;30027.549586756217;30391.696083039107;30471.08586742401;2777.472280266743;2797.314657908805;2803.327201471632;2896.203544025389;2916.737493625563;389515;390314;390738;390826;392018.99999999715;47215.5278447218;47821.04357912822;68322.3167768326;68745.31254687389;68923.62152756916;46554.767226163654;46686.83282917954;46893.3587324442;47106.5289347109;47214.76392618015;17318.740218896728;17560.121993900255;17565.121743912754;17568.472945811645;17574;14089.013769036274;14133.222672752892;14189;14202.85797142036;14209;15180.392784288504;15352.846471535366;15422.691546169013;15483.458078967182;15582.9220853895;6473.708683109271;6568.8357791055605;6638.6680665966505;6673.165854268216;6673.866522669519;1002.9899701002896;1057.2387880725864;1065.3927261461047;1089.4607169451172;1139.5043156227068;24788.628170577456;30208.09375718732;30477.23806904845;30989.69010309868;31157.376852462825;1126.9436528173558;1181.8818118188112;1187.857457105153;1229.993850030762;1263.4693428759942;15283.46507872219;15478.458253961056;15487.303071361815;15640.061596304258;15760.448384306494;545028;551185;551752;552316;553851;60872.08691869625;62049.06926396018;62172;62183.37816621867;62256.68871655613;1244.2721008210117;1298.7921932490756;1359.9256587295924;1449.644837014938;1525.80927384077;24293.02827886865;29433.558496622994;29481.115566533037;30653.846730766203;31032.68967310298;49679.25481117714;49713.75143124406;50264.748676256386;50305.99388012292;50309.993800124525;330711;332658;333455;334719;335055;30010.69989300079;33926.15184620404;34560.82719586386;34872.9538113857;35110.47334290039;41669.79165104155;42174.36738448987;44047.77976110227;44193;48004;38300.6169938297;38361.808190958865;38776;38985;40088.59911400965;37989;38131.80934095312;38180.6181938177;38918.80540597279;39110.608893911834;38188.04529886775;38691;39023;39334.80332598433;39365;33305.00084997454;33694.49458258079;34578.48132278068;34642.48036279407;34730;21798;22390.328290151323;25577.232683019538;25963.61054584145;26496 11:04:57 INFO - PROCESS | 1762 | |2;jquery.html;369.56391458079463;373.17528262539787;376.4466234635086;376.45978021539094;383.560822857828;16642.417515386966;19454.513637159078;20542.794572054274;21382.89308553459;21446.463838404048;17030.74453883193;21008.579828403424;21284.57430851386;21351;21392.572148557058;5828.417158284169;6111.144439778434;6155.107509411133;6157.7536898524;6158.199434073565;5849.122631605272;6033.758649654009;6041.728122234488;6049.969750151243;6064.120702498135;5948.048312270038;5972;5985.34161242263;5995.280566332046;6000.009998350267;5717.942820571803;5996.4902983246475;6011.068284415923;6017.789377371771;6041.516678665696;5228.346456692913;5245.554127899133;5261.1319132343115;5262.631615786897;5273.1299335609965;22221.888890555445;26939.46121077587;27573.172804815888;27626.033088841796;28114.71885281162;2231.163313757341;2247.0337754765446;2253.0311965854676;2506.0602274147195;2691.1791903469434;14457.855421445862;15076.24618769057;15411.306491207923;15581.844181558152;15589;1714.4599451172965;1745.3106023120922;1760.6610653138891;1834.7340335168824;1863.3571417860817;104744;106426.46786766016;108355;108590.45704771504;109538.9999999992;8863.64545418176;11144.60993865211;11426.94286528562;11452.083833293316;11537.48081336342;14177.929110354382;14180.787288190686;14201.147931124166;14220.573382798533;14227.715445691236;9039.23166530839;9235.307351948632;9274.072592740671;9385.483798391155;9469.289803264644;7662;9567.138957493858;9593.904060959441;9618.698997203715;9701.9029809701;6522.869542609121;6559.967200163968;6569.737210511526;6576.276609572943;6583.604983700993;1622.537576790609;1838.9724154137698;1871.3356758350862;1895.2987394664062;1929.4404622659272;986.5264672957021;998.6854140945579;1032.736652153711;1050.3277902142636;1064.834950582661;18581.628367432575;21890.562188756136;22073;22262.332130036124;22314.10743570239;927.3879239701764;1025.8153532364247;1046.215338496128;1071.7910007548453;1082.0477979378097;11413.942930285295;11940.985016273715;11953;11977.341246231366;11980.400979950968;638411.8079409666;642671;644215;666416;669437;88941;102693;105348;107122;109004.45497772619;1074.5970261152067;1084.0514549768952;1097.9670609881875;1112.3881864974232;1114.9219554631097;19238.23047078157;19615.31346402869;20033.89813560268;20044.599108017468;20116.59766804685;40619.390709139974;41236.79381603073;49231.50768492269;49956.75108122326;51082.722387581525;65986;70352.94470582843;70707.58584828378;70723;70766;8044.919550804417;8125.593720314079;8233.83532329362;8262.339012879076;8347.58262086881;12947.611571652866;13278;13443.529476468277;13591.728165436834;13638.613242682293;11278.436078196222;11553;11732.648020559396;11734.706632333919;12011.75976480448;10952.671419857417;11703.23928944616;11896.762064758483;12054.397280136134;12173.45219465144;9864.408135511892;11053.392063436266;11927.701807454536;11976;12231.694207644525;8171.918280817354;8274.462159959583;8351.791205219919;8611.6985905493;8751.124887511198;8004.5597492138495;8837.779055523662;11153.665390038312;12127.81808272859;12199.512019519474 11:04:57 INFO - PROCESS | 1762 | |3;mootools.html;1482.3033174408024;1614.1848366574877;1638.4347400146949;1965.1451618545934;2060.350989438328;8451.154884511554;9087.227585655219;9260.305477089229;9279.21126704231;9302.209312208453;8897.91102088979;9163.77090572736;9174.678886238982;9176.541172941359;9180.908190918106;2541.796656267494;2550.961735573968;2557.782588479972;2569.9486010279784;2582.18661121747;2522.545941730488;2587.2496975876975;2593.1831473085917;2593.818432709711;2599.0383558083536;2544.2875994721417;2571.035861551918;2573.858437785921;2574.909878154265;2580.7935365170742;2544.7836933860644;2558.5778346572793;2563.474487730011;2566.5765148750434;2567.370994106456;2523.835950663201;2549.3626593351664;2557.258395065429;2564.333273348924;2565.538203123437;9233.815323693556;9283.58223879927;9288.814223715555;9295.953520232355;9301.581428835718;5625.128105143668;5785.190073389729;5812.564057695689;5833.504152147073;5835.679037652927;3668.9082772930624;3759.868404605853;3812.8284227209842;3818.179091495314;3822.140018495816;1063.6064656077224;1079.1798233342638;1079.94060326682;1093.9835902461468;1112.1714322829464;12572.622821315375;12595;12603.243805371707;12609.054320925967;12621.43203555833;4994.825181118644;5043.3191519145175;5091.465396133352;5109.667871588409;5136.43499215086;8920.420172688755;10594.205434592437;10605.257631965842;10615.893841061645;10659.467026648637;5814.069748840166;5822.621529600562;5829.387914268941;5829.571754920072;5829.62107463022;4515.471394826842;4690.81236750533;4803;4857.587105096107;5281.102212623863;3619.8371073301764;4041.8989525262105;4109.958900411018;4137.8965525862095;4138.296489596776;1337.6321511584197;1358.5720498043086;1363.236587510997;1373.1623709537175;1379.8689124533153;1133.1161693878787;1167.8073117935446;1169.3042639629407;1190.089581470176;1201.039168665082;8520.062793092755;8557.614907329185;8596.742097737078;8609.182127697984;8816.426932249384;1274.6239859241362;1280.3534215221255;1281.4681907008487;1281.557862537423;1293.747719194748;6488.708008139645;6541.738330466728;6594.20869495654;6610.900836487456;6624.039514270404;10783.946080269548;11088.390138542458;11185.888141118647;11223.551057957753;11244.943775281072;11024.173187011007;11031.669049928514;11096.944515277533;11301.26541774782;11361.488733007034;8769.736907892773;8805.955970220108;8873.556322183866;8893.510856902933;8907.02022777494;8198.754037378889;8351.791205219675;8445.408821382443;8446.239838414327;8453.112423195476;9812.264080194156;9873.358231714916;9923.801523969625;9927.205823533955;9970.40177589347;10028.047335503115;10327.741806454898;10364.585416583554;10483.37099774016;10496.265261431627;7118.857622847618;7310.378617817545;7588.392928565812;7712.383009359126;7814.921850781419;8496.872546911678;8512.063672995842;8541.658333666584;8563.272121869462;8566.271866891384;7504.2870927264;7636.694532218871;7643.503172293783;7646.388288936983;7727.072751269883;6132.816015519542;7445.255474452511;7523.285287897641;7584.241575842371;7689.307962283421;7505.849883002418;7539.472236943361;8116.269535741575;8168.346532277523;8180.631871565913;7100.467464940047;7161.427085833225;7220.8916866246;7294.416446684147;7305.3425191732995;7342.48602597813;7425.517341372793;7437.070366204224;7440.776776696708;7446.888296675445 11:04:57 INFO - PROCESS | 1762 | |4;prototype.html;287.6002356724155;319.20199501246884;336.5154177983703;340.03938872684654;343.69926314474833;5577.9959607270675;6448;6537.280899101101;6541;6543.280239173687;6141.477974372184;6441.355864413556;6441.8711625767455;6467.676616169197;6478.319776423478;4690.50749671283;4705.529447055284;4828.7585620719;4834.58905992991;4878.463369029404;4777.617790576745;4808.831690890819;4811.639127065484;4815.085133824579;4816.807327706888;4783.569478746912;4828.106800241949;4835.637327200457;4837.0567739290855;4849.733264670442;4657.371254880599;4733.455652599943;4810.254410566367;4839.588634966032;4848.200046992242;4168.8332466701295;4171.457710497646;4175.937360939588;4188.4555007849085;4189.874303770892;6082.543809214327;6131.63210207389;6138.294096178952;6148.323684394713;6257.906131408033;5719.885602287931;5726.971365143189;5735.283089613798;5738;5743.827685169452;6678.43233325168;6917.757878474229;6919.411849992756;6929.653517324114;6937.826554336131;3865.8067096645336;4734.218853889104;4746.09824133417;4747.905041899177;4753.453352864431;7169.74905878297;7326.120865496121;7330.413566914687;7333.706651733924;7344;4831.106245344622;4837.95162048382;4845.176320025604;4846.491118432585;4849;4842.104210721028;4907.067657145131;4913.434954980152;4920.975395123073;4925.852224433273;4484.9103017940115;5756.453136951983;5776.104703770922;5778.739956701958;5782.190493330937;6702.932970670328;6947.930520694829;6967.059446974695;6984.860302793915;6995.545289556163;1688.50189194188;1706.8293170682832;1717.6822287876782;1721.6040310728351;1724.965500689979;1049.6850944716555;1083.3932997521413;1102.1513434655271;1108.467935391017;1135.8182690769438;6514.250861150934;6613.107230523914;6636.8672626547195;6637.070810086591;6656;6530.314316996647;6637.037629543689;7206.927930720731;7220.747273845495;7229.530080544748;6597.175353080865;6604.075429439882;6604.570702904296;6611.63636000015;6614.437772789271;3696.149885526344;3768.1333293342686;3802.1825307558456;3809.2191100824266;3817.61823817616;7408.518446300973;7448.478606497493;7490.475666703387;7529.397648188132;7552;5917.881642367129;7379.151397589346;7409.333160015624;7410.703571857065;7420.257974202536;6805;7393.778186654409;7488.176300606929;7502.062242219723;7514.924850751422;5501.339839219319;7176.928230717626;7180.964095179491;7187.928120718726;7187.928120718726;5648.406917273792;7036.542624729376;7063.5055546113335;7073.292670732885;7081.7167313308955;7320.048393708784;7468.589227592534;7493.850122997401;7513.060867391576;7529.1717911028645;4812.855614331575;4819.7349145795915;4825.927611085766;4830.734309613005;4833.275008748716;7112.964435177791;7117.1459424869345;7120.572765634079;7129.679164437716;7139.393151581966;6201.844953876189;6514.771982980573;6844.041834143323;6846.657667116724;6865.41643960249;5168.508991645787;5518.751656175402;6816.454683625199;6880.4839637026425;6886.586804791728;6686.0973768540625;6691.464682825265;6770.289119642367;6838.281980392187;6841.452683785385;6866.622335771581;6878.209005964178;6883.208431030495;6883.414909732529;6910.308969103251;5872.911906321323;6506.577072490273;6588.275289718223;6776.220734615582;6814.352636499525 11:04:57 INFO - PROCESS | 1762 | |5;yui.html;708.3306275569587;763.6792547130204;779.6062988190967;792.4413288631512;793.9722109726157;15344.07935523868;15701.37194512221;15729.37082516698;15742.21288935553;15746.370145194192;14450.855491445109;14522.636934076627;14591.927040364782;14653.487127950524;14672.779908301383;769.9653515591812;790.3558599741192;928.5589345061076;967.8451447768358;968.6222373274429;801.8276070644811;941.2752180820764;954.3844220477788;955.2930831184942;969.9515024248794;829.3986859526825;1024.2471783239314;1027.7636143686957;1028.2493779540903;1028.388109075099;834.1741675741004;835.8161204534993;977.8337682593976;1013.6148263659762;1015.0813513769976;753.3144838197269;755.6750597243183;756.0964647246543;757.0385610274975;758.2076729817354;11992.580259690956;15326.310316035806;15331.923340383339;15361;15401.383944642314;13041.413136408884;13141.145825521406;13270.203787772765;13406.932965335209;13546.525871594546;10294.124999375063;11357.829632555518;11397.259178153394;11685.824712629317;11868.287902725864;3518.3842827505086;3533.9823300883586;3553.4847447120283;3606.711463082947;3779.1496913194587;89139;89199.10800892038;90455;90736.55580665116;90941.54529227377;8908.688195913111;9392.62429502826;9761.707148785548;9894.901050989398;10035.648752293635;21890.562188756136;22059.889700551394;22068.448288792588;22083.227087051877;22127.225547105772;7641.732539361095;7677.731279405194;7717.729879454305;7759.30166285037;7919.564423956737;4191.3293872980785;4291.592298731615;4304.677149213759;4313.051128751669;4572.908541829212;3767.208886133888;3811.313963486599;3820.5033345665443;3825.081980324702;3827.158025234444;564.5032371513042;569.4959960435045;657.6547312660796;658.6016846337851;668.0713807807152;534.8181618249814;603.4840211619003;609.9786507472218;627.5669787846372;634.6255709131542;8344.8331033379;8499.490030598185;8572.699955501528;8612.741617751477;8649.73849163581;598.5391248738534;601.3745704467392;606.9499765405873;615.3477314047125;622.3776223776224;3278.2623909620143;3849.9807500962875;3950.940735888964;3992.5608183100417;4229.302165142779;92285.61571576432;94262;94508.52745736227;94644;97593;73293.26706732971;73555;74228.62885685537;74418;74603.25396746071;54158.7292063545;69619.65190174017;70866.64566677134;70867;70923.64538177276;7802.219778022152;7963.80090497719;8072.798180045545;8185.30424913889;8236.740602659325;51349.97300054053;51728.96542069062;52450.90196392102;53566.66083347947;53632.195517066495;66436;68628.28429289308;68824.96762548466;69422;70681;11113.83329250078;11298.265612735146;11537.884621154017;11574.247673901169;11608.825867611824;9952.800943980936;11956.70108247266;12165.57420490314;12254.938725306316;12554.623361299176;11560.190786644855;11608.709782255512;11634.53461861516;11704.70738231551;12133.09001824849;11784.646460606196;11850.407479626158;11867.76264474723;12027.27836329788;12038.638840834788;11329.490172942073;11444.828327574927;11669.59156429521;11752.647420577396;12091.879081209076;9723.902760972584;9853.507324633883;9902.75243118899;10055.597776089167;10138.341007834468;9980.60077596888;10200.438975856103;10200.877903430764;10224.488775561342;10227.94886025565 11:04:57 INFO - PROCESS | 1762 | __end_tp_report 11:04:57 INFO - PROCESS | 1762 | __start_cc_report 11:04:57 INFO - PROCESS | 1762 | _x_x_mozilla_cycle_collect,1014 11:04:57 INFO - PROCESS | 1762 | __end_cc_report 11:04:57 INFO - PROCESS | 1762 | __startTimestamp1465236297870__endTimestamp 11:04:57 INFO - PROCESS | 1762 | 11:04:57 INFO - PROCESS | 1762 | ------- Summary: start ------- 11:04:57 INFO - PROCESS | 1762 | Number of tests: 6 11:04:57 INFO - PROCESS | 1762 | 11:04:57 INFO - PROCESS | 1762 | [#0] dojo.html Cycles:165 Average:5865.02 Median:6134.61 stddev:614.53 (10.0%) stddev-sans-first:587.80 11:04:57 INFO - PROCESS | 1762 | Values: 3502.5 3588.0 3589.7 3610.5 3655.7 5824.9 5828.5 5838.2 5865.4 5913.0 5848.9 5879.9 5889.1 5906.0 5909.1 5127.1 5232.0 5279.6 5296.1 5311.1 5355.5 5396.5 5399.7 5406.9 5411.7 5295.6 5337.5 5350.8 5360.1 5381.9 5380.2 5382.3 5400.9 5432.3 5451.7 5156.0 5317.0 5334.7 5351.9 5357.4 5691.4 5737.2 5738.7 5747.0 5772.4 6138.5 6242.0 6256.6 6257.2 6260.7 6219.8 6229.7 6274.9 6298.1 6298.8 6028.6 6037.8 6052.5 6061.2 6087.7 6233.7 6294.7 6416.3 6457.7 6458.7 6223.4 6233.7 6237.7 6241.7 6251.8 6265.7 6286.1 6291.4 6305.6 6311.1 6134.6 6143.2 6156.3 6203.3 6237.7 6189.4 6212.4 6232.1 6248.4 6248.5 5025.2 5032.5 5040.1 5047.5 5054.0 4451.0 4535.7 4563.0 4581.8 4604.6 5859.6 5913.1 5931.6 5931.7 5942.8 6198.4 6206.5 6207.2 6209.4 6227.2 5859.9 5878.9 5903.0 5942.7 5969.6 5475.7 5477.2 5494.0 5495.3 5517.9 6476.4 6513.3 6520.6 6529.2 6549.4 6143.8 6199.0 6254.0 6260.2 6265.3 6471.7 6480.9 6503.4 6504.1 6520.6 6317.9 6318.0 6334.8 6341.3 6350.8 6239.8 6263.8 6291.4 6336.7 6339.5 6255.3 6263.1 6278.4 6279.8 6293.0 6254.1 6277.2 6279.5 6282.4 6287.6 5974.2 6069.5 6134.3 6153.0 6155.5 6211.7 6221.3 6259.6 6276.9 6285.1 5942.3 5961.0 6073.0 6119.9 6135.4 11:04:57 INFO - PROCESS | 1762 | 11:04:57 INFO - PROCESS | 1762 | [#1] ext.html Cycles:180 Average:58026.62 Median:390526.00 stddev:115418.83 (29.6%) stddev-sans-first:115661.78 11:04:57 INFO - PROCESS | 1762 | Values: 494.9 593.8 597.0 598.8 661.9 39825.4 39995.6 40041.6 40112.0 40143.0 43415.3 44025.9 44026.8 44092.6 44099.3 9658.2 9892.9 9906.4 9906.7 9938.4 9698.1 9829.1 9848.0 9850.1 9858.1 9901.2 9967.2 9969.4 9978.1 9995.1 9860.6 9930.4 9936.5 9963.9 9987.0 9739.0 9868.6 9873.8 9875.0 9875.5 36294.8 39532.8 41561.8 42281.8 42337.2 3547.9 3878.7 3947.3 3964.3 4000.6 29102.0 29958.9 30027.5 30391.7 30471.1 2777.5 2797.3 2803.3 2896.2 2916.7 389515.0 390314.0 390738.0 390826.0 392019.0 47215.5 47821.0 68322.3 68745.3 68923.6 46554.8 46686.8 46893.4 47106.5 47214.8 17318.7 17560.1 17565.1 17568.5 17574.0 14089.0 14133.2 14189.0 14202.9 14209.0 15180.4 15352.8 15422.7 15483.5 15582.9 6473.7 6568.8 6638.7 6673.2 6673.9 1003.0 1057.2 1065.4 1089.5 1139.5 24788.6 30208.1 30477.2 30989.7 31157.4 1126.9 1181.9 1187.9 1230.0 1263.5 15283.5 15478.5 15487.3 15640.1 15760.4 545028.0 551185.0 551752.0 552316.0 553851.0 60872.1 62049.1 62172.0 62183.4 62256.7 1244.3 1298.8 1359.9 1449.6 1525.8 24293.0 29433.6 29481.1 30653.8 31032.7 49679.3 49713.8 50264.7 50306.0 50310.0 330711.0 332658.0 333455.0 334719.0 335055.0 30010.7 33926.2 34560.8 34873.0 35110.5 41669.8 42174.4 44047.8 44193.0 48004.0 38300.6 38361.8 38776.0 38985.0 40088.6 37989.0 38131.8 38180.6 38918.8 39110.6 38188.0 38691.0 39023.0 39334.8 39365.0 33305.0 33694.5 34578.5 34642.5 34730.0 21798.0 22390.3 25577.2 25963.6 26496.0 11:04:57 INFO - PROCESS | 1762 | 11:04:57 INFO - PROCESS | 1762 | [#2] jquery.html Cycles:180 Average:35497.42 Median:22242.11 stddev:107499.23 (483.3%) stddev-sans-first:107768.43 11:04:57 INFO - PROCESS | 1762 | Values: 369.6 373.2 376.4 376.5 383.6 16642.4 19454.5 20542.8 21382.9 21446.5 17030.7 21008.6 21284.6 21351.0 21392.6 5828.4 6111.1 6155.1 6157.8 6158.2 5849.1 6033.8 6041.7 6050.0 6064.1 5948.0 5972.0 5985.3 5995.3 6000.0 5717.9 5996.5 6011.1 6017.8 6041.5 5228.3 5245.6 5261.1 5262.6 5273.1 22221.9 26939.5 27573.2 27626.0 28114.7 2231.2 2247.0 2253.0 2506.1 2691.2 14457.9 15076.2 15411.3 15581.8 15589.0 1714.5 1745.3 1760.7 1834.7 1863.4 104744.0 106426.5 108355.0 108590.5 109539.0 8863.6 11144.6 11426.9 11452.1 11537.5 14177.9 14180.8 14201.1 14220.6 14227.7 9039.2 9235.3 9274.1 9385.5 9469.3 7662.0 9567.1 9593.9 9618.7 9701.9 6522.9 6560.0 6569.7 6576.3 6583.6 1622.5 1839.0 1871.3 1895.3 1929.4 986.5 998.7 1032.7 1050.3 1064.8 18581.6 21890.6 22073.0 22262.3 22314.1 927.4 1025.8 1046.2 1071.8 1082.0 11413.9 11941.0 11953.0 11977.3 11980.4 638411.8 642671.0 644215.0 666416.0 669437.0 88941.0 102693.0 105348.0 107122.0 109004.5 1074.6 1084.1 1098.0 1112.4 1114.9 19238.2 19615.3 20033.9 20044.6 20116.6 40619.4 41236.8 49231.5 49956.8 51082.7 65986.0 70352.9 70707.6 70723.0 70766.0 8044.9 8125.6 8233.8 8262.3 8347.6 12947.6 13278.0 13443.5 13591.7 13638.6 11278.4 11553.0 11732.6 11734.7 12011.8 10952.7 11703.2 11896.8 12054.4 12173.5 9864.4 11053.4 11927.7 11976.0 12231.7 8171.9 8274.5 8351.8 8611.7 8751.1 8004.6 8837.8 11153.7 12127.8 12199.5 11:04:57 INFO - PROCESS | 1762 | 11:04:57 INFO - PROCESS | 1762 | [#3] mootools.html Cycles:180 Average:6320.68 Median:5100.57 stddev:3329.42 (65.3%) stddev-sans-first:3318.89 11:04:57 INFO - PROCESS | 1762 | Values: 1482.3 1614.2 1638.4 1965.1 2060.4 8451.2 9087.2 9260.3 9279.2 9302.2 8897.9 9163.8 9174.7 9176.5 9180.9 2541.8 2551.0 2557.8 2569.9 2582.2 2522.5 2587.2 2593.2 2593.8 2599.0 2544.3 2571.0 2573.9 2574.9 2580.8 2544.8 2558.6 2563.5 2566.6 2567.4 2523.8 2549.4 2557.3 2564.3 2565.5 9233.8 9283.6 9288.8 9296.0 9301.6 5625.1 5785.2 5812.6 5833.5 5835.7 3668.9 3759.9 3812.8 3818.2 3822.1 1063.6 1079.2 1079.9 1094.0 1112.2 12572.6 12595.0 12603.2 12609.1 12621.4 4994.8 5043.3 5091.5 5109.7 5136.4 8920.4 10594.2 10605.3 10615.9 10659.5 5814.1 5822.6 5829.4 5829.6 5829.6 4515.5 4690.8 4803.0 4857.6 5281.1 3619.8 4041.9 4110.0 4137.9 4138.3 1337.6 1358.6 1363.2 1373.2 1379.9 1133.1 1167.8 1169.3 1190.1 1201.0 8520.1 8557.6 8596.7 8609.2 8816.4 1274.6 1280.4 1281.5 1281.6 1293.7 6488.7 6541.7 6594.2 6610.9 6624.0 10783.9 11088.4 11185.9 11223.6 11244.9 11024.2 11031.7 11096.9 11301.3 11361.5 8769.7 8806.0 8873.6 8893.5 8907.0 8198.8 8351.8 8445.4 8446.2 8453.1 9812.3 9873.4 9923.8 9927.2 9970.4 10028.0 10327.7 10364.6 10483.4 10496.3 7118.9 7310.4 7588.4 7712.4 7814.9 8496.9 8512.1 8541.7 8563.3 8566.3 7504.3 7636.7 7643.5 7646.4 7727.1 6132.8 7445.3 7523.3 7584.2 7689.3 7505.8 7539.5 8116.3 8168.3 8180.6 7100.5 7161.4 7220.9 7294.4 7305.3 7342.5 7425.5 7437.1 7440.8 7446.9 11:04:57 INFO - PROCESS | 1762 | 11:04:57 INFO - PROCESS | 1762 | [#4] prototype.html Cycles:180 Average:5668.09 Median:6444.94 stddev:1760.72 (27.3%) stddev-sans-first:1718.73 11:04:57 INFO - PROCESS | 1762 | Values: 287.6 319.2 336.5 340.0 343.7 5578.0 6448.0 6537.3 6541.0 6543.3 6141.5 6441.4 6441.9 6467.7 6478.3 4690.5 4705.5 4828.8 4834.6 4878.5 4777.6 4808.8 4811.6 4815.1 4816.8 4783.6 4828.1 4835.6 4837.1 4849.7 4657.4 4733.5 4810.3 4839.6 4848.2 4168.8 4171.5 4175.9 4188.5 4189.9 6082.5 6131.6 6138.3 6148.3 6257.9 5719.9 5727.0 5735.3 5738.0 5743.8 6678.4 6917.8 6919.4 6929.7 6937.8 3865.8 4734.2 4746.1 4747.9 4753.5 7169.7 7326.1 7330.4 7333.7 7344.0 4831.1 4838.0 4845.2 4846.5 4849.0 4842.1 4907.1 4913.4 4921.0 4925.9 4484.9 5756.5 5776.1 5778.7 5782.2 6702.9 6947.9 6967.1 6984.9 6995.5 1688.5 1706.8 1717.7 1721.6 1725.0 1049.7 1083.4 1102.2 1108.5 1135.8 6514.3 6613.1 6636.9 6637.1 6656.0 6530.3 6637.0 7206.9 7220.7 7229.5 6597.2 6604.1 6604.6 6611.6 6614.4 3696.1 3768.1 3802.2 3809.2 3817.6 7408.5 7448.5 7490.5 7529.4 7552.0 5917.9 7379.2 7409.3 7410.7 7420.3 6805.0 7393.8 7488.2 7502.1 7514.9 5501.3 7176.9 7181.0 7187.9 7187.9 5648.4 7036.5 7063.5 7073.3 7081.7 7320.0 7468.6 7493.9 7513.1 7529.2 4812.9 4819.7 4825.9 4830.7 4833.3 7113.0 7117.1 7120.6 7129.7 7139.4 6201.8 6514.8 6844.0 6846.7 6865.4 5168.5 5518.8 6816.5 6880.5 6886.6 6686.1 6691.5 6770.3 6838.3 6841.5 6866.6 6878.2 6883.2 6883.4 6910.3 5872.9 6506.6 6588.3 6776.2 6814.4 11:04:57 INFO - PROCESS | 1762 | 11:04:57 INFO - PROCESS | 1762 | [#5] yui.html Cycles:180 Average:18727.63 Median:27050.74 stddev:26273.42 (97.1%) stddev-sans-first:26312.29 11:04:57 INFO - PROCESS | 1762 | Values: 708.3 763.7 779.6 792.4 794.0 15344.1 15701.4 15729.4 15742.2 15746.4 14450.9 14522.6 14591.9 14653.5 14672.8 770.0 790.4 928.6 967.8 968.6 801.8 941.3 954.4 955.3 970.0 829.4 1024.2 1027.8 1028.2 1028.4 834.2 835.8 977.8 1013.6 1015.1 753.3 755.7 756.1 757.0 758.2 11992.6 15326.3 15331.9 15361.0 15401.4 13041.4 13141.1 13270.2 13406.9 13546.5 10294.1 11357.8 11397.3 11685.8 11868.3 3518.4 3534.0 3553.5 3606.7 3779.1 89139.0 89199.1 90455.0 90736.6 90941.5 8908.7 9392.6 9761.7 9894.9 10035.6 21890.6 22059.9 22068.4 22083.2 22127.2 7641.7 7677.7 7717.7 7759.3 7919.6 4191.3 4291.6 4304.7 4313.1 4572.9 3767.2 3811.3 3820.5 3825.1 3827.2 564.5 569.5 657.7 658.6 668.1 534.8 603.5 610.0 627.6 634.6 8344.8 8499.5 8572.7 8612.7 8649.7 598.5 601.4 606.9 615.3 622.4 3278.3 3850.0 3950.9 3992.6 4229.3 92285.6 94262.0 94508.5 94644.0 97593.0 73293.3 73555.0 74228.6 74418.0 74603.3 54158.7 69619.7 70866.6 70867.0 70923.6 7802.2 7963.8 8072.8 8185.3 8236.7 51350.0 51729.0 52450.9 53566.7 53632.2 66436.0 68628.3 68825.0 69422.0 70681.0 11113.8 11298.3 11537.9 11574.2 11608.8 9952.8 11956.7 12165.6 12254.9 12554.6 11560.2 11608.7 11634.5 11704.7 12133.1 11784.6 11850.4 11867.8 12027.3 12038.6 11329.5 11444.8 11669.6 11752.6 12091.9 9723.9 9853.5 9902.8 10055.6 10138.3 9980.6 10200.4 10200.9 10224.5 10227.9 11:04:57 INFO - PROCESS | 1762 | -------- Summary: end -------- 11:04:57 INFO - PROCESS | 1762 | 11:04:58 INFO - TEST-INFO | 1762: exit 0 11:04:58 INFO - TEST-OK | dromaeo_css | took 1111779ms 11:04:58 INFO - TEST-START | kraken 11:04:58 INFO - operating with platform_type : mac_ 11:04:58 INFO - Initialising browser for kraken test... 11:04:58 INFO - TEST-INFO | started process 1879 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/tmp0YALPK/profile http://localhost:49279/getInfo.html) 11:05:00 INFO - PROCESS | 1879 | __metrics Screen width/height:1600/1200 11:05:00 INFO - PROCESS | 1879 | colorDepth:24 11:05:00 INFO - PROCESS | 1879 | Browser inner width/height: 1024/689 11:05:00 INFO - PROCESS | 1879 | __metrics 11:05:00 INFO - PROCESS | 1879 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:05:00 INFO - PROCESS | 1879 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:05:01 INFO - TEST-INFO | 1879: exit 0 11:05:01 INFO - Browser initialized. 11:05:01 INFO - Running cycle 1/1 for kraken test... 11:05:01 INFO - TEST-INFO | started process 1883 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/tmp0YALPK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:05:12 INFO - PROCESS | 1883 | RSS: Main: 157507584 11:05:12 INFO - PROCESS | 1883 | 11:05:15 INFO - PROCESS | 1883 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 11:05:16 INFO - PROCESS | 1883 | RSS: Main: 218656768 11:05:16 INFO - PROCESS | 1883 | 11:05:18 INFO - PROCESS | 1883 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 11:05:19 INFO - PROCESS | 1883 | RSS: Main: 228548608 11:05:19 INFO - PROCESS | 1883 | 11:05:22 INFO - PROCESS | 1883 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 11:05:22 INFO - PROCESS | 1883 | RSS: Main: 218284032 11:05:22 INFO - PROCESS | 1883 | 11:05:24 INFO - PROCESS | 1883 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 11:05:25 INFO - PROCESS | 1883 | RSS: Main: 218955776 11:05:25 INFO - PROCESS | 1883 | 11:05:27 INFO - PROCESS | 1883 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:05:28 INFO - PROCESS | 1883 | RSS: Main: 219152384 11:05:28 INFO - PROCESS | 1883 | 11:05:30 INFO - PROCESS | 1883 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 11:05:31 INFO - PROCESS | 1883 | RSS: Main: 220229632 11:05:31 INFO - PROCESS | 1883 | 11:05:34 INFO - PROCESS | 1883 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 11:05:34 INFO - PROCESS | 1883 | RSS: Main: 220401664 11:05:34 INFO - PROCESS | 1883 | 11:05:37 INFO - PROCESS | 1883 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 11:05:37 INFO - PROCESS | 1883 | RSS: Main: 220528640 11:05:37 INFO - PROCESS | 1883 | 11:05:39 INFO - PROCESS | 1883 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:05:40 INFO - PROCESS | 1883 | RSS: Main: 255442944 11:05:40 INFO - PROCESS | 1883 | 11:05:41 INFO - PROCESS | 1883 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:05:42 INFO - PROCESS | 1883 | RSS: Main: 256376832 11:05:42 INFO - PROCESS | 1883 | 11:05:44 INFO - PROCESS | 1883 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:05:45 INFO - PROCESS | 1883 | RSS: Main: 261427200 11:05:45 INFO - PROCESS | 1883 | 11:05:47 INFO - PROCESS | 1883 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:05:48 INFO - PROCESS | 1883 | RSS: Main: 263102464 11:05:48 INFO - PROCESS | 1883 | 11:05:50 INFO - PROCESS | 1883 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:05:51 INFO - PROCESS | 1883 | RSS: Main: 263000064 11:05:51 INFO - PROCESS | 1883 | 11:05:52 INFO - PROCESS | 1883 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 11:05:53 INFO - PROCESS | 1883 | RSS: Main: 326295552 11:05:53 INFO - PROCESS | 1883 | 11:05:53 INFO - PROCESS | 1883 | __start_tp_report 11:05:53 INFO - PROCESS | 1883 | _x_x_mozilla_page_load 11:05:53 INFO - PROCESS | 1883 | _x_x_mozilla_page_load_details 11:05:53 INFO - PROCESS | 1883 | |i|pagename|runs| 11:05:53 INFO - PROCESS | 1883 | |0;ai-astar;113;112;112;112;113;112;129;110;110;110 11:05:53 INFO - PROCESS | 1883 | |1;audio-beat-detection;162;144;176;161;118;142;134;116;159;117 11:05:53 INFO - PROCESS | 1883 | |2;audio-dft;181;183;183;185;182;184;182;182;181;182 11:05:53 INFO - PROCESS | 1883 | |3;audio-fft;77;75;72;114;55;57;58;58;117;56 11:05:53 INFO - PROCESS | 1883 | |4;audio-oscillator;88;91;128;78;80;83;118;77;78;119 11:05:53 INFO - PROCESS | 1883 | |5;imaging-gaussian-blur;87;84;87;84;90;86;90;84;87;84 11:05:53 INFO - PROCESS | 1883 | |6;imaging-darkroom;93;93;101;149;135;94;92;93;93;92 11:05:53 INFO - PROCESS | 1883 | |7;imaging-desaturate;83;86;87;86;86;85;86;85;84;85 11:05:53 INFO - PROCESS | 1883 | |8;json-parse-financial;56;58;56;58;56;58;56;58;67;51 11:05:53 INFO - PROCESS | 1883 | |9;json-stringify-tinderbox;60;63;64;78;71;67;65;65;66;65 11:05:53 INFO - PROCESS | 1883 | |10;stanford-crypto-aes;80;82;81;79;81;80;74;81;105;111 11:05:53 INFO - PROCESS | 1883 | |11;stanford-crypto-ccm;125;132;140;119;116;115;116;117;127;128 11:05:53 INFO - PROCESS | 1883 | |12;stanford-crypto-pbkdf2;130;129;141;134;134;122;132;131;131;133 11:05:53 INFO - PROCESS | 1883 | |13;stanford-crypto-sha256-iterative;67;64;64;65;65;66;65;65;65;65 11:05:53 INFO - PROCESS | 1883 | __end_tp_report 11:05:53 INFO - PROCESS | 1883 | __start_cc_report 11:05:53 INFO - PROCESS | 1883 | _x_x_mozilla_cycle_collect,1187 11:05:53 INFO - PROCESS | 1883 | __end_cc_report 11:05:53 INFO - PROCESS | 1883 | __startTimestamp1465236353214__endTimestamp 11:05:53 INFO - PROCESS | 1883 | 11:05:53 INFO - PROCESS | 1883 | ------- Summary: start ------- 11:05:53 INFO - PROCESS | 1883 | Number of tests: 14 11:05:53 INFO - PROCESS | 1883 | 11:05:53 INFO - PROCESS | 1883 | [#0] ai-astar Cycles:10 Average:113.30 Median:112.00 stddev:5.64 (5.0%) stddev-sans-first:5.98 11:05:53 INFO - PROCESS | 1883 | Values: 113.0 112.0 112.0 112.0 113.0 112.0 129.0 110.0 110.0 110.0 11:05:53 INFO - PROCESS | 1883 | 11:05:53 INFO - PROCESS | 1883 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:151.50 stddev:21.46 (14.2%) stddev-sans-first:21.61 11:05:53 INFO - PROCESS | 1883 | Values: 162.0 144.0 176.0 161.0 118.0 142.0 134.0 116.0 159.0 117.0 11:05:53 INFO - PROCESS | 1883 | 11:05:53 INFO - PROCESS | 1883 | [#2] audio-dft Cycles:10 Average:182.50 Median:182.50 stddev:1.27 (0.7%) stddev-sans-first:1.22 11:05:53 INFO - PROCESS | 1883 | Values: 181.0 183.0 183.0 185.0 182.0 184.0 182.0 182.0 181.0 182.0 11:05:53 INFO - PROCESS | 1883 | 11:05:53 INFO - PROCESS | 1883 | [#3] audio-fft Cycles:10 Average:73.90 Median:58.00 stddev:23.45 (40.4%) stddev-sans-first:24.85 11:05:53 INFO - PROCESS | 1883 | Values: 77.0 75.0 72.0 114.0 55.0 57.0 58.0 58.0 117.0 56.0 11:05:53 INFO - PROCESS | 1883 | 11:05:53 INFO - PROCESS | 1883 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:79.00 stddev:19.78 (25.0%) stddev-sans-first:20.86 11:05:53 INFO - PROCESS | 1883 | Values: 88.0 91.0 128.0 78.0 80.0 83.0 118.0 77.0 78.0 119.0 11:05:53 INFO - PROCESS | 1883 | 11:05:53 INFO - PROCESS | 1883 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.00 stddev:2.36 (2.7%) stddev-sans-first:2.49 11:05:53 INFO - PROCESS | 1883 | Values: 87.0 84.0 87.0 84.0 90.0 86.0 90.0 84.0 87.0 84.0 11:05:53 INFO - PROCESS | 1883 | 11:05:53 INFO - PROCESS | 1883 | [#6] imaging-darkroom Cycles:10 Average:103.50 Median:93.00 stddev:20.72 (22.3%) stddev-sans-first:21.63 11:05:53 INFO - PROCESS | 1883 | Values: 93.0 93.0 101.0 149.0 135.0 94.0 92.0 93.0 93.0 92.0 11:05:53 INFO - PROCESS | 1883 | 11:05:53 INFO - PROCESS | 1883 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:86.00 stddev:1.16 (1.3%) stddev-sans-first:0.88 11:05:53 INFO - PROCESS | 1883 | Values: 83.0 86.0 87.0 86.0 86.0 85.0 86.0 85.0 84.0 85.0 11:05:53 INFO - PROCESS | 1883 | 11:05:53 INFO - PROCESS | 1883 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:58.00 stddev:3.98 (6.9%) stddev-sans-first:4.19 11:05:53 INFO - PROCESS | 1883 | Values: 56.0 58.0 56.0 58.0 56.0 58.0 56.0 58.0 67.0 51.0 11:05:53 INFO - PROCESS | 1883 | 11:05:53 INFO - PROCESS | 1883 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:65.50 stddev:4.95 (7.6%) stddev-sans-first:4.68 11:05:53 INFO - PROCESS | 1883 | Values: 60.0 63.0 64.0 78.0 71.0 67.0 65.0 65.0 66.0 65.0 11:05:53 INFO - PROCESS | 1883 | 11:05:53 INFO - PROCESS | 1883 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:80.50 stddev:12.19 (15.1%) stddev-sans-first:12.78 11:05:53 INFO - PROCESS | 1883 | Values: 80.0 82.0 81.0 79.0 81.0 80.0 74.0 81.0 105.0 111.0 11:05:53 INFO - PROCESS | 1883 | 11:05:53 INFO - PROCESS | 1883 | [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:126.00 stddev:8.34 (6.6%) stddev-sans-first:8.83 11:05:53 INFO - PROCESS | 1883 | Values: 125.0 132.0 140.0 119.0 116.0 115.0 116.0 117.0 127.0 128.0 11:05:53 INFO - PROCESS | 1883 | 11:05:53 INFO - PROCESS | 1883 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:131.70 Median:132.50 stddev:4.76 (3.6%) stddev-sans-first:5.01 11:05:53 INFO - PROCESS | 1883 | Values: 130.0 129.0 141.0 134.0 134.0 122.0 132.0 131.0 131.0 133.0 11:05:53 INFO - PROCESS | 1883 | 11:05:53 INFO - PROCESS | 1883 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.60 11:05:53 INFO - PROCESS | 1883 | Values: 67.0 64.0 64.0 65.0 65.0 66.0 65.0 65.0 65.0 65.0 11:05:53 INFO - PROCESS | 1883 | -------- Summary: end -------- 11:05:53 INFO - PROCESS | 1883 | 11:05:53 INFO - TEST-INFO | 1883: exit 0 11:05:53 INFO - TEST-OK | kraken | took 55549ms 11:05:53 INFO - SUITE-END | took 1167s 11:05:54 INFO - Completed test suite (00:19:27) 11:05:54 INFO - javascript benchmark 11:05:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3502.4921386398973, 3587.977426433467, 3589.6769290763827, 3610.476480910268, 3655.7440979131457, 5824.9338979344375, 5828.475437210661, 5838.153467747175, 5865.413458654132, 5912.970435147824, 5848.941510584893, 5879.941200587993, 5889.116632505126, 5906.0, 5909.143174239733, 5127.077126117298, 5232.032074066291, 5279.577633789288, 5296.1261391870485, 5311.097113490697, 5355.544778693816, 5396.460353964611, 5399.730013499309, 5406.945930540704, 5411.675299482044, 5295.629305948566, 5337.5463085637575, 5350.759215835296, 5360.115580929142, 5381.892362152755, 5380.21986811912, 5382.313978238529, 5400.945990540084, 5432.293801805779, 5451.700156491392, 5155.974220128913, 5316.973415132899, 5334.653247538898, 5351.946480535184, 5357.357117145929, 5691.430856914276, 5737.168110623936, 5738.741756620962, 5746.994276001725, 5772.3938986406665, 6138.541671868701, 6241.968790156066, 6256.624602523818, 6257.155284036642, 6260.655663938482, 6219.813405597839, 6229.6573688447115, 6274.937250627481, 6298.086777417295, 6298.842528936768, 6028.638281703112, 6037.818865434044, 6052.485538729214, 6061.242344706911, 6087.726052327655, 6233.688315584202, 6294.685265736694, 6416.294207637156, 6457.741690332428, 6458.709358078898, 6223.408776166257, 6233.719482623293, 6237.656928868956, 6241.7191226394925, 6251.781187658501, 6265.749370025148, 6286.119943207955, 6291.402316779899, 6305.558610897285, 6311.084892690626, 6134.614040518015, 6143.235544005215, 6156.322804491502, 6203.31763506014, 6237.688115594202, 6189.442950134509, 6212.378762123752, 6232.065190221412, 6248.375162483715, 6248.4688801452385, 5025.195968645073, 5032.521910418504, 5040.092783299041, 5047.545720885138, 5053.974730126326, 4450.977745111254, 4535.659825513099, 4562.954370456319, 4581.816727330869, 4604.562566556172, 5859.589828712034, 5913.142594323885, 5931.58478906481, 5931.703414829241, 5942.762289508371, 6198.411150940653, 6206.534509911775, 6207.193064901534, 6209.379062093845, 6227.19046523949, 5859.882802344015, 5878.882422351529, 5903.0, 5942.6731529766275, 5969.641821490724, 5475.7262136893, 5477.1510415885605, 5493.972530137324, 5495.340559132929, 5517.862053448696, 6476.417122459001, 6513.2509761377105, 6520.608763474207, 6529.183852018497, 6549.443297319686, 6143.757528502154, 6199.0, 6254.0, 6260.186175797117, 6265.342139075514, 6471.676416179266, 6480.935190648033, 6503.382178693017, 6504.056911747675, 6520.641364724986, 6317.936820631919, 6317.96841015792, 6334.841628959129, 6341.302456729663, 6350.809475715736, 6239.7504099837315, 6263.843403914939, 6291.433770960635, 6336.7465301389275, 6339.461145802658, 6255.343188965093, 6263.060540918898, 6278.372162783685, 6279.780207692709, 6293.024581189923, 6254.061890716429, 6277.2153480814895, 6279.497640188682, 6282.371762823681, 6287.559870809182, 5974.1636170935235, 6069.484093852072, 6134.294556125924, 6153.0, 6155.538334625011, 6211.65835879031, 6221.346758590283, 6259.62442253448, 6276.905846412216, 6285.088662144055, 5942.286925568959, 5961.0, 6073.0, 6119.908201376894, 6135.355787642234], "unit": "score", "name": "dojo.html", "value": 5827.511485005176}, {"lowerIsBetter": false, "replicates": [494.8985457981114, 593.8034859757587, 596.958307752971, 598.7755040941274, 661.851083506211, 39825.4026189607, 39995.60004399955, 40041.59958400419, 40112.0, 40142.99285035748, 43415.348769768476, 44025.8993525162, 44026.779866100704, 44092.55907440925, 44099.338509922374, 9658.179054780352, 9892.90107098927, 9906.405615663083, 9906.702798916043, 9938.403695778277, 9698.078682525183, 9829.066238707312, 9847.950760246189, 9850.113489785917, 9858.112769850712, 9901.207903367713, 9967.152792012688, 9969.351992120526, 9978.052085051908, 9995.050470205355, 9860.605575776995, 9930.354526955725, 9936.453495057805, 9963.90036099637, 9987.0, 9739.0, 9868.60525578976, 9873.753156171082, 9874.9506252469, 9875.506224688737, 36294.81852590747, 39532.802335988425, 41561.79219103915, 42281.78859105716, 42337.15325693469, 3547.8580856765698, 3878.728489005771, 3947.3486874665646, 3964.266610677034, 4000.5599384067727, 29101.981430649827, 29958.85020574905, 30027.549586756217, 30391.696083039107, 30471.08586742401, 2777.472280266743, 2797.314657908805, 2803.327201471632, 2896.203544025389, 2916.737493625563, 389515.0, 390314.0, 390738.0, 390826.0, 392018.99999999715, 47215.5278447218, 47821.04357912822, 68322.3167768326, 68745.31254687389, 68923.62152756916, 46554.767226163654, 46686.83282917954, 46893.3587324442, 47106.5289347109, 47214.76392618015, 17318.740218896728, 17560.121993900255, 17565.121743912754, 17568.472945811645, 17574.0, 14089.013769036274, 14133.222672752892, 14189.0, 14202.85797142036, 14209.0, 15180.392784288504, 15352.846471535366, 15422.691546169013, 15483.458078967182, 15582.9220853895, 6473.708683109271, 6568.8357791055605, 6638.6680665966505, 6673.165854268216, 6673.866522669519, 1002.9899701002896, 1057.2387880725864, 1065.3927261461047, 1089.4607169451172, 1139.5043156227068, 24788.628170577456, 30208.09375718732, 30477.23806904845, 30989.69010309868, 31157.376852462825, 1126.9436528173558, 1181.8818118188112, 1187.857457105153, 1229.993850030762, 1263.4693428759942, 15283.46507872219, 15478.458253961056, 15487.303071361815, 15640.061596304258, 15760.448384306494, 545028.0, 551185.0, 551752.0, 552316.0, 553851.0, 60872.08691869625, 62049.06926396018, 62172.0, 62183.37816621867, 62256.68871655613, 1244.2721008210117, 1298.7921932490756, 1359.9256587295924, 1449.644837014938, 1525.80927384077, 24293.02827886865, 29433.558496622994, 29481.115566533037, 30653.846730766203, 31032.68967310298, 49679.25481117714, 49713.75143124406, 50264.748676256386, 50305.99388012292, 50309.993800124525, 330711.0, 332658.0, 333455.0, 334719.0, 335055.0, 30010.69989300079, 33926.15184620404, 34560.82719586386, 34872.9538113857, 35110.47334290039, 41669.79165104155, 42174.36738448987, 44047.77976110227, 44193.0, 48004.0, 38300.6169938297, 38361.808190958865, 38776.0, 38985.0, 40088.59911400965, 37989.0, 38131.80934095312, 38180.6181938177, 38918.80540597279, 39110.608893911834, 38188.04529886775, 38691.0, 39023.0, 39334.80332598433, 39365.0, 33305.00084997454, 33694.49458258079, 34578.48132278068, 34642.48036279407, 34730.0, 21798.0, 22390.328290151323, 25577.232683019538, 25963.61054584145, 26496.0], "unit": "score", "name": "ext.html", "value": 19629.091109146488}, {"lowerIsBetter": false, "replicates": [369.56391458079463, 373.17528262539787, 376.4466234635086, 376.45978021539094, 383.560822857828, 16642.417515386966, 19454.513637159078, 20542.794572054274, 21382.89308553459, 21446.463838404048, 17030.74453883193, 21008.579828403424, 21284.57430851386, 21351.0, 21392.572148557058, 5828.417158284169, 6111.144439778434, 6155.107509411133, 6157.7536898524, 6158.199434073565, 5849.122631605272, 6033.758649654009, 6041.728122234488, 6049.969750151243, 6064.120702498135, 5948.048312270038, 5972.0, 5985.34161242263, 5995.280566332046, 6000.009998350267, 5717.942820571803, 5996.4902983246475, 6011.068284415923, 6017.789377371771, 6041.516678665696, 5228.346456692913, 5245.554127899133, 5261.1319132343115, 5262.631615786897, 5273.1299335609965, 22221.888890555445, 26939.46121077587, 27573.172804815888, 27626.033088841796, 28114.71885281162, 2231.163313757341, 2247.0337754765446, 2253.0311965854676, 2506.0602274147195, 2691.1791903469434, 14457.855421445862, 15076.24618769057, 15411.306491207923, 15581.844181558152, 15589.0, 1714.4599451172965, 1745.3106023120922, 1760.6610653138891, 1834.7340335168824, 1863.3571417860817, 104744.0, 106426.46786766016, 108355.0, 108590.45704771504, 109538.9999999992, 8863.64545418176, 11144.60993865211, 11426.94286528562, 11452.083833293316, 11537.48081336342, 14177.929110354382, 14180.787288190686, 14201.147931124166, 14220.573382798533, 14227.715445691236, 9039.23166530839, 9235.307351948632, 9274.072592740671, 9385.483798391155, 9469.289803264644, 7662.0, 9567.138957493858, 9593.904060959441, 9618.698997203715, 9701.9029809701, 6522.869542609121, 6559.967200163968, 6569.737210511526, 6576.276609572943, 6583.604983700993, 1622.537576790609, 1838.9724154137698, 1871.3356758350862, 1895.2987394664062, 1929.4404622659272, 986.5264672957021, 998.6854140945579, 1032.736652153711, 1050.3277902142636, 1064.834950582661, 18581.628367432575, 21890.562188756136, 22073.0, 22262.332130036124, 22314.10743570239, 927.3879239701764, 1025.8153532364247, 1046.215338496128, 1071.7910007548453, 1082.0477979378097, 11413.942930285295, 11940.985016273715, 11953.0, 11977.341246231366, 11980.400979950968, 638411.8079409666, 642671.0, 644215.0, 666416.0, 669437.0, 88941.0, 102693.0, 105348.0, 107122.0, 109004.45497772619, 1074.5970261152067, 1084.0514549768952, 1097.9670609881875, 1112.3881864974232, 1114.9219554631097, 19238.23047078157, 19615.31346402869, 20033.89813560268, 20044.599108017468, 20116.59766804685, 40619.390709139974, 41236.79381603073, 49231.50768492269, 49956.75108122326, 51082.722387581525, 65986.0, 70352.94470582843, 70707.58584828378, 70723.0, 70766.0, 8044.919550804417, 8125.593720314079, 8233.83532329362, 8262.339012879076, 8347.58262086881, 12947.611571652866, 13278.0, 13443.529476468277, 13591.728165436834, 13638.613242682293, 11278.436078196222, 11553.0, 11732.648020559396, 11734.706632333919, 12011.75976480448, 10952.671419857417, 11703.23928944616, 11896.762064758483, 12054.397280136134, 12173.45219465144, 9864.408135511892, 11053.392063436266, 11927.701807454536, 11976.0, 12231.694207644525, 8171.918280817354, 8274.462159959583, 8351.791205219919, 8611.6985905493, 8751.124887511198, 8004.5597492138495, 8837.779055523662, 11153.665390038312, 12127.81808272859, 12199.512019519474], "unit": "score", "name": "jquery.html", "value": 9854.899746894314}, {"lowerIsBetter": false, "replicates": [1482.3033174408024, 1614.1848366574877, 1638.4347400146949, 1965.1451618545934, 2060.350989438328, 8451.154884511554, 9087.227585655219, 9260.305477089229, 9279.21126704231, 9302.209312208453, 8897.91102088979, 9163.77090572736, 9174.678886238982, 9176.541172941359, 9180.908190918106, 2541.796656267494, 2550.961735573968, 2557.782588479972, 2569.9486010279784, 2582.18661121747, 2522.545941730488, 2587.2496975876975, 2593.1831473085917, 2593.818432709711, 2599.0383558083536, 2544.2875994721417, 2571.035861551918, 2573.858437785921, 2574.909878154265, 2580.7935365170742, 2544.7836933860644, 2558.5778346572793, 2563.474487730011, 2566.5765148750434, 2567.370994106456, 2523.835950663201, 2549.3626593351664, 2557.258395065429, 2564.333273348924, 2565.538203123437, 9233.815323693556, 9283.58223879927, 9288.814223715555, 9295.953520232355, 9301.581428835718, 5625.128105143668, 5785.190073389729, 5812.564057695689, 5833.504152147073, 5835.679037652927, 3668.9082772930624, 3759.868404605853, 3812.8284227209842, 3818.179091495314, 3822.140018495816, 1063.6064656077224, 1079.1798233342638, 1079.94060326682, 1093.9835902461468, 1112.1714322829464, 12572.622821315375, 12595.0, 12603.243805371707, 12609.054320925967, 12621.43203555833, 4994.825181118644, 5043.3191519145175, 5091.465396133352, 5109.667871588409, 5136.43499215086, 8920.420172688755, 10594.205434592437, 10605.257631965842, 10615.893841061645, 10659.467026648637, 5814.069748840166, 5822.621529600562, 5829.387914268941, 5829.571754920072, 5829.62107463022, 4515.471394826842, 4690.81236750533, 4803.0, 4857.587105096107, 5281.102212623863, 3619.8371073301764, 4041.8989525262105, 4109.958900411018, 4137.8965525862095, 4138.296489596776, 1337.6321511584197, 1358.5720498043086, 1363.236587510997, 1373.1623709537175, 1379.8689124533153, 1133.1161693878787, 1167.8073117935446, 1169.3042639629407, 1190.089581470176, 1201.039168665082, 8520.062793092755, 8557.614907329185, 8596.742097737078, 8609.182127697984, 8816.426932249384, 1274.6239859241362, 1280.3534215221255, 1281.4681907008487, 1281.557862537423, 1293.747719194748, 6488.708008139645, 6541.738330466728, 6594.20869495654, 6610.900836487456, 6624.039514270404, 10783.946080269548, 11088.390138542458, 11185.888141118647, 11223.551057957753, 11244.943775281072, 11024.173187011007, 11031.669049928514, 11096.944515277533, 11301.26541774782, 11361.488733007034, 8769.736907892773, 8805.955970220108, 8873.556322183866, 8893.510856902933, 8907.02022777494, 8198.754037378889, 8351.791205219675, 8445.408821382443, 8446.239838414327, 8453.112423195476, 9812.264080194156, 9873.358231714916, 9923.801523969625, 9927.205823533955, 9970.40177589347, 10028.047335503115, 10327.741806454898, 10364.585416583554, 10483.37099774016, 10496.265261431627, 7118.857622847618, 7310.378617817545, 7588.392928565812, 7712.383009359126, 7814.921850781419, 8496.872546911678, 8512.063672995842, 8541.658333666584, 8563.272121869462, 8566.271866891384, 7504.2870927264, 7636.694532218871, 7643.503172293783, 7646.388288936983, 7727.072751269883, 6132.816015519542, 7445.255474452511, 7523.285287897641, 7584.241575842371, 7689.307962283421, 7505.849883002418, 7539.472236943361, 8116.269535741575, 8168.346532277523, 8180.631871565913, 7100.467464940047, 7161.427085833225, 7220.8916866246, 7294.416446684147, 7305.3425191732995, 7342.48602597813, 7425.517341372793, 7437.070366204224, 7440.776776696708, 7446.888296675445], "unit": "score", "name": "mootools.html", "value": 5153.394955571498}, {"lowerIsBetter": false, "replicates": [287.6002356724155, 319.20199501246884, 336.5154177983703, 340.03938872684654, 343.69926314474833, 5577.9959607270675, 6448.0, 6537.280899101101, 6541.0, 6543.280239173687, 6141.477974372184, 6441.355864413556, 6441.8711625767455, 6467.676616169197, 6478.319776423478, 4690.50749671283, 4705.529447055284, 4828.7585620719, 4834.58905992991, 4878.463369029404, 4777.617790576745, 4808.831690890819, 4811.639127065484, 4815.085133824579, 4816.807327706888, 4783.569478746912, 4828.106800241949, 4835.637327200457, 4837.0567739290855, 4849.733264670442, 4657.371254880599, 4733.455652599943, 4810.254410566367, 4839.588634966032, 4848.200046992242, 4168.8332466701295, 4171.457710497646, 4175.937360939588, 4188.4555007849085, 4189.874303770892, 6082.543809214327, 6131.63210207389, 6138.294096178952, 6148.323684394713, 6257.906131408033, 5719.885602287931, 5726.971365143189, 5735.283089613798, 5738.0, 5743.827685169452, 6678.43233325168, 6917.757878474229, 6919.411849992756, 6929.653517324114, 6937.826554336131, 3865.8067096645336, 4734.218853889104, 4746.09824133417, 4747.905041899177, 4753.453352864431, 7169.74905878297, 7326.120865496121, 7330.413566914687, 7333.706651733924, 7344.0, 4831.106245344622, 4837.95162048382, 4845.176320025604, 4846.491118432585, 4849.0, 4842.104210721028, 4907.067657145131, 4913.434954980152, 4920.975395123073, 4925.852224433273, 4484.9103017940115, 5756.453136951983, 5776.104703770922, 5778.739956701958, 5782.190493330937, 6702.932970670328, 6947.930520694829, 6967.059446974695, 6984.860302793915, 6995.545289556163, 1688.50189194188, 1706.8293170682832, 1717.6822287876782, 1721.6040310728351, 1724.965500689979, 1049.6850944716555, 1083.3932997521413, 1102.1513434655271, 1108.467935391017, 1135.8182690769438, 6514.250861150934, 6613.107230523914, 6636.8672626547195, 6637.070810086591, 6656.0, 6530.314316996647, 6637.037629543689, 7206.927930720731, 7220.747273845495, 7229.530080544748, 6597.175353080865, 6604.075429439882, 6604.570702904296, 6611.63636000015, 6614.437772789271, 3696.149885526344, 3768.1333293342686, 3802.1825307558456, 3809.2191100824266, 3817.61823817616, 7408.518446300973, 7448.478606497493, 7490.475666703387, 7529.397648188132, 7552.0, 5917.881642367129, 7379.151397589346, 7409.333160015624, 7410.703571857065, 7420.257974202536, 6805.0, 7393.778186654409, 7488.176300606929, 7502.062242219723, 7514.924850751422, 5501.339839219319, 7176.928230717626, 7180.964095179491, 7187.928120718726, 7187.928120718726, 5648.406917273792, 7036.542624729376, 7063.5055546113335, 7073.292670732885, 7081.7167313308955, 7320.048393708784, 7468.589227592534, 7493.850122997401, 7513.060867391576, 7529.1717911028645, 4812.855614331575, 4819.7349145795915, 4825.927611085766, 4830.734309613005, 4833.275008748716, 7112.964435177791, 7117.1459424869345, 7120.572765634079, 7129.679164437716, 7139.393151581966, 6201.844953876189, 6514.771982980573, 6844.041834143323, 6846.657667116724, 6865.41643960249, 5168.508991645787, 5518.751656175402, 6816.454683625199, 6880.4839637026425, 6886.586804791728, 6686.0973768540625, 6691.464682825265, 6770.289119642367, 6838.281980392187, 6841.452683785385, 6866.622335771581, 6878.209005964178, 6883.208431030495, 6883.414909732529, 6910.308969103251, 5872.911906321323, 6506.577072490273, 6588.275289718223, 6776.220734615582, 6814.352636499525], "unit": "score", "name": "prototype.html", "value": 5087.581274157938}, {"lowerIsBetter": false, "replicates": [708.3306275569587, 763.6792547130204, 779.6062988190967, 792.4413288631512, 793.9722109726157, 15344.07935523868, 15701.37194512221, 15729.37082516698, 15742.21288935553, 15746.370145194192, 14450.855491445109, 14522.636934076627, 14591.927040364782, 14653.487127950524, 14672.779908301383, 769.9653515591812, 790.3558599741192, 928.5589345061076, 967.8451447768358, 968.6222373274429, 801.8276070644811, 941.2752180820764, 954.3844220477788, 955.2930831184942, 969.9515024248794, 829.3986859526825, 1024.2471783239314, 1027.7636143686957, 1028.2493779540903, 1028.388109075099, 834.1741675741004, 835.8161204534993, 977.8337682593976, 1013.6148263659762, 1015.0813513769976, 753.3144838197269, 755.6750597243183, 756.0964647246543, 757.0385610274975, 758.2076729817354, 11992.580259690956, 15326.310316035806, 15331.923340383339, 15361.0, 15401.383944642314, 13041.413136408884, 13141.145825521406, 13270.203787772765, 13406.932965335209, 13546.525871594546, 10294.124999375063, 11357.829632555518, 11397.259178153394, 11685.824712629317, 11868.287902725864, 3518.3842827505086, 3533.9823300883586, 3553.4847447120283, 3606.711463082947, 3779.1496913194587, 89139.0, 89199.10800892038, 90455.0, 90736.55580665116, 90941.54529227377, 8908.688195913111, 9392.62429502826, 9761.707148785548, 9894.901050989398, 10035.648752293635, 21890.562188756136, 22059.889700551394, 22068.448288792588, 22083.227087051877, 22127.225547105772, 7641.732539361095, 7677.731279405194, 7717.729879454305, 7759.30166285037, 7919.564423956737, 4191.3293872980785, 4291.592298731615, 4304.677149213759, 4313.051128751669, 4572.908541829212, 3767.208886133888, 3811.313963486599, 3820.5033345665443, 3825.081980324702, 3827.158025234444, 564.5032371513042, 569.4959960435045, 657.6547312660796, 658.6016846337851, 668.0713807807152, 534.8181618249814, 603.4840211619003, 609.9786507472218, 627.5669787846372, 634.6255709131542, 8344.8331033379, 8499.490030598185, 8572.699955501528, 8612.741617751477, 8649.73849163581, 598.5391248738534, 601.3745704467392, 606.9499765405873, 615.3477314047125, 622.3776223776224, 3278.2623909620143, 3849.9807500962875, 3950.940735888964, 3992.5608183100417, 4229.302165142779, 92285.61571576432, 94262.0, 94508.52745736227, 94644.0, 97593.0, 73293.26706732971, 73555.0, 74228.62885685537, 74418.0, 74603.25396746071, 54158.7292063545, 69619.65190174017, 70866.64566677134, 70867.0, 70923.64538177276, 7802.219778022152, 7963.80090497719, 8072.798180045545, 8185.30424913889, 8236.740602659325, 51349.97300054053, 51728.96542069062, 52450.90196392102, 53566.66083347947, 53632.195517066495, 66436.0, 68628.28429289308, 68824.96762548466, 69422.0, 70681.0, 11113.83329250078, 11298.265612735146, 11537.884621154017, 11574.247673901169, 11608.825867611824, 9952.800943980936, 11956.70108247266, 12165.57420490314, 12254.938725306316, 12554.623361299176, 11560.190786644855, 11608.709782255512, 11634.53461861516, 11704.70738231551, 12133.09001824849, 11784.646460606196, 11850.407479626158, 11867.76264474723, 12027.27836329788, 12038.638840834788, 11329.490172942073, 11444.828327574927, 11669.59156429521, 11752.647420577396, 12091.879081209076, 9723.902760972584, 9853.507324633883, 9902.75243118899, 10055.597776089167, 10138.341007834468, 9980.60077596888, 10200.438975856103, 10200.877903430764, 10224.488775561342, 10227.94886025565], "unit": "score", "name": "yui.html", "value": 7102.722312629304}], "name": "dromaeo_css", "value": 7709.326559911025}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 112.0, 112.0, 112.0, 113.0, 112.0, 129.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 113.3}, {"lowerIsBetter": true, "replicates": [162.0, 144.0, 176.0, 161.0, 118.0, 142.0, 134.0, 116.0, 159.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 142.9}, {"lowerIsBetter": true, "replicates": [181.0, 183.0, 183.0, 185.0, 182.0, 184.0, 182.0, 182.0, 181.0, 182.0], "unit": "score", "name": "audio-dft", "value": 182.5}, {"lowerIsBetter": true, "replicates": [77.0, 75.0, 72.0, 114.0, 55.0, 57.0, 58.0, 58.0, 117.0, 56.0], "unit": "score", "name": "audio-fft", "value": 73.9}, {"lowerIsBetter": true, "replicates": [88.0, 91.0, 128.0, 78.0, 80.0, 83.0, 118.0, 77.0, 78.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 94.0}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 87.0, 84.0, 90.0, 86.0, 90.0, 84.0, 87.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.3}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 101.0, 149.0, 135.0, 94.0, 92.0, 93.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 103.5}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 87.0, 86.0, 86.0, 85.0, 86.0, 85.0, 84.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.3}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 56.0, 58.0, 56.0, 58.0, 56.0, 58.0, 67.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [60.0, 63.0, 64.0, 78.0, 71.0, 67.0, 65.0, 65.0, 66.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.4}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 81.0, 79.0, 81.0, 80.0, 74.0, 81.0, 105.0, 111.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [125.0, 132.0, 140.0, 119.0, 116.0, 115.0, 116.0, 117.0, 127.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.5}, {"lowerIsBetter": true, "replicates": [130.0, 129.0, 141.0, 134.0, 134.0, 122.0, 132.0, 131.0, 131.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 131.7}, {"lowerIsBetter": true, "replicates": [67.0, 64.0, 64.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.1}], "name": "kraken", "value": 1411.1999999999998}]} 11:05:54 INFO - Return code: 0 11:05:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:05:54 INFO - # TBPL SUCCESS # 11:05:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:05:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:05:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:05:54 INFO - 2016-06-06 11:05:54.555 screenresolution[1892:10733] starting screenresolution argv=screenresolution get 11:05:54 INFO - 2016-06-06 11:05:54.557 screenresolution[1892:10733] Display 0: 1600x1200x32@60 11:05:54 INFO - 2016-06-06 11:05:54.563 screenresolution[1893:10737] starting screenresolution argv=screenresolution list 11:05:54 INFO - Available Modes on Display 0 11:05:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:05:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:05:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:05:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:05:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:05:54 INFO - Intel Iris: 11:05:54 INFO - Chipset Model: Intel Iris 11:05:54 INFO - Type: GPU 11:05:54 INFO - Bus: Built-In 11:05:54 INFO - VRAM (Dynamic, Max): 1536 MB 11:05:54 INFO - Vendor: Intel (0x8086) 11:05:54 INFO - Device ID: 0x0a2e 11:05:54 INFO - Revision ID: 0x0009 11:05:54 INFO - Displays: 11:05:54 INFO - Display: 11:05:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:05:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:05:54 INFO - Display Serial Number: 1600x1200 60 11:05:54 INFO - Main Display: Yes 11:05:54 INFO - Mirror: Off 11:05:54 INFO - Online: Yes 11:05:54 INFO - Rotation: Supported 11:05:54 INFO - Return code: 0 11:05:54 INFO - Running post-action listener: _resource_record_post_action 11:05:54 INFO - Running post-run listener: _resource_record_post_run 11:05:55 INFO - Total resource usage - Wall time: 1192s; CPU: 52.0%; Read bytes: 31780352; Write bytes: 513424384; Read time: 199; Write time: 1625 11:05:55 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 196862464; Write bytes: 199280640; Read time: 17988; Write time: 441 11:05:55 INFO - run-tests - Wall time: 1170s; CPU: 52.0%; Read bytes: 30846464; Write bytes: 304182272; Read time: 187; Write time: 1150 11:05:55 INFO - Running post-run listener: _upload_blobber_files 11:05:55 INFO - Blob upload gear active. 11:05:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:05:55 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:05:55 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:05:55 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:05:56 INFO - (blobuploader) - INFO - Open directory for files ... 11:05:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:05:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:05:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:05:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:05:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:05:57 INFO - (blobuploader) - INFO - Done attempting. 11:05:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:05:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:05:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:05:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:05:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:05:58 INFO - (blobuploader) - INFO - Done attempting. 11:05:58 INFO - (blobuploader) - INFO - Iteration through files over. 11:05:58 INFO - Return code: 0 11:05:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:05:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:05:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a457bc44c2f46b802326bc8b31db4088327e03eeb0db5b1a038a2f9813b167ba0503c6c865afddf2f29d9d599eacd37653853423ac9b1c2a3feccd1d150faa78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a9008350e7cd70f8ea217974ce64928ecdafeb0057b5e282ac44c2eda8ac8b53628631cffd3e752a9faf24cbdbebc1bf8fe1a0cc74933831556b6ba29a3eaff5"} 11:05:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:05:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:05:58 INFO - Contents: 11:05:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a457bc44c2f46b802326bc8b31db4088327e03eeb0db5b1a038a2f9813b167ba0503c6c865afddf2f29d9d599eacd37653853423ac9b1c2a3feccd1d150faa78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a9008350e7cd70f8ea217974ce64928ecdafeb0057b5e282ac44c2eda8ac8b53628631cffd3e752a9faf24cbdbebc1bf8fe1a0cc74933831556b6ba29a3eaff5"} 11:05:58 INFO - Running post-run listener: copy_logs_to_upload_dir 11:05:58 INFO - Copying logs to upload dir... 11:05:58 INFO - mkdir: /builds/slave/test/build/upload/logs 11:05:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.961813 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-06 11:05:58.473185) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 11:05:58.476718) ========= 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.rw7enFw8TW/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.vNQ57N8lBj/Listeners TMPDIR=/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a457bc44c2f46b802326bc8b31db4088327e03eeb0db5b1a038a2f9813b167ba0503c6c865afddf2f29d9d599eacd37653853423ac9b1c2a3feccd1d150faa78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a9008350e7cd70f8ea217974ce64928ecdafeb0057b5e282ac44c2eda8ac8b53628631cffd3e752a9faf24cbdbebc1bf8fe1a0cc74933831556b6ba29a3eaff5"} 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.011013 build_url: 'https://queue.taskcluster.net/v1/task/GDtD6blyRNqObnbr__fRpw/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a457bc44c2f46b802326bc8b31db4088327e03eeb0db5b1a038a2f9813b167ba0503c6c865afddf2f29d9d599eacd37653853423ac9b1c2a3feccd1d150faa78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a9008350e7cd70f8ea217974ce64928ecdafeb0057b5e282ac44c2eda8ac8b53628631cffd3e752a9faf24cbdbebc1bf8fe1a0cc74933831556b6ba29a3eaff5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 11:05:58.507747) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:05:58.508088) ========= 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.rw7enFw8TW/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.vNQ57N8lBj/Listeners TMPDIR=/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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.005108 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:05:58.556335) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 11:05:58.556642) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 11:05:58.557017) ========= ========= Total master_lag: 0.18 =========