builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0319 starttime: 1468605138.03 results: success (0) buildid: 20160713141046 builduid: f56c373fb50a40f583c4b414d4dcca39 revision: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.034241) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.034671) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.034940) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.140854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.141096) ========= 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.9gygcHe4QD/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.eRbk9E4jh0/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-15 10:52:18-- 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% 19.3M=0.001s 2016-07-15 10:52:18 (19.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.477627 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.642400) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.642724) ========= 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.9gygcHe4QD/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.eRbk9E4jh0/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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.025147 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.691635) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 10:52:18.691981) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5fd14a66be3191e5628af3cfb0a456dd70f179b8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5fd14a66be3191e5628af3cfb0a456dd70f179b8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9gygcHe4QD/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.eRbk9E4jh0/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-15 10:52:18,774 truncating revision to first 12 chars 2016-07-15 10:52:18,774 Setting DEBUG logging. 2016-07-15 10:52:18,774 attempt 1/10 2016-07-15 10:52:18,775 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5fd14a66be31?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 10:52:19,875 unpacking tar archive at: mozilla-central-5fd14a66be31/testing/mozharness/ program finished with exit code 0 elapsedTime=1.388068 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 10:52:20.102303) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:20.102951) ========= script_repo_revision: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:20.103338) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:20.103615) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:20.145458) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 20 secs) (at 2016-07-15 10:52:20.145893) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9gygcHe4QD/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.eRbk9E4jh0/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:52:20 INFO - MultiFileLogger online at 20160715 10:52:20 in /builds/slave/test 10:52:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:52:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:52:20 INFO - {'append_to_log': False, 10:52:20 INFO - 'base_work_dir': '/builds/slave/test', 10:52:20 INFO - 'blob_upload_branch': 'Firefox', 10:52:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:52:20 INFO - 'branch': 'Firefox', 10:52:20 INFO - 'buildbot_json_path': 'buildprops.json', 10:52:20 INFO - 'config_files': ('talos/mac_config.py',), 10:52:20 INFO - 'default_actions': ('clobber', 10:52:20 INFO - 'read-buildbot-config', 10:52:20 INFO - 'download-and-extract', 10:52:20 INFO - 'populate-webroot', 10:52:20 INFO - 'create-virtualenv', 10:52:20 INFO - 'install', 10:52:20 INFO - 'run-tests'), 10:52:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:52:20 INFO - 'download_minidump_stackwalk': True, 10:52:20 INFO - 'download_symbols': 'ondemand', 10:52:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:52:20 INFO - 'tooltool.py': '/tools/tooltool.py', 10:52:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:52:20 INFO - '/tools/misc-python/virtualenv.py')}, 10:52:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:52:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:52:20 INFO - 'installer_path': 'installer.exe', 10:52:20 INFO - 'log_level': 'info', 10:52:20 INFO - 'log_name': 'talos', 10:52:20 INFO - 'log_to_console': True, 10:52:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:52:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:52:20 INFO - 'opt_config_files': (), 10:52:20 INFO - 'pip_index': False, 10:52:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:52:20 INFO - 'cmd': ('bash', 10:52:20 INFO - '-c', 10:52:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:52:20 INFO - 'enabled': True, 10:52:20 INFO - 'halt_on_failure': False, 10:52:20 INFO - 'name': 'check_screen_resolution'},), 10:52:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:52:20 INFO - 'cmd': ('bash', 10:52:20 INFO - '-c', 10:52:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:52:20 INFO - 'enabled': True, 10:52:20 INFO - 'halt_on_failure': False, 10:52:20 INFO - 'name': 'check_screen_resolution'},), 10:52:20 INFO - 'run_cmd_checks_enabled': True, 10:52:20 INFO - 'sps_profile': False, 10:52:20 INFO - 'sps_profile_interval': 0, 10:52:20 INFO - 'suite': 'dromaeojs-e10s', 10:52:20 INFO - 'system_bits': '32', 10:52:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:52:20 INFO - 'title': 't-yosemite-r7-0319', 10:52:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:52:20 INFO - 'use_talos_json': True, 10:52:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:52:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:52:20 INFO - 'work_dir': 'build'} 10:52:20 INFO - ##### 10:52:20 INFO - ##### Running clobber step. 10:52:20 INFO - ##### 10:52:20 INFO - Running pre-action listener: _resource_record_pre_action 10:52:20 INFO - Running main action method: clobber 10:52:20 INFO - rmtree: /builds/slave/test/build 10:52:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:52:21 INFO - Running post-action listener: _resource_record_post_action 10:52:21 INFO - ##### 10:52:21 INFO - ##### Finished clobber step (success) 10:52:21 INFO - ##### 10:52:21 INFO - ##### 10:52:21 INFO - ##### Running read-buildbot-config step. 10:52:21 INFO - ##### 10:52:21 INFO - Running pre-action listener: _resource_record_pre_action 10:52:21 INFO - Running main action method: read_buildbot_config 10:52:21 INFO - Using buildbot properties: 10:52:21 INFO - { 10:52:21 INFO - "project": "", 10:52:21 INFO - "product": "firefox", 10:52:21 INFO - "script_repo_revision": "production", 10:52:21 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:52:21 INFO - "repository": "", 10:52:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:52:21 INFO - "buildid": "20160713141046", 10:52:21 INFO - "pgo_build": "False", 10:52:21 INFO - "basedir": "/builds/slave/test", 10:52:21 INFO - "buildnumber": 59, 10:52:21 INFO - "slavename": "t-yosemite-r7-0319", 10:52:21 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 10:52:21 INFO - "platform": "yosemite_r7", 10:52:21 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:52:21 INFO - "branch": "mozilla-central", 10:52:21 INFO - "repo_path": "mozilla-central", 10:52:21 INFO - "revision": "5fd14a66be3191e5628af3cfb0a456dd70f179b8", 10:52:21 INFO - "stage_platform": "macosx64", 10:52:21 INFO - "builduid": "f56c373fb50a40f583c4b414d4dcca39", 10:52:21 INFO - "slavebuilddir": "test" 10:52:21 INFO - } 10:52:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 10:52:21 INFO - Running post-action listener: _resource_record_post_action 10:52:21 INFO - ##### 10:52:21 INFO - ##### Finished read-buildbot-config step (success) 10:52:21 INFO - ##### 10:52:21 INFO - ##### 10:52:21 INFO - ##### Running download-and-extract step. 10:52:21 INFO - ##### 10:52:21 INFO - Running pre-action listener: _resource_record_pre_action 10:52:21 INFO - Running main action method: download_and_extract 10:52:21 INFO - mkdir: /builds/slave/test/build/tests 10:52:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:21 INFO - https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:52:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 10:52:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 10:52:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 10:52:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 10:52:35 INFO - Downloaded 1199 bytes. 10:52:35 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 10:52:35 INFO - Using the following test package requirements: 10:52:35 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 10:52:35 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:35 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 10:52:35 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:35 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 10:52:35 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:35 INFO - u'jsshell-mac.zip'], 10:52:35 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:35 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 10:52:35 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 10:52:35 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:35 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 10:52:35 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:35 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 10:52:35 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:35 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 10:52:35 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:35 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 10:52:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:35 INFO - https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:52:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:52:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:52:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:52:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:53:05 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip: timed out 10:53:05 INFO - retry: attempt #1 caught exception: timed out 10:53:05 INFO - retry: Failed, sleeping 30 seconds before retrying 10:53:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #2 10:53:38 INFO - Downloaded 18827271 bytes. 10:53:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:53:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:53:41 INFO - Return code: 0 10:53:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:41 INFO - https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:53:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:53:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:53:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:53:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:54:11 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip: timed out 10:54:11 INFO - retry: attempt #1 caught exception: timed out 10:54:11 INFO - retry: Failed, sleeping 30 seconds before retrying 10:54:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #2 10:54:43 INFO - Downloaded 18827271 bytes. 10:54:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:54:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:54:46 INFO - Return code: 0 10:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:46 INFO - https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:54:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:54:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:54:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:54:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:54:48 INFO - Downloaded 14403317 bytes. 10:54:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:54:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:54:48 INFO - Return code: 0 10:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:48 INFO - https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:54:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:54:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:54:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 10:54:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 10:54:51 INFO - Downloaded 112779863 bytes. 10:54:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:54:51 INFO - mkdir: /builds/slave/test/properties 10:54:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:54:51 INFO - Writing to file /builds/slave/test/properties/build_url 10:54:51 INFO - Contents: 10:54:51 INFO - build_url:https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:54:52 INFO - Running post-action listener: _resource_record_post_action 10:54:52 INFO - Running post-action listener: set_extra_try_arguments 10:54:52 INFO - ##### 10:54:52 INFO - ##### Finished download-and-extract step (success) 10:54:52 INFO - ##### 10:54:52 INFO - ##### 10:54:52 INFO - ##### Running populate-webroot step. 10:54:52 INFO - ##### 10:54:52 INFO - Running pre-action listener: _resource_record_pre_action 10:54:52 INFO - Running main action method: populate_webroot 10:54:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:54:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:54:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:54:52 INFO - '--tppagecycles', 10:54:52 INFO - '7'], 10:54:52 INFO - 'tests': ['tsvgm']}}, 10:54:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:54:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:54:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:54:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:54:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:54:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:54:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:52 INFO - 'talos_options': ['--disable-e10s'], 10:54:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:54:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:54:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:52 INFO - 'talos_options': ['--disable-e10s'], 10:54:52 INFO - 'tests': ['damp', 'tps']}, 10:54:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:52 INFO - 'tests': ['damp', 'tps']}, 10:54:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:54:52 INFO - 'tests': ['dromaeo_dom']}, 10:54:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:54:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:54:52 INFO - 'tests': ['basic_compositor_video']}, 10:54:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:54:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:54:52 INFO - 'tests': ['a11yr', 10:54:52 INFO - 'ts_paint', 10:54:52 INFO - 'tpaint', 10:54:52 INFO - 'sessionrestore', 10:54:52 INFO - 'sessionrestore_no_auto_restore', 10:54:52 INFO - 'tabpaint']}, 10:54:52 INFO - 'other-e10s': {'tests': ['a11yr', 10:54:52 INFO - 'ts_paint', 10:54:52 INFO - 'tpaint', 10:54:52 INFO - 'sessionrestore', 10:54:52 INFO - 'sessionrestore_no_auto_restore', 10:54:52 INFO - 'tabpaint']}, 10:54:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:54:52 INFO - 'ts_paint', 10:54:52 INFO - 'tpaint', 10:54:52 INFO - 'sessionrestore', 10:54:52 INFO - 'sessionrestore_no_auto_restore', 10:54:52 INFO - 'tabpaint']}, 10:54:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:54:52 INFO - 'ts_paint', 10:54:52 INFO - 'tpaint', 10:54:52 INFO - 'sessionrestore', 10:54:52 INFO - 'sessionrestore_no_auto_restore', 10:54:52 INFO - 'tabpaint']}, 10:54:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:54:52 INFO - 'tests': ['a11yr', 10:54:52 INFO - 'ts_paint', 10:54:52 INFO - 'tpaint', 10:54:52 INFO - 'sessionrestore', 10:54:52 INFO - 'sessionrestore_no_auto_restore', 10:54:52 INFO - 'tabpaint']}, 10:54:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:54:52 INFO - 'tests': ['a11yr', 10:54:52 INFO - 'ts_paint', 10:54:52 INFO - 'tpaint', 10:54:52 INFO - 'sessionrestore', 10:54:52 INFO - 'sessionrestore_no_auto_restore', 10:54:52 INFO - 'tabpaint']}, 10:54:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:54:52 INFO - 'tests': ['tsvgx', 10:54:52 INFO - 'tsvgr_opacity', 10:54:52 INFO - 'tart', 10:54:52 INFO - 'tscrollx', 10:54:52 INFO - 'cart']}, 10:54:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:54:52 INFO - 'tsvgr_opacity', 10:54:52 INFO - 'tart', 10:54:52 INFO - 'tscrollx', 10:54:52 INFO - 'cart']}, 10:54:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:52 INFO - 'talos_options': ['--disable-e10s'], 10:54:52 INFO - 'tests': ['tp5o']}, 10:54:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:52 INFO - 'tests': ['tp5o']}, 10:54:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:52 INFO - 'talos_options': ['--disable-e10s', 10:54:52 INFO - '--xperf_path', 10:54:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:54:52 INFO - 'tests': ['tp5n']}, 10:54:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:52 INFO - 'talos_options': ['--xperf_path', 10:54:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:54:52 INFO - 'tests': ['tp5n']}}, 10:54:52 INFO - 'talos.zip': {'path': '', 10:54:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:54:52 INFO - Running post-action listener: _resource_record_post_action 10:54:52 INFO - ##### 10:54:52 INFO - ##### Finished populate-webroot step (success) 10:54:52 INFO - ##### 10:54:52 INFO - ##### 10:54:52 INFO - ##### Running create-virtualenv step. 10:54:52 INFO - ##### 10:54:52 INFO - Running pre-action listener: _resource_record_pre_action 10:54:52 INFO - Running main action method: create_virtualenv 10:54:52 INFO - Creating virtualenv /builds/slave/test/build/venv 10:54:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:54:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:54:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:54:52 INFO - Using real prefix '/tools/python27' 10:54:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:54:53 INFO - Installing distribute.............................................................................................................................................................................................done. 10:54:56 INFO - Installing pip.................done. 10:54:56 INFO - Return code: 0 10:54:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:56 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 0x109451a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094e6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8280ca4500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093b5d30>, '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 0x10911adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093adb20>, '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.9gygcHe4QD/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.eRbk9E4jh0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:54:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9gygcHe4QD/Render', 10:54:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:56 INFO - 'HOME': '/Users/cltbld', 10:54:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:56 INFO - 'LOGNAME': 'cltbld', 10:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:56 INFO - 'MOZ_NO_REMOTE': '1', 10:54:56 INFO - 'NO_EM_RESTART': '1', 10:54:56 INFO - 'PAGER': '/bin/cat', 10:54:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:56 INFO - 'PWD': '/builds/slave/test', 10:54:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:56 INFO - 'SHELL': '/bin/bash', 10:54:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRbk9E4jh0/Listeners', 10:54:56 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 10:54:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:56 INFO - 'USER': 'cltbld', 10:54:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:56 INFO - 'XPC_FLAGS': '0x0', 10:54:56 INFO - 'XPC_SERVICE_NAME': '0', 10:54:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:54:56 INFO - Cleaning up... 10:54:56 INFO - Return code: 0 10:54:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:56 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109451a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094e6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8280ca4500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093b5d30>, '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 0x10911adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093adb20>, '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.9gygcHe4QD/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.eRbk9E4jh0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54:56 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>=3.1.1'] in /builds/slave/test/build 10:54:56 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>=3.1.1 10:54:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9gygcHe4QD/Render', 10:54:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:56 INFO - 'HOME': '/Users/cltbld', 10:54:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:56 INFO - 'LOGNAME': 'cltbld', 10:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:56 INFO - 'MOZ_NO_REMOTE': '1', 10:54:56 INFO - 'NO_EM_RESTART': '1', 10:54:56 INFO - 'PAGER': '/bin/cat', 10:54:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:56 INFO - 'PWD': '/builds/slave/test', 10:54:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:56 INFO - 'SHELL': '/bin/bash', 10:54:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRbk9E4jh0/Listeners', 10:54:56 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 10:54:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:56 INFO - 'USER': 'cltbld', 10:54:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:56 INFO - 'XPC_FLAGS': '0x0', 10:54:56 INFO - 'XPC_SERVICE_NAME': '0', 10:54:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:57 INFO - Downloading/unpacking psutil>=3.1.1 10:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:55:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:55:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:55:00 INFO - Installing collected packages: psutil 10:55:00 INFO - Running setup.py install for psutil 10:55:00 INFO - building 'psutil._psutil_osx' extension 10:55:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:55:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:55:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:55:01 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:55:01 INFO - building 'psutil._psutil_posix' extension 10:55:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:55:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:55:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:55:01 INFO - ^ 10:55:01 INFO - 1 warning generated. 10:55:01 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:55:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:55:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:55:01 INFO - Successfully installed psutil 10:55:01 INFO - Cleaning up... 10:55:01 INFO - Return code: 0 10:55:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:55:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:01 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109451a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094e6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8280ca4500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093b5d30>, '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 0x10911adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093adb20>, '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.9gygcHe4QD/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.eRbk9E4jh0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:55:01 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.3'] in /builds/slave/test/build 10:55:01 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.3 10:55:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9gygcHe4QD/Render', 10:55:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:01 INFO - 'HOME': '/Users/cltbld', 10:55:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:01 INFO - 'LOGNAME': 'cltbld', 10:55:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:01 INFO - 'MOZ_NO_REMOTE': '1', 10:55:01 INFO - 'NO_EM_RESTART': '1', 10:55:01 INFO - 'PAGER': '/bin/cat', 10:55:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:01 INFO - 'PWD': '/builds/slave/test', 10:55:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:01 INFO - 'SHELL': '/bin/bash', 10:55:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRbk9E4jh0/Listeners', 10:55:01 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 10:55:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:01 INFO - 'USER': 'cltbld', 10:55:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:01 INFO - 'XPC_FLAGS': '0x0', 10:55:01 INFO - 'XPC_SERVICE_NAME': '0', 10:55:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:55:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:55:04 INFO - Installing collected packages: mozsystemmonitor 10:55:04 INFO - Running setup.py install for mozsystemmonitor 10:55:04 INFO - Successfully installed mozsystemmonitor 10:55:04 INFO - Cleaning up... 10:55:04 INFO - Return code: 0 10:55:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:55: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')]} 10:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55: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')]} 10:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109451a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094e6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8280ca4500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093b5d30>, '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 0x10911adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093adb20>, '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.9gygcHe4QD/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.eRbk9E4jh0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:55:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:55:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9gygcHe4QD/Render', 10:55:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:04 INFO - 'HOME': '/Users/cltbld', 10:55:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:04 INFO - 'LOGNAME': 'cltbld', 10:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:04 INFO - 'MOZ_NO_REMOTE': '1', 10:55:04 INFO - 'NO_EM_RESTART': '1', 10:55:04 INFO - 'PAGER': '/bin/cat', 10:55:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:04 INFO - 'PWD': '/builds/slave/test', 10:55:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:04 INFO - 'SHELL': '/bin/bash', 10:55:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRbk9E4jh0/Listeners', 10:55:04 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 10:55:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:04 INFO - 'USER': 'cltbld', 10:55:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:04 INFO - 'XPC_FLAGS': '0x0', 10:55:04 INFO - 'XPC_SERVICE_NAME': '0', 10:55:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:04 INFO - Downloading/unpacking jsonschema==2.5.1 10:55: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 10:55: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 10:55: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 10:55: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 10:55: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 10:55: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 10:55:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:55:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:55: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 10:55: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 10:55: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 10:55: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 10:55: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 10:55: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 10:55:07 INFO - Downloading functools32-3.2.3-2.tar.gz 10:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:55:07 INFO - warning: no files found matching '*.txt' 10:55:07 INFO - no previously-included directories found matching 'build' 10:55:07 INFO - no previously-included directories found matching 'dist' 10:55:07 INFO - no previously-included directories found matching '.git*' 10:55:07 INFO - Installing collected packages: jsonschema, functools32 10:55:07 INFO - Running setup.py install for functools32 10:55:07 INFO - warning: no files found matching '*.txt' 10:55:07 INFO - no previously-included directories found matching 'build' 10:55:07 INFO - no previously-included directories found matching 'dist' 10:55:07 INFO - no previously-included directories found matching '.git*' 10:55:07 INFO - Successfully installed jsonschema functools32 10:55:07 INFO - Cleaning up... 10:55:08 INFO - Return code: 0 10:55:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:08 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 0x109451a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094e6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8280ca4500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093b5d30>, '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 0x10911adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093adb20>, '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.9gygcHe4QD/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.eRbk9E4jh0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:55:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:55:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9gygcHe4QD/Render', 10:55:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:08 INFO - 'HOME': '/Users/cltbld', 10:55:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:08 INFO - 'LOGNAME': 'cltbld', 10:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:08 INFO - 'MOZ_NO_REMOTE': '1', 10:55:08 INFO - 'NO_EM_RESTART': '1', 10:55:08 INFO - 'PAGER': '/bin/cat', 10:55:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:08 INFO - 'PWD': '/builds/slave/test', 10:55:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:08 INFO - 'SHELL': '/bin/bash', 10:55:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRbk9E4jh0/Listeners', 10:55:08 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 10:55:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:08 INFO - 'USER': 'cltbld', 10:55:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:08 INFO - 'XPC_FLAGS': '0x0', 10:55:08 INFO - 'XPC_SERVICE_NAME': '0', 10:55:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:08 INFO - Downloading/unpacking blobuploader==1.2.4 10:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:10 INFO - Downloading blobuploader-1.2.4.tar.gz 10:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:55:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:55:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:11 INFO - Downloading docopt-0.6.1.tar.gz 10:55:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:55:12 INFO - Installing collected packages: blobuploader, requests, docopt 10:55:12 INFO - Running setup.py install for blobuploader 10:55:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:55:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:55:12 INFO - Running setup.py install for requests 10:55:12 INFO - Running setup.py install for docopt 10:55:12 INFO - Successfully installed blobuploader requests docopt 10:55:12 INFO - Cleaning up... 10:55:12 INFO - Return code: 0 10:55:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:12 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 0x109451a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094e6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8280ca4500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093b5d30>, '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 0x10911adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093adb20>, '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.9gygcHe4QD/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.eRbk9E4jh0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:55:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:55:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9gygcHe4QD/Render', 10:55:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:12 INFO - 'HOME': '/Users/cltbld', 10:55:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:12 INFO - 'LOGNAME': 'cltbld', 10:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:12 INFO - 'MOZ_NO_REMOTE': '1', 10:55:12 INFO - 'NO_EM_RESTART': '1', 10:55:12 INFO - 'PAGER': '/bin/cat', 10:55:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:12 INFO - 'PWD': '/builds/slave/test', 10:55:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:12 INFO - 'SHELL': '/bin/bash', 10:55:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRbk9E4jh0/Listeners', 10:55:12 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 10:55:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:12 INFO - 'USER': 'cltbld', 10:55:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:12 INFO - 'XPC_FLAGS': '0x0', 10:55:12 INFO - 'XPC_SERVICE_NAME': '0', 10:55:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:55:13 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-5Lwia8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:55:13 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-NM4CAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:55:13 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-Xj3ySO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:55:13 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-k0W38N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:55:13 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-8xlJnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:55:13 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-ICjd9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:55:13 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-6AjMJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:55:13 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-uYFPR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:55:13 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-hxi3Zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:55:14 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-Xrxm5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:55:14 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-adA7Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:55:14 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-1b8xTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:55:14 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-BJcqvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:55:14 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-TH9D4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:55:14 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-tHIkV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:55:14 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-9Vn_XJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:55:14 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-soLWPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:55:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:55:14 INFO - Running setup.py install for manifestparser 10:55:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:55:15 INFO - Running setup.py install for mozcrash 10:55:15 INFO - Running setup.py install for mozdebug 10:55:15 INFO - Running setup.py install for mozdevice 10:55:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:55:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:55:15 INFO - Running setup.py install for mozfile 10:55:15 INFO - Running setup.py install for mozhttpd 10:55:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:55:15 INFO - Running setup.py install for mozinfo 10:55:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:55:15 INFO - Running setup.py install for mozInstall 10:55:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:55:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:55:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:55:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:55:16 INFO - Running setup.py install for mozleak 10:55:16 INFO - Running setup.py install for mozlog 10:55:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:55:16 INFO - Running setup.py install for moznetwork 10:55:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:55:16 INFO - Running setup.py install for mozprocess 10:55:16 INFO - Running setup.py install for mozprofile 10:55:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:55:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:55:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:55:16 INFO - Running setup.py install for mozrunner 10:55:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:55:17 INFO - Running setup.py install for mozscreenshot 10:55:17 INFO - Running setup.py install for moztest 10:55:17 INFO - Running setup.py install for mozversion 10:55:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:55:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:55:17 INFO - Cleaning up... 10:55:17 INFO - Return code: 0 10:55:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:55: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')]} 10:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55: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')]} 10:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:17 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 0x109451a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094e6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8280ca4500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093b5d30>, '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 0x10911adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093adb20>, '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.9gygcHe4QD/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.eRbk9E4jh0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:55:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:55:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9gygcHe4QD/Render', 10:55:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:17 INFO - 'HOME': '/Users/cltbld', 10:55:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:17 INFO - 'LOGNAME': 'cltbld', 10:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:17 INFO - 'MOZ_NO_REMOTE': '1', 10:55:17 INFO - 'NO_EM_RESTART': '1', 10:55:17 INFO - 'PAGER': '/bin/cat', 10:55:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:17 INFO - 'PWD': '/builds/slave/test', 10:55:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:17 INFO - 'SHELL': '/bin/bash', 10:55:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRbk9E4jh0/Listeners', 10:55:17 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 10:55:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:17 INFO - 'USER': 'cltbld', 10:55:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:17 INFO - 'XPC_FLAGS': '0x0', 10:55:17 INFO - 'XPC_SERVICE_NAME': '0', 10:55:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:55:17 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-JLRHnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:55:17 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-5pOaDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:55:17 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-Yvu1bB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:55:18 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-IPZ6u2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:55:18 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-AYgAnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:55:18 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-zcMm5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:55:18 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-kmUGvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:55:18 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-b8eONS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:55:18 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-TkY7Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:55:18 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-Gj6yrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:55:18 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-kSyPjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:55:18 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-zfibTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:55:19 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-_t2d4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:55:19 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-BWuwR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:55:19 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-jFG7Ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:55:19 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-0Yz_5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:55:19 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-NVUQ7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:55:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:21 INFO - Downloading blessings-1.6.tar.gz 10:55:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:55:22 INFO - Installing collected packages: blessings 10:55:22 INFO - Running setup.py install for blessings 10:55:22 INFO - Successfully installed blessings 10:55:22 INFO - Cleaning up... 10:55:22 INFO - Return code: 0 10:55:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:55:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:55:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:55:22 INFO - Reading from file tmpfile_stdout 10:55:22 INFO - Current package versions: 10:55:22 INFO - blessings == 1.6 10:55:22 INFO - blobuploader == 1.2.4 10:55:22 INFO - docopt == 0.6.1 10:55:22 INFO - functools32 == 3.2.3-2 10:55:22 INFO - jsonschema == 2.5.1 10:55:22 INFO - manifestparser == 1.1 10:55:22 INFO - mozInstall == 1.12 10:55:22 INFO - mozcrash == 0.17 10:55:22 INFO - mozdebug == 0.1 10:55:22 INFO - mozdevice == 0.48 10:55:22 INFO - mozfile == 1.2 10:55:22 INFO - mozhttpd == 0.7 10:55:22 INFO - mozinfo == 0.9 10:55:22 INFO - mozleak == 0.1 10:55:22 INFO - mozlog == 3.2 10:55:22 INFO - moznetwork == 0.27 10:55:22 INFO - mozprocess == 0.23 10:55:22 INFO - mozprofile == 0.28 10:55:22 INFO - mozrunner == 6.12 10:55:22 INFO - mozscreenshot == 0.1 10:55:22 INFO - mozsystemmonitor == 0.3 10:55:22 INFO - moztest == 0.7 10:55:22 INFO - mozversion == 1.4 10:55:22 INFO - psutil == 3.1.1 10:55:22 INFO - requests == 1.2.3 10:55:22 INFO - wsgiref == 0.1.2 10:55:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:55: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')]} 10:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55: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')]} 10:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:22 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 0x109451a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094e6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8280ca4500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093b5d30>, '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 0x10911adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093adb20>, '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.9gygcHe4QD/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.eRbk9E4jh0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:55:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:55:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:55:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9gygcHe4QD/Render', 10:55:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:22 INFO - 'HOME': '/Users/cltbld', 10:55:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:22 INFO - 'LOGNAME': 'cltbld', 10:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:22 INFO - 'MOZ_NO_REMOTE': '1', 10:55:22 INFO - 'NO_EM_RESTART': '1', 10:55:22 INFO - 'PAGER': '/bin/cat', 10:55:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:22 INFO - 'PWD': '/builds/slave/test', 10:55:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:22 INFO - 'SHELL': '/bin/bash', 10:55:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRbk9E4jh0/Listeners', 10:55:22 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 10:55:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:22 INFO - 'USER': 'cltbld', 10:55:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:22 INFO - 'XPC_FLAGS': '0x0', 10:55:22 INFO - 'XPC_SERVICE_NAME': '0', 10:55:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:55:22 INFO - Cleaning up... 10:55:22 INFO - Return code: 0 10:55:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:55: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')]} 10:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55: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')]} 10:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:22 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 0x109451a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094e6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8280ca4500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093b5d30>, '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 0x10911adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093adb20>, '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.9gygcHe4QD/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.eRbk9E4jh0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:55:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:55:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:55:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9gygcHe4QD/Render', 10:55:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:22 INFO - 'HOME': '/Users/cltbld', 10:55:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:22 INFO - 'LOGNAME': 'cltbld', 10:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:22 INFO - 'MOZ_NO_REMOTE': '1', 10:55:22 INFO - 'NO_EM_RESTART': '1', 10:55:22 INFO - 'PAGER': '/bin/cat', 10:55:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:22 INFO - 'PWD': '/builds/slave/test', 10:55:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:22 INFO - 'SHELL': '/bin/bash', 10:55:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRbk9E4jh0/Listeners', 10:55:22 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 10:55:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:22 INFO - 'USER': 'cltbld', 10:55:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:22 INFO - 'XPC_FLAGS': '0x0', 10:55:22 INFO - 'XPC_SERVICE_NAME': '0', 10:55:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:55:23 INFO - Cleaning up... 10:55:23 INFO - Return code: 0 10:55:23 INFO - Running post-action listener: _resource_record_post_action 10:55:23 INFO - Running post-action listener: _start_resource_monitoring 10:55:23 INFO - Starting resource monitoring. 10:55:23 INFO - ##### 10:55:23 INFO - ##### Finished create-virtualenv step (success) 10:55:23 INFO - ##### 10:55:23 INFO - ##### 10:55:23 INFO - ##### Running install step. 10:55:23 INFO - ##### 10:55:23 INFO - Running pre-action listener: _resource_record_pre_action 10:55:23 INFO - Running main action method: install 10:55:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:55:23 INFO - Reading from file tmpfile_stdout 10:55:23 INFO - Detecting whether we're running mozinstall >=1.0... 10:55:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:55:23 INFO - Reading from file tmpfile_stdout 10:55:23 INFO - Output received: 10:55:23 INFO - Usage: mozinstall [options] installer 10:55:23 INFO - Options: 10:55:23 INFO - -h, --help show this help message and exit 10:55:23 INFO - -d DEST, --destination=DEST 10:55:23 INFO - Directory to install application into. [default: 10:55:23 INFO - "/builds/slave/test"] 10:55:23 INFO - --app=APP Application being installed. [default: firefox] 10:55:23 INFO - mkdir: /builds/slave/test/build/application 10:55:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:55:57 INFO - Reading from file tmpfile_stdout 10:55:57 INFO - Output received: 10:55:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:55:57 INFO - Running post-action listener: _resource_record_post_action 10:55:57 INFO - ##### 10:55:57 INFO - ##### Finished install step (success) 10:55:57 INFO - ##### 10:55:57 INFO - ##### 10:55:57 INFO - ##### Running run-tests step. 10:55:57 INFO - ##### 10:55:57 INFO - Running pre-action listener: _resource_record_pre_action 10:55:57 INFO - Running main action method: run_tests 10:55:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:55:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:55:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:55:57 INFO - 2016-07-15 10:55:57.568 screenresolution[1661:10772] starting screenresolution argv=screenresolution get 10:55:57 INFO - 2016-07-15 10:55:57.570 screenresolution[1661:10772] Display 0: 1600x1200x32@60 10:55:57 INFO - 2016-07-15 10:55:57.577 screenresolution[1662:10774] starting screenresolution argv=screenresolution list 10:55:57 INFO - Available Modes on Display 0 10:55:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:55:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:55:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:55:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:55:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:55:57 INFO - Intel Iris: 10:55:57 INFO - Chipset Model: Intel Iris 10:55:57 INFO - Type: GPU 10:55:57 INFO - Bus: Built-In 10:55:57 INFO - VRAM (Dynamic, Max): 1536 MB 10:55:57 INFO - Vendor: Intel (0x8086) 10:55:57 INFO - Device ID: 0x0a2e 10:55:57 INFO - Revision ID: 0x0009 10:55:57 INFO - Displays: 10:55:57 INFO - Display: 10:55:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:55:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:55:57 INFO - Display Serial Number: 1600x1200 60 10:55:57 INFO - Main Display: Yes 10:55:57 INFO - Mirror: Off 10:55:57 INFO - Online: Yes 10:55:57 INFO - Rotation: Supported 10:55:57 INFO - Return code: 0 10:55:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:55:57 INFO - Python 2.7.3 10:55:57 INFO - Return code: 0 10:55:57 INFO - grabbing minidump binary from tooltool 10:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:57 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093b5d30>, '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 0x10911adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093adb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:55:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:55:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:55:57 INFO - Calling ['/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'] with output_timeout 600 10:55:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:55:57 INFO - Return code: 0 10:55:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:55:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:55:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:55:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:55:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:55:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0319', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0319 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:55:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9gygcHe4QD/Render', 10:55:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:57 INFO - 'HOME': '/Users/cltbld', 10:55:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:57 INFO - 'LOGNAME': 'cltbld', 10:55:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:55:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:57 INFO - 'MOZ_NO_REMOTE': '1', 10:55:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:55:57 INFO - 'NO_EM_RESTART': '1', 10:55:57 INFO - 'PAGER': '/bin/cat', 10:55:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:57 INFO - 'PWD': '/builds/slave/test', 10:55:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:55:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:57 INFO - 'SHELL': '/bin/bash', 10:55:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRbk9E4jh0/Listeners', 10:55:57 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 10:55:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:57 INFO - 'USER': 'cltbld', 10:55:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:57 INFO - 'XPC_FLAGS': '0x0', 10:55:57 INFO - 'XPC_SERVICE_NAME': '0', 10:55:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0319', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:55:58 INFO - mozversion application_buildid: 20160713141046 10:55:58 INFO - mozversion application_changeset: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 10:55:58 INFO - mozversion application_display_name: Nightly 10:55:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:55:58 INFO - mozversion application_name: Firefox 10:55:58 INFO - mozversion application_remotingname: firefox 10:55:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:55:58 INFO - mozversion application_vendor: Mozilla 10:55:58 INFO - mozversion application_version: 50.0a1 10:55:58 INFO - mozversion platform_buildid: 20160713141046 10:55:58 INFO - mozversion platform_changeset: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 10:55:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:55:58 INFO - mozversion platform_version: 50.0a1 10:55:58 INFO - using testdate: 1468605358 10:55:58 INFO - actual date: 1468605358 10:55:58 INFO - starting webserver on 'localhost:49276' 10:55:58 INFO - SUITE-START | Running 2 tests 10:55:58 INFO - TEST-START | dromaeo_css 10:55:58 INFO - operating with platform_type : mac_ 10:55:58 INFO - Initialising browser for dromaeo_css test... 10:55:58 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmpfdXGh2/profile http://localhost:49276/getInfo.html) 10:56:01 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 10:56:01 INFO - PROCESS | 1672 | colorDepth:24 10:56:01 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 10:56:01 INFO - PROCESS | 1672 | __metrics 10:56:01 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 10:56:01 INFO - TEST-INFO | 1672: exit 0 10:56:01 INFO - Browser initialized. 10:56:01 INFO - Running cycle 1/1 for dromaeo_css test... 10:56:01 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmpfdXGh2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:56:13 INFO - PROCESS | 1676 | RSS: Main: 254341120 10:56:13 INFO - PROCESS | 1676 | 10:57:03 INFO - PROCESS | 1676 | 1468605423518 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:59:14 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 10:59:16 INFO - PROCESS | 1676 | RSS: Main: 266944512 10:59:16 INFO - PROCESS | 1676 | 11:02:18 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 11:02:19 INFO - PROCESS | 1676 | RSS: Main: 275443712 11:02:19 INFO - PROCESS | 1676 | 11:05:21 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 11:05:21 INFO - PROCESS | 1676 | RSS: Main: 279764992 11:05:21 INFO - PROCESS | 1676 | 11:08:23 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 11:08:24 INFO - PROCESS | 1676 | RSS: Main: 279216128 11:08:24 INFO - PROCESS | 1676 | 11:11:26 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 11:11:27 INFO - PROCESS | 1676 | RSS: Main: 282726400 11:11:27 INFO - PROCESS | 1676 | 11:14:30 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 11:14:30 INFO - PROCESS | 1676 | RSS: Main: 282595328 11:14:30 INFO - PROCESS | 1676 | 11:14:30 INFO - PROCESS | 1676 | __start_tp_report 11:14:30 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 11:14:30 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 11:14:30 INFO - PROCESS | 1676 | |i|pagename|runs| 11:14:30 INFO - PROCESS | 1676 | |0;dojo.html;3413.522106905032;3421.0421082097014;3447.4139396302644;3449.1894404814866;3460.982695086525;4583.954160458395;4884.755762211888;5523.199136125259;5733.054046082397;5907.468327850493;5833.795817146401;5902.970485147568;5908.113782932563;5931.970340148293;5949.762009519625;5203.375594928614;5266.736663166846;5276.182191760264;5280.762365693534;5448.727563621823;5432.293801805759;5442.2380866678695;5456.127019676853;5478.342598888119;5483.259759932418;5251.6061295403;5281.735913204325;5317.973410132963;5332.840014799563;5334.839954801362;4696.929546056812;5345.732713364355;5362.276092727471;5370.140777475585;5375.838724838261;4978.950210497885;5289.95827399247;5323.6273460857365;5334.67991920486;5360.3299587551555;4841.273808928654;5656.236408084897;5835.212246346731;5890.97054514729;5936.287645482526;4925.2858335541505;5762.394948530427;6074.48366888815;6245.500359971192;6249;6165.414285642902;6278.152449419315;6308.653024083674;6312.715927783261;6322.87354252917;5645.491905728463;5675.233843431125;6057.606255593417;6069.15031895535;6103.542234332354;6428.77499287532;6504.414602685686;6509.1863517060365;6519.511036672268;6533.82391169594;5934.8813023739285;6112.938870611326;6138.631682098999;6155.076738489262;6201.720922558496;5160.303359046556;5249.658772179872;6185.907211391833;6252.968260237101;6330.651814150266;6133.212252453684;6205.2553693557065;6237.064440333987;6289.7169627366875;6296.622202667854;5195.376554813371;6106.703363853616;6253.312135665074;6253.5622506424115;6272.40412160844;5066.392032956069;5096.566791822663;5110.821121260738;5127;5128.3845938486875;4513;4531.796069176895;4550.658700597469;4556.498785133633;4566.4063671723125;5845.707714614252;5914.615549989237;5952.613080149777;6013.6993150342305;6030.366811484819;6208.844778880564;6255.812325630239;6281.497480201573;6288.151099601495;6307.905381419282;5941.287045554561;5956.880862382728;5971.416725361801;5980.401959803985;6012.518998480111;5510.1459273812625;5558.499735023867;5584.860378490489;5607.579431542569;5608.523275521545;6503.804885853432;6507.446867016357;6527.5757075789925;6535.019747037983;6540.345965403421;6331.176946996861;6335.714892829741;6337.429631333202;6347.841303967253;6352.809415717536;6126.548209434937;6314.968425157845;6370.267419246846;6377.107204991212;6520.967395163184;6197.101420293942;6237.719302631302;6247.562670613195;6263.248410190624;6273;6253.530985176039;6265;6272.6236425814595;6272.74909003653;6293.024581189923;6110.224634763573;6118.541109416722;6181.3200547938795;6186.4741496973265;6239.656818875005;5985.311689155803;6204.689765511796;6223.564350495421;6228.065790131516;6259.280182779039;4924.4090709115135;6071.635701857903;6104.786332478342;6143.017117261216;6158.445739883432;6100.611450805989;6108.190302030417;6168.691565421621;6216.53375996793;6218.81343559694;6132.632042077311;6135.447809697149;6137.8060289514;6142.556499222768;6164.753409863555 11:14:30 INFO - PROCESS | 1676 | |1;ext.html;488.479769045966;515.8323544847925;525.1780962793231;534.2440446767823;565.4854082784666;31738.841305793467;43473.13053738923;43475.34786978194;43541.99999999996;43553.128937421236;43192.352114718306;44008.559914400845;44712.32931506022;44969.325460118125;44992.775036124774;9556.76108097298;9693.757656058584;9809;9819.165370943478;9895;9732.318737688365;9818.607255709763;9841.753956151082;9842;9844.753881152958;9806.264530160232;9857.753556161117;9886.863010753783;9896.703098907008;9905.306628536006;9758.463284519348;9760.902390976105;9824.852627210597;9826.65606703762;9873.308868379216;9689.370190937567;9740.074692904163;9795.706128816148;9799.216062714966;9822.459764712938;41884.58115418868;42095.57904420947;42143;42162.36756448656;42510;3305.93388132236;3379.96620033799;3400.778949368283;3407.04455097348;3534.7172226222096;28607.427851443063;31406.842965785254;33230.66769332324;33871.322573548634;34070.48894266588;3311.403947289487;3426;3435;3464;3472.7742696724886;540404;546802;548862;549710;551264;35104.29791404158;36197.81901090478;66695.33304666891;66815;67115.32884671188;35824.82087589546;36011.4598281026;36126;36205.275894481965;36428.63571364252;15041.849581504264;15245.542633721006;15333.386664533517;15475.226238688021;15496.690066198613;12924.483020679256;12954.80567791484;13058.477660893648;13059.21644701321;13093.41079651418;7619.352355049883;7739.110002349802;7797.181295963956;7869.921300786918;7871.921280787119;3212.16483714236;3227.257730721947;3242.562254095667;3244.416005119101;3277.524758909945;944.7165850244899;988.9406635601744;1079.1852151625471;1082.6968448834339;1090.4166271044953;23240.416207565206;31202.375952481278;31335.373292534023;31410.842945785123;31902.042938711875;1017.8829434614966;1076.05844885725;1144.227646338718;1159.252282277926;1253.7116463213513;13716.794248086288;14195.64510887236;15395.923020384826;15641.217939102999;15857.286422111032;573510.3973440318;1008383;1009478;1031506;1035672.7514537106;61568.69215653983;61941.380586194464;62412.687936560025;62580.37419625746;62669;1394.546772299007;1423.5729281215595;1433.0756661952773;1434.168182454174;1435.4904009076836;31342.432878355536;31853.522197167524;32041.359172815948;32611;32675.183120422178;54454.455455444935;54765;55050.44949550453;55073.724631376586;55161.72419137879;556002;556190;561101;561186;563862;27361;27487.037953671526;28158.43683126367;28235.858820705766;28284.85857570699;46933.53066469292;48594.51405486041;50237.24644130414;50852.237216442525;50947;35242.64757352394;40252.79873600613;40972.38541421822;41637.37543936904;42281.57718422776;39359.60640393559;40847;41178.38232426456;41608.167836643705;43393.91515212145;39173.02067448336;39726.60273397229;40174.79475615736;40216.59783402128;40236;33338;35344.82327588346;35370.68759461443;35757.64242357543;35883.92348229557;24588.139415120386;26279;26315.21054368372;26661;26804 11:14:30 INFO - PROCESS | 1676 | |2;jquery.html;386.5728370150981;387.7557139002428;389.417820358564;392.2958289869683;415.6591594892188;20566.691499627497;21759.020844062037;21779.346619601416;22469.325920222378;22471.775282247214;21337.35987920361;21371.572568548658;21932.232371866987;22014.33956981293;22029.889850550764;5809.796657117002;6239.15771370866;6264.123022776815;6277.874442511147;6288.654124023177;6102.938970610281;6153.907691384633;6157.353477884825;6192.0402337637515;6222.222222222223;5993.28080630325;6003.849903752419;6031.0048841941025;6133.355997620252;6193.6283822970545;5218.634695571312;5703.5152012079025;5943.078822782432;6062.120992456091;6176.444120029197;5769.740361683735;5889.204957330791;5908.350081491032;5918.496927761145;5931.614445061057;17081.57296067596;26214;26232.73767262341;27255.727442725518;27735.861320693468;1947.1627200303863;2157.2665293800183;2226.599212141814;2237.474193564511;2344.882755862217;10496.002879726413;10574.259801813876;10657.680269591925;13164.868351316556;14816.666500014942;1768.5843826700716;1904.3239649924355;1915.0999030455664;1964.5186929202437;1990.333238365135;98578;137935.31032344775;140382.89425658522;140791;142132;11670.94164529172;11735.589254376056;11761.647150585497;11773.823392649118;11856.644300670994;14463.49377771773;14482.493112741215;14687.706245875022;14775;14909.850901491063;6664.400203981665;6794.93205067943;8361.372897032747;8877.156670116328;8959.10408959112;7515.624218789038;7656;8626.008009079036;8882.15619516145;8929.883764529433;3866.342721737255;4568.223402021597;4599.862004139881;4681.50844161365;4700.694454860423;1999.3402177281462;2005.9799402006086;2012.1448384436555;2020.090959068425;2059.969100463494;884.3146561414954;895.6686026170229;959.472290240365;970.7767213540925;972.863799068131;18486.260549578135;21216.15135394567;22084.45408821367;22160.224392146196;22268.99789509476;898.4025622960788;980.4117529482254;984.7784248544164;990.6631745206664;1064.1114669251108;10491.895081049244;10613.681589552325;10958.452077396098;11283.66149015531;11409.543618255177;606238;607746;613874;617549;620210;109004;138279;147067;156853.43146568388;158695;973.3867663372031;996.0985308296003;1016.0550687860214;1019.658414431159;1021.065724861758;14802.555923322318;19078.809211907705;19165.904170479058;19255.711164332828;19268.42194734104;50461.49538504568;57275.71362143163;57360.71319643375;57963;58577.70711146417;81608;82942.58528707559;83362;83495.582522087;83829.58085209534;8291;8389.916100838913;8399;8455.069942306218;8479.95760021196;9367.297452691211;12950.287734174712;13104.606861794162;13211.735765284833;13515.391807368494;10454.581816727246;11130.220884538005;11254.94372528132;11354.716132096764;11389.715257118307;9137.40606860552;9293.143345511537;10724.142068634335;10783.892161078289;11554.480048397674;11787.469563869818;11834.408279585814;11842.644720658394;11905.940470297593;11910.940445297718;5664.433556644302;7287.744928927674;7720.691172353043;7805.687772489036;8544.957275213585;9781.706548803262;10341.74145646365;11437.942810285895;11715.472803723682;11812.822807658064 11:14:30 INFO - PROCESS | 1676 | |3;mootools.html;1560.5552417560993;1599.1924078340437;1838.5403649087727;1856.3038860427332;1939.9903000484996;7309.524880882739;8185.386096042791;8771.56142192891;9206.263498920087;9219.81560368793;8852.911470885289;8876.112388761121;9006.819863602725;9014.233790127848;9015.63937442503;2373.525294941014;2399.2682231919257;2399.4961058177805;2411.3248290478696;2413.662087307778;2375.085592047066;2390.462146017141;2401.591729406005;2403.7836594706473;2421.7457166997474;2369.2418426103654;2388.1880160745345;2402.423418379585;2404.519096180762;2406.2300063979533;2349.635806450003;2352.4001379648253;2368.9999999999914;2379.452725873042;2383.7366195916193;2332.090484710964;2354.5290941811704;2356.3873392917794;2357.6817129687443;2368.1593034472685;7277;8999.280057595442;9048;9137.862932056025;9452.676625272466;4608.516105808909;4729.881752956169;5380.300560927094;5387.730613469311;5478.890422191574;3392.9491057634154;3618.203995121069;3695.2055308108884;3719.3863012602887;3719.4048952167523;1089.5805115030691;1106.3804269608963;1110.3869937466106;1112.593903225325;1136.6703655939768;11983;12157;12180.57367992116;12180.878191218064;12232.694182645417;4644.187267228222;4681.408321170818;4849.030193961222;4873.707577545359;4880.707157570486;10113.039261270167;10120.949395253125;10148.188144948386;10153.289269751194;10253.282270241161;5273.235380869753;5294.7617357219015;5294.841154765286;5310.097283461821;5335;3622.239329740731;4754.95245047552;4905.705657660552;4916.631252656065;4948.158813001798;3945.3884647879627;3999.7000224983244;4015.056461731491;4063.004563881868;4088.5707000765087;1289.8516670582815;1297.1827748518563;1299.5971248912867;1306.6472052545948;1311.2591385866954;967.066780556766;975.9365641233297;978.3493976505687;988.5600907596195;994.3586386780486;5453.863653408696;6022.789202377896;6193.535484838655;6269.62382257066;6397.424231819158;973.2603221551531;978.3151793744407;980.2207245240052;995.382862625177;1037.2531777120462;4100.487439070116;4178.644815190682;4188.5811418857875;4239.130978149472;4253.787310634456;10728.015317166193;10892.94553527243;11107.444627768578;11135.665930022113;11167.385793781257;10865;10928.836067458995;11019.504122314514;11089.112870970303;11141.832872506919;8412.663493460315;8513.574321283912;8538.573071346284;8554.871676924726;8569.528675922884;5844.240248767803;5953.166556681981;6219.471344935731;6221.657808820558;6248.500119990481;7932.849736788249;10208.897911020795;10233.437160956219;10447.268691191544;10519.053285204369;10300.321916301666;10318.174546036149;10343.896561034595;10701.19741019411;10738.46307684597;7262.527935684164;7295.963520182365;7324.340809327186;7381.11426628808;7406.14829294638;8381.49711017341;8530.786730331543;8547.74356769298;8590.65637374498;8649.264812490757;7471.140818805907;7641.7707468776025;7722.845543088994;7754.573498457639;7796.727114550963;7576.659050342638;7629.351505122127;7636.312731853937;7636.923630763844;7773.805654858674;7173.282671732994;7210.459215558959;7227.9638601806655;7232.74685386009;7251.673674684546;3930.941035884407;5119.948800512097;5227.843164705065;5259.658122222043;5293.814716484904;5220.3735551734035;5249.4225635180865;5350.919736203882;5409.729513524387;5413.891722165456 11:14:30 INFO - PROCESS | 1676 | |4;prototype.html;276.9543025400809;287.587312206983;320.79789732468544;322.3536808698559;328.10591139145845;4624.4913059563505;5154.226865970107;5787.47912687858;5811.447912448316;5843.532517398608;5037.675134411289;5151.69089854609;5675.404082571333;5754.510866576346;5759.654420734759;3493.6331685173136;4196.811143498535;4308.763018034007;4326.675499337546;4347.108842687241;3889.7163935901085;3899.883003509899;4264.466941632296;4286.185624731306;4308.246056940038;3093.1184612385364;3795.525559305087;3882.1847412043503;3897.922041559167;4176.749395036308;3470.548828652259;4179.456670632799;4192.805526880018;4296.291111966521;4318.330658747899;3658.743887927846;3693.8522459101605;3695.371786796251;3710.1466662667735;3714.9814250928844;5537.667739935577;5566.165075238706;5571.944280557183;5610.298712660918;5611.044213829281;4351.803254105114;4570.154521413549;4876.333488514913;4995.800167993276;5029.239766081879;5259.711370714162;5471.206675032138;6040.5469589780505;6042.667653279068;6256.592266739993;3939.665128464084;4143.901866005481;4159.355299928516;4160.77257209121;4172.833086676529;4844.76458503083;5014.924776128361;5938.61399009063;6066.8786624267705;6363.981762917957;3905.7656540607654;4125.4834550923915;4142.233686767958;4166.541680415152;4202.243596152722;3532.788032718045;3648.744587878823;3727.7390582658954;4256.70203085781;4266.5946735060115;4580.1068791585985;4704.858854234379;4994.500549945049;5015.523525265094;5021.347224860745;5326.813561525328;5902.61632993854;6125.601835880653;6142.170806941006;6175.62946223228;1277.157076329618;1398.356755892301;1399.2653856725096;1412.173878281217;1424.309210033133;866.0084203586983;884.2086332732168;886.4000479135223;889.9332550058772;901.9594118264694;4777.56015668718;5475.616706830484;5516.8966206758805;5567.610267281251;5615.241942337814;5150.97424512875;5493.587980901449;6157.692115394212;6166.321704612489;6174.38256174379;5316.627836051439;5570.022641962126;5579.330480342385;5592.720363981784;5771.740271687784;2478.8512689238705;2707.309636042836;2780.3188218886503;2815.7606603438935;3193.1059303395086;6054.727537260834;6173.722182501798;6181.567290289637;6522.21733391996;6584.670766461753;5366.8658283542445;6176;6474.805755827333;6487.086309538698;6491.285958544557;5928.555358348228;6453.935460645427;6579.605223686594;6586.407223349922;6622;5187.377514698261;5490.80782172622;5717.17101020358;6267.373262673878;6309.558330916791;6156.507479401547;6185.628862268279;6219.937800622117;6228.657423841732;6252.374762523893;5069.391672999116;5103.770330335218;5813.331466881363;5911.793087241926;6041.214642096499;3382.763206575516;4050.1292222172374;4089.8568550100604;4099.241640296555;4140.585941405835;6233.158523599256;6248.906266406098;6267.811965641038;6272.372762723691;6278.636347738278;4806;5301.204819277139;5542.422773410383;5691.288588926384;6111.388861113853;4515.065207615076;5407.540359069523;5407.621056630692;5929.555283353852;5987.64074155552;5037.319961805109;5689.715514224355;5951.791687290924;5971.342752475281;5973.402659733992;5091.567216786467;5129.767332690799;5742.224799652161;5910.556708246812;6010.639361638316;5142.971405718946;5261.026710058652;5418.431064738145;5868.38381969887;5971.790987315423 11:14:30 INFO - PROCESS | 1676 | |5;yui.html;715.3275920634607;723.9782806515805;764.2510339866931;770.295179910382;809.8380323935214;15200.619984500394;15434.650516480564;15810.84189158108;15832.287547060381;15837.445689400873;11509.366984815832;13226.735465290689;13799;14550.490732824353;14577.562673119797;718.7089228862319;895.9820803583924;898.8606765951272;900.1178844732167;911.3483859040784;884.7699598104507;915.555955361649;918.5682729117304;921.9124183202618;922.8477301245287;948.7438391634255;974.8878878928907;978.4814048554277;978.8531720241949;979.8432250839867;928.9256859451227;965.5944503308627;966.9846661005915;969;971.281251873612;703.4548225125518;716.3338095571116;720.5568575326137;722.2236096196557;723.1358526560762;15298.923505382512;15598.532044038697;15738.055716656923;15858.920705396515;15868.365265389371;13376.531821386205;13434.395452204673;13508;13570.606445467582;13734.381952812148;11393.031592314663;13103.2138071716;13337.86662133376;13590.864091359059;13910.721785564232;4627.167109920213;4688.5077066907825;4744.430668319824;4827.541383568555;4852.1508735971065;93044.06955930422;97848;98451;107839;107965.38051929306;11198.776024479628;11451.370174640308;11554.76890462186;11864.762704745857;11912.702182445335;18822.52943676419;19443.4166974991;21300.573988520144;21582.460438488848;22991.080356785875;8322;8387.035490918623;8393.370497212734;8395.202455766814;8443.95778021106;4565.6119229865835;4593.448786145617;4645.163870503342;4665.883352916137;4713.057388522241;3150.779445438843;3637.890863274106;3735.495708079429;3735.6264373562426;3738.700903927679;655.7180412422608;683.1494788987643;687.693382573105;690.7881714896465;717.9461540384492;567.4098937105447;628.6071205496564;670.5339788846704;681.6932380428827;706.7667669668997;9442.763930901783;9573.18627916621;9683.952804414961;9692.951535242279;9805.117539421486;567.8949394362056;574.9396313387118;676.158183062081;682.9282925292872;695.6869408766075;4693.272542755878;4721.905561888743;4731.858044258678;4735.958089220366;4755.976220118877;165031;167122;167531;168012;175470.2452975454;139893;142760;143753;144496;145147;70834;110270.79458410786;118308;126862;126902;9502.904970950201;9763.951180244054;9908.455034972858;9982.362439448516;10209.74475638115;45612.543874560826;46937.82655433642;53532.46467535275;57164;59904.400955989884;86207.5689621548;86835.56582217048;87688.5615571918;88883.55558222167;89491.21017579742;11880.821787673365;12513.061520385825;12547.372631368578;13975.371108299947;14240.430382784572;14221.928890355483;14356.11955784369;15040.398384064514;15098.471553495576;15496.147711875956;14057.578272651837;14235.217063061216;14499;14535.127892326494;14571.41714331415;11569.225242127508;13885.930570347084;14279.928600356932;14444;14780.704385912006;13636.386362613508;13958.58124256274;14097.295135243401;14166.433342666178;14584.927075364556;11601.883981160418;11604.24572402825;11666.125040621817;11721.413929303671;11734.295942243492;11409.828852567383;11454.599089031844;11524.654260372203;11646.301221926711;11692.240004399688 11:14:30 INFO - PROCESS | 1676 | __end_tp_report 11:14:30 INFO - PROCESS | 1676 | __start_cc_report 11:14:30 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,441 11:14:30 INFO - PROCESS | 1676 | __end_cc_report 11:14:30 INFO - PROCESS | 1676 | __startTimestamp1468606470663__endTimestamp 11:14:30 INFO - PROCESS | 1676 | 11:14:30 INFO - PROCESS | 1676 | ------- Summary: start ------- 11:14:30 INFO - PROCESS | 1676 | Number of tests: 6 11:14:30 INFO - PROCESS | 1676 | 11:14:30 INFO - PROCESS | 1676 | [#0] dojo.html Cycles:165 Average:5795.41 Median:6071.64 stddev:656.20 (10.8%) stddev-sans-first:631.05 11:14:30 INFO - PROCESS | 1676 | Values: 3413.5 3421.0 3447.4 3449.2 3461.0 4584.0 4884.8 5523.2 5733.1 5907.5 5833.8 5903.0 5908.1 5932.0 5949.8 5203.4 5266.7 5276.2 5280.8 5448.7 5432.3 5442.2 5456.1 5478.3 5483.3 5251.6 5281.7 5318.0 5332.8 5334.8 4696.9 5345.7 5362.3 5370.1 5375.8 4979.0 5290.0 5323.6 5334.7 5360.3 4841.3 5656.2 5835.2 5891.0 5936.3 4925.3 5762.4 6074.5 6245.5 6249.0 6165.4 6278.2 6308.7 6312.7 6322.9 5645.5 5675.2 6057.6 6069.2 6103.5 6428.8 6504.4 6509.2 6519.5 6533.8 5934.9 6112.9 6138.6 6155.1 6201.7 5160.3 5249.7 6185.9 6253.0 6330.7 6133.2 6205.3 6237.1 6289.7 6296.6 5195.4 6106.7 6253.3 6253.6 6272.4 5066.4 5096.6 5110.8 5127.0 5128.4 4513.0 4531.8 4550.7 4556.5 4566.4 5845.7 5914.6 5952.6 6013.7 6030.4 6208.8 6255.8 6281.5 6288.2 6307.9 5941.3 5956.9 5971.4 5980.4 6012.5 5510.1 5558.5 5584.9 5607.6 5608.5 6503.8 6507.4 6527.6 6535.0 6540.3 6331.2 6335.7 6337.4 6347.8 6352.8 6126.5 6315.0 6370.3 6377.1 6521.0 6197.1 6237.7 6247.6 6263.2 6273.0 6253.5 6265.0 6272.6 6272.7 6293.0 6110.2 6118.5 6181.3 6186.5 6239.7 5985.3 6204.7 6223.6 6228.1 6259.3 4924.4 6071.6 6104.8 6143.0 6158.4 6100.6 6108.2 6168.7 6216.5 6218.8 6132.6 6135.4 6137.8 6142.6 6164.8 11:14:30 INFO - PROCESS | 1676 | 11:14:30 INFO - PROCESS | 1676 | [#1] ext.html Cycles:180 Average:78958.54 Median:40226.30 stddev:192008.21 (477.3%) stddev-sans-first:192456.45 11:14:30 INFO - PROCESS | 1676 | Values: 488.5 515.8 525.2 534.2 565.5 31738.8 43473.1 43475.3 43542.0 43553.1 43192.4 44008.6 44712.3 44969.3 44992.8 9556.8 9693.8 9809.0 9819.2 9895.0 9732.3 9818.6 9841.8 9842.0 9844.8 9806.3 9857.8 9886.9 9896.7 9905.3 9758.5 9760.9 9824.9 9826.7 9873.3 9689.4 9740.1 9795.7 9799.2 9822.5 41884.6 42095.6 42143.0 42162.4 42510.0 3305.9 3380.0 3400.8 3407.0 3534.7 28607.4 31406.8 33230.7 33871.3 34070.5 3311.4 3426.0 3435.0 3464.0 3472.8 540404.0 546802.0 548862.0 549710.0 551264.0 35104.3 36197.8 66695.3 66815.0 67115.3 35824.8 36011.5 36126.0 36205.3 36428.6 15041.8 15245.5 15333.4 15475.2 15496.7 12924.5 12954.8 13058.5 13059.2 13093.4 7619.4 7739.1 7797.2 7869.9 7871.9 3212.2 3227.3 3242.6 3244.4 3277.5 944.7 988.9 1079.2 1082.7 1090.4 23240.4 31202.4 31335.4 31410.8 31902.0 1017.9 1076.1 1144.2 1159.3 1253.7 13716.8 14195.6 15395.9 15641.2 15857.3 573510.4 1008383.0 1009478.0 1031506.0 1035672.8 61568.7 61941.4 62412.7 62580.4 62669.0 1394.5 1423.6 1433.1 1434.2 1435.5 31342.4 31853.5 32041.4 32611.0 32675.2 54454.5 54765.0 55050.4 55073.7 55161.7 556002.0 556190.0 561101.0 561186.0 563862.0 27361.0 27487.0 28158.4 28235.9 28284.9 46933.5 48594.5 50237.2 50852.2 50947.0 35242.6 40252.8 40972.4 41637.4 42281.6 39359.6 40847.0 41178.4 41608.2 43393.9 39173.0 39726.6 40174.8 40216.6 40236.0 33338.0 35344.8 35370.7 35757.6 35883.9 24588.1 26279.0 26315.2 26661.0 26804.0 11:14:30 INFO - PROCESS | 1676 | 11:14:30 INFO - PROCESS | 1676 | [#2] jquery.html Cycles:180 Average:36571.62 Median:26223.37 stddev:103051.35 (393.0%) stddev-sans-first:103304.62 11:14:30 INFO - PROCESS | 1676 | Values: 386.6 387.8 389.4 392.3 415.7 20566.7 21759.0 21779.3 22469.3 22471.8 21337.4 21371.6 21932.2 22014.3 22029.9 5809.8 6239.2 6264.1 6277.9 6288.7 6102.9 6153.9 6157.4 6192.0 6222.2 5993.3 6003.8 6031.0 6133.4 6193.6 5218.6 5703.5 5943.1 6062.1 6176.4 5769.7 5889.2 5908.4 5918.5 5931.6 17081.6 26214.0 26232.7 27255.7 27735.9 1947.2 2157.3 2226.6 2237.5 2344.9 10496.0 10574.3 10657.7 13164.9 14816.7 1768.6 1904.3 1915.1 1964.5 1990.3 98578.0 137935.3 140382.9 140791.0 142132.0 11670.9 11735.6 11761.6 11773.8 11856.6 14463.5 14482.5 14687.7 14775.0 14909.9 6664.4 6794.9 8361.4 8877.2 8959.1 7515.6 7656.0 8626.0 8882.2 8929.9 3866.3 4568.2 4599.9 4681.5 4700.7 1999.3 2006.0 2012.1 2020.1 2060.0 884.3 895.7 959.5 970.8 972.9 18486.3 21216.2 22084.5 22160.2 22269.0 898.4 980.4 984.8 990.7 1064.1 10491.9 10613.7 10958.5 11283.7 11409.5 606238.0 607746.0 613874.0 617549.0 620210.0 109004.0 138279.0 147067.0 156853.4 158695.0 973.4 996.1 1016.1 1019.7 1021.1 14802.6 19078.8 19165.9 19255.7 19268.4 50461.5 57275.7 57360.7 57963.0 58577.7 81608.0 82942.6 83362.0 83495.6 83829.6 8291.0 8389.9 8399.0 8455.1 8480.0 9367.3 12950.3 13104.6 13211.7 13515.4 10454.6 11130.2 11254.9 11354.7 11389.7 9137.4 9293.1 10724.1 10783.9 11554.5 11787.5 11834.4 11842.6 11905.9 11910.9 5664.4 7287.7 7720.7 7805.7 8545.0 9781.7 10341.7 11437.9 11715.5 11812.8 11:14:30 INFO - PROCESS | 1676 | 11:14:30 INFO - PROCESS | 1676 | [#3] mootools.html Cycles:180 Average:5835.48 Median:4742.42 stddev:3281.32 (69.2%) stddev-sans-first:3274.80 11:14:30 INFO - PROCESS | 1676 | Values: 1560.6 1599.2 1838.5 1856.3 1940.0 7309.5 8185.4 8771.6 9206.3 9219.8 8852.9 8876.1 9006.8 9014.2 9015.6 2373.5 2399.3 2399.5 2411.3 2413.7 2375.1 2390.5 2401.6 2403.8 2421.7 2369.2 2388.2 2402.4 2404.5 2406.2 2349.6 2352.4 2369.0 2379.5 2383.7 2332.1 2354.5 2356.4 2357.7 2368.2 7277.0 8999.3 9048.0 9137.9 9452.7 4608.5 4729.9 5380.3 5387.7 5478.9 3392.9 3618.2 3695.2 3719.4 3719.4 1089.6 1106.4 1110.4 1112.6 1136.7 11983.0 12157.0 12180.6 12180.9 12232.7 4644.2 4681.4 4849.0 4873.7 4880.7 10113.0 10120.9 10148.2 10153.3 10253.3 5273.2 5294.8 5294.8 5310.1 5335.0 3622.2 4755.0 4905.7 4916.6 4948.2 3945.4 3999.7 4015.1 4063.0 4088.6 1289.9 1297.2 1299.6 1306.6 1311.3 967.1 975.9 978.3 988.6 994.4 5453.9 6022.8 6193.5 6269.6 6397.4 973.3 978.3 980.2 995.4 1037.3 4100.5 4178.6 4188.6 4239.1 4253.8 10728.0 10892.9 11107.4 11135.7 11167.4 10865.0 10928.8 11019.5 11089.1 11141.8 8412.7 8513.6 8538.6 8554.9 8569.5 5844.2 5953.2 6219.5 6221.7 6248.5 7932.8 10208.9 10233.4 10447.3 10519.1 10300.3 10318.2 10343.9 10701.2 10738.5 7262.5 7296.0 7324.3 7381.1 7406.1 8381.5 8530.8 8547.7 8590.7 8649.3 7471.1 7641.8 7722.8 7754.6 7796.7 7576.7 7629.4 7636.3 7636.9 7773.8 7173.3 7210.5 7228.0 7232.7 7251.7 3930.9 5119.9 5227.8 5259.7 5293.8 5220.4 5249.4 5350.9 5409.7 5413.9 11:14:30 INFO - PROCESS | 1676 | 11:14:30 INFO - PROCESS | 1676 | [#4] prototype.html Cycles:180 Average:4781.16 Median:5321.72 stddev:1521.60 (28.6%) stddev-sans-first:1487.84 11:14:30 INFO - PROCESS | 1676 | Values: 277.0 287.6 320.8 322.4 328.1 4624.5 5154.2 5787.5 5811.4 5843.5 5037.7 5151.7 5675.4 5754.5 5759.7 3493.6 4196.8 4308.8 4326.7 4347.1 3889.7 3899.9 4264.5 4286.2 4308.2 3093.1 3795.5 3882.2 3897.9 4176.7 3470.5 4179.5 4192.8 4296.3 4318.3 3658.7 3693.9 3695.4 3710.1 3715.0 5537.7 5566.2 5571.9 5610.3 5611.0 4351.8 4570.2 4876.3 4995.8 5029.2 5259.7 5471.2 6040.5 6042.7 6256.6 3939.7 4143.9 4159.4 4160.8 4172.8 4844.8 5014.9 5938.6 6066.9 6364.0 3905.8 4125.5 4142.2 4166.5 4202.2 3532.8 3648.7 3727.7 4256.7 4266.6 4580.1 4704.9 4994.5 5015.5 5021.3 5326.8 5902.6 6125.6 6142.2 6175.6 1277.2 1398.4 1399.3 1412.2 1424.3 866.0 884.2 886.4 889.9 902.0 4777.6 5475.6 5516.9 5567.6 5615.2 5151.0 5493.6 6157.7 6166.3 6174.4 5316.6 5570.0 5579.3 5592.7 5771.7 2478.9 2707.3 2780.3 2815.8 3193.1 6054.7 6173.7 6181.6 6522.2 6584.7 5366.9 6176.0 6474.8 6487.1 6491.3 5928.6 6453.9 6579.6 6586.4 6622.0 5187.4 5490.8 5717.2 6267.4 6309.6 6156.5 6185.6 6219.9 6228.7 6252.4 5069.4 5103.8 5813.3 5911.8 6041.2 3382.8 4050.1 4089.9 4099.2 4140.6 6233.2 6248.9 6267.8 6272.4 6278.6 4806.0 5301.2 5542.4 5691.3 6111.4 4515.1 5407.5 5407.6 5929.6 5987.6 5037.3 5689.7 5951.8 5971.3 5973.4 5091.6 5129.8 5742.2 5910.6 6010.6 5143.0 5261.0 5418.4 5868.4 5971.8 11:14:30 INFO - PROCESS | 1676 | 11:14:30 INFO - PROCESS | 1676 | [#5] yui.html Cycles:180 Average:25386.80 Median:3737.16 stddev:41747.85 (1117.1%) stddev-sans-first:41823.87 11:14:30 INFO - PROCESS | 1676 | Values: 715.3 724.0 764.3 770.3 809.8 15200.6 15434.7 15810.8 15832.3 15837.4 11509.4 13226.7 13799.0 14550.5 14577.6 718.7 896.0 898.9 900.1 911.3 884.8 915.6 918.6 921.9 922.8 948.7 974.9 978.5 978.9 979.8 928.9 965.6 967.0 969.0 971.3 703.5 716.3 720.6 722.2 723.1 15298.9 15598.5 15738.1 15858.9 15868.4 13376.5 13434.4 13508.0 13570.6 13734.4 11393.0 13103.2 13337.9 13590.9 13910.7 4627.2 4688.5 4744.4 4827.5 4852.2 93044.1 97848.0 98451.0 107839.0 107965.4 11198.8 11451.4 11554.8 11864.8 11912.7 18822.5 19443.4 21300.6 21582.5 22991.1 8322.0 8387.0 8393.4 8395.2 8444.0 4565.6 4593.4 4645.2 4665.9 4713.1 3150.8 3637.9 3735.5 3735.6 3738.7 655.7 683.1 687.7 690.8 717.9 567.4 628.6 670.5 681.7 706.8 9442.8 9573.2 9684.0 9693.0 9805.1 567.9 574.9 676.2 682.9 695.7 4693.3 4721.9 4731.9 4736.0 4756.0 165031.0 167122.0 167531.0 168012.0 175470.2 139893.0 142760.0 143753.0 144496.0 145147.0 70834.0 110270.8 118308.0 126862.0 126902.0 9502.9 9764.0 9908.5 9982.4 10209.7 45612.5 46937.8 53532.5 57164.0 59904.4 86207.6 86835.6 87688.6 88883.6 89491.2 11880.8 12513.1 12547.4 13975.4 14240.4 14221.9 14356.1 15040.4 15098.5 15496.1 14057.6 14235.2 14499.0 14535.1 14571.4 11569.2 13885.9 14279.9 14444.0 14780.7 13636.4 13958.6 14097.3 14166.4 14584.9 11601.9 11604.2 11666.1 11721.4 11734.3 11409.8 11454.6 11524.7 11646.3 11692.2 11:14:30 INFO - PROCESS | 1676 | -------- Summary: end -------- 11:14:30 INFO - PROCESS | 1676 | 11:14:31 INFO - TEST-INFO | 1676: exit 0 11:14:31 INFO - TEST-OK | dromaeo_css | took 1113091ms 11:14:31 INFO - TEST-START | kraken 11:14:31 INFO - operating with platform_type : mac_ 11:14:31 INFO - Initialising browser for kraken test... 11:14:31 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmpl7kpQQ/profile http://localhost:49276/getInfo.html) 11:14:33 INFO - PROCESS | 1685 | __metrics Screen width/height:1600/1200 11:14:33 INFO - PROCESS | 1685 | colorDepth:24 11:14:33 INFO - PROCESS | 1685 | Browser inner width/height: 1024/689 11:14:33 INFO - PROCESS | 1685 | __metrics 11:14:34 ERROR - PROCESS | 1685 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 11:14:34 INFO - TEST-INFO | 1685: exit 0 11:14:34 INFO - Browser initialized. 11:14:34 INFO - Running cycle 1/1 for kraken test... 11:14:34 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmpl7kpQQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:14:46 INFO - PROCESS | 1687 | RSS: Main: 254005248 11:14:46 INFO - PROCESS | 1687 | 11:14:49 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 11:14:50 INFO - PROCESS | 1687 | RSS: Main: 267481088 11:14:50 INFO - PROCESS | 1687 | 11:14:52 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 11:14:53 INFO - PROCESS | 1687 | RSS: Main: 271052800 11:14:53 INFO - PROCESS | 1687 | 11:14:56 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 11:14:57 INFO - PROCESS | 1687 | RSS: Main: 271093760 11:14:57 INFO - PROCESS | 1687 | 11:14:59 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 11:15:00 INFO - PROCESS | 1687 | RSS: Main: 272117760 11:15:00 INFO - PROCESS | 1687 | 11:15:02 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:15:02 INFO - PROCESS | 1687 | RSS: Main: 272805888 11:15:02 INFO - PROCESS | 1687 | 11:15:05 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 11:15:06 INFO - PROCESS | 1687 | RSS: Main: 273580032 11:15:06 INFO - PROCESS | 1687 | 11:15:09 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 11:15:09 INFO - PROCESS | 1687 | RSS: Main: 273633280 11:15:09 INFO - PROCESS | 1687 | 11:15:13 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 11:15:13 INFO - PROCESS | 1687 | RSS: Main: 273833984 11:15:13 INFO - PROCESS | 1687 | 11:15:15 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:15:15 INFO - PROCESS | 1687 | RSS: Main: 273227776 11:15:15 INFO - PROCESS | 1687 | 11:15:17 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:15:18 INFO - PROCESS | 1687 | RSS: Main: 273231872 11:15:18 INFO - PROCESS | 1687 | 11:15:20 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:15:21 INFO - PROCESS | 1687 | RSS: Main: 273543168 11:15:21 INFO - PROCESS | 1687 | 11:15:24 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:15:25 INFO - PROCESS | 1687 | RSS: Main: 273645568 11:15:25 INFO - PROCESS | 1687 | 11:15:27 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:15:28 INFO - PROCESS | 1687 | RSS: Main: 273821696 11:15:28 INFO - PROCESS | 1687 | 11:15:30 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 11:15:30 INFO - PROCESS | 1687 | RSS: Main: 274771968 11:15:30 INFO - PROCESS | 1687 | 11:15:30 INFO - PROCESS | 1687 | __start_tp_report 11:15:30 INFO - PROCESS | 1687 | _x_x_mozilla_page_load 11:15:30 INFO - PROCESS | 1687 | _x_x_mozilla_page_load_details 11:15:30 INFO - PROCESS | 1687 | |i|pagename|runs| 11:15:30 INFO - PROCESS | 1687 | |0;ai-astar;103;117;107;116;116;117;107;114;116;116 11:15:30 INFO - PROCESS | 1687 | |1;audio-beat-detection;141;109;126;167;144;128;127;108;195;142 11:15:30 INFO - PROCESS | 1687 | |2;audio-dft;196;200;195;219;209;273;276;200;192;278 11:15:30 INFO - PROCESS | 1687 | |3;audio-fft;70;82;76;139;58;60;58;61;136;59 11:15:30 INFO - PROCESS | 1687 | |4;audio-oscillator;70;61;146;58;75;129;148;61;67;121 11:15:30 INFO - PROCESS | 1687 | |5;imaging-gaussian-blur;92;88;101;84;87;84;127;78;76;73 11:15:30 INFO - PROCESS | 1687 | |6;imaging-darkroom;95;150;94;96;95;98;93;96;105;92 11:15:30 INFO - PROCESS | 1687 | |7;imaging-desaturate;94;151;149;93;147;147;86;147;77;150 11:15:30 INFO - PROCESS | 1687 | |8;json-parse-financial;54;55;56;53;57;53;57;55;56;55 11:15:30 INFO - PROCESS | 1687 | |9;json-stringify-tinderbox;67;71;73;69;81;111;112;104;72;72 11:15:30 INFO - PROCESS | 1687 | |10;stanford-crypto-aes;86;82;85;81;85;80;99;73;97;107 11:15:30 INFO - PROCESS | 1687 | |11;stanford-crypto-ccm;141;149;127;127;150;150;151;152;189;159 11:15:30 INFO - PROCESS | 1687 | |12;stanford-crypto-pbkdf2;166;168;161;163;166;160;163;165;161;161 11:15:30 INFO - PROCESS | 1687 | |13;stanford-crypto-sha256-iterative;68;72;68;67;69;64;68;66;67;64 11:15:30 INFO - PROCESS | 1687 | __end_tp_report 11:15:30 INFO - PROCESS | 1687 | __start_cc_report 11:15:30 INFO - PROCESS | 1687 | _x_x_mozilla_cycle_collect,1121 11:15:30 INFO - PROCESS | 1687 | __end_cc_report 11:15:30 INFO - PROCESS | 1687 | __startTimestamp1468606530426__endTimestamp 11:15:30 INFO - PROCESS | 1687 | 11:15:30 INFO - PROCESS | 1687 | ------- Summary: start ------- 11:15:30 INFO - PROCESS | 1687 | Number of tests: 14 11:15:30 INFO - PROCESS | 1687 | 11:15:30 INFO - PROCESS | 1687 | [#0] ai-astar Cycles:10 Average:112.90 Median:116.00 stddev:5.17 (4.5%) stddev-sans-first:4.06 11:15:30 INFO - PROCESS | 1687 | Values: 103.0 117.0 107.0 116.0 116.0 117.0 107.0 114.0 116.0 116.0 11:15:30 INFO - PROCESS | 1687 | 11:15:30 INFO - PROCESS | 1687 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:141.50 stddev:26.36 (18.6%) stddev-sans-first:27.94 11:15:30 INFO - PROCESS | 1687 | Values: 141.0 109.0 126.0 167.0 144.0 128.0 127.0 108.0 195.0 142.0 11:15:30 INFO - PROCESS | 1687 | 11:15:30 INFO - PROCESS | 1687 | [#2] audio-dft Cycles:10 Average:223.80 Median:214.00 stddev:36.62 (17.1%) stddev-sans-first:37.44 11:15:30 INFO - PROCESS | 1687 | Values: 196.0 200.0 195.0 219.0 209.0 273.0 276.0 200.0 192.0 278.0 11:15:30 INFO - PROCESS | 1687 | 11:15:30 INFO - PROCESS | 1687 | [#3] audio-fft Cycles:10 Average:79.90 Median:60.50 stddev:31.46 (52.0%) stddev-sans-first:33.16 11:15:30 INFO - PROCESS | 1687 | Values: 70.0 82.0 76.0 139.0 58.0 60.0 58.0 61.0 136.0 59.0 11:15:30 INFO - PROCESS | 1687 | 11:15:30 INFO - PROCESS | 1687 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:61.00 stddev:37.58 (61.6%) stddev-sans-first:38.88 11:15:30 INFO - PROCESS | 1687 | Values: 70.0 61.0 146.0 58.0 75.0 129.0 148.0 61.0 67.0 121.0 11:15:30 INFO - PROCESS | 1687 | 11:15:30 INFO - PROCESS | 1687 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:84.00 stddev:15.63 (18.6%) stddev-sans-first:16.54 11:15:30 INFO - PROCESS | 1687 | Values: 92.0 88.0 101.0 84.0 87.0 84.0 127.0 78.0 76.0 73.0 11:15:30 INFO - PROCESS | 1687 | 11:15:30 INFO - PROCESS | 1687 | [#6] imaging-darkroom Cycles:10 Average:101.40 Median:95.00 stddev:17.45 (18.4%) stddev-sans-first:18.35 11:15:30 INFO - PROCESS | 1687 | Values: 95.0 150.0 94.0 96.0 95.0 98.0 93.0 96.0 105.0 92.0 11:15:30 INFO - PROCESS | 1687 | 11:15:30 INFO - PROCESS | 1687 | [#7] imaging-desaturate Cycles:10 Average:124.10 Median:114.00 stddev:31.85 (27.9%) stddev-sans-first:31.87 11:15:30 INFO - PROCESS | 1687 | Values: 94.0 151.0 149.0 93.0 147.0 147.0 86.0 147.0 77.0 150.0 11:15:30 INFO - PROCESS | 1687 | 11:15:30 INFO - PROCESS | 1687 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.50 stddev:1.45 (2.6%) stddev-sans-first:1.48 11:15:30 INFO - PROCESS | 1687 | Values: 54.0 55.0 56.0 53.0 57.0 53.0 57.0 55.0 56.0 55.0 11:15:30 INFO - PROCESS | 1687 | 11:15:30 INFO - PROCESS | 1687 | [#9] json-stringify-tinderbox Cycles:10 Average:83.20 Median:71.50 stddev:18.28 (25.6%) stddev-sans-first:18.43 11:15:30 INFO - PROCESS | 1687 | Values: 67.0 71.0 73.0 69.0 81.0 111.0 112.0 104.0 72.0 72.0 11:15:30 INFO - PROCESS | 1687 | 11:15:30 INFO - PROCESS | 1687 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:85.00 stddev:10.31 (12.1%) stddev-sans-first:10.92 11:15:30 INFO - PROCESS | 1687 | Values: 86.0 82.0 85.0 81.0 85.0 80.0 99.0 73.0 97.0 107.0 11:15:30 INFO - PROCESS | 1687 | 11:15:30 INFO - PROCESS | 1687 | [#11] stanford-crypto-ccm Cycles:10 Average:149.50 Median:150.50 stddev:17.46 (11.6%) stddev-sans-first:18.25 11:15:30 INFO - PROCESS | 1687 | Values: 141.0 149.0 127.0 127.0 150.0 150.0 151.0 152.0 189.0 159.0 11:15:30 INFO - PROCESS | 1687 | 11:15:30 INFO - PROCESS | 1687 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.40 Median:164.00 stddev:2.72 (1.7%) stddev-sans-first:2.71 11:15:30 INFO - PROCESS | 1687 | Values: 166.0 168.0 161.0 163.0 166.0 160.0 163.0 165.0 161.0 161.0 11:15:30 INFO - PROCESS | 1687 | 11:15:30 INFO - PROCESS | 1687 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:2.36 (3.5%) stddev-sans-first:2.49 11:15:30 INFO - PROCESS | 1687 | Values: 68.0 72.0 68.0 67.0 69.0 64.0 68.0 66.0 67.0 64.0 11:15:30 INFO - PROCESS | 1687 | -------- Summary: end -------- 11:15:30 INFO - PROCESS | 1687 | 11:15:31 INFO - TEST-INFO | 1687: exit 0 11:15:31 INFO - TEST-OK | kraken | took 60007ms 11:15:31 INFO - SUITE-END | took 1173s 11:15:31 INFO - Completed test suite (00:19:33) 11:15:31 INFO - javascript benchmark 11:15:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7505.640474901676, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3413.522106905032, 3421.0421082097014, 3447.4139396302644, 3449.1894404814866, 3460.982695086525, 4583.954160458395, 4884.755762211888, 5523.199136125259, 5733.054046082397, 5907.468327850493, 5833.795817146401, 5902.970485147568, 5908.113782932563, 5931.970340148293, 5949.762009519625, 5203.375594928614, 5266.736663166846, 5276.182191760264, 5280.762365693534, 5448.727563621823, 5432.293801805759, 5442.2380866678695, 5456.127019676853, 5478.342598888119, 5483.259759932418, 5251.6061295403, 5281.735913204325, 5317.973410132963, 5332.840014799563, 5334.839954801362, 4696.929546056812, 5345.732713364355, 5362.276092727471, 5370.140777475585, 5375.838724838261, 4978.950210497885, 5289.95827399247, 5323.6273460857365, 5334.67991920486, 5360.3299587551555, 4841.273808928654, 5656.236408084897, 5835.212246346731, 5890.97054514729, 5936.287645482526, 4925.2858335541505, 5762.394948530427, 6074.48366888815, 6245.500359971192, 6249.0, 6165.414285642902, 6278.152449419315, 6308.653024083674, 6312.715927783261, 6322.87354252917, 5645.491905728463, 5675.233843431125, 6057.606255593417, 6069.15031895535, 6103.542234332354, 6428.77499287532, 6504.414602685686, 6509.1863517060365, 6519.511036672268, 6533.82391169594, 5934.8813023739285, 6112.938870611326, 6138.631682098999, 6155.076738489262, 6201.720922558496, 5160.303359046556, 5249.658772179872, 6185.907211391833, 6252.968260237101, 6330.651814150266, 6133.212252453684, 6205.2553693557065, 6237.064440333987, 6289.7169627366875, 6296.622202667854, 5195.376554813371, 6106.703363853616, 6253.312135665074, 6253.5622506424115, 6272.40412160844, 5066.392032956069, 5096.566791822663, 5110.821121260738, 5127.0, 5128.3845938486875, 4513.0, 4531.796069176895, 4550.658700597469, 4556.498785133633, 4566.4063671723125, 5845.707714614252, 5914.615549989237, 5952.613080149777, 6013.6993150342305, 6030.366811484819, 6208.844778880564, 6255.812325630239, 6281.497480201573, 6288.151099601495, 6307.905381419282, 5941.287045554561, 5956.880862382728, 5971.416725361801, 5980.401959803985, 6012.518998480111, 5510.1459273812625, 5558.499735023867, 5584.860378490489, 5607.579431542569, 5608.523275521545, 6503.804885853432, 6507.446867016357, 6527.5757075789925, 6535.019747037983, 6540.345965403421, 6331.176946996861, 6335.714892829741, 6337.429631333202, 6347.841303967253, 6352.809415717536, 6126.548209434937, 6314.968425157845, 6370.267419246846, 6377.107204991212, 6520.967395163184, 6197.101420293942, 6237.719302631302, 6247.562670613195, 6263.248410190624, 6273.0, 6253.530985176039, 6265.0, 6272.6236425814595, 6272.74909003653, 6293.024581189923, 6110.224634763573, 6118.541109416722, 6181.3200547938795, 6186.4741496973265, 6239.656818875005, 5985.311689155803, 6204.689765511796, 6223.564350495421, 6228.065790131516, 6259.280182779039, 4924.4090709115135, 6071.635701857903, 6104.786332478342, 6143.017117261216, 6158.445739883432, 6100.611450805989, 6108.190302030417, 6168.691565421621, 6216.53375996793, 6218.81343559694, 6132.632042077311, 6135.447809697149, 6137.8060289514, 6142.556499222768, 6164.753409863555], "value": 5756.37262961486, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.479769045966, 515.8323544847925, 525.1780962793231, 534.2440446767823, 565.4854082784666, 31738.841305793467, 43473.13053738923, 43475.34786978194, 43541.99999999996, 43553.128937421236, 43192.352114718306, 44008.559914400845, 44712.32931506022, 44969.325460118125, 44992.775036124774, 9556.76108097298, 9693.757656058584, 9809.0, 9819.165370943478, 9895.0, 9732.318737688365, 9818.607255709763, 9841.753956151082, 9842.0, 9844.753881152958, 9806.264530160232, 9857.753556161117, 9886.863010753783, 9896.703098907008, 9905.306628536006, 9758.463284519348, 9760.902390976105, 9824.852627210597, 9826.65606703762, 9873.308868379216, 9689.370190937567, 9740.074692904163, 9795.706128816148, 9799.216062714966, 9822.459764712938, 41884.58115418868, 42095.57904420947, 42143.0, 42162.36756448656, 42510.0, 3305.93388132236, 3379.96620033799, 3400.778949368283, 3407.04455097348, 3534.7172226222096, 28607.427851443063, 31406.842965785254, 33230.66769332324, 33871.322573548634, 34070.48894266588, 3311.403947289487, 3426.0, 3435.0, 3464.0, 3472.7742696724886, 540404.0, 546802.0, 548862.0, 549710.0, 551264.0, 35104.29791404158, 36197.81901090478, 66695.33304666891, 66815.0, 67115.32884671188, 35824.82087589546, 36011.4598281026, 36126.0, 36205.275894481965, 36428.63571364252, 15041.849581504264, 15245.542633721006, 15333.386664533517, 15475.226238688021, 15496.690066198613, 12924.483020679256, 12954.80567791484, 13058.477660893648, 13059.21644701321, 13093.41079651418, 7619.352355049883, 7739.110002349802, 7797.181295963956, 7869.921300786918, 7871.921280787119, 3212.16483714236, 3227.257730721947, 3242.562254095667, 3244.416005119101, 3277.524758909945, 944.7165850244899, 988.9406635601744, 1079.1852151625471, 1082.6968448834339, 1090.4166271044953, 23240.416207565206, 31202.375952481278, 31335.373292534023, 31410.842945785123, 31902.042938711875, 1017.8829434614966, 1076.05844885725, 1144.227646338718, 1159.252282277926, 1253.7116463213513, 13716.794248086288, 14195.64510887236, 15395.923020384826, 15641.217939102999, 15857.286422111032, 573510.3973440318, 1008383.0, 1009478.0, 1031506.0, 1035672.7514537106, 61568.69215653983, 61941.380586194464, 62412.687936560025, 62580.37419625746, 62669.0, 1394.546772299007, 1423.5729281215595, 1433.0756661952773, 1434.168182454174, 1435.4904009076836, 31342.432878355536, 31853.522197167524, 32041.359172815948, 32611.0, 32675.183120422178, 54454.455455444935, 54765.0, 55050.44949550453, 55073.724631376586, 55161.72419137879, 556002.0, 556190.0, 561101.0, 561186.0, 563862.0, 27361.0, 27487.037953671526, 28158.43683126367, 28235.858820705766, 28284.85857570699, 46933.53066469292, 48594.51405486041, 50237.24644130414, 50852.237216442525, 50947.0, 35242.64757352394, 40252.79873600613, 40972.38541421822, 41637.37543936904, 42281.57718422776, 39359.60640393559, 40847.0, 41178.38232426456, 41608.167836643705, 43393.91515212145, 39173.02067448336, 39726.60273397229, 40174.79475615736, 40216.59783402128, 40236.0, 33338.0, 35344.82327588346, 35370.68759461443, 35757.64242357543, 35883.92348229557, 24588.139415120386, 26279.0, 26315.21054368372, 26661.0, 26804.0], "value": 19481.620684008212, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.5728370150981, 387.7557139002428, 389.417820358564, 392.2958289869683, 415.6591594892188, 20566.691499627497, 21759.020844062037, 21779.346619601416, 22469.325920222378, 22471.775282247214, 21337.35987920361, 21371.572568548658, 21932.232371866987, 22014.33956981293, 22029.889850550764, 5809.796657117002, 6239.15771370866, 6264.123022776815, 6277.874442511147, 6288.654124023177, 6102.938970610281, 6153.907691384633, 6157.353477884825, 6192.0402337637515, 6222.222222222223, 5993.28080630325, 6003.849903752419, 6031.0048841941025, 6133.355997620252, 6193.6283822970545, 5218.634695571312, 5703.5152012079025, 5943.078822782432, 6062.120992456091, 6176.444120029197, 5769.740361683735, 5889.204957330791, 5908.350081491032, 5918.496927761145, 5931.614445061057, 17081.57296067596, 26214.0, 26232.73767262341, 27255.727442725518, 27735.861320693468, 1947.1627200303863, 2157.2665293800183, 2226.599212141814, 2237.474193564511, 2344.882755862217, 10496.002879726413, 10574.259801813876, 10657.680269591925, 13164.868351316556, 14816.666500014942, 1768.5843826700716, 1904.3239649924355, 1915.0999030455664, 1964.5186929202437, 1990.333238365135, 98578.0, 137935.31032344775, 140382.89425658522, 140791.0, 142132.0, 11670.94164529172, 11735.589254376056, 11761.647150585497, 11773.823392649118, 11856.644300670994, 14463.49377771773, 14482.493112741215, 14687.706245875022, 14775.0, 14909.850901491063, 6664.400203981665, 6794.93205067943, 8361.372897032747, 8877.156670116328, 8959.10408959112, 7515.624218789038, 7656.0, 8626.008009079036, 8882.15619516145, 8929.883764529433, 3866.342721737255, 4568.223402021597, 4599.862004139881, 4681.50844161365, 4700.694454860423, 1999.3402177281462, 2005.9799402006086, 2012.1448384436555, 2020.090959068425, 2059.969100463494, 884.3146561414954, 895.6686026170229, 959.472290240365, 970.7767213540925, 972.863799068131, 18486.260549578135, 21216.15135394567, 22084.45408821367, 22160.224392146196, 22268.99789509476, 898.4025622960788, 980.4117529482254, 984.7784248544164, 990.6631745206664, 1064.1114669251108, 10491.895081049244, 10613.681589552325, 10958.452077396098, 11283.66149015531, 11409.543618255177, 606238.0, 607746.0, 613874.0, 617549.0, 620210.0, 109004.0, 138279.0, 147067.0, 156853.43146568388, 158695.0, 973.3867663372031, 996.0985308296003, 1016.0550687860214, 1019.658414431159, 1021.065724861758, 14802.555923322318, 19078.809211907705, 19165.904170479058, 19255.711164332828, 19268.42194734104, 50461.49538504568, 57275.71362143163, 57360.71319643375, 57963.0, 58577.70711146417, 81608.0, 82942.58528707559, 83362.0, 83495.582522087, 83829.58085209534, 8291.0, 8389.916100838913, 8399.0, 8455.069942306218, 8479.95760021196, 9367.297452691211, 12950.287734174712, 13104.606861794162, 13211.735765284833, 13515.391807368494, 10454.581816727246, 11130.220884538005, 11254.94372528132, 11354.716132096764, 11389.715257118307, 9137.40606860552, 9293.143345511537, 10724.142068634335, 10783.892161078289, 11554.480048397674, 11787.469563869818, 11834.408279585814, 11842.644720658394, 11905.940470297593, 11910.940445297718, 5664.433556644302, 7287.744928927674, 7720.691172353043, 7805.687772489036, 8544.957275213585, 9781.706548803262, 10341.74145646365, 11437.942810285895, 11715.472803723682, 11812.822807658064], "value": 9790.296333645529, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1560.5552417560993, 1599.1924078340437, 1838.5403649087727, 1856.3038860427332, 1939.9903000484996, 7309.524880882739, 8185.386096042791, 8771.56142192891, 9206.263498920087, 9219.81560368793, 8852.911470885289, 8876.112388761121, 9006.819863602725, 9014.233790127848, 9015.63937442503, 2373.525294941014, 2399.2682231919257, 2399.4961058177805, 2411.3248290478696, 2413.662087307778, 2375.085592047066, 2390.462146017141, 2401.591729406005, 2403.7836594706473, 2421.7457166997474, 2369.2418426103654, 2388.1880160745345, 2402.423418379585, 2404.519096180762, 2406.2300063979533, 2349.635806450003, 2352.4001379648253, 2368.9999999999914, 2379.452725873042, 2383.7366195916193, 2332.090484710964, 2354.5290941811704, 2356.3873392917794, 2357.6817129687443, 2368.1593034472685, 7277.0, 8999.280057595442, 9048.0, 9137.862932056025, 9452.676625272466, 4608.516105808909, 4729.881752956169, 5380.300560927094, 5387.730613469311, 5478.890422191574, 3392.9491057634154, 3618.203995121069, 3695.2055308108884, 3719.3863012602887, 3719.4048952167523, 1089.5805115030691, 1106.3804269608963, 1110.3869937466106, 1112.593903225325, 1136.6703655939768, 11983.0, 12157.0, 12180.57367992116, 12180.878191218064, 12232.694182645417, 4644.187267228222, 4681.408321170818, 4849.030193961222, 4873.707577545359, 4880.707157570486, 10113.039261270167, 10120.949395253125, 10148.188144948386, 10153.289269751194, 10253.282270241161, 5273.235380869753, 5294.7617357219015, 5294.841154765286, 5310.097283461821, 5335.0, 3622.239329740731, 4754.95245047552, 4905.705657660552, 4916.631252656065, 4948.158813001798, 3945.3884647879627, 3999.7000224983244, 4015.056461731491, 4063.004563881868, 4088.5707000765087, 1289.8516670582815, 1297.1827748518563, 1299.5971248912867, 1306.6472052545948, 1311.2591385866954, 967.066780556766, 975.9365641233297, 978.3493976505687, 988.5600907596195, 994.3586386780486, 5453.863653408696, 6022.789202377896, 6193.535484838655, 6269.62382257066, 6397.424231819158, 973.2603221551531, 978.3151793744407, 980.2207245240052, 995.382862625177, 1037.2531777120462, 4100.487439070116, 4178.644815190682, 4188.5811418857875, 4239.130978149472, 4253.787310634456, 10728.015317166193, 10892.94553527243, 11107.444627768578, 11135.665930022113, 11167.385793781257, 10865.0, 10928.836067458995, 11019.504122314514, 11089.112870970303, 11141.832872506919, 8412.663493460315, 8513.574321283912, 8538.573071346284, 8554.871676924726, 8569.528675922884, 5844.240248767803, 5953.166556681981, 6219.471344935731, 6221.657808820558, 6248.500119990481, 7932.849736788249, 10208.897911020795, 10233.437160956219, 10447.268691191544, 10519.053285204369, 10300.321916301666, 10318.174546036149, 10343.896561034595, 10701.19741019411, 10738.46307684597, 7262.527935684164, 7295.963520182365, 7324.340809327186, 7381.11426628808, 7406.14829294638, 8381.49711017341, 8530.786730331543, 8547.74356769298, 8590.65637374498, 8649.264812490757, 7471.140818805907, 7641.7707468776025, 7722.845543088994, 7754.573498457639, 7796.727114550963, 7576.659050342638, 7629.351505122127, 7636.312731853937, 7636.923630763844, 7773.805654858674, 7173.282671732994, 7210.459215558959, 7227.9638601806655, 7232.74685386009, 7251.673674684546, 3930.941035884407, 5119.948800512097, 5227.843164705065, 5259.658122222043, 5293.814716484904, 5220.3735551734035, 5249.4225635180865, 5350.919736203882, 5409.729513524387, 5413.891722165456], "value": 4703.542835829547, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.9543025400809, 287.587312206983, 320.79789732468544, 322.3536808698559, 328.10591139145845, 4624.4913059563505, 5154.226865970107, 5787.47912687858, 5811.447912448316, 5843.532517398608, 5037.675134411289, 5151.69089854609, 5675.404082571333, 5754.510866576346, 5759.654420734759, 3493.6331685173136, 4196.811143498535, 4308.763018034007, 4326.675499337546, 4347.108842687241, 3889.7163935901085, 3899.883003509899, 4264.466941632296, 4286.185624731306, 4308.246056940038, 3093.1184612385364, 3795.525559305087, 3882.1847412043503, 3897.922041559167, 4176.749395036308, 3470.548828652259, 4179.456670632799, 4192.805526880018, 4296.291111966521, 4318.330658747899, 3658.743887927846, 3693.8522459101605, 3695.371786796251, 3710.1466662667735, 3714.9814250928844, 5537.667739935577, 5566.165075238706, 5571.944280557183, 5610.298712660918, 5611.044213829281, 4351.803254105114, 4570.154521413549, 4876.333488514913, 4995.800167993276, 5029.239766081879, 5259.711370714162, 5471.206675032138, 6040.5469589780505, 6042.667653279068, 6256.592266739993, 3939.665128464084, 4143.901866005481, 4159.355299928516, 4160.77257209121, 4172.833086676529, 4844.76458503083, 5014.924776128361, 5938.61399009063, 6066.8786624267705, 6363.981762917957, 3905.7656540607654, 4125.4834550923915, 4142.233686767958, 4166.541680415152, 4202.243596152722, 3532.788032718045, 3648.744587878823, 3727.7390582658954, 4256.70203085781, 4266.5946735060115, 4580.1068791585985, 4704.858854234379, 4994.500549945049, 5015.523525265094, 5021.347224860745, 5326.813561525328, 5902.61632993854, 6125.601835880653, 6142.170806941006, 6175.62946223228, 1277.157076329618, 1398.356755892301, 1399.2653856725096, 1412.173878281217, 1424.309210033133, 866.0084203586983, 884.2086332732168, 886.4000479135223, 889.9332550058772, 901.9594118264694, 4777.56015668718, 5475.616706830484, 5516.8966206758805, 5567.610267281251, 5615.241942337814, 5150.97424512875, 5493.587980901449, 6157.692115394212, 6166.321704612489, 6174.38256174379, 5316.627836051439, 5570.022641962126, 5579.330480342385, 5592.720363981784, 5771.740271687784, 2478.8512689238705, 2707.309636042836, 2780.3188218886503, 2815.7606603438935, 3193.1059303395086, 6054.727537260834, 6173.722182501798, 6181.567290289637, 6522.21733391996, 6584.670766461753, 5366.8658283542445, 6176.0, 6474.805755827333, 6487.086309538698, 6491.285958544557, 5928.555358348228, 6453.935460645427, 6579.605223686594, 6586.407223349922, 6622.0, 5187.377514698261, 5490.80782172622, 5717.17101020358, 6267.373262673878, 6309.558330916791, 6156.507479401547, 6185.628862268279, 6219.937800622117, 6228.657423841732, 6252.374762523893, 5069.391672999116, 5103.770330335218, 5813.331466881363, 5911.793087241926, 6041.214642096499, 3382.763206575516, 4050.1292222172374, 4089.8568550100604, 4099.241640296555, 4140.585941405835, 6233.158523599256, 6248.906266406098, 6267.811965641038, 6272.372762723691, 6278.636347738278, 4806.0, 5301.204819277139, 5542.422773410383, 5691.288588926384, 6111.388861113853, 4515.065207615076, 5407.540359069523, 5407.621056630692, 5929.555283353852, 5987.64074155552, 5037.319961805109, 5689.715514224355, 5951.791687290924, 5971.342752475281, 5973.402659733992, 5091.567216786467, 5129.767332690799, 5742.224799652161, 5910.556708246812, 6010.639361638316, 5142.971405718946, 5261.026710058652, 5418.431064738145, 5868.38381969887, 5971.790987315423], "value": 4289.660323206488, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.3275920634607, 723.9782806515805, 764.2510339866931, 770.295179910382, 809.8380323935214, 15200.619984500394, 15434.650516480564, 15810.84189158108, 15832.287547060381, 15837.445689400873, 11509.366984815832, 13226.735465290689, 13799.0, 14550.490732824353, 14577.562673119797, 718.7089228862319, 895.9820803583924, 898.8606765951272, 900.1178844732167, 911.3483859040784, 884.7699598104507, 915.555955361649, 918.5682729117304, 921.9124183202618, 922.8477301245287, 948.7438391634255, 974.8878878928907, 978.4814048554277, 978.8531720241949, 979.8432250839867, 928.9256859451227, 965.5944503308627, 966.9846661005915, 969.0, 971.281251873612, 703.4548225125518, 716.3338095571116, 720.5568575326137, 722.2236096196557, 723.1358526560762, 15298.923505382512, 15598.532044038697, 15738.055716656923, 15858.920705396515, 15868.365265389371, 13376.531821386205, 13434.395452204673, 13508.0, 13570.606445467582, 13734.381952812148, 11393.031592314663, 13103.2138071716, 13337.86662133376, 13590.864091359059, 13910.721785564232, 4627.167109920213, 4688.5077066907825, 4744.430668319824, 4827.541383568555, 4852.1508735971065, 93044.06955930422, 97848.0, 98451.0, 107839.0, 107965.38051929306, 11198.776024479628, 11451.370174640308, 11554.76890462186, 11864.762704745857, 11912.702182445335, 18822.52943676419, 19443.4166974991, 21300.573988520144, 21582.460438488848, 22991.080356785875, 8322.0, 8387.035490918623, 8393.370497212734, 8395.202455766814, 8443.95778021106, 4565.6119229865835, 4593.448786145617, 4645.163870503342, 4665.883352916137, 4713.057388522241, 3150.779445438843, 3637.890863274106, 3735.495708079429, 3735.6264373562426, 3738.700903927679, 655.7180412422608, 683.1494788987643, 687.693382573105, 690.7881714896465, 717.9461540384492, 567.4098937105447, 628.6071205496564, 670.5339788846704, 681.6932380428827, 706.7667669668997, 9442.763930901783, 9573.18627916621, 9683.952804414961, 9692.951535242279, 9805.117539421486, 567.8949394362056, 574.9396313387118, 676.158183062081, 682.9282925292872, 695.6869408766075, 4693.272542755878, 4721.905561888743, 4731.858044258678, 4735.958089220366, 4755.976220118877, 165031.0, 167122.0, 167531.0, 168012.0, 175470.2452975454, 139893.0, 142760.0, 143753.0, 144496.0, 145147.0, 70834.0, 110270.79458410786, 118308.0, 126862.0, 126902.0, 9502.904970950201, 9763.951180244054, 9908.455034972858, 9982.362439448516, 10209.74475638115, 45612.543874560826, 46937.82655433642, 53532.46467535275, 57164.0, 59904.400955989884, 86207.5689621548, 86835.56582217048, 87688.5615571918, 88883.55558222167, 89491.21017579742, 11880.821787673365, 12513.061520385825, 12547.372631368578, 13975.371108299947, 14240.430382784572, 14221.928890355483, 14356.11955784369, 15040.398384064514, 15098.471553495576, 15496.147711875956, 14057.578272651837, 14235.217063061216, 14499.0, 14535.127892326494, 14571.41714331415, 11569.225242127508, 13885.930570347084, 14279.928600356932, 14444.0, 14780.704385912006, 13636.386362613508, 13958.58124256274, 14097.295135243401, 14166.433342666178, 14584.927075364556, 11601.883981160418, 11604.24572402825, 11666.125040621817, 11721.413929303671, 11734.295942243492, 11409.828852567383, 11454.599089031844, 11524.654260372203, 11646.301221926711, 11692.240004399688], "value": 8069.867670183918, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1569.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 117.0, 107.0, 116.0, 116.0, 117.0, 107.0, 114.0, 116.0, 116.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 109.0, 126.0, 167.0, 144.0, 128.0, 127.0, 108.0, 195.0, 142.0], "value": 138.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 200.0, 195.0, 219.0, 209.0, 273.0, 276.0, 200.0, 192.0, 278.0], "value": 223.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 82.0, 76.0, 139.0, 58.0, 60.0, 58.0, 61.0, 136.0, 59.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 61.0, 146.0, 58.0, 75.0, 129.0, 148.0, 61.0, 67.0, 121.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 101.0, 84.0, 87.0, 84.0, 127.0, 78.0, 76.0, 73.0], "value": 89.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 150.0, 94.0, 96.0, 95.0, 98.0, 93.0, 96.0, 105.0, 92.0], "value": 101.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 151.0, 149.0, 93.0, 147.0, 147.0, 86.0, 147.0, 77.0, 150.0], "value": 124.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 56.0, 53.0, 57.0, 53.0, 57.0, 55.0, 56.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 73.0, 69.0, 81.0, 111.0, 112.0, 104.0, 72.0, 72.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 85.0, 81.0, 85.0, 80.0, 99.0, 73.0, 97.0, 107.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 149.0, 127.0, 127.0, 150.0, 150.0, 151.0, 152.0, 189.0, 159.0], "value": 149.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 161.0, 163.0, 166.0, 160.0, 163.0, 165.0, 161.0, 161.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 68.0, 67.0, 69.0, 64.0, 68.0, 66.0, 67.0, 64.0], "value": 67.3, "unit": "score"}]}]} 11:15:31 INFO - Return code: 0 11:15:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:15:31 ERROR - # TBPL SUCCESS # 11:15:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:15:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:15:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:15:31 INFO - 2016-07-15 11:15:31.733 screenresolution[1692:13789] starting screenresolution argv=screenresolution get 11:15:31 INFO - 2016-07-15 11:15:31.735 screenresolution[1692:13789] Display 0: 1600x1200x32@60 11:15:31 INFO - 2016-07-15 11:15:31.741 screenresolution[1693:13792] starting screenresolution argv=screenresolution list 11:15:31 INFO - Available Modes on Display 0 11:15:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:15:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:15:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:15:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:15:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:15:31 INFO - Intel Iris: 11:15:31 INFO - Chipset Model: Intel Iris 11:15:31 INFO - Type: GPU 11:15:31 INFO - Bus: Built-In 11:15:31 INFO - VRAM (Dynamic, Max): 1536 MB 11:15:31 INFO - Vendor: Intel (0x8086) 11:15:31 INFO - Device ID: 0x0a2e 11:15:31 INFO - Revision ID: 0x0009 11:15:31 INFO - Displays: 11:15:31 INFO - Display: 11:15:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:15:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:15:31 INFO - Display Serial Number: 1600x1200 60 11:15:31 INFO - Main Display: Yes 11:15:31 INFO - Mirror: Off 11:15:31 INFO - Online: Yes 11:15:31 INFO - Rotation: Supported 11:15:31 INFO - Return code: 0 11:15:31 INFO - Running post-action listener: _resource_record_post_action 11:15:31 INFO - ##### 11:15:31 INFO - ##### Finished run-tests step (success) 11:15:31 INFO - ##### 11:15:31 INFO - Running post-run listener: _resource_record_post_run 11:15:32 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 43053568; Write bytes: 719872000; Read time: 333; Write time: 2111 11:15:32 INFO - TinderboxPrint: CPU usage
54.2% 11:15:32 INFO - TinderboxPrint: I/O read bytes / time
43,053,568 / 333 11:15:32 INFO - TinderboxPrint: I/O write bytes / time
719,872,000 / 2,111 11:15:32 INFO - TinderboxPrint: CPU idle
2,213.0 (45.8%) 11:15:32 INFO - TinderboxPrint: CPU system
972.5 (20.1%) 11:15:32 INFO - TinderboxPrint: CPU user
1,648.1 (34.1%) 11:15:32 INFO - TinderboxPrint: Swap in / out
438,767,616 / 0 11:15:32 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403122688; Write bytes: 396961792; Read time: 29591; Write time: 835 11:15:32 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 40956416; Write bytes: 309221376; Read time: 312; Write time: 1242 11:15:32 INFO - Running post-run listener: _upload_blobber_files 11:15:32 INFO - Blob upload gear active. 11:15:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:15:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:15:32 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:15:32 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:15:32 INFO - (blobuploader) - INFO - Open directory for files ... 11:15:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:15:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:15:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:15:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:15:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:15:34 INFO - (blobuploader) - INFO - Done attempting. 11:15:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:15:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:15:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:15:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:15:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:15:34 INFO - (blobuploader) - INFO - Done attempting. 11:15:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:15:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:15:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:15:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:15:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:15:37 INFO - (blobuploader) - INFO - Done attempting. 11:15:37 INFO - (blobuploader) - INFO - Iteration through files over. 11:15:37 INFO - Return code: 0 11:15:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:15:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:15:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c4ffa0e7c258e74dddfa5dc26f9b0d0af0e55524caebf55f7f7ec362e5168861b7fe40c81045fb24dca82c4b2a8bc95aec338bddeb0d8ae2512838413627421", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/539832d39f13d6d6794ffdcca69821d9b245f911085dfb7bd2e78d2f3ef2abdc470764ba91ae4aba9368077d90c409649eeeb39a34ac183ade47dd553ab01809", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4a1db67dfc697fb69253a2d37e3cacf2a4e5f01a569d9e64bee9b56f327d607a48cce49a9770a4ad3f1e5cc414be40fa6458e92fbd47c561f721cfbad538d8a"} 11:15:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:15:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:15:37 INFO - Contents: 11:15:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c4ffa0e7c258e74dddfa5dc26f9b0d0af0e55524caebf55f7f7ec362e5168861b7fe40c81045fb24dca82c4b2a8bc95aec338bddeb0d8ae2512838413627421", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/539832d39f13d6d6794ffdcca69821d9b245f911085dfb7bd2e78d2f3ef2abdc470764ba91ae4aba9368077d90c409649eeeb39a34ac183ade47dd553ab01809", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4a1db67dfc697fb69253a2d37e3cacf2a4e5f01a569d9e64bee9b56f327d607a48cce49a9770a4ad3f1e5cc414be40fa6458e92fbd47c561f721cfbad538d8a"} 11:15:37 INFO - Running post-run listener: copy_logs_to_upload_dir 11:15:37 INFO - Copying logs to upload dir... 11:15:37 INFO - mkdir: /builds/slave/test/build/upload/logs 11:15:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1397.348614 ========= master_lag: 3.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 20 secs) (at 2016-07-15 11:15:40.589903) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 11:15:40.594017) ========= 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.9gygcHe4QD/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.eRbk9E4jh0/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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/Firefox/sha512/7c4ffa0e7c258e74dddfa5dc26f9b0d0af0e55524caebf55f7f7ec362e5168861b7fe40c81045fb24dca82c4b2a8bc95aec338bddeb0d8ae2512838413627421", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/539832d39f13d6d6794ffdcca69821d9b245f911085dfb7bd2e78d2f3ef2abdc470764ba91ae4aba9368077d90c409649eeeb39a34ac183ade47dd553ab01809", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4a1db67dfc697fb69253a2d37e3cacf2a4e5f01a569d9e64bee9b56f327d607a48cce49a9770a4ad3f1e5cc414be40fa6458e92fbd47c561f721cfbad538d8a"} build_url:https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011028 build_url: 'https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c4ffa0e7c258e74dddfa5dc26f9b0d0af0e55524caebf55f7f7ec362e5168861b7fe40c81045fb24dca82c4b2a8bc95aec338bddeb0d8ae2512838413627421", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/539832d39f13d6d6794ffdcca69821d9b245f911085dfb7bd2e78d2f3ef2abdc470764ba91ae4aba9368077d90c409649eeeb39a34ac183ade47dd553ab01809", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4a1db67dfc697fb69253a2d37e3cacf2a4e5f01a569d9e64bee9b56f327d607a48cce49a9770a4ad3f1e5cc414be40fa6458e92fbd47c561f721cfbad538d8a"}' ========= master_lag: 0.78 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 11:15:41.388047) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:15:41.388382) ========= 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.9gygcHe4QD/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.eRbk9E4jh0/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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.005098 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:15:41.415083) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 11:15:41.415393) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 11:15:41.415690) ========= ========= Total master_lag: 3.97 =========