builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0174 starttime: 1461015131.44 results: success (0) buildid: 20160418094943 builduid: 82cf067085264d8d8a7159b7c61cf302 revision: 1a229bf7891d7b453eb6e5269c11ace513e400a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 14:32:11.435619) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 14:32:11.436086) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 14:32:11.436359) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 14:32:11.455017) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 14:32:11.455284) ========= 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.s87zJXjh3I/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.0gNdigrWF8/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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-04-18 14:32:11-- 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% 12.6M=0.001s 2016-04-18 14:32:11 (12.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107286 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 14:32:11.582975) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 14:32:11.583264) ========= 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.s87zJXjh3I/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.0gNdigrWF8/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.029171 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 14:32:11.637995) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-18 14:32:11.638300) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1a229bf7891d7b453eb6e5269c11ace513e400a4 --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-aurora --rev 1a229bf7891d7b453eb6e5269c11ace513e400a4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.s87zJXjh3I/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.0gNdigrWF8/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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-04-18 14:32:11,717 truncating revision to first 12 chars 2016-04-18 14:32:11,718 Setting DEBUG logging. 2016-04-18 14:32:11,718 attempt 1/10 2016-04-18 14:32:11,718 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1a229bf7891d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 14:32:13,496 unpacking tar archive at: mozilla-aurora-1a229bf7891d/testing/mozharness/ program finished with exit code 0 elapsedTime=2.031621 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-18 14:32:13.691297) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 14:32:13.691575) ========= script_repo_revision: 1a229bf7891d7b453eb6e5269c11ace513e400a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 14:32:13.691954) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 14:32:13.692213) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 14:32:13.716328) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-18 14:32:13.716600) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.s87zJXjh3I/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.0gNdigrWF8/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 14:32:13 INFO - MultiFileLogger online at 20160418 14:32:13 in /builds/slave/test 14:32:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:32:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:32:13 INFO - {'append_to_log': False, 14:32:13 INFO - 'base_work_dir': '/builds/slave/test', 14:32:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:32:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:32:13 INFO - 'branch': 'Mozilla-Aurora', 14:32:13 INFO - 'buildbot_json_path': 'buildprops.json', 14:32:13 INFO - 'config_files': ('talos/mac_config.py',), 14:32:13 INFO - 'default_actions': ('clobber', 14:32:13 INFO - 'read-buildbot-config', 14:32:13 INFO - 'download-and-extract', 14:32:13 INFO - 'populate-webroot', 14:32:13 INFO - 'create-virtualenv', 14:32:13 INFO - 'install', 14:32:13 INFO - 'run-tests'), 14:32:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:32:13 INFO - 'download_minidump_stackwalk': True, 14:32:13 INFO - 'download_symbols': 'ondemand', 14:32:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:32:13 INFO - 'tooltool.py': '/tools/tooltool.py', 14:32:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:32:13 INFO - '/tools/misc-python/virtualenv.py')}, 14:32:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:32:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:32:13 INFO - 'installer_path': 'installer.exe', 14:32:13 INFO - 'log_level': 'info', 14:32:13 INFO - 'log_name': 'talos', 14:32:13 INFO - 'log_to_console': True, 14:32:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:32:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:32:13 INFO - 'opt_config_files': (), 14:32:13 INFO - 'pip_index': False, 14:32:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:32:13 INFO - 'cmd': ('bash', 14:32:13 INFO - '-c', 14:32:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:32:13 INFO - 'enabled': True, 14:32:13 INFO - 'halt_on_failure': False, 14:32:13 INFO - 'name': 'check_screen_resolution'},), 14:32:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:32:13 INFO - 'cmd': ('bash', 14:32:13 INFO - '-c', 14:32:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:32:13 INFO - 'enabled': True, 14:32:13 INFO - 'halt_on_failure': False, 14:32:13 INFO - 'name': 'check_screen_resolution'},), 14:32:13 INFO - 'run_cmd_checks_enabled': True, 14:32:13 INFO - 'sps_profile': False, 14:32:13 INFO - 'sps_profile_interval': 0, 14:32:13 INFO - 'suite': 'dromaeojs-e10s', 14:32:13 INFO - 'system_bits': '32', 14:32:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:32:13 INFO - 'title': 't-yosemite-r7-0174', 14:32:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:32:13 INFO - 'use_talos_json': True, 14:32:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:32:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:32:13 INFO - 'work_dir': 'build'} 14:32:13 INFO - ##### 14:32:13 INFO - ##### Running clobber step. 14:32:13 INFO - ##### 14:32:13 INFO - Running pre-action listener: _resource_record_pre_action 14:32:13 INFO - Running main action method: clobber 14:32:13 INFO - rmtree: /builds/slave/test/build 14:32:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:32:15 INFO - Running post-action listener: _resource_record_post_action 14:32:15 INFO - ##### 14:32:15 INFO - ##### Running read-buildbot-config step. 14:32:15 INFO - ##### 14:32:15 INFO - Running pre-action listener: _resource_record_pre_action 14:32:15 INFO - Running main action method: read_buildbot_config 14:32:15 INFO - Using buildbot properties: 14:32:15 INFO - { 14:32:15 INFO - "project": "", 14:32:15 INFO - "product": "firefox", 14:32:15 INFO - "script_repo_revision": "production", 14:32:15 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 14:32:15 INFO - "repository": "", 14:32:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 14:32:15 INFO - "buildid": "20160418094943", 14:32:15 INFO - "pgo_build": "False", 14:32:15 INFO - "basedir": "/builds/slave/test", 14:32:15 INFO - "buildnumber": 247, 14:32:15 INFO - "slavename": "t-yosemite-r7-0174", 14:32:15 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:32:15 INFO - "platform": "yosemite_r7", 14:32:15 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:32:15 INFO - "branch": "mozilla-aurora", 14:32:15 INFO - "repo_path": "releases/mozilla-aurora", 14:32:15 INFO - "revision": "1a229bf7891d7b453eb6e5269c11ace513e400a4", 14:32:15 INFO - "stage_platform": "macosx64", 14:32:15 INFO - "builduid": "82cf067085264d8d8a7159b7c61cf302", 14:32:15 INFO - "slavebuilddir": "test" 14:32:15 INFO - } 14:32:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 14:32:15 INFO - Running post-action listener: _resource_record_post_action 14:32:15 INFO - ##### 14:32:15 INFO - ##### Running download-and-extract step. 14:32:15 INFO - ##### 14:32:15 INFO - Running pre-action listener: _resource_record_pre_action 14:32:15 INFO - Running main action method: download_and_extract 14:32:15 INFO - mkdir: /builds/slave/test/build/tests 14:32: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')]} 14:32:15 INFO - https://queue.taskcluster.net/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:32:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 14:32:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 14:32:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 14:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 14:32:17 INFO - Downloaded 1277 bytes. 14:32:17 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 14:32:17 INFO - Using the following test package requirements: 14:32:17 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 14:32:17 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 14:32:17 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 14:32:17 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 14:32:17 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 14:32:17 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 14:32:17 INFO - u'jsshell-mac.zip'], 14:32:17 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 14:32:17 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 14:32:17 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 14:32:17 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 14:32:17 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 14:32:17 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 14:32:17 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 14:32:17 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 14:32:17 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 14:32:17 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 14:32:17 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 14:32:17 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 14:32:17 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:17 INFO - https://queue.taskcluster.net/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:32:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 14:32:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 14:32:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 14:32:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:32:19 INFO - Downloaded 17910943 bytes. 14:32:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:32:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:32:22 INFO - Return code: 0 14:32:22 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 14:32:22 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')]} 14:32:22 INFO - https://queue.taskcluster.net/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:32:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 14:32:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 14:32:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 14:32:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:32:23 INFO - Downloaded 17910943 bytes. 14:32:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:32:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:32:27 INFO - Return code: 0 14:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:27 INFO - https://queue.taskcluster.net/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:32:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 14:32:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 14:32:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 14:32:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 14:32:28 INFO - Downloaded 10845168 bytes. 14:32:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:32:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:32:28 INFO - Return code: 0 14:32:28 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')]} 14:32:28 INFO - https://queue.taskcluster.net/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 14:32:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 14:32:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 14:32:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 14:32:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 14:32:32 INFO - Downloaded 115239763 bytes. 14:32:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 14:32:32 INFO - mkdir: /builds/slave/test/properties 14:32:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:32:32 INFO - Writing to file /builds/slave/test/properties/build_url 14:32:32 INFO - Contents: 14:32:32 INFO - build_url:https://queue.taskcluster.net/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 14:32:33 INFO - Running post-action listener: _resource_record_post_action 14:32:33 INFO - Running post-action listener: set_extra_try_arguments 14:32:33 INFO - ##### 14:32:33 INFO - ##### Running populate-webroot step. 14:32:33 INFO - ##### 14:32:33 INFO - Running pre-action listener: _resource_record_pre_action 14:32:33 INFO - Running main action method: populate_webroot 14:32:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:32:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:32:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:32:33 INFO - '--tppagecycles', 14:32:33 INFO - '7'], 14:32:33 INFO - 'tests': ['tsvgm']}}, 14:32:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:32:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:32:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:32:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:32:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:32:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:32:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:33 INFO - 'talos_options': ['--e10s'], 14:32:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:33 INFO - 'tests': ['damp', 'tps']}, 14:32:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:33 INFO - 'talos_options': ['--e10s'], 14:32:33 INFO - 'tests': ['damp', 'tps']}, 14:32:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:32:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:32:33 INFO - 'other': {'tests': ['a11yr', 14:32:33 INFO - 'ts_paint', 14:32:33 INFO - 'tpaint', 14:32:33 INFO - 'sessionrestore', 14:32:33 INFO - 'sessionrestore_no_auto_restore', 14:32:33 INFO - 'tabpaint']}, 14:32:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:32:33 INFO - 'tests': ['a11yr', 14:32:33 INFO - 'ts_paint', 14:32:33 INFO - 'tpaint', 14:32:33 INFO - 'sessionrestore', 14:32:33 INFO - 'sessionrestore_no_auto_restore', 14:32:33 INFO - 'tabpaint']}, 14:32:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:32:33 INFO - 'tests': ['a11yr', 14:32:33 INFO - 'ts_paint', 14:32:33 INFO - 'tpaint', 14:32:33 INFO - 'sessionrestore', 14:32:33 INFO - 'sessionrestore_no_auto_restore', 14:32:33 INFO - 'tabpaint']}, 14:32:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:32:33 INFO - 'tests': ['a11yr', 14:32:33 INFO - 'ts_paint', 14:32:33 INFO - 'tpaint', 14:32:33 INFO - 'sessionrestore', 14:32:33 INFO - 'sessionrestore_no_auto_restore', 14:32:33 INFO - 'tabpaint']}, 14:32:33 INFO - 'other_l64': {'tests': ['a11yr', 14:32:33 INFO - 'ts_paint', 14:32:33 INFO - 'tpaint', 14:32:33 INFO - 'sessionrestore', 14:32:33 INFO - 'sessionrestore_no_auto_restore', 14:32:33 INFO - 'tabpaint']}, 14:32:33 INFO - 'other_nol64': {'tests': ['a11yr', 14:32:33 INFO - 'ts_paint', 14:32:33 INFO - 'tpaint', 14:32:33 INFO - 'sessionrestore', 14:32:33 INFO - 'sessionrestore_no_auto_restore', 14:32:33 INFO - 'tabpaint']}, 14:32:33 INFO - 'svgr': {'tests': ['tsvgx', 14:32:33 INFO - 'tsvgr_opacity', 14:32:33 INFO - 'tart', 14:32:33 INFO - 'tscrollx', 14:32:33 INFO - 'cart']}, 14:32:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:32:33 INFO - 'tests': ['tsvgx', 14:32:33 INFO - 'tsvgr_opacity', 14:32:33 INFO - 'tart', 14:32:33 INFO - 'tscrollx', 14:32:33 INFO - 'cart']}, 14:32:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:33 INFO - 'tests': ['tp5o']}, 14:32:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:33 INFO - 'talos_options': ['--e10s'], 14:32:33 INFO - 'tests': ['tp5o']}, 14:32:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:33 INFO - 'talos_options': ['--xperf_path', 14:32:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:33 INFO - 'tests': ['tp5n']}, 14:32:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:33 INFO - 'talos_options': ['--e10s', 14:32:33 INFO - '--xperf_path', 14:32:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:33 INFO - 'tests': ['tp5n']}}, 14:32:33 INFO - 'talos.zip': {'path': '', 14:32:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:32:33 INFO - Running post-action listener: _resource_record_post_action 14:32:33 INFO - ##### 14:32:33 INFO - ##### Running create-virtualenv step. 14:32:33 INFO - ##### 14:32:33 INFO - Running pre-action listener: _resource_record_pre_action 14:32:33 INFO - Running main action method: create_virtualenv 14:32:33 INFO - Creating virtualenv /builds/slave/test/build/venv 14:32:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:32:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:32:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:32:33 INFO - Using real prefix '/tools/python27' 14:32:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:32:34 INFO - Installing distribute.............................................................................................................................................................................................done. 14:32:37 INFO - Installing pip.................done. 14:32:37 INFO - Return code: 0 14:32:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd68a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb0add1b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc0cd30>, '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 0x10ca70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc03b20>, '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.s87zJXjh3I/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.0gNdigrWF8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 14:32:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:32:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:32:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s87zJXjh3I/Render', 14:32:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:37 INFO - 'HOME': '/Users/cltbld', 14:32:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:37 INFO - 'LOGNAME': 'cltbld', 14:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:37 INFO - 'MOZ_NO_REMOTE': '1', 14:32:37 INFO - 'NO_EM_RESTART': '1', 14:32:37 INFO - 'PAGER': '/bin/cat', 14:32:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:37 INFO - 'PWD': '/builds/slave/test', 14:32:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:37 INFO - 'SHELL': '/bin/bash', 14:32:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0gNdigrWF8/Listeners', 14:32:37 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 14:32:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:37 INFO - 'USER': 'cltbld', 14:32:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:37 INFO - 'XPC_FLAGS': '0x0', 14:32:37 INFO - 'XPC_SERVICE_NAME': '0', 14:32:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:32:37 INFO - Cleaning up... 14:32:37 INFO - Return code: 0 14:32:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd68a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb0add1b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc0cd30>, '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 0x10ca70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc03b20>, '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.s87zJXjh3I/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.0gNdigrWF8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 14:32:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:32:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:32:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s87zJXjh3I/Render', 14:32:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:37 INFO - 'HOME': '/Users/cltbld', 14:32:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:37 INFO - 'LOGNAME': 'cltbld', 14:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:37 INFO - 'MOZ_NO_REMOTE': '1', 14:32:37 INFO - 'NO_EM_RESTART': '1', 14:32:37 INFO - 'PAGER': '/bin/cat', 14:32:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:37 INFO - 'PWD': '/builds/slave/test', 14:32:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:37 INFO - 'SHELL': '/bin/bash', 14:32:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0gNdigrWF8/Listeners', 14:32:37 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 14:32:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:37 INFO - 'USER': 'cltbld', 14:32:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:37 INFO - 'XPC_FLAGS': '0x0', 14:32:37 INFO - 'XPC_SERVICE_NAME': '0', 14:32:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:37 INFO - Downloading/unpacking psutil>=0.7.1 14:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:32:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:32:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:32:40 INFO - Installing collected packages: psutil 14:32:40 INFO - Running setup.py install for psutil 14:32:41 INFO - building 'psutil._psutil_osx' extension 14:32:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:32:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:32:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:32:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:32:41 INFO - building 'psutil._psutil_posix' extension 14:32:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:32:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:32:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:32:41 INFO - ^ 14:32:41 INFO - 1 warning generated. 14:32:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:32:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:32:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:32:42 INFO - Successfully installed psutil 14:32:42 INFO - Cleaning up... 14:32:42 INFO - Return code: 0 14:32:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cd68a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb0add1b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc0cd30>, '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 0x10ca70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc03b20>, '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.s87zJXjh3I/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.0gNdigrWF8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 14:32:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:32:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s87zJXjh3I/Render', 14:32:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:42 INFO - 'HOME': '/Users/cltbld', 14:32:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:42 INFO - 'LOGNAME': 'cltbld', 14:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:42 INFO - 'MOZ_NO_REMOTE': '1', 14:32:42 INFO - 'NO_EM_RESTART': '1', 14:32:42 INFO - 'PAGER': '/bin/cat', 14:32:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:42 INFO - 'PWD': '/builds/slave/test', 14:32:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:42 INFO - 'SHELL': '/bin/bash', 14:32:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0gNdigrWF8/Listeners', 14:32:42 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 14:32:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:42 INFO - 'USER': 'cltbld', 14:32:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:42 INFO - 'XPC_FLAGS': '0x0', 14:32:42 INFO - 'XPC_SERVICE_NAME': '0', 14:32:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:32:44 INFO - Installing collected packages: mozsystemmonitor 14:32:44 INFO - Running setup.py install for mozsystemmonitor 14:32:45 INFO - Successfully installed mozsystemmonitor 14:32:45 INFO - Cleaning up... 14:32:45 INFO - Return code: 0 14:32:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:32:45 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')]} 14:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:45 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')]} 14:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:45 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 0x10cd68a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb0add1b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc0cd30>, '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 0x10ca70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc03b20>, '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.s87zJXjh3I/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.0gNdigrWF8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 14:32:45 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 14:32:45 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 14:32:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s87zJXjh3I/Render', 14:32:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:45 INFO - 'HOME': '/Users/cltbld', 14:32:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:45 INFO - 'LOGNAME': 'cltbld', 14:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:45 INFO - 'MOZ_NO_REMOTE': '1', 14:32:45 INFO - 'NO_EM_RESTART': '1', 14:32:45 INFO - 'PAGER': '/bin/cat', 14:32:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:45 INFO - 'PWD': '/builds/slave/test', 14:32:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:45 INFO - 'SHELL': '/bin/bash', 14:32:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0gNdigrWF8/Listeners', 14:32:45 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 14:32:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:45 INFO - 'USER': 'cltbld', 14:32:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:45 INFO - 'XPC_FLAGS': '0x0', 14:32:45 INFO - 'XPC_SERVICE_NAME': '0', 14:32:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:45 INFO - Downloading/unpacking blobuploader==1.2.4 14:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:47 INFO - Downloading blobuploader-1.2.4.tar.gz 14:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:32:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:32:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:48 INFO - Downloading docopt-0.6.1.tar.gz 14:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:32:49 INFO - Installing collected packages: blobuploader, requests, docopt 14:32:49 INFO - Running setup.py install for blobuploader 14:32:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:32:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:32:49 INFO - Running setup.py install for requests 14:32:49 INFO - Running setup.py install for docopt 14:32:49 INFO - Successfully installed blobuploader requests docopt 14:32:49 INFO - Cleaning up... 14:32:49 INFO - Return code: 0 14:32:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd68a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb0add1b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc0cd30>, '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 0x10ca70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc03b20>, '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.s87zJXjh3I/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.0gNdigrWF8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 14:32:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:32:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s87zJXjh3I/Render', 14:32:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:49 INFO - 'HOME': '/Users/cltbld', 14:32:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:49 INFO - 'LOGNAME': 'cltbld', 14:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:49 INFO - 'MOZ_NO_REMOTE': '1', 14:32:49 INFO - 'NO_EM_RESTART': '1', 14:32:49 INFO - 'PAGER': '/bin/cat', 14:32:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:49 INFO - 'PWD': '/builds/slave/test', 14:32:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:49 INFO - 'SHELL': '/bin/bash', 14:32:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0gNdigrWF8/Listeners', 14:32:49 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 14:32:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:49 INFO - 'USER': 'cltbld', 14:32:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:49 INFO - 'XPC_FLAGS': '0x0', 14:32:49 INFO - 'XPC_SERVICE_NAME': '0', 14:32:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:32:50 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-OLo83L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:32:50 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-qXXofi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:32:50 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-zEOCDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:32:50 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-FpqXQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:32:50 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-cDobWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:32:50 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-nm9tSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:32:50 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-7p1t0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:32:50 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-fKRPsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:32:51 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-0r9IGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:32:51 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-K4jPpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:32:51 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-OcGbVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:32:51 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-g4pfcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:32:51 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-EkGxkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:32:51 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-tGd99S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:51 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-hpka6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:32:51 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-OChRBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:32:51 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-18REEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:32:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:32:52 INFO - Running setup.py install for manifestparser 14:32:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:32:52 INFO - Running setup.py install for mozcrash 14:32:52 INFO - Running setup.py install for mozdebug 14:32:52 INFO - Running setup.py install for mozdevice 14:32:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:32:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:32:52 INFO - Running setup.py install for mozfile 14:32:52 INFO - Running setup.py install for mozhttpd 14:32:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:32:52 INFO - Running setup.py install for mozinfo 14:32:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:32:53 INFO - Running setup.py install for mozInstall 14:32:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:32:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:32:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:32:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:32:53 INFO - Running setup.py install for mozleak 14:32:53 INFO - Running setup.py install for mozlog 14:32:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:32:53 INFO - Running setup.py install for moznetwork 14:32:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:32:53 INFO - Running setup.py install for mozprocess 14:32:53 INFO - Running setup.py install for mozprofile 14:32:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:32:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:32:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:32:53 INFO - Running setup.py install for mozrunner 14:32:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:32:54 INFO - Running setup.py install for mozscreenshot 14:32:54 INFO - Running setup.py install for moztest 14:32:54 INFO - Running setup.py install for mozversion 14:32:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:32:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:32:54 INFO - Cleaning up... 14:32:54 INFO - Return code: 0 14:32:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32: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')]} 14:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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')]} 14:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd68a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb0add1b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc0cd30>, '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 0x10ca70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc03b20>, '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.s87zJXjh3I/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.0gNdigrWF8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 14:32:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:32:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s87zJXjh3I/Render', 14:32:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:54 INFO - 'HOME': '/Users/cltbld', 14:32:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:54 INFO - 'LOGNAME': 'cltbld', 14:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:54 INFO - 'MOZ_NO_REMOTE': '1', 14:32:54 INFO - 'NO_EM_RESTART': '1', 14:32:54 INFO - 'PAGER': '/bin/cat', 14:32:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:54 INFO - 'PWD': '/builds/slave/test', 14:32:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:54 INFO - 'SHELL': '/bin/bash', 14:32:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0gNdigrWF8/Listeners', 14:32:54 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 14:32:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:54 INFO - 'USER': 'cltbld', 14:32:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:54 INFO - 'XPC_FLAGS': '0x0', 14:32:54 INFO - 'XPC_SERVICE_NAME': '0', 14:32:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:32:54 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-7k1eGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:32:54 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-ZeicE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:32:55 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)) 14:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:32:55 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-5O1vDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:32:55 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)) 14:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:32:55 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-emY8VE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:32:55 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-O4j9Se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:32:55 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-5E_pPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:32:55 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-U22_IH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:32:55 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Hhsteu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:32:55 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-l3s9nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:32:55 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-p72jAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:32:55 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-qieGrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:32:56 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)) 14:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:32:56 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-pMNEuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:32:56 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)) 14:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:32:56 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-IMytYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:32:56 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)) 14:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:32:56 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-a_kWFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:56 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-03iLOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:32:56 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-E1imLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:32:56 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-IgxnuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:32:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32:59 INFO - Downloading blessings-1.6.tar.gz 14:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:32:59 INFO - Installing collected packages: blessings 14:32:59 INFO - Running setup.py install for blessings 14:32:59 INFO - Successfully installed blessings 14:32:59 INFO - Cleaning up... 14:32:59 INFO - Return code: 0 14:32:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:32:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:32:59 INFO - Reading from file tmpfile_stdout 14:32:59 INFO - Current package versions: 14:32:59 INFO - blessings == 1.6 14:32:59 INFO - blobuploader == 1.2.4 14:32:59 INFO - docopt == 0.6.1 14:32:59 INFO - manifestparser == 1.1 14:32:59 INFO - mozInstall == 1.12 14:32:59 INFO - mozcrash == 0.17 14:32:59 INFO - mozdebug == 0.1 14:32:59 INFO - mozdevice == 0.48 14:32:59 INFO - mozfile == 1.2 14:32:59 INFO - mozhttpd == 0.7 14:32:59 INFO - mozinfo == 0.9 14:32:59 INFO - mozleak == 0.1 14:32:59 INFO - mozlog == 3.1 14:32:59 INFO - moznetwork == 0.27 14:32:59 INFO - mozprocess == 0.22 14:32:59 INFO - mozprofile == 0.28 14:32:59 INFO - mozrunner == 6.11 14:32:59 INFO - mozscreenshot == 0.1 14:32:59 INFO - mozsystemmonitor == 0.0 14:32:59 INFO - moztest == 0.7 14:32:59 INFO - mozversion == 1.4 14:32:59 INFO - psutil == 3.1.1 14:32:59 INFO - requests == 1.2.3 14:32:59 INFO - wsgiref == 0.1.2 14:32:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:00 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')]} 14:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:00 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 0x10cd68a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb0add1b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc0cd30>, '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 0x10ca70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc03b20>, '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.s87zJXjh3I/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.0gNdigrWF8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 14:33:00 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 14:33:00 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 14:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s87zJXjh3I/Render', 14:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:00 INFO - 'HOME': '/Users/cltbld', 14:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:00 INFO - 'LOGNAME': 'cltbld', 14:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:00 INFO - 'MOZ_NO_REMOTE': '1', 14:33:00 INFO - 'NO_EM_RESTART': '1', 14:33:00 INFO - 'PAGER': '/bin/cat', 14:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:00 INFO - 'PWD': '/builds/slave/test', 14:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:00 INFO - 'SHELL': '/bin/bash', 14:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0gNdigrWF8/Listeners', 14:33:00 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 14:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:00 INFO - 'USER': 'cltbld', 14:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:00 INFO - 'XPC_FLAGS': '0x0', 14:33:00 INFO - 'XPC_SERVICE_NAME': '0', 14:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:00 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)) 14:33:00 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)) 14:33:00 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)) 14:33:00 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)) 14:33:00 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)) 14:33:00 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)) 14:33:00 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)) 14:33:00 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)) 14:33:00 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)) 14:33:00 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)) 14:33:00 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)) 14:33:00 INFO - Cleaning up... 14:33:00 INFO - Return code: 0 14:33:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:33:00 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')]} 14:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:00 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')]} 14:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:00 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 0x10cd68a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb0add1b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc0cd30>, '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 0x10ca70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc03b20>, '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.s87zJXjh3I/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.0gNdigrWF8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 14:33:00 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 14:33:00 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 14:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s87zJXjh3I/Render', 14:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:00 INFO - 'HOME': '/Users/cltbld', 14:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:00 INFO - 'LOGNAME': 'cltbld', 14:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:00 INFO - 'MOZ_NO_REMOTE': '1', 14:33:00 INFO - 'NO_EM_RESTART': '1', 14:33:00 INFO - 'PAGER': '/bin/cat', 14:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:00 INFO - 'PWD': '/builds/slave/test', 14:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:00 INFO - 'SHELL': '/bin/bash', 14:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0gNdigrWF8/Listeners', 14:33:00 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 14:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:00 INFO - 'USER': 'cltbld', 14:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:00 INFO - 'XPC_FLAGS': '0x0', 14:33:00 INFO - 'XPC_SERVICE_NAME': '0', 14:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:01 INFO - Downloading/unpacking jsonschema 14:33: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 14:33: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 14:33: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 14:33: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 14:33: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 14:33: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 14:33:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:33:03 INFO - Downloading/unpacking functools32 (from jsonschema) 14:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:04 INFO - Downloading functools32-3.2.3-2.tar.gz 14:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:33:04 INFO - warning: no files found matching '*.txt' 14:33:04 INFO - no previously-included directories found matching 'build' 14:33:04 INFO - no previously-included directories found matching 'dist' 14:33:04 INFO - no previously-included directories found matching '.git*' 14:33:04 INFO - Installing collected packages: jsonschema, functools32 14:33:04 INFO - Running setup.py install for functools32 14:33:04 INFO - warning: no files found matching '*.txt' 14:33:04 INFO - no previously-included directories found matching 'build' 14:33:04 INFO - no previously-included directories found matching 'dist' 14:33:04 INFO - no previously-included directories found matching '.git*' 14:33:04 INFO - Successfully installed jsonschema functools32 14:33:04 INFO - Cleaning up... 14:33:04 INFO - Return code: 0 14:33:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd68a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb0add1b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc0cd30>, '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 0x10ca70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc03b20>, '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.s87zJXjh3I/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.0gNdigrWF8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 14:33:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:33:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s87zJXjh3I/Render', 14:33:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:04 INFO - 'HOME': '/Users/cltbld', 14:33:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:04 INFO - 'LOGNAME': 'cltbld', 14:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:04 INFO - 'MOZ_NO_REMOTE': '1', 14:33:04 INFO - 'NO_EM_RESTART': '1', 14:33:04 INFO - 'PAGER': '/bin/cat', 14:33:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:04 INFO - 'PWD': '/builds/slave/test', 14:33:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:04 INFO - 'SHELL': '/bin/bash', 14:33:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0gNdigrWF8/Listeners', 14:33:04 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 14:33:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:04 INFO - 'USER': 'cltbld', 14:33:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:04 INFO - 'XPC_FLAGS': '0x0', 14:33:04 INFO - 'XPC_SERVICE_NAME': '0', 14:33:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:04 INFO - Downloading/unpacking flake8 14:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:33:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:33:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:33:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:33:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:33:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:33:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:33:08 INFO - no previously-included directories found matching 'docs/_build' 14:33:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:33:08 INFO - Running setup.py install for pep8 14:33:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:33:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:33:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:33:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:33:08 INFO - no previously-included directories found matching 'docs/_build' 14:33:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:33:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:33:08 INFO - Cleaning up... 14:33:08 INFO - Return code: 0 14:33:08 INFO - Running post-action listener: _resource_record_post_action 14:33:08 INFO - Running post-action listener: _start_resource_monitoring 14:33:08 INFO - Starting resource monitoring. 14:33:08 INFO - ##### 14:33:08 INFO - ##### Running install step. 14:33:08 INFO - ##### 14:33:08 INFO - Running pre-action listener: _resource_record_pre_action 14:33:08 INFO - Running main action method: install 14:33:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:33:09 INFO - Reading from file tmpfile_stdout 14:33:09 INFO - Detecting whether we're running mozinstall >=1.0... 14:33:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:33:09 INFO - Reading from file tmpfile_stdout 14:33:09 INFO - Output received: 14:33:09 INFO - Usage: mozinstall [options] installer 14:33:09 INFO - Options: 14:33:09 INFO - -h, --help show this help message and exit 14:33:09 INFO - -d DEST, --destination=DEST 14:33:09 INFO - Directory to install application into. [default: 14:33:09 INFO - "/builds/slave/test"] 14:33:09 INFO - --app=APP Application being installed. [default: firefox] 14:33:09 INFO - mkdir: /builds/slave/test/build/application 14:33:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 14:33:42 INFO - Reading from file tmpfile_stdout 14:33:42 INFO - Output received: 14:33:42 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:33:42 INFO - Running post-action listener: _resource_record_post_action 14:33:42 INFO - ##### 14:33:42 INFO - ##### Running run-tests step. 14:33:42 INFO - ##### 14:33:42 INFO - Running pre-action listener: _resource_record_pre_action 14:33:42 INFO - Running main action method: run_tests 14:33:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:33:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:33:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:33:42 INFO - 2016-04-18 14:33:42.149 screenresolution[1638:7681] starting screenresolution argv=screenresolution get 14:33:42 INFO - 2016-04-18 14:33:42.151 screenresolution[1638:7681] Display 0: 1600x1200x32@60 14:33:42 INFO - 2016-04-18 14:33:42.156 screenresolution[1639:7683] starting screenresolution argv=screenresolution list 14:33:42 INFO - Available Modes on Display 0 14:33:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:33:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:33:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:33:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:33:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:33:42 INFO - Intel Iris: 14:33:42 INFO - Chipset Model: Intel Iris 14:33:42 INFO - Type: GPU 14:33:42 INFO - Bus: Built-In 14:33:42 INFO - VRAM (Dynamic, Max): 1536 MB 14:33:42 INFO - Vendor: Intel (0x8086) 14:33:42 INFO - Device ID: 0x0a2e 14:33:42 INFO - Revision ID: 0x0009 14:33:42 INFO - Displays: 14:33:42 INFO - Display: 14:33:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:33:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:33:42 INFO - Display Serial Number: 1600x1200 60 14:33:42 INFO - Main Display: Yes 14:33:42 INFO - Mirror: Off 14:33:42 INFO - Online: Yes 14:33:42 INFO - Rotation: Supported 14:33:42 INFO - Return code: 0 14:33:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:33:42 INFO - Python 2.7.3 14:33:42 INFO - Return code: 0 14:33:42 INFO - grabbing minidump binary from tooltool 14:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:42 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 0x10cc0cd30>, '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 0x10ca70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc03b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:33:42 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 14:33:42 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 14:33:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:33:42 INFO - Return code: 0 14:33:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:33:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:33:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:33:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:33:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:33:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:33:43 INFO - Return code: 0 14:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0174', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0174 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:33:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s87zJXjh3I/Render', 14:33:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:43 INFO - 'HOME': '/Users/cltbld', 14:33:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:43 INFO - 'LOGNAME': 'cltbld', 14:33:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:33:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:43 INFO - 'MOZ_NO_REMOTE': '1', 14:33:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:33:43 INFO - 'NO_EM_RESTART': '1', 14:33:43 INFO - 'PAGER': '/bin/cat', 14:33:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:43 INFO - 'PWD': '/builds/slave/test', 14:33:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:33:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:43 INFO - 'SHELL': '/bin/bash', 14:33:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0gNdigrWF8/Listeners', 14:33:43 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 14:33:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:43 INFO - 'USER': 'cltbld', 14:33:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:43 INFO - 'XPC_FLAGS': '0x0', 14:33:43 INFO - 'XPC_SERVICE_NAME': '0', 14:33:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0174', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:33:43 INFO - mozversion application_buildid: 20160418094943 14:33:43 INFO - mozversion application_changeset: 1a229bf7891d7b453eb6e5269c11ace513e400a4 14:33:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:33:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:33:43 INFO - mozversion application_name: Firefox 14:33:43 INFO - mozversion application_remotingname: firefox-dev 14:33:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:33:43 INFO - mozversion application_vendor: Mozilla 14:33:43 INFO - mozversion application_version: 47.0a2 14:33:43 INFO - mozversion platform_buildid: 20160418094943 14:33:43 INFO - mozversion platform_changeset: 1a229bf7891d7b453eb6e5269c11ace513e400a4 14:33:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:33:43 INFO - mozversion platform_version: 47.0a2 14:33:43 INFO - using testdate: 1461015223 14:33:43 INFO - actual date: 1461015223 14:33:43 INFO - starting webserver on 'localhost:49283' 14:33:43 INFO - SUITE-START | Running 2 tests 14:33:43 INFO - TEST-START | dromaeo_css 14:33:43 INFO - operating with platform_type : mac_ 14:33:43 INFO - Initialising browser for dromaeo_css test... 14:33:43 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmpdyzmQ_/profile http://localhost:49283/getInfo.html) 14:33:46 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 14:33:46 INFO - PROCESS | 1657 | colorDepth:24 14:33:46 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 14:33:46 INFO - PROCESS | 1657 | __metrics 14:33:46 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 14:33:47 INFO - TEST-INFO | 1657: exit 0 14:33:47 INFO - Browser initialized. 14:33:47 INFO - Running cycle 1/1 for dromaeo_css test... 14:33:47 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmpdyzmQ_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:33:59 INFO - PROCESS | 1660 | RSS: Main: 217456640 14:33:59 INFO - PROCESS | 1660 | 14:34:49 INFO - PROCESS | 1660 | 1461015289007 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] 14:37:00 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49283/tests/dromaeo/cssquery-ext.html) 14:37:02 INFO - PROCESS | 1660 | RSS: Main: 228294656 14:37:02 INFO - PROCESS | 1660 | 14:40:04 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-ext.html (next: http://localhost:49283/tests/dromaeo/cssquery-jquery.html) 14:40:04 INFO - PROCESS | 1660 | RSS: Main: 240582656 14:40:04 INFO - PROCESS | 1660 | 14:43:06 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49283/tests/dromaeo/cssquery-mootools.html) 14:43:06 INFO - PROCESS | 1660 | RSS: Main: 242376704 14:43:06 INFO - PROCESS | 1660 | 14:46:08 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49283/tests/dromaeo/cssquery-prototype.html) 14:46:09 INFO - PROCESS | 1660 | RSS: Main: 243970048 14:46:09 INFO - PROCESS | 1660 | 14:49:11 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49283/tests/dromaeo/cssquery-yui.html) 14:49:12 INFO - PROCESS | 1660 | RSS: Main: 246255616 14:49:12 INFO - PROCESS | 1660 | 14:52:14 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-yui.html (next: http://localhost:49283/tests/dromaeo/cssquery-dojo.html) 14:52:14 INFO - PROCESS | 1660 | RSS: Main: 247644160 14:52:14 INFO - PROCESS | 1660 | 14:52:14 INFO - PROCESS | 1660 | __start_tp_report 14:52:14 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 14:52:14 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 14:52:14 INFO - PROCESS | 1660 | |i|pagename|runs| 14:52:14 INFO - PROCESS | 1660 | |0;dojo.html;3008.684088170742;3536.664016918392;3557.252976874857;3573.231755172639;3623.710103191745;5347.679139251648;5865.706714664266;5871.735771890275;5883.294004719434;5892.499137573301;5863.1205319202145;5870.383609720981;5943.910841337372;5946.137810017545;5973.820785376446;5271.815486457975;5357.812476563321;5379.085555455563;5401.918971215416;5415.593830462731;5289.973550132244;5384.623076384654;5401.675899446026;5407.405185429599;5429.077056900336;5283.154695248761;5367.570594352443;5398.271233383502;5410.269613602172;5418.078926582491;5350.197470379455;5430;5457.808976685837;5462.126059830408;5486.341639003305;5277.076511610491;5333.2000199969925;5349.465053494659;5351.030178251069;5402.91895621566;4683.929741053853;4899.314096026559;5621.718914054321;5788.855278618026;5861.032929566616;4915.3855768029;5782.306123265193;6236.812895613093;6269.592476489013;6272.717727702265;6284.748610055638;6304.117423560705;6305.211848518935;6320.146780184708;6320.71556779946;5880.8235752927485;5994.100884867261;6074.635521868702;6080.6351618903445;6082.057281121433;6348;6425.646589437626;6436.742530298736;6443.420092191725;6455.61266324022;6118.6191791732535;6299.905501417483;6307.2431308242385;6324.620522768557;6348.301686814447;5136.332276804066;6283.905741413882;6296.968515157487;6297.811065668037;6298.622082675054;6250.406211409909;6293.653849038255;6293.748250069946;6298.716557754912;6311.463525600376;6181.690915454209;6267.341929097471;6279.811605651837;6288.591241569375;6328.11406403104;4969.304297398367;4978.477259887732;4998.90002199954;4999.475055119233;5030.320906677625;4508.211063063951;4522.140793249272;4540.977295113504;4547.7498737569085;4563.087382523442;5258.158694608921;5914.497267732291;5958.553108516879;5979.9402005980255;6016.608920420159;6223.782167624111;6230.470410015108;6293.30773614902;6312.147860038836;6320;4824.252240902666;5822.796202132905;5862;5899.112284069057;5918.171455996164;5055.963527476858;5193.636445448858;5433.782648694087;5435.211894275308;5435.864103397446;5891.086881533369;6097.7865774697675;6448.193975753031;6486.027095935553;6517.315681853432;4717.811287548459;6197.163382943245;6287.119803227643;6294.087357333253;6341.270753863365;5785.8139081489035;5868.853278667897;6348.650824204713;6490.935090649033;6499.447546958561;5862.736176872137;5959.67221802805;6257.499400047895;6314.179156709598;6320.051992201206;5632.788950375689;6269.843253918506;6310.873782524232;6321.778737744157;6377.362263773585;6111.5110791137495;6170.136180934763;6189.35011823752;6234.127222188807;6268.279147897868;6235.594686345373;6253.656048917172;6266.968665156645;6271.498280137669;6275.152854364603;6009.639421634716;6128.9693551531955;6157.84605384869;6193.318734939243;6199.1011303359855;6108.511319094373;6120.569035656853;6201.875962480815;6252.874942501216;6264.060390941395;5287.418383977836;5972.074328479092;6150.323464418821;6170.197874276315;6202.28673702512 14:52:14 INFO - PROCESS | 1660 | |1;ext.html;462.40580853603103;532.7042349986683;591.6213623281101;614.0574218574484;662.443547420167;38032;38847.611523884785;38856.80571597145;38889.41665875014;38954.02614934628;40200.19599608006;40231.19537609246;40449.39325910114;40610.7969460153;40959;9566.234701223902;9644.324897257195;9810.068043535888;9812.264080193978;9836.163926066292;8873.911260887373;9736.172425343855;9744.464054477;9762.853557196648;9766.316357854954;9667.70996870095;9783.755406114833;9787.314887957846;9789.706308810712;9840.311178217527;9011.549422528913;9242.768930776718;9641.180499657537;9760.414375137514;9771.316007879452;9610.51947402627;9646.324757266993;9702.029797020312;9716.659916902874;9733.56198971048;32377.6762232377;33190.502142467885;39300.803495982625;39592.802035989924;40003.7999810002;3008.608880845498;3225.59680039995;3228.515722641599;3321.4021476134285;3330.5670262865915;27355.45289094227;27500;27544.898204072015;27840.841436792933;28012.439751205067;2640.405908670553;2644.5239856825765;2669.6529451171223;2684.3154995476225;2708.769754570864;342830;343519;343653;344117;413132.86867131246;48265;62826.68586657038;63303.050454243225;63608.72782544323;63760.68119659372;47425.05149896983;47606.5239347609;47613;47615;47681.523184768404;16655.83344166567;16883.746743798853;17050.829491704924;17103.74344384835;17140;13325.66685832862;13481.460741570423;13498.257595832127;13592.728145437035;13603.931980340036;13153.671158221121;14690.26548672562;15162.24188790578;15575;15660.843391566166;6541.116949211795;6632.436242919406;6653.567518111307;6656.334366563402;6664.1336626239245;992.1021475564481;1030.1985672867097;1051.138066785244;1070.8393740938766;1152.1013609384693;29205.41589168205;29986.700132998827;30227.942022029125;30637.84681076625;30781.846090769403;1104.5250542266901;1111.655070442722;1171.654361963206;1187.566538213563;1267.9683007924875;11435.085193184525;15531.301091450912;15533.766993495106;15652.217389130497;15823.446179383667;477248;478705;486014;486449;490090;61899.38100619026;61963.6901815488;62233;62774.37225627685;62996.74006519936;1528.6560523882038;1531.1655147944398;1561.2193903048476;1566.451741890352;1578.2976575424057;29791;29792.404151917275;29894.85052574723;30415;30494.7802087914;52787.47212527979;53458.66353341042;53564;53655;54131.45868541422;466221;466237;469235;469465;469708;34285.14287142841;34916.65083349134;34965;45351.866203345184;46278;43989.78005109954;44025.55974440215;44713.776431117636;45265.32102018538;45799.31301030554;38154;38328.2334353317;38805.4477820884;39103.2179356417;39362.606373935894;30944.381112377177;37424.25151497009;37775.43336849895;37882.0529486765;38025.80987095047;34044.65955340415;38563.2287354257;38641;38751.6124838748;40006.99982500344;31391.05826825199;32531.512027319135;32572.674273256966;32752;32867.83566082154;24991.375215619755;25051;25307.873460632578;25450.236492905242;25635.487290254463 14:52:14 INFO - PROCESS | 1660 | |2;jquery.html;330.5207449198663;353.3322021379592;368.5614119198154;380.83624041662074;383.96352346527107;20359.592808143847;20478.6928196077;20908.26821061263;21481.57036859262;21488.247911323087;21282;21574.89212553939;21808.563828723418;21966.89016554915;22223.44441388966;5804.042333015058;6036.426539478743;6077.11881777142;6079;6079.604825686339;5597.412271711472;5782.161586569945;5832.766689332421;5870.647761134324;5942.227510423639;5831.766729330821;5872.882542349151;5881.441263080001;5891.410858914096;5898.469137777599;4483.125790470859;5103.974480127576;5828.271466066742;5902.793402230923;5938.10928360745;4353.216421044211;5046.243063540462;5142.971405718834;5158.690478571298;5168.3539557555305;21306.89346553273;25939.74060259392;26172.607410888853;26260.474790504275;26764.19707408781;2311.456807650201;2451.889664965063;2552.1960582416477;2751.5872619107095;2920.561915712639;15019.02376345545;15034.17312047837;15352.616184595474;15471.767923481044;15484.993475424175;1733.246037973473;1747.790265168188;1770.3980646580096;1814.4738025972451;1887.5658598522416;98477.64462376063;100043;100240.9975900239;103288.48355758173;103967;11474.254173478697;11627.883721162849;11732.824007639892;11777.52889884395;11819.704507387212;13955.162690238618;14469.421223151166;14474.493392731203;14576.344064517121;14594;6920.996455513922;8101;8764.824703505894;8982.910170898207;9063.59213835379;9244.689809117044;9345.158935695685;9427.717168484956;9451.621935122655;9492.335536512377;3794.8102594870697;4317.589828966243;4357.172137293967;4481;4645.767711614473;1935.34198372554;1968.9015549222481;1969.3894892583346;1985.106701984113;2001.2895422125227;907.8456662367413;951.8096380723883;1001.9799604008025;1075.4817881122633;1130.739929816147;20138.295159669633;20474.692879606817;20535.28126515565;20907;21219.36341909745;1009.9192064634811;1010.7877345757327;1017.659084206799;1058.2539309786582;1081.9404932728776;8899.866502002475;9288.7677808054;9501.00239474859;10761.515731792088;10921.617743378943;605287;622969;633402;648290;648594;77278;102293.48853255686;122184;122533;123212;934.9668616179024;990.4651488196293;990.6570959680304;1034.0641719244097;1042.2547878267076;17809.73285400746;18270.63458730791;18386;18504.537386565444;18753.437396878115;53787;53869;54546;54919.725401372736;55002;73348.26651733414;74311.2568874326;78096.21903781117;78461.8230726551;79341;7629.122650895218;8074.757757267292;8120.350371970347;8195.754127376189;8500.617472213642;11198.776024479628;13173.077884547989;13555;13588.320583970959;13633.659158521117;9975.800483990135;11579.768404632028;11742.17804753659;11909.285442873108;11987;11425.771484570429;11559.479823407799;11602.18784685064;11653.88346116528;11841.881581184078;6025.517958563392;9817.509124543602;11965.341906195243;11995.700107497383;12106.213096148722;7804.9609751950875;8258.339332853477;8366.916330836857;8513.446625969293;8719.171678690514;9930;10593.788124237626;10742.140628749525;10795.460226988462;11558.537658493566 14:52:14 INFO - PROCESS | 1660 | |3;mootools.html;1579.0920220872997;1600.2158942118358;1936.1868015433517;2055.445029841943;2070.751509818822;8554.95722521388;9002.279817614592;9236.84539432571;9454.432734035963;9458.196053335467;9149.451032938012;9181.449113053222;9241.90758092419;9247.21398681113;9298.116678915492;2563.512932542811;2566.4482136340685;2580.6258092576563;2608.6217498462806;2608.9217323480325;2517.4461618444006;2589.5597748382725;2589.7669209771116;2591.727868573801;2600.4539046800196;2312.89591968361;2443.315871555967;2546.5925451927696;2608.569586018314;2618.48939456806;2268.2854900706225;2579.058643595093;2605.6352110704515;2605.908793192248;2613.2421597736634;2575.742425757428;2576.36878964653;2578.6647735794413;2580.7161212266637;2603.8437693738438;9342.2526197904;9370.765730856783;9408.153266206005;9450.810983780355;9451.054894510562;5783.306003279591;5802.332731735863;5892.616979896293;5965.3736357682255;5980.073088671263;3604.1350075981836;3648.781073135594;3733.290674771785;3757.455169000507;3800.1259710266518;1032.8450732390202;1052.0116978909866;1062.1237479079714;1069.1553672598639;1069.8127827630212;11023.06303964172;12578.182418142791;12695.936520317431;12732;12762.106652534327;4371.519132895379;4964.478729733398;5142.331496905378;5202.4277329493725;5219.895602088013;10933.671989840317;10935.671929842118;10944.507497162647;10968.396738179317;11004.954529319702;5755.3381361143165;5756.453136951983;5827.79602713903;5889.234399528034;5901.321348044944;4269.893252668646;4629.722216667011;5093.18509038552;5141.048905952411;5194.844154675366;4078.063794068266;4124.711270211116;4162.604552567501;4190.266703326905;4205.705600607989;1370.8080868678394;1388.972160601168;1389.1040279019976;1391.3391139208795;1398.1960372785688;1406.683496213344;1409.4714482069223;1433.7347590695754;1443.6679563700197;1460.1385182742233;7522.887156692654;8565.52889591066;8601.741947741577;8675.089115642893;8686.348523860735;530.5967464726835;534.4228233507803;536.0565404887426;538.8221886777354;547.3103889099763;6375.553711240262;6386.457151142112;6394.104825324458;6473.77341793035;6480.870382592322;9879.703608891745;11208.831867521994;11589.536418543332;11698.415079246173;11739.23694959825;10894.782104357868;11260.493277802354;11304.491297891615;11396.658100257006;11540.538378464935;8716.564171791386;8863.556822158995;8868.423552469068;8926.642934282685;8956.417832840845;8451.915480845359;8501.234888860032;8544.572771361283;8577.742667719978;8595.312375009858;9783.461909594756;10037.34757240777;10085.243606729378;10107.140893023881;10121.645742398981;9610.087041731025;10281.84577231357;10583.94708026455;10589.52347144365;10650.8934910653;7250.41996640257;7563.432742544442;7863.3316168124065;8373.49759014461;8568.386642073978;8720.912790872264;8734.781630459289;8738.781530461789;8781.824363512822;8799.076097009722;7534.623268836646;7691.1155217150745;7722.845543088994;7724.150343462327;7826.139124696393;7471.028766260569;7525.397968162643;7543.019407477213;7576.810579735551;7673.271039251262;8043.83912321762;8158.306543943594;8161.551114688749;8220.671173153007;8229.25936665703;7329.083864516935;7366.152892417441;7415.703371865065;7436.96281518589;7442.404607631484;7417.147028091838;7493.475456717977;7505.774826755206;7506.9249307506225;7507.399408047234 14:52:14 INFO - PROCESS | 1660 | |4;prototype.html;333.9197695455203;339.8742465287844;340.35672578826006;344.7242206235012;345.6353547007906;5713.257276554047;6768.221654509733;6910.447164226863;6962.756303529378;7000.859982800341;5493.670379777216;5971.701414929247;6451.483881289498;6834.384905358516;6916.861662766742;4178.582141785828;4864.294677271793;4982.177940639808;5092.694438333693;5149.871253218662;3965.8413663453425;4166.791660416982;5145.093022442326;5167.509086636764;5176.404713457963;5071.847844564669;5079.974600126994;5090.211017292326;5090.236464530313;5109.540141387274;5081.415637201713;5087.414947281073;5111.974440127813;5126.974365128188;5136.691798492103;4388.407564978751;4396.8021439035;4397.824087036514;4402.603765661074;4403.713758605681;6272.1219029335925;6612.6693665317025;6614.5039122065555;6642.468602511787;6647.3020332864835;5813.651180929115;5871.2073870027425;5879.176915231871;5886.6468011919;5891.91162132564;6005.669688167149;7306.671199796022;7323.12122545298;7357.484976051678;7364.963175184143;4708.176069187913;4710.552497512731;4718.221493453576;4727.929081063787;4737.265723812815;6191.442770150663;7361.4110871130715;7592.696292148307;7627.237276272328;7640.422491581121;4583.2666773316105;4643.698159619614;4722.386089808303;4731.645126615517;4743.95256047442;4780.77693872351;4830.686005409637;4831.613470922318;4831.98528309059;4836.008618233324;5763.337216220189;5770.307563092372;5770.451807078405;5781.4218578141845;5805.941940580625;7195.676194571257;7199;7205.963970180115;7209.459290553229;7216.422686185093;1679.3366620184959;1703.1228917107699;1704.3267909175806;1704.735765956254;1709.5555155659617;1026.0047753679069;1067.80779459698;1072.4369705904307;1078.2883297023927;1086.5277548921256;6726.630035348005;6806.897896531556;6816.420604248595;6819.522633415613;6869.210040845367;6274.811755647338;7179.1026121734785;7341.879701127;7521.210272921265;7628.923710762932;6639.834004149839;6856.280090590516;6863.38229559342;6866.759663411856;6899.241083480813;4007.699422543321;4035.7780322082567;4036.5156181258435;4053.108316170438;4058.6753059755147;6233.781817636361;7625.618719064025;7975.680972761141;7977.920220797834;7993.360531157494;6013.338532761392;6733.3266673333255;7495.613311537383;7894.447388682737;7967.123616402191;6970.965145174242;7931.4844535103875;7967.920320796834;7975.042994840656;7988.360931125496;7650.387968962358;7662.310392064518;7671.194524574839;7676.923230767621;7714.305712485903;7492.438067144877;7503.137139229058;7508.436867235088;7510.211427800003;7515;6161.784337548164;7975.960120199362;7984;8017.5991200438575;8029.07665618438;4755.500672429345;4780.760961951819;4811.08589368019;4817.855464335936;4827.589654879234;7634.274743899321;7641.083070031632;7648.732294369893;7682.0397450318715;7695.268949449794;7334.743283985035;7356.117265928123;7361.411087113125;7376.7786966391095;7383.043493474341;7112.751053713096;7343.466504056092;7353.654087390118;7390.482666213314;7415.962920185365;7140.571565706075;7150.64246787669;7183;7187.460940429593;7200.351968322876;7341.559506429631;7368.4842061055215;7374.410047196104;7382.704691812482;7395.519291246052;6177.042558403455;6889.207741109836;6935.445164386938;7155.212926578176;7184.281571842774 14:52:14 INFO - PROCESS | 1660 | |5;yui.html;731.1482123326325;736.5065406177858;757.5454727163702;765.5980610179656;772.8531578999994;14968.625784355383;15101.546953591409;15193;15198.392064317442;15216.69566608667;16272.674546509063;16605.33578656852;16611.750823737624;16623.168841557905;16632.584185395343;766.4022062791004;860.1183786618734;876.408424313589;927.1701826864952;979.8873129590118;939.4973689076346;974.8586454964026;977.2719324103552;978.1245785022436;979.2802290316612;1041.1410586266322;1042.5100202904623;1047.010575006619;1047.3454091193005;1048.266213650444;960.4621412009262;1000.3847633705292;1002.2983911262073;1026.1995643398086;1033.1166852341253;743.35699619829;755.0486387152228;757.3524636435823;768.0476209500235;774.1020416317101;15668;15688.215589220608;16033.198340082949;16102.194890255558;16130.919345403316;12880.677983050406;12916.225026498347;12967.610971670865;13061.542846000344;13080.607581772561;8335.274727998227;10181.269184238623;10402.583896644124;10425.113865321457;10475.371477711362;3456.015035714809;3512.2624248907505;3516.613172551017;3518.700910422617;3576.4635304704243;83605.3278934424;84268.15731842665;84325;84507.73238401429;85618;9547.140757331874;9554.426734395958;9622.47076410804;9721.951390243003;9739.951300243454;21962;22019.11923523041;22090.0059497323;22126.778732212795;22295.773732444548;7464;7588.27911348421;7745.148033716287;7859.842803143905;7953.164917683675;4118.073433477503;4173.812178451977;4185.727927684691;4214.620684138442;4407.052483715952;3145.4495463293833;3671.742977991515;3720.795356255432;3743.513343265358;3775.075106598846;589.1604463639297;606.6723969056749;607.0681503891506;607.4259824465837;607.9483243924227;410.9876703698894;472.518031607765;600.6066026752484;610.8289678889918;628.9119822706743;8264.793380165544;8528.488290702579;8646.135386461303;8685.565721714016;8831.514266715392;597.1813042439678;600.3366280260336;603.1736520966217;604.5919004671829;625.2340882419;3596.3346780845627;3611.7291203159866;3955.92088158241;3992.8003599819895;4121.175764847043;93963;94498;98374;98599;98866.50566747264;79028.60485697535;80169.59915200503;82644;83083.33000439362;84932;72524.63737681383;72930;73109;73586.63206683932;74429.62785186147;7726.343260822893;7936.960315198387;7976.84046319082;8057.83884322322;8071.677132914852;51077.978440431725;52543;52702;53343.199852001475;53435.732821335645;68884.6555767218;74202;75440;75786.62106689431;75955.62022189854;8210.220029097227;8284.420090593841;10054.44700541448;10096.747581310527;10101.898981010096;9943.552540135566;11117.3329600221;12060.336681482602;12113.818292725793;12686.302253375783;11534.019608333385;11726.824097638371;11750.94124529372;11782.941085294862;11893.76212475763;11239.438028098399;11614;11701.488982718833;11898.04815614766;12047.216930899815;10010.549525271235;11725.941370293094;11728.94135529317;11750.70623234426;11926.463309151282;9847.409155450696;9905.356151850106;9909.702708918743;10050.894401615962;10066.094051535398;9932.503374831374;9935.552900119368;9954.402735835873;9976.20190384782;10167.237457190888 14:52:14 INFO - PROCESS | 1660 | __end_tp_report 14:52:14 INFO - PROCESS | 1660 | __start_cc_report 14:52:14 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,369 14:52:14 INFO - PROCESS | 1660 | __end_cc_report 14:52:14 INFO - PROCESS | 1660 | __startTimestamp1461016334630__endTimestamp 14:52:14 INFO - PROCESS | 1660 | 14:52:14 INFO - PROCESS | 1660 | ------- Summary: start ------- 14:52:14 INFO - PROCESS | 1660 | Number of tests: 6 14:52:14 INFO - PROCESS | 1660 | 14:52:14 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5790.96 Median:5994.10 stddev:653.93 (10.9%) stddev-sans-first:618.44 14:52:14 INFO - PROCESS | 1660 | Values: 3008.7 3536.7 3557.3 3573.2 3623.7 5347.7 5865.7 5871.7 5883.3 5892.5 5863.1 5870.4 5943.9 5946.1 5973.8 5271.8 5357.8 5379.1 5401.9 5415.6 5290.0 5384.6 5401.7 5407.4 5429.1 5283.2 5367.6 5398.3 5410.3 5418.1 5350.2 5430.0 5457.8 5462.1 5486.3 5277.1 5333.2 5349.5 5351.0 5402.9 4683.9 4899.3 5621.7 5788.9 5861.0 4915.4 5782.3 6236.8 6269.6 6272.7 6284.7 6304.1 6305.2 6320.1 6320.7 5880.8 5994.1 6074.6 6080.6 6082.1 6348.0 6425.6 6436.7 6443.4 6455.6 6118.6 6299.9 6307.2 6324.6 6348.3 5136.3 6283.9 6297.0 6297.8 6298.6 6250.4 6293.7 6293.7 6298.7 6311.5 6181.7 6267.3 6279.8 6288.6 6328.1 4969.3 4978.5 4998.9 4999.5 5030.3 4508.2 4522.1 4541.0 4547.7 4563.1 5258.2 5914.5 5958.6 5979.9 6016.6 6223.8 6230.5 6293.3 6312.1 6320.0 4824.3 5822.8 5862.0 5899.1 5918.2 5056.0 5193.6 5433.8 5435.2 5435.9 5891.1 6097.8 6448.2 6486.0 6517.3 4717.8 6197.2 6287.1 6294.1 6341.3 5785.8 5868.9 6348.7 6490.9 6499.4 5862.7 5959.7 6257.5 6314.2 6320.1 5632.8 6269.8 6310.9 6321.8 6377.4 6111.5 6170.1 6189.4 6234.1 6268.3 6235.6 6253.7 6267.0 6271.5 6275.2 6009.6 6129.0 6157.8 6193.3 6199.1 6108.5 6120.6 6201.9 6252.9 6264.1 5287.4 5972.1 6150.3 6170.2 6202.3 14:52:14 INFO - PROCESS | 1660 | 14:52:14 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:58810.64 Median:38826.53 stddev:116751.87 (300.7%) stddev-sans-first:116997.19 14:52:14 INFO - PROCESS | 1660 | Values: 462.4 532.7 591.6 614.1 662.4 38032.0 38847.6 38856.8 38889.4 38954.0 40200.2 40231.2 40449.4 40610.8 40959.0 9566.2 9644.3 9810.1 9812.3 9836.2 8873.9 9736.2 9744.5 9762.9 9766.3 9667.7 9783.8 9787.3 9789.7 9840.3 9011.5 9242.8 9641.2 9760.4 9771.3 9610.5 9646.3 9702.0 9716.7 9733.6 32377.7 33190.5 39300.8 39592.8 40003.8 3008.6 3225.6 3228.5 3321.4 3330.6 27355.5 27500.0 27544.9 27840.8 28012.4 2640.4 2644.5 2669.7 2684.3 2708.8 342830.0 343519.0 343653.0 344117.0 413132.9 48265.0 62826.7 63303.1 63608.7 63760.7 47425.1 47606.5 47613.0 47615.0 47681.5 16655.8 16883.7 17050.8 17103.7 17140.0 13325.7 13481.5 13498.3 13592.7 13603.9 13153.7 14690.3 15162.2 15575.0 15660.8 6541.1 6632.4 6653.6 6656.3 6664.1 992.1 1030.2 1051.1 1070.8 1152.1 29205.4 29986.7 30227.9 30637.8 30781.8 1104.5 1111.7 1171.7 1187.6 1268.0 11435.1 15531.3 15533.8 15652.2 15823.4 477248.0 478705.0 486014.0 486449.0 490090.0 61899.4 61963.7 62233.0 62774.4 62996.7 1528.7 1531.2 1561.2 1566.5 1578.3 29791.0 29792.4 29894.9 30415.0 30494.8 52787.5 53458.7 53564.0 53655.0 54131.5 466221.0 466237.0 469235.0 469465.0 469708.0 34285.1 34916.7 34965.0 45351.9 46278.0 43989.8 44025.6 44713.8 45265.3 45799.3 38154.0 38328.2 38805.4 39103.2 39362.6 30944.4 37424.3 37775.4 37882.1 38025.8 34044.7 38563.2 38641.0 38751.6 40007.0 31391.1 32531.5 32572.7 32752.0 32867.8 24991.4 25051.0 25307.9 25450.2 25635.5 14:52:14 INFO - PROCESS | 1660 | 14:52:14 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:35149.92 Median:26056.17 stddev:104427.99 (400.8%) stddev-sans-first:104688.21 14:52:14 INFO - PROCESS | 1660 | Values: 330.5 353.3 368.6 380.8 384.0 20359.6 20478.7 20908.3 21481.6 21488.2 21282.0 21574.9 21808.6 21966.9 22223.4 5804.0 6036.4 6077.1 6079.0 6079.6 5597.4 5782.2 5832.8 5870.6 5942.2 5831.8 5872.9 5881.4 5891.4 5898.5 4483.1 5104.0 5828.3 5902.8 5938.1 4353.2 5046.2 5143.0 5158.7 5168.4 21306.9 25939.7 26172.6 26260.5 26764.2 2311.5 2451.9 2552.2 2751.6 2920.6 15019.0 15034.2 15352.6 15471.8 15485.0 1733.2 1747.8 1770.4 1814.5 1887.6 98477.6 100043.0 100241.0 103288.5 103967.0 11474.3 11627.9 11732.8 11777.5 11819.7 13955.2 14469.4 14474.5 14576.3 14594.0 6921.0 8101.0 8764.8 8982.9 9063.6 9244.7 9345.2 9427.7 9451.6 9492.3 3794.8 4317.6 4357.2 4481.0 4645.8 1935.3 1968.9 1969.4 1985.1 2001.3 907.8 951.8 1002.0 1075.5 1130.7 20138.3 20474.7 20535.3 20907.0 21219.4 1009.9 1010.8 1017.7 1058.3 1081.9 8899.9 9288.8 9501.0 10761.5 10921.6 605287.0 622969.0 633402.0 648290.0 648594.0 77278.0 102293.5 122184.0 122533.0 123212.0 935.0 990.5 990.7 1034.1 1042.3 17809.7 18270.6 18386.0 18504.5 18753.4 53787.0 53869.0 54546.0 54919.7 55002.0 73348.3 74311.3 78096.2 78461.8 79341.0 7629.1 8074.8 8120.4 8195.8 8500.6 11198.8 13173.1 13555.0 13588.3 13633.7 9975.8 11579.8 11742.2 11909.3 11987.0 11425.8 11559.5 11602.2 11653.9 11841.9 6025.5 9817.5 11965.3 11995.7 12106.2 7805.0 8258.3 8366.9 8513.4 8719.2 9930.0 10593.8 10742.1 10795.5 11558.5 14:52:14 INFO - PROCESS | 1660 | 14:52:14 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:6378.90 Median:5211.16 stddev:3400.70 (65.3%) stddev-sans-first:3391.11 14:52:14 INFO - PROCESS | 1660 | Values: 1579.1 1600.2 1936.2 2055.4 2070.8 8555.0 9002.3 9236.8 9454.4 9458.2 9149.5 9181.4 9241.9 9247.2 9298.1 2563.5 2566.4 2580.6 2608.6 2608.9 2517.4 2589.6 2589.8 2591.7 2600.5 2312.9 2443.3 2546.6 2608.6 2618.5 2268.3 2579.1 2605.6 2605.9 2613.2 2575.7 2576.4 2578.7 2580.7 2603.8 9342.3 9370.8 9408.2 9450.8 9451.1 5783.3 5802.3 5892.6 5965.4 5980.1 3604.1 3648.8 3733.3 3757.5 3800.1 1032.8 1052.0 1062.1 1069.2 1069.8 11023.1 12578.2 12695.9 12732.0 12762.1 4371.5 4964.5 5142.3 5202.4 5219.9 10933.7 10935.7 10944.5 10968.4 11005.0 5755.3 5756.5 5827.8 5889.2 5901.3 4269.9 4629.7 5093.2 5141.0 5194.8 4078.1 4124.7 4162.6 4190.3 4205.7 1370.8 1389.0 1389.1 1391.3 1398.2 1406.7 1409.5 1433.7 1443.7 1460.1 7522.9 8565.5 8601.7 8675.1 8686.3 530.6 534.4 536.1 538.8 547.3 6375.6 6386.5 6394.1 6473.8 6480.9 9879.7 11208.8 11589.5 11698.4 11739.2 10894.8 11260.5 11304.5 11396.7 11540.5 8716.6 8863.6 8868.4 8926.6 8956.4 8451.9 8501.2 8544.6 8577.7 8595.3 9783.5 10037.3 10085.2 10107.1 10121.6 9610.1 10281.8 10583.9 10589.5 10650.9 7250.4 7563.4 7863.3 8373.5 8568.4 8720.9 8734.8 8738.8 8781.8 8799.1 7534.6 7691.1 7722.8 7724.2 7826.1 7471.0 7525.4 7543.0 7576.8 7673.3 8043.8 8158.3 8161.6 8220.7 8229.3 7329.1 7366.2 7415.7 7437.0 7442.4 7417.1 7493.5 7505.8 7506.9 7507.4 14:52:14 INFO - PROCESS | 1660 | 14:52:14 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:5918.28 Median:6644.89 stddev:1895.03 (28.5%) stddev-sans-first:1853.41 14:52:14 INFO - PROCESS | 1660 | Values: 333.9 339.9 340.4 344.7 345.6 5713.3 6768.2 6910.4 6962.8 7000.9 5493.7 5971.7 6451.5 6834.4 6916.9 4178.6 4864.3 4982.2 5092.7 5149.9 3965.8 4166.8 5145.1 5167.5 5176.4 5071.8 5080.0 5090.2 5090.2 5109.5 5081.4 5087.4 5112.0 5127.0 5136.7 4388.4 4396.8 4397.8 4402.6 4403.7 6272.1 6612.7 6614.5 6642.5 6647.3 5813.7 5871.2 5879.2 5886.6 5891.9 6005.7 7306.7 7323.1 7357.5 7365.0 4708.2 4710.6 4718.2 4727.9 4737.3 6191.4 7361.4 7592.7 7627.2 7640.4 4583.3 4643.7 4722.4 4731.6 4744.0 4780.8 4830.7 4831.6 4832.0 4836.0 5763.3 5770.3 5770.5 5781.4 5805.9 7195.7 7199.0 7206.0 7209.5 7216.4 1679.3 1703.1 1704.3 1704.7 1709.6 1026.0 1067.8 1072.4 1078.3 1086.5 6726.6 6806.9 6816.4 6819.5 6869.2 6274.8 7179.1 7341.9 7521.2 7628.9 6639.8 6856.3 6863.4 6866.8 6899.2 4007.7 4035.8 4036.5 4053.1 4058.7 6233.8 7625.6 7975.7 7977.9 7993.4 6013.3 6733.3 7495.6 7894.4 7967.1 6971.0 7931.5 7967.9 7975.0 7988.4 7650.4 7662.3 7671.2 7676.9 7714.3 7492.4 7503.1 7508.4 7510.2 7515.0 6161.8 7976.0 7984.0 8017.6 8029.1 4755.5 4780.8 4811.1 4817.9 4827.6 7634.3 7641.1 7648.7 7682.0 7695.3 7334.7 7356.1 7361.4 7376.8 7383.0 7112.8 7343.5 7353.7 7390.5 7416.0 7140.6 7150.6 7183.0 7187.5 7200.4 7341.6 7368.5 7374.4 7382.7 7395.5 6177.0 6889.2 6935.4 7155.2 7184.3 14:52:14 INFO - PROCESS | 1660 | 14:52:14 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:19110.13 Median:593.17 stddev:27171.00 (4580.6%) stddev-sans-first:27212.18 14:52:14 INFO - PROCESS | 1660 | Values: 731.1 736.5 757.5 765.6 772.9 14968.6 15101.5 15193.0 15198.4 15216.7 16272.7 16605.3 16611.8 16623.2 16632.6 766.4 860.1 876.4 927.2 979.9 939.5 974.9 977.3 978.1 979.3 1041.1 1042.5 1047.0 1047.3 1048.3 960.5 1000.4 1002.3 1026.2 1033.1 743.4 755.0 757.4 768.0 774.1 15668.0 15688.2 16033.2 16102.2 16130.9 12880.7 12916.2 12967.6 13061.5 13080.6 8335.3 10181.3 10402.6 10425.1 10475.4 3456.0 3512.3 3516.6 3518.7 3576.5 83605.3 84268.2 84325.0 84507.7 85618.0 9547.1 9554.4 9622.5 9722.0 9740.0 21962.0 22019.1 22090.0 22126.8 22295.8 7464.0 7588.3 7745.1 7859.8 7953.2 4118.1 4173.8 4185.7 4214.6 4407.1 3145.4 3671.7 3720.8 3743.5 3775.1 589.2 606.7 607.1 607.4 607.9 411.0 472.5 600.6 610.8 628.9 8264.8 8528.5 8646.1 8685.6 8831.5 597.2 600.3 603.2 604.6 625.2 3596.3 3611.7 3955.9 3992.8 4121.2 93963.0 94498.0 98374.0 98599.0 98866.5 79028.6 80169.6 82644.0 83083.3 84932.0 72524.6 72930.0 73109.0 73586.6 74429.6 7726.3 7937.0 7976.8 8057.8 8071.7 51078.0 52543.0 52702.0 53343.2 53435.7 68884.7 74202.0 75440.0 75786.6 75955.6 8210.2 8284.4 10054.4 10096.7 10101.9 9943.6 11117.3 12060.3 12113.8 12686.3 11534.0 11726.8 11750.9 11782.9 11893.8 11239.4 11614.0 11701.5 11898.0 12047.2 10010.5 11725.9 11728.9 11750.7 11926.5 9847.4 9905.4 9909.7 10050.9 10066.1 9932.5 9935.6 9954.4 9976.2 10167.2 14:52:14 INFO - PROCESS | 1660 | -------- Summary: end -------- 14:52:14 INFO - PROCESS | 1660 | 14:52:15 INFO - TEST-INFO | 1660: exit 0 14:52:15 INFO - TEST-OK | dromaeo_css | took 1111245ms 14:52:15 INFO - TEST-START | kraken 14:52:15 INFO - operating with platform_type : mac_ 14:52:15 INFO - Initialising browser for kraken test... 14:52:15 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmp5bXmRZ/profile http://localhost:49283/getInfo.html) 14:52:18 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 14:52:18 INFO - PROCESS | 1672 | colorDepth:24 14:52:18 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 14:52:18 INFO - PROCESS | 1672 | __metrics 14:52:18 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 14:52:18 INFO - TEST-INFO | 1672: exit 0 14:52:18 INFO - Browser initialized. 14:52:18 INFO - Running cycle 1/1 for kraken test... 14:52:18 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmp5bXmRZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:52:30 INFO - PROCESS | 1675 | RSS: Main: 217956352 14:52:30 INFO - PROCESS | 1675 | 14:52:33 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection) 14:52:33 INFO - PROCESS | 1675 | RSS: Main: 229961728 14:52:33 INFO - PROCESS | 1675 | 14:52:36 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-dft) 14:52:37 INFO - PROCESS | 1675 | RSS: Main: 238948352 14:52:37 INFO - PROCESS | 1675 | 14:52:40 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-fft) 14:52:41 INFO - PROCESS | 1675 | RSS: Main: 242946048 14:52:41 INFO - PROCESS | 1675 | 14:52:43 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator) 14:52:43 INFO - PROCESS | 1675 | RSS: Main: 242741248 14:52:43 INFO - PROCESS | 1675 | 14:52:45 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:52:46 INFO - PROCESS | 1675 | RSS: Main: 244539392 14:52:46 INFO - PROCESS | 1675 | 14:52:49 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom) 14:52:49 INFO - PROCESS | 1675 | RSS: Main: 244727808 14:52:49 INFO - PROCESS | 1675 | 14:52:52 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate) 14:52:53 INFO - PROCESS | 1675 | RSS: Main: 244543488 14:52:53 INFO - PROCESS | 1675 | 14:52:56 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial) 14:52:56 INFO - PROCESS | 1675 | RSS: Main: 244379648 14:52:56 INFO - PROCESS | 1675 | 14:52:58 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:52:58 INFO - PROCESS | 1675 | RSS: Main: 244699136 14:52:58 INFO - PROCESS | 1675 | 14:53:00 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:53:01 INFO - PROCESS | 1675 | RSS: Main: 244609024 14:53:01 INFO - PROCESS | 1675 | 14:53:03 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:53:04 INFO - PROCESS | 1675 | RSS: Main: 244695040 14:53:04 INFO - PROCESS | 1675 | 14:53:06 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:53:07 INFO - PROCESS | 1675 | RSS: Main: 244781056 14:53:07 INFO - PROCESS | 1675 | 14:53:09 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:53:10 INFO - PROCESS | 1675 | RSS: Main: 244867072 14:53:10 INFO - PROCESS | 1675 | 14:53:12 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49283/tests/kraken/driver.html?testName=ai-astar) 14:53:12 INFO - PROCESS | 1675 | RSS: Main: 246521856 14:53:12 INFO - PROCESS | 1675 | 14:53:12 INFO - PROCESS | 1675 | __start_tp_report 14:53:12 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 14:53:12 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 14:53:12 INFO - PROCESS | 1675 | |i|pagename|runs| 14:53:12 INFO - PROCESS | 1675 | |0;ai-astar;116;113;116;115;116;129;115;114;116;114 14:53:12 INFO - PROCESS | 1675 | |1;audio-beat-detection;149;120;151;193;148;140;120;159;148;118 14:53:12 INFO - PROCESS | 1675 | |2;audio-dft;202;197;200;201;220;214;198;199;223;266 14:53:12 INFO - PROCESS | 1675 | |3;audio-fft;63;76;73;102;47;46;71;77;157;87 14:53:12 INFO - PROCESS | 1675 | |4;audio-oscillator;86;85;120;80;77;81;118;80;80;120 14:53:12 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;92;87;108;117;92;92;124;88;91;87 14:53:12 INFO - PROCESS | 1675 | |6;imaging-darkroom;97;96;96;133;95;102;137;96;95;102 14:53:12 INFO - PROCESS | 1675 | |7;imaging-desaturate;93;93;91;92;96;92;91;103;90;112 14:53:12 INFO - PROCESS | 1675 | |8;json-parse-financial;56;61;70;88;92;86;60;68;60;56 14:53:12 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;94;102;71;64;71;68;68;65;65;66 14:53:12 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;83;82;82;84;82;84;80;82;83;84 14:53:12 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;120;136;140;131;143;124;121;121;144;136 14:53:12 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;156;135;136;134;133;138;136;180;142;110 14:53:12 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;67;68;64;71;67;65;64;68;68;66 14:53:12 INFO - PROCESS | 1675 | __end_tp_report 14:53:12 INFO - PROCESS | 1675 | __start_cc_report 14:53:12 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,938 14:53:12 INFO - PROCESS | 1675 | __end_cc_report 14:53:12 INFO - PROCESS | 1675 | __startTimestamp1461016392424__endTimestamp 14:53:12 INFO - PROCESS | 1675 | 14:53:12 INFO - PROCESS | 1675 | ------- Summary: start ------- 14:53:12 INFO - PROCESS | 1675 | Number of tests: 14 14:53:12 INFO - PROCESS | 1675 | 14:53:12 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:116.40 Median:116.00 stddev:4.55 (3.9%) stddev-sans-first:4.82 14:53:12 INFO - PROCESS | 1675 | Values: 116.0 113.0 116.0 115.0 116.0 129.0 115.0 114.0 116.0 114.0 14:53:12 INFO - PROCESS | 1675 | 14:53:12 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:148.50 stddev:22.54 (15.2%) stddev-sans-first:23.85 14:53:12 INFO - PROCESS | 1675 | Values: 149.0 120.0 151.0 193.0 148.0 140.0 120.0 159.0 148.0 118.0 14:53:12 INFO - PROCESS | 1675 | 14:53:12 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:212.00 Median:208.00 stddev:21.24 (10.2%) stddev-sans-first:22.22 14:53:12 INFO - PROCESS | 1675 | Values: 202.0 197.0 200.0 201.0 220.0 214.0 198.0 199.0 223.0 266.0 14:53:12 INFO - PROCESS | 1675 | 14:53:12 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:79.90 Median:72.00 stddev:31.89 (44.3%) stddev-sans-first:33.23 14:53:12 INFO - PROCESS | 1675 | Values: 63.0 76.0 73.0 102.0 47.0 46.0 71.0 77.0 157.0 87.0 14:53:12 INFO - PROCESS | 1675 | 14:53:12 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:80.00 stddev:18.57 (23.2%) stddev-sans-first:19.53 14:53:12 INFO - PROCESS | 1675 | Values: 86.0 85.0 120.0 80.0 77.0 81.0 118.0 80.0 80.0 120.0 14:53:12 INFO - PROCESS | 1675 | 14:53:12 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:97.80 Median:89.50 stddev:13.48 (15.1%) stddev-sans-first:14.13 14:53:12 INFO - PROCESS | 1675 | Values: 92.0 87.0 108.0 117.0 92.0 92.0 124.0 88.0 91.0 87.0 14:53:12 INFO - PROCESS | 1675 | 14:53:12 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:104.90 Median:95.50 stddev:16.10 (16.9%) stddev-sans-first:16.82 14:53:12 INFO - PROCESS | 1675 | Values: 97.0 96.0 96.0 133.0 95.0 102.0 137.0 96.0 95.0 102.0 14:53:12 INFO - PROCESS | 1675 | 14:53:12 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:92.00 stddev:6.96 (7.6%) stddev-sans-first:7.33 14:53:12 INFO - PROCESS | 1675 | Values: 93.0 93.0 91.0 92.0 96.0 92.0 91.0 103.0 90.0 112.0 14:53:12 INFO - PROCESS | 1675 | 14:53:12 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:69.70 Median:69.00 stddev:13.90 (20.2%) stddev-sans-first:13.84 14:53:12 INFO - PROCESS | 1675 | Values: 56.0 61.0 70.0 88.0 92.0 86.0 60.0 68.0 60.0 56.0 14:53:12 INFO - PROCESS | 1675 | 14:53:12 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:73.40 Median:68.00 stddev:13.32 (19.6%) stddev-sans-first:11.86 14:53:12 INFO - PROCESS | 1675 | Values: 94.0 102.0 71.0 64.0 71.0 68.0 68.0 65.0 65.0 66.0 14:53:12 INFO - PROCESS | 1675 | 14:53:12 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:1.26 (1.5%) stddev-sans-first:1.33 14:53:12 INFO - PROCESS | 1675 | Values: 83.0 82.0 82.0 84.0 82.0 84.0 80.0 82.0 83.0 84.0 14:53:12 INFO - PROCESS | 1675 | 14:53:12 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:136.00 stddev:9.49 (7.0%) stddev-sans-first:9.09 14:53:12 INFO - PROCESS | 1675 | Values: 120.0 136.0 140.0 131.0 143.0 124.0 121.0 121.0 144.0 136.0 14:53:12 INFO - PROCESS | 1675 | 14:53:12 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.00 Median:137.00 stddev:17.97 (13.1%) stddev-sans-first:18.10 14:53:12 INFO - PROCESS | 1675 | Values: 156.0 135.0 136.0 134.0 133.0 138.0 136.0 180.0 142.0 110.0 14:53:12 INFO - PROCESS | 1675 | 14:53:12 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.50 stddev:2.15 (3.2%) stddev-sans-first:2.28 14:53:12 INFO - PROCESS | 1675 | Values: 67.0 68.0 64.0 71.0 67.0 65.0 64.0 68.0 68.0 66.0 14:53:12 INFO - PROCESS | 1675 | -------- Summary: end -------- 14:53:12 INFO - PROCESS | 1675 | 14:53:13 INFO - TEST-INFO | 1675: exit 0 14:53:13 INFO - TEST-OK | kraken | took 58187ms 14:53:13 INFO - SUITE-END | took 1169s 14:53:13 INFO - Completed test suite (00:19:29) 14:53:13 INFO - javascript benchmark 14:53:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3008.684088170742, 3536.664016918392, 3557.252976874857, 3573.231755172639, 3623.710103191745, 5347.679139251648, 5865.706714664266, 5871.735771890275, 5883.294004719434, 5892.499137573301, 5863.1205319202145, 5870.383609720981, 5943.910841337372, 5946.137810017545, 5973.820785376446, 5271.815486457975, 5357.812476563321, 5379.085555455563, 5401.918971215416, 5415.593830462731, 5289.973550132244, 5384.623076384654, 5401.675899446026, 5407.405185429599, 5429.077056900336, 5283.154695248761, 5367.570594352443, 5398.271233383502, 5410.269613602172, 5418.078926582491, 5350.197470379455, 5430.0, 5457.808976685837, 5462.126059830408, 5486.341639003305, 5277.076511610491, 5333.2000199969925, 5349.465053494659, 5351.030178251069, 5402.91895621566, 4683.929741053853, 4899.314096026559, 5621.718914054321, 5788.855278618026, 5861.032929566616, 4915.3855768029, 5782.306123265193, 6236.812895613093, 6269.592476489013, 6272.717727702265, 6284.748610055638, 6304.117423560705, 6305.211848518935, 6320.146780184708, 6320.71556779946, 5880.8235752927485, 5994.100884867261, 6074.635521868702, 6080.6351618903445, 6082.057281121433, 6348.0, 6425.646589437626, 6436.742530298736, 6443.420092191725, 6455.61266324022, 6118.6191791732535, 6299.905501417483, 6307.2431308242385, 6324.620522768557, 6348.301686814447, 5136.332276804066, 6283.905741413882, 6296.968515157487, 6297.811065668037, 6298.622082675054, 6250.406211409909, 6293.653849038255, 6293.748250069946, 6298.716557754912, 6311.463525600376, 6181.690915454209, 6267.341929097471, 6279.811605651837, 6288.591241569375, 6328.11406403104, 4969.304297398367, 4978.477259887732, 4998.90002199954, 4999.475055119233, 5030.320906677625, 4508.211063063951, 4522.140793249272, 4540.977295113504, 4547.7498737569085, 4563.087382523442, 5258.158694608921, 5914.497267732291, 5958.553108516879, 5979.9402005980255, 6016.608920420159, 6223.782167624111, 6230.470410015108, 6293.30773614902, 6312.147860038836, 6320.0, 4824.252240902666, 5822.796202132905, 5862.0, 5899.112284069057, 5918.171455996164, 5055.963527476858, 5193.636445448858, 5433.782648694087, 5435.211894275308, 5435.864103397446, 5891.086881533369, 6097.7865774697675, 6448.193975753031, 6486.027095935553, 6517.315681853432, 4717.811287548459, 6197.163382943245, 6287.119803227643, 6294.087357333253, 6341.270753863365, 5785.8139081489035, 5868.853278667897, 6348.650824204713, 6490.935090649033, 6499.447546958561, 5862.736176872137, 5959.67221802805, 6257.499400047895, 6314.179156709598, 6320.051992201206, 5632.788950375689, 6269.843253918506, 6310.873782524232, 6321.778737744157, 6377.362263773585, 6111.5110791137495, 6170.136180934763, 6189.35011823752, 6234.127222188807, 6268.279147897868, 6235.594686345373, 6253.656048917172, 6266.968665156645, 6271.498280137669, 6275.152854364603, 6009.639421634716, 6128.9693551531955, 6157.84605384869, 6193.318734939243, 6199.1011303359855, 6108.511319094373, 6120.569035656853, 6201.875962480815, 6252.874942501216, 6264.060390941395, 5287.418383977836, 5972.074328479092, 6150.323464418821, 6170.197874276315, 6202.28673702512], "unit": "score", "name": "dojo.html", "value": 5753.286780227909}, {"lowerIsBetter": false, "replicates": [462.40580853603103, 532.7042349986683, 591.6213623281101, 614.0574218574484, 662.443547420167, 38032.0, 38847.611523884785, 38856.80571597145, 38889.41665875014, 38954.02614934628, 40200.19599608006, 40231.19537609246, 40449.39325910114, 40610.7969460153, 40959.0, 9566.234701223902, 9644.324897257195, 9810.068043535888, 9812.264080193978, 9836.163926066292, 8873.911260887373, 9736.172425343855, 9744.464054477, 9762.853557196648, 9766.316357854954, 9667.70996870095, 9783.755406114833, 9787.314887957846, 9789.706308810712, 9840.311178217527, 9011.549422528913, 9242.768930776718, 9641.180499657537, 9760.414375137514, 9771.316007879452, 9610.51947402627, 9646.324757266993, 9702.029797020312, 9716.659916902874, 9733.56198971048, 32377.6762232377, 33190.502142467885, 39300.803495982625, 39592.802035989924, 40003.7999810002, 3008.608880845498, 3225.59680039995, 3228.515722641599, 3321.4021476134285, 3330.5670262865915, 27355.45289094227, 27500.0, 27544.898204072015, 27840.841436792933, 28012.439751205067, 2640.405908670553, 2644.5239856825765, 2669.6529451171223, 2684.3154995476225, 2708.769754570864, 342830.0, 343519.0, 343653.0, 344117.0, 413132.86867131246, 48265.0, 62826.68586657038, 63303.050454243225, 63608.72782544323, 63760.68119659372, 47425.05149896983, 47606.5239347609, 47613.0, 47615.0, 47681.523184768404, 16655.83344166567, 16883.746743798853, 17050.829491704924, 17103.74344384835, 17140.0, 13325.66685832862, 13481.460741570423, 13498.257595832127, 13592.728145437035, 13603.931980340036, 13153.671158221121, 14690.26548672562, 15162.24188790578, 15575.0, 15660.843391566166, 6541.116949211795, 6632.436242919406, 6653.567518111307, 6656.334366563402, 6664.1336626239245, 992.1021475564481, 1030.1985672867097, 1051.138066785244, 1070.8393740938766, 1152.1013609384693, 29205.41589168205, 29986.700132998827, 30227.942022029125, 30637.84681076625, 30781.846090769403, 1104.5250542266901, 1111.655070442722, 1171.654361963206, 1187.566538213563, 1267.9683007924875, 11435.085193184525, 15531.301091450912, 15533.766993495106, 15652.217389130497, 15823.446179383667, 477248.0, 478705.0, 486014.0, 486449.0, 490090.0, 61899.38100619026, 61963.6901815488, 62233.0, 62774.37225627685, 62996.74006519936, 1528.6560523882038, 1531.1655147944398, 1561.2193903048476, 1566.451741890352, 1578.2976575424057, 29791.0, 29792.404151917275, 29894.85052574723, 30415.0, 30494.7802087914, 52787.47212527979, 53458.66353341042, 53564.0, 53655.0, 54131.45868541422, 466221.0, 466237.0, 469235.0, 469465.0, 469708.0, 34285.14287142841, 34916.65083349134, 34965.0, 45351.866203345184, 46278.0, 43989.78005109954, 44025.55974440215, 44713.776431117636, 45265.32102018538, 45799.31301030554, 38154.0, 38328.2334353317, 38805.4477820884, 39103.2179356417, 39362.606373935894, 30944.381112377177, 37424.25151497009, 37775.43336849895, 37882.0529486765, 38025.80987095047, 34044.65955340415, 38563.2287354257, 38641.0, 38751.6124838748, 40006.99982500344, 31391.05826825199, 32531.512027319135, 32572.674273256966, 32752.0, 32867.83566082154, 24991.375215619755, 25051.0, 25307.873460632578, 25450.236492905242, 25635.487290254463], "unit": "score", "name": "ext.html", "value": 19402.12382755183}, {"lowerIsBetter": false, "replicates": [330.5207449198663, 353.3322021379592, 368.5614119198154, 380.83624041662074, 383.96352346527107, 20359.592808143847, 20478.6928196077, 20908.26821061263, 21481.57036859262, 21488.247911323087, 21282.0, 21574.89212553939, 21808.563828723418, 21966.89016554915, 22223.44441388966, 5804.042333015058, 6036.426539478743, 6077.11881777142, 6079.0, 6079.604825686339, 5597.412271711472, 5782.161586569945, 5832.766689332421, 5870.647761134324, 5942.227510423639, 5831.766729330821, 5872.882542349151, 5881.441263080001, 5891.410858914096, 5898.469137777599, 4483.125790470859, 5103.974480127576, 5828.271466066742, 5902.793402230923, 5938.10928360745, 4353.216421044211, 5046.243063540462, 5142.971405718834, 5158.690478571298, 5168.3539557555305, 21306.89346553273, 25939.74060259392, 26172.607410888853, 26260.474790504275, 26764.19707408781, 2311.456807650201, 2451.889664965063, 2552.1960582416477, 2751.5872619107095, 2920.561915712639, 15019.02376345545, 15034.17312047837, 15352.616184595474, 15471.767923481044, 15484.993475424175, 1733.246037973473, 1747.790265168188, 1770.3980646580096, 1814.4738025972451, 1887.5658598522416, 98477.64462376063, 100043.0, 100240.9975900239, 103288.48355758173, 103967.0, 11474.254173478697, 11627.883721162849, 11732.824007639892, 11777.52889884395, 11819.704507387212, 13955.162690238618, 14469.421223151166, 14474.493392731203, 14576.344064517121, 14594.0, 6920.996455513922, 8101.0, 8764.824703505894, 8982.910170898207, 9063.59213835379, 9244.689809117044, 9345.158935695685, 9427.717168484956, 9451.621935122655, 9492.335536512377, 3794.8102594870697, 4317.589828966243, 4357.172137293967, 4481.0, 4645.767711614473, 1935.34198372554, 1968.9015549222481, 1969.3894892583346, 1985.106701984113, 2001.2895422125227, 907.8456662367413, 951.8096380723883, 1001.9799604008025, 1075.4817881122633, 1130.739929816147, 20138.295159669633, 20474.692879606817, 20535.28126515565, 20907.0, 21219.36341909745, 1009.9192064634811, 1010.7877345757327, 1017.659084206799, 1058.2539309786582, 1081.9404932728776, 8899.866502002475, 9288.7677808054, 9501.00239474859, 10761.515731792088, 10921.617743378943, 605287.0, 622969.0, 633402.0, 648290.0, 648594.0, 77278.0, 102293.48853255686, 122184.0, 122533.0, 123212.0, 934.9668616179024, 990.4651488196293, 990.6570959680304, 1034.0641719244097, 1042.2547878267076, 17809.73285400746, 18270.63458730791, 18386.0, 18504.537386565444, 18753.437396878115, 53787.0, 53869.0, 54546.0, 54919.725401372736, 55002.0, 73348.26651733414, 74311.2568874326, 78096.21903781117, 78461.8230726551, 79341.0, 7629.122650895218, 8074.757757267292, 8120.350371970347, 8195.754127376189, 8500.617472213642, 11198.776024479628, 13173.077884547989, 13555.0, 13588.320583970959, 13633.659158521117, 9975.800483990135, 11579.768404632028, 11742.17804753659, 11909.285442873108, 11987.0, 11425.771484570429, 11559.479823407799, 11602.18784685064, 11653.88346116528, 11841.881581184078, 6025.517958563392, 9817.509124543602, 11965.341906195243, 11995.700107497383, 12106.213096148722, 7804.9609751950875, 8258.339332853477, 8366.916330836857, 8513.446625969293, 8719.171678690514, 9930.0, 10593.788124237626, 10742.140628749525, 10795.460226988462, 11558.537658493566], "unit": "score", "name": "jquery.html", "value": 9652.84600271213}, {"lowerIsBetter": false, "replicates": [1579.0920220872997, 1600.2158942118358, 1936.1868015433517, 2055.445029841943, 2070.751509818822, 8554.95722521388, 9002.279817614592, 9236.84539432571, 9454.432734035963, 9458.196053335467, 9149.451032938012, 9181.449113053222, 9241.90758092419, 9247.21398681113, 9298.116678915492, 2563.512932542811, 2566.4482136340685, 2580.6258092576563, 2608.6217498462806, 2608.9217323480325, 2517.4461618444006, 2589.5597748382725, 2589.7669209771116, 2591.727868573801, 2600.4539046800196, 2312.89591968361, 2443.315871555967, 2546.5925451927696, 2608.569586018314, 2618.48939456806, 2268.2854900706225, 2579.058643595093, 2605.6352110704515, 2605.908793192248, 2613.2421597736634, 2575.742425757428, 2576.36878964653, 2578.6647735794413, 2580.7161212266637, 2603.8437693738438, 9342.2526197904, 9370.765730856783, 9408.153266206005, 9450.810983780355, 9451.054894510562, 5783.306003279591, 5802.332731735863, 5892.616979896293, 5965.3736357682255, 5980.073088671263, 3604.1350075981836, 3648.781073135594, 3733.290674771785, 3757.455169000507, 3800.1259710266518, 1032.8450732390202, 1052.0116978909866, 1062.1237479079714, 1069.1553672598639, 1069.8127827630212, 11023.06303964172, 12578.182418142791, 12695.936520317431, 12732.0, 12762.106652534327, 4371.519132895379, 4964.478729733398, 5142.331496905378, 5202.4277329493725, 5219.895602088013, 10933.671989840317, 10935.671929842118, 10944.507497162647, 10968.396738179317, 11004.954529319702, 5755.3381361143165, 5756.453136951983, 5827.79602713903, 5889.234399528034, 5901.321348044944, 4269.893252668646, 4629.722216667011, 5093.18509038552, 5141.048905952411, 5194.844154675366, 4078.063794068266, 4124.711270211116, 4162.604552567501, 4190.266703326905, 4205.705600607989, 1370.8080868678394, 1388.972160601168, 1389.1040279019976, 1391.3391139208795, 1398.1960372785688, 1406.683496213344, 1409.4714482069223, 1433.7347590695754, 1443.6679563700197, 1460.1385182742233, 7522.887156692654, 8565.52889591066, 8601.741947741577, 8675.089115642893, 8686.348523860735, 530.5967464726835, 534.4228233507803, 536.0565404887426, 538.8221886777354, 547.3103889099763, 6375.553711240262, 6386.457151142112, 6394.104825324458, 6473.77341793035, 6480.870382592322, 9879.703608891745, 11208.831867521994, 11589.536418543332, 11698.415079246173, 11739.23694959825, 10894.782104357868, 11260.493277802354, 11304.491297891615, 11396.658100257006, 11540.538378464935, 8716.564171791386, 8863.556822158995, 8868.423552469068, 8926.642934282685, 8956.417832840845, 8451.915480845359, 8501.234888860032, 8544.572771361283, 8577.742667719978, 8595.312375009858, 9783.461909594756, 10037.34757240777, 10085.243606729378, 10107.140893023881, 10121.645742398981, 9610.087041731025, 10281.84577231357, 10583.94708026455, 10589.52347144365, 10650.8934910653, 7250.41996640257, 7563.432742544442, 7863.3316168124065, 8373.49759014461, 8568.386642073978, 8720.912790872264, 8734.781630459289, 8738.781530461789, 8781.824363512822, 8799.076097009722, 7534.623268836646, 7691.1155217150745, 7722.845543088994, 7724.150343462327, 7826.139124696393, 7471.028766260569, 7525.397968162643, 7543.019407477213, 7576.810579735551, 7673.271039251262, 8043.83912321762, 8158.306543943594, 8161.551114688749, 8220.671173153007, 8229.25936665703, 7329.083864516935, 7366.152892417441, 7415.703371865065, 7436.96281518589, 7442.404607631484, 7417.147028091838, 7493.475456717977, 7505.774826755206, 7506.9249307506225, 7507.399408047234], "unit": "score", "name": "mootools.html", "value": 5105.096107930275}, {"lowerIsBetter": false, "replicates": [333.9197695455203, 339.8742465287844, 340.35672578826006, 344.7242206235012, 345.6353547007906, 5713.257276554047, 6768.221654509733, 6910.447164226863, 6962.756303529378, 7000.859982800341, 5493.670379777216, 5971.701414929247, 6451.483881289498, 6834.384905358516, 6916.861662766742, 4178.582141785828, 4864.294677271793, 4982.177940639808, 5092.694438333693, 5149.871253218662, 3965.8413663453425, 4166.791660416982, 5145.093022442326, 5167.509086636764, 5176.404713457963, 5071.847844564669, 5079.974600126994, 5090.211017292326, 5090.236464530313, 5109.540141387274, 5081.415637201713, 5087.414947281073, 5111.974440127813, 5126.974365128188, 5136.691798492103, 4388.407564978751, 4396.8021439035, 4397.824087036514, 4402.603765661074, 4403.713758605681, 6272.1219029335925, 6612.6693665317025, 6614.5039122065555, 6642.468602511787, 6647.3020332864835, 5813.651180929115, 5871.2073870027425, 5879.176915231871, 5886.6468011919, 5891.91162132564, 6005.669688167149, 7306.671199796022, 7323.12122545298, 7357.484976051678, 7364.963175184143, 4708.176069187913, 4710.552497512731, 4718.221493453576, 4727.929081063787, 4737.265723812815, 6191.442770150663, 7361.4110871130715, 7592.696292148307, 7627.237276272328, 7640.422491581121, 4583.2666773316105, 4643.698159619614, 4722.386089808303, 4731.645126615517, 4743.95256047442, 4780.77693872351, 4830.686005409637, 4831.613470922318, 4831.98528309059, 4836.008618233324, 5763.337216220189, 5770.307563092372, 5770.451807078405, 5781.4218578141845, 5805.941940580625, 7195.676194571257, 7199.0, 7205.963970180115, 7209.459290553229, 7216.422686185093, 1679.3366620184959, 1703.1228917107699, 1704.3267909175806, 1704.735765956254, 1709.5555155659617, 1026.0047753679069, 1067.80779459698, 1072.4369705904307, 1078.2883297023927, 1086.5277548921256, 6726.630035348005, 6806.897896531556, 6816.420604248595, 6819.522633415613, 6869.210040845367, 6274.811755647338, 7179.1026121734785, 7341.879701127, 7521.210272921265, 7628.923710762932, 6639.834004149839, 6856.280090590516, 6863.38229559342, 6866.759663411856, 6899.241083480813, 4007.699422543321, 4035.7780322082567, 4036.5156181258435, 4053.108316170438, 4058.6753059755147, 6233.781817636361, 7625.618719064025, 7975.680972761141, 7977.920220797834, 7993.360531157494, 6013.338532761392, 6733.3266673333255, 7495.613311537383, 7894.447388682737, 7967.123616402191, 6970.965145174242, 7931.4844535103875, 7967.920320796834, 7975.042994840656, 7988.360931125496, 7650.387968962358, 7662.310392064518, 7671.194524574839, 7676.923230767621, 7714.305712485903, 7492.438067144877, 7503.137139229058, 7508.436867235088, 7510.211427800003, 7515.0, 6161.784337548164, 7975.960120199362, 7984.0, 8017.5991200438575, 8029.07665618438, 4755.500672429345, 4780.760961951819, 4811.08589368019, 4817.855464335936, 4827.589654879234, 7634.274743899321, 7641.083070031632, 7648.732294369893, 7682.0397450318715, 7695.268949449794, 7334.743283985035, 7356.117265928123, 7361.411087113125, 7376.7786966391095, 7383.043493474341, 7112.751053713096, 7343.466504056092, 7353.654087390118, 7390.482666213314, 7415.962920185365, 7140.571565706075, 7150.64246787669, 7183.0, 7187.460940429593, 7200.351968322876, 7341.559506429631, 7368.4842061055215, 7374.410047196104, 7382.704691812482, 7395.519291246052, 6177.042558403455, 6889.207741109836, 6935.445164386938, 7155.212926578176, 7184.281571842774], "unit": "score", "name": "prototype.html", "value": 5288.1755182282295}, {"lowerIsBetter": false, "replicates": [731.1482123326325, 736.5065406177858, 757.5454727163702, 765.5980610179656, 772.8531578999994, 14968.625784355383, 15101.546953591409, 15193.0, 15198.392064317442, 15216.69566608667, 16272.674546509063, 16605.33578656852, 16611.750823737624, 16623.168841557905, 16632.584185395343, 766.4022062791004, 860.1183786618734, 876.408424313589, 927.1701826864952, 979.8873129590118, 939.4973689076346, 974.8586454964026, 977.2719324103552, 978.1245785022436, 979.2802290316612, 1041.1410586266322, 1042.5100202904623, 1047.010575006619, 1047.3454091193005, 1048.266213650444, 960.4621412009262, 1000.3847633705292, 1002.2983911262073, 1026.1995643398086, 1033.1166852341253, 743.35699619829, 755.0486387152228, 757.3524636435823, 768.0476209500235, 774.1020416317101, 15668.0, 15688.215589220608, 16033.198340082949, 16102.194890255558, 16130.919345403316, 12880.677983050406, 12916.225026498347, 12967.610971670865, 13061.542846000344, 13080.607581772561, 8335.274727998227, 10181.269184238623, 10402.583896644124, 10425.113865321457, 10475.371477711362, 3456.015035714809, 3512.2624248907505, 3516.613172551017, 3518.700910422617, 3576.4635304704243, 83605.3278934424, 84268.15731842665, 84325.0, 84507.73238401429, 85618.0, 9547.140757331874, 9554.426734395958, 9622.47076410804, 9721.951390243003, 9739.951300243454, 21962.0, 22019.11923523041, 22090.0059497323, 22126.778732212795, 22295.773732444548, 7464.0, 7588.27911348421, 7745.148033716287, 7859.842803143905, 7953.164917683675, 4118.073433477503, 4173.812178451977, 4185.727927684691, 4214.620684138442, 4407.052483715952, 3145.4495463293833, 3671.742977991515, 3720.795356255432, 3743.513343265358, 3775.075106598846, 589.1604463639297, 606.6723969056749, 607.0681503891506, 607.4259824465837, 607.9483243924227, 410.9876703698894, 472.518031607765, 600.6066026752484, 610.8289678889918, 628.9119822706743, 8264.793380165544, 8528.488290702579, 8646.135386461303, 8685.565721714016, 8831.514266715392, 597.1813042439678, 600.3366280260336, 603.1736520966217, 604.5919004671829, 625.2340882419, 3596.3346780845627, 3611.7291203159866, 3955.92088158241, 3992.8003599819895, 4121.175764847043, 93963.0, 94498.0, 98374.0, 98599.0, 98866.50566747264, 79028.60485697535, 80169.59915200503, 82644.0, 83083.33000439362, 84932.0, 72524.63737681383, 72930.0, 73109.0, 73586.63206683932, 74429.62785186147, 7726.343260822893, 7936.960315198387, 7976.84046319082, 8057.83884322322, 8071.677132914852, 51077.978440431725, 52543.0, 52702.0, 53343.199852001475, 53435.732821335645, 68884.6555767218, 74202.0, 75440.0, 75786.62106689431, 75955.62022189854, 8210.220029097227, 8284.420090593841, 10054.44700541448, 10096.747581310527, 10101.898981010096, 9943.552540135566, 11117.3329600221, 12060.336681482602, 12113.818292725793, 12686.302253375783, 11534.019608333385, 11726.824097638371, 11750.94124529372, 11782.941085294862, 11893.76212475763, 11239.438028098399, 11614.0, 11701.488982718833, 11898.04815614766, 12047.216930899815, 10010.549525271235, 11725.941370293094, 11728.94135529317, 11750.70623234426, 11926.463309151282, 9847.409155450696, 9905.356151850106, 9909.702708918743, 10050.894401615962, 10066.094051535398, 9932.503374831374, 9935.552900119368, 9954.402735835873, 9976.20190384782, 10167.237457190888], "unit": "score", "name": "yui.html", "value": 7080.898476691125}], "name": "dromaeo_css", "value": 7684.9643219457375}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 113.0, 116.0, 115.0, 116.0, 129.0, 115.0, 114.0, 116.0, 114.0], "unit": "score", "name": "ai-astar", "value": 116.4}, {"lowerIsBetter": true, "replicates": [149.0, 120.0, 151.0, 193.0, 148.0, 140.0, 120.0, 159.0, 148.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 144.6}, {"lowerIsBetter": true, "replicates": [202.0, 197.0, 200.0, 201.0, 220.0, 214.0, 198.0, 199.0, 223.0, 266.0], "unit": "score", "name": "audio-dft", "value": 212.0}, {"lowerIsBetter": true, "replicates": [63.0, 76.0, 73.0, 102.0, 47.0, 46.0, 71.0, 77.0, 157.0, 87.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 120.0, 80.0, 77.0, 81.0, 118.0, 80.0, 80.0, 120.0], "unit": "score", "name": "audio-oscillator", "value": 92.7}, {"lowerIsBetter": true, "replicates": [92.0, 87.0, 108.0, 117.0, 92.0, 92.0, 124.0, 88.0, 91.0, 87.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 97.8}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 133.0, 95.0, 102.0, 137.0, 96.0, 95.0, 102.0], "unit": "score", "name": "imaging-darkroom", "value": 104.9}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 91.0, 92.0, 96.0, 92.0, 91.0, 103.0, 90.0, 112.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [56.0, 61.0, 70.0, 88.0, 92.0, 86.0, 60.0, 68.0, 60.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 69.7}, {"lowerIsBetter": true, "replicates": [94.0, 102.0, 71.0, 64.0, 71.0, 68.0, 68.0, 65.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 73.4}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 82.0, 84.0, 82.0, 84.0, 80.0, 82.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [120.0, 136.0, 140.0, 131.0, 143.0, 124.0, 121.0, 121.0, 144.0, 136.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.6}, {"lowerIsBetter": true, "replicates": [156.0, 135.0, 136.0, 134.0, 133.0, 138.0, 136.0, 180.0, 142.0, 110.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.0}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 64.0, 71.0, 67.0, 65.0, 64.0, 68.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1507.6999999999998}]} 14:53:13 INFO - Return code: 0 14:53:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:53:13 ERROR - # TBPL SUCCESS # 14:53:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:53:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:53:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:53:13 INFO - 2016-04-18 14:53:13.739 screenresolution[1680:10832] starting screenresolution argv=screenresolution get 14:53:13 INFO - 2016-04-18 14:53:13.742 screenresolution[1680:10832] Display 0: 1600x1200x32@60 14:53:13 INFO - 2016-04-18 14:53:13.748 screenresolution[1681:10835] starting screenresolution argv=screenresolution list 14:53:13 INFO - Available Modes on Display 0 14:53:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:53:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:53:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:53:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:53:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:53:13 INFO - Intel Iris: 14:53:13 INFO - Chipset Model: Intel Iris 14:53:13 INFO - Type: GPU 14:53:13 INFO - Bus: Built-In 14:53:13 INFO - VRAM (Dynamic, Max): 1536 MB 14:53:13 INFO - Vendor: Intel (0x8086) 14:53:13 INFO - Device ID: 0x0a2e 14:53:13 INFO - Revision ID: 0x0009 14:53:13 INFO - Displays: 14:53:13 INFO - Display: 14:53:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:53:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:53:13 INFO - Display Serial Number: 1600x1200 60 14:53:13 INFO - Main Display: Yes 14:53:13 INFO - Mirror: Off 14:53:13 INFO - Online: Yes 14:53:13 INFO - Rotation: Supported 14:53:13 INFO - Return code: 0 14:53:13 INFO - Running post-action listener: _resource_record_post_action 14:53:13 INFO - Running post-run listener: _resource_record_post_run 14:53:15 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 37623296; Write bytes: 668960768; Read time: 396; Write time: 1998 14:53:15 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 360806912; Write bytes: 354854400; Read time: 29616; Write time: 829 14:53:15 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 35718656; Write bytes: 303976960; Read time: 371; Write time: 1139 14:53:15 INFO - Running post-run listener: _upload_blobber_files 14:53:15 INFO - Blob upload gear active. 14:53:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:53:15 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 14:53:15 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:53:15 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:53:15 INFO - (blobuploader) - INFO - Open directory for files ... 14:53:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:53:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:53:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:16 INFO - (blobuploader) - INFO - Done attempting. 14:53:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:53:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:53:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:18 INFO - (blobuploader) - INFO - Done attempting. 14:53:18 INFO - (blobuploader) - INFO - Iteration through files over. 14:53:18 INFO - Return code: 0 14:53:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:53:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:53:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6780aa98e06ba11e10180337f35231ac47c0d5e72fd87937d791ba86918e62c3f482857dc02c8d3d6860049e08d89b52f5cb2e0e3591f34d8dcb6d8548b5cd3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f27b5f95462296da4726c9e605f44cebbbb3ccf829f2d7ce1dae06572ed586f5e494a465f280192b8cb93478c716dade389e51c89b249fb92b7ad16408182c58"} 14:53:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:53:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:53:18 INFO - Contents: 14:53:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6780aa98e06ba11e10180337f35231ac47c0d5e72fd87937d791ba86918e62c3f482857dc02c8d3d6860049e08d89b52f5cb2e0e3591f34d8dcb6d8548b5cd3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f27b5f95462296da4726c9e605f44cebbbb3ccf829f2d7ce1dae06572ed586f5e494a465f280192b8cb93478c716dade389e51c89b249fb92b7ad16408182c58"} 14:53:18 INFO - Running post-run listener: copy_logs_to_upload_dir 14:53:18 INFO - Copying logs to upload dir... 14:53:18 INFO - mkdir: /builds/slave/test/build/upload/logs 14:53:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.351581 ========= master_lag: 1.53 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-18 14:53:19.602390) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 14:53:19.603461) ========= 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.s87zJXjh3I/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.0gNdigrWF8/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6780aa98e06ba11e10180337f35231ac47c0d5e72fd87937d791ba86918e62c3f482857dc02c8d3d6860049e08d89b52f5cb2e0e3591f34d8dcb6d8548b5cd3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f27b5f95462296da4726c9e605f44cebbbb3ccf829f2d7ce1dae06572ed586f5e494a465f280192b8cb93478c716dade389e51c89b249fb92b7ad16408182c58"} build_url:https://queue.taskcluster.net/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011513 build_url: 'https://queue.taskcluster.net/v1/task/XOTQuqBPRSypGgW0dvE7bg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6780aa98e06ba11e10180337f35231ac47c0d5e72fd87937d791ba86918e62c3f482857dc02c8d3d6860049e08d89b52f5cb2e0e3591f34d8dcb6d8548b5cd3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f27b5f95462296da4726c9e605f44cebbbb3ccf829f2d7ce1dae06572ed586f5e494a465f280192b8cb93478c716dade389e51c89b249fb92b7ad16408182c58"}' ========= master_lag: 0.49 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 14:53:20.100756) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 14:53:20.101073) ========= 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.s87zJXjh3I/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.0gNdigrWF8/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.004940 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 14:53:20.195840) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 14:53:20.196145) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 14:53:20.201220) ========= ========= Total master_lag: 2.18 =========