builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0047 starttime: 1471658257.6 results: success (0) buildid: 20160819173814 builduid: 0e5219a2f33542b795cd4e097f09ce50 revision: 30fa88c82366a358f412ca2cc3268142c8991f0d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 18:57:37.598167) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 18:57:37.598612) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 18:57:37.598914) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 18:57:37.622950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 18:57:37.623330) ========= 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.Rn8vQYkGKI/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.T7wRrpoa27/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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-08-19 18:57:37-- 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% 6.85M=0.002s 2016-08-19 18:57:37 (6.85 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114841 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 18:57:37.760568) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 18:57:37.760889) ========= 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.Rn8vQYkGKI/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.T7wRrpoa27/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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.020933 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 18:57:37.825550) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 18:57:37.825909) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 30fa88c82366a358f412ca2cc3268142c8991f0d --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 30fa88c82366a358f412ca2cc3268142c8991f0d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Rn8vQYkGKI/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.T7wRrpoa27/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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-08-19 18:57:37,901 truncating revision to first 12 chars 2016-08-19 18:57:37,901 Setting DEBUG logging. 2016-08-19 18:57:37,901 attempt 1/10 2016-08-19 18:57:37,901 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/30fa88c82366?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 18:57:39,160 unpacking tar archive at: mozilla-central-30fa88c82366/testing/mozharness/ program finished with exit code 0 elapsedTime=1.527238 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 18:57:39.376309) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 18:57:39.376614) ========= script_repo_revision: 30fa88c82366a358f412ca2cc3268142c8991f0d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 18:57:39.377012) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 18:57:39.377278) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 18:57:39.396140) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-19 18:57:39.396550) ========= /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.Rn8vQYkGKI/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.T7wRrpoa27/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 18:57:39 INFO - MultiFileLogger online at 20160819 18:57:39 in /builds/slave/test 18:57:39 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 18:57:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:57:39 INFO - {'append_to_log': False, 18:57:39 INFO - 'base_work_dir': '/builds/slave/test', 18:57:39 INFO - 'blob_upload_branch': 'Firefox', 18:57:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:57:39 INFO - 'branch': 'Firefox', 18:57:39 INFO - 'buildbot_json_path': 'buildprops.json', 18:57:39 INFO - 'config_files': ('talos/mac_config.py',), 18:57:39 INFO - 'default_actions': ('clobber', 18:57:39 INFO - 'read-buildbot-config', 18:57:39 INFO - 'download-and-extract', 18:57:39 INFO - 'populate-webroot', 18:57:39 INFO - 'create-virtualenv', 18:57:39 INFO - 'install', 18:57:39 INFO - 'run-tests'), 18:57:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:57:39 INFO - 'download_minidump_stackwalk': True, 18:57:39 INFO - 'download_symbols': 'ondemand', 18:57:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:57:39 INFO - 'tooltool.py': '/tools/tooltool.py', 18:57:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:57:39 INFO - '/tools/misc-python/virtualenv.py')}, 18:57:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:57:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:57:39 INFO - 'installer_path': 'installer.exe', 18:57:39 INFO - 'log_level': 'info', 18:57:39 INFO - 'log_name': 'talos', 18:57:39 INFO - 'log_to_console': True, 18:57:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:57:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:57:39 INFO - 'opt_config_files': (), 18:57:39 INFO - 'pip_index': False, 18:57:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:57:39 INFO - 'cmd': ('bash', 18:57:39 INFO - '-c', 18:57:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:57:39 INFO - 'enabled': True, 18:57:39 INFO - 'halt_on_failure': False, 18:57:39 INFO - 'name': 'check_screen_resolution'},), 18:57:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:57:39 INFO - 'cmd': ('bash', 18:57:39 INFO - '-c', 18:57:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:57:39 INFO - 'enabled': True, 18:57:39 INFO - 'halt_on_failure': False, 18:57:39 INFO - 'name': 'check_screen_resolution'},), 18:57:39 INFO - 'run_cmd_checks_enabled': True, 18:57:39 INFO - 'sps_profile': False, 18:57:39 INFO - 'sps_profile_interval': 0, 18:57:39 INFO - 'suite': 'dromaeojs-e10s', 18:57:39 INFO - 'system_bits': '32', 18:57:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:57:39 INFO - 'title': 't-yosemite-r7-0047', 18:57:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:57:39 INFO - 'use_talos_json': True, 18:57:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:57:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:57:39 INFO - 'work_dir': 'build'} 18:57:39 INFO - [mozharness: 2016-08-20 01:57:39.588240Z] Running clobber step. 18:57:39 INFO - Running pre-action listener: _resource_record_pre_action 18:57:39 INFO - Running main action method: clobber 18:57:39 INFO - rmtree: /builds/slave/test/build 18:57:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:57:41 INFO - Running post-action listener: _resource_record_post_action 18:57:41 INFO - [mozharness: 2016-08-20 01:57:41.048985Z] Finished clobber step (success) 18:57:41 INFO - [mozharness: 2016-08-20 01:57:41.049162Z] Running read-buildbot-config step. 18:57:41 INFO - Running pre-action listener: _resource_record_pre_action 18:57:41 INFO - Running main action method: read_buildbot_config 18:57:41 INFO - Using buildbot properties: 18:57:41 INFO - { 18:57:41 INFO - "project": "", 18:57:41 INFO - "product": "firefox", 18:57:41 INFO - "script_repo_revision": "production", 18:57:41 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 18:57:41 INFO - "repository": "", 18:57:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 18:57:41 INFO - "buildid": "20160819173814", 18:57:41 INFO - "pgo_build": "False", 18:57:41 INFO - "basedir": "/builds/slave/test", 18:57:41 INFO - "buildnumber": 45, 18:57:41 INFO - "slavename": "t-yosemite-r7-0047", 18:57:41 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 18:57:41 INFO - "platform": "yosemite_r7", 18:57:41 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:57:41 INFO - "branch": "mozilla-central", 18:57:41 INFO - "repo_path": "mozilla-central", 18:57:41 INFO - "revision": "30fa88c82366a358f412ca2cc3268142c8991f0d", 18:57:41 INFO - "stage_platform": "macosx64", 18:57:41 INFO - "builduid": "0e5219a2f33542b795cd4e097f09ce50", 18:57:41 INFO - "slavebuilddir": "test" 18:57:41 INFO - } 18:57:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 18:57:41 INFO - Running post-action listener: _resource_record_post_action 18:57:41 INFO - [mozharness: 2016-08-20 01:57:41.052672Z] Finished read-buildbot-config step (success) 18:57:41 INFO - [mozharness: 2016-08-20 01:57:41.052770Z] Running download-and-extract step. 18:57:41 INFO - Running pre-action listener: _resource_record_pre_action 18:57:41 INFO - Running main action method: download_and_extract 18:57:41 INFO - mkdir: /builds/slave/test/build/tests 18:57: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:41 INFO - trying https://queue.taskcluster.net/v1/task/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 18:57:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 18:57:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 18:57:42 INFO - Downloaded 1199 bytes. 18:57:42 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 18:57:42 INFO - Using the following test package requirements: 18:57:42 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 18:57:42 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:57:42 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 18:57:42 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:57:42 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 18:57:42 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:57:42 INFO - u'jsshell-mac.zip'], 18:57:42 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:57:42 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 18:57:42 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 18:57:42 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:57:42 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 18:57:42 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:57:42 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 18:57:42 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:57:42 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 18:57:42 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:57:42 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 18:57:42 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:42 INFO - trying https://queue.taskcluster.net/v1/task/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 18:57:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 18:57:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:57:43 INFO - Downloaded 16351301 bytes. 18:57:43 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 18:57:50 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:57:50 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:50 INFO - trying https://queue.taskcluster.net/v1/task/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 18:57:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 18:57:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:57:51 INFO - Downloaded 16351301 bytes. 18:57:51 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 18:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:58 INFO - trying https://queue.taskcluster.net/v1/task/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 18:57:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 18:57:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:57:59 INFO - Downloaded 14413981 bytes. 18:57:59 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 18:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:59 INFO - trying https://queue.taskcluster.net/v1/task/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 18:57:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 18:57:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 18:58:02 INFO - Downloaded 111464663 bytes. 18:58:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 18:58:02 INFO - mkdir: /builds/slave/test/properties 18:58:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:58:02 INFO - Writing to file /builds/slave/test/properties/build_url 18:58:02 INFO - Contents: 18:58:02 INFO - build_url:https://queue.taskcluster.net/v1/task/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 18:58:03 INFO - Running post-action listener: _resource_record_post_action 18:58:03 INFO - Running post-action listener: set_extra_try_arguments 18:58:03 INFO - [mozharness: 2016-08-20 01:58:03.336669Z] Finished download-and-extract step (success) 18:58:03 INFO - [mozharness: 2016-08-20 01:58:03.336818Z] Running populate-webroot step. 18:58:03 INFO - Running pre-action listener: _resource_record_pre_action 18:58:03 INFO - Running main action method: populate_webroot 18:58:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:58:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:58:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:58:03 INFO - '--tppagecycles', 18:58:03 INFO - '7'], 18:58:03 INFO - 'tests': ['tsvgm']}}, 18:58:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:58:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:58:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:58:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:58:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:58:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:58:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:03 INFO - 'talos_options': ['--disable-e10s'], 18:58:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:58:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:58:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:03 INFO - 'talos_options': ['--disable-e10s'], 18:58:03 INFO - 'tests': ['damp', 'tps']}, 18:58:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:03 INFO - 'tests': ['damp', 'tps']}, 18:58:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:58:03 INFO - 'tests': ['dromaeo_dom']}, 18:58:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:58:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:58:03 INFO - 'tests': ['basic_compositor_video']}, 18:58:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:58:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:58:03 INFO - 'tests': ['a11yr', 18:58:03 INFO - 'ts_paint', 18:58:03 INFO - 'tpaint', 18:58:03 INFO - 'sessionrestore', 18:58:03 INFO - 'sessionrestore_no_auto_restore', 18:58:03 INFO - 'tabpaint']}, 18:58:03 INFO - 'other-e10s': {'tests': ['a11yr', 18:58:03 INFO - 'ts_paint', 18:58:03 INFO - 'tpaint', 18:58:03 INFO - 'sessionrestore', 18:58:03 INFO - 'sessionrestore_no_auto_restore', 18:58:03 INFO - 'tabpaint']}, 18:58:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:58:03 INFO - 'ts_paint', 18:58:03 INFO - 'tpaint', 18:58:03 INFO - 'sessionrestore', 18:58:03 INFO - 'sessionrestore_no_auto_restore', 18:58:03 INFO - 'tabpaint']}, 18:58:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:58:03 INFO - 'ts_paint', 18:58:03 INFO - 'tpaint', 18:58:03 INFO - 'sessionrestore', 18:58:03 INFO - 'sessionrestore_no_auto_restore', 18:58:03 INFO - 'tabpaint']}, 18:58:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:58:03 INFO - 'tests': ['a11yr', 18:58:03 INFO - 'ts_paint', 18:58:03 INFO - 'tpaint', 18:58:03 INFO - 'sessionrestore', 18:58:03 INFO - 'sessionrestore_no_auto_restore', 18:58:03 INFO - 'tabpaint']}, 18:58:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:58:03 INFO - 'tests': ['a11yr', 18:58:03 INFO - 'ts_paint', 18:58:03 INFO - 'tpaint', 18:58:03 INFO - 'sessionrestore', 18:58:03 INFO - 'sessionrestore_no_auto_restore', 18:58:03 INFO - 'tabpaint']}, 18:58:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:58:03 INFO - 'tests': ['tsvgx', 18:58:03 INFO - 'tsvgr_opacity', 18:58:03 INFO - 'tart', 18:58:03 INFO - 'tscrollx', 18:58:03 INFO - 'cart']}, 18:58:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:58:03 INFO - 'tsvgr_opacity', 18:58:03 INFO - 'tart', 18:58:03 INFO - 'tscrollx', 18:58:03 INFO - 'cart']}, 18:58:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:03 INFO - 'talos_options': ['--disable-e10s'], 18:58:03 INFO - 'tests': ['tp5o']}, 18:58:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:03 INFO - 'tests': ['tp5o']}, 18:58:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:03 INFO - 'talos_options': ['--disable-e10s', 18:58:03 INFO - '--xperf_path', 18:58:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:58:03 INFO - 'tests': ['tp5n']}, 18:58:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:03 INFO - 'talos_options': ['--xperf_path', 18:58:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:58:03 INFO - 'tests': ['tp5n']}}, 18:58:03 INFO - 'talos.zip': {'path': '', 18:58:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:58:03 INFO - Running post-action listener: _resource_record_post_action 18:58:03 INFO - [mozharness: 2016-08-20 01:58:03.356006Z] Finished populate-webroot step (success) 18:58:03 INFO - [mozharness: 2016-08-20 01:58:03.356120Z] Running create-virtualenv step. 18:58:03 INFO - Running pre-action listener: _resource_record_pre_action 18:58:03 INFO - Running main action method: create_virtualenv 18:58:03 INFO - Creating virtualenv /builds/slave/test/build/venv 18:58:03 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 18:58:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:58:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:58:03 INFO - Using real prefix '/tools/python27' 18:58:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:58:04 INFO - Installing distribute.............................................................................................................................................................................................done. 18:58:07 INFO - Installing pip.................done. 18:58:07 INFO - Return code: 0 18:58:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ff0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8299dc4610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ebfd30>, '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 0x104c24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eb7b20>, '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.Rn8vQYkGKI/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.T7wRrpoa27/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 18:58:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:58:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:58:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rn8vQYkGKI/Render', 18:58:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:58:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:58:07 INFO - 'HOME': '/Users/cltbld', 18:58:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:58:07 INFO - 'LOGNAME': 'cltbld', 18:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:07 INFO - 'MOZ_NO_REMOTE': '1', 18:58:07 INFO - 'NO_EM_RESTART': '1', 18:58:07 INFO - 'PAGER': '/bin/cat', 18:58:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:07 INFO - 'PWD': '/builds/slave/test', 18:58:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:58:07 INFO - 'SHELL': '/bin/bash', 18:58:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T7wRrpoa27/Listeners', 18:58:07 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 18:58:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:58:07 INFO - 'USER': 'cltbld', 18:58:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:58:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:07 INFO - 'XPC_FLAGS': '0x0', 18:58:07 INFO - 'XPC_SERVICE_NAME': '0', 18:58:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:58:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:07 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 18:58:07 INFO - Cleaning up... 18:58:07 INFO - Return code: 0 18:58:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104f5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ff0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8299dc4610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ebfd30>, '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 0x104c24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eb7b20>, '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.Rn8vQYkGKI/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.T7wRrpoa27/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 18:58:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:58:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:58:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rn8vQYkGKI/Render', 18:58:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:58:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:58:07 INFO - 'HOME': '/Users/cltbld', 18:58:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:58:07 INFO - 'LOGNAME': 'cltbld', 18:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:07 INFO - 'MOZ_NO_REMOTE': '1', 18:58:07 INFO - 'NO_EM_RESTART': '1', 18:58:07 INFO - 'PAGER': '/bin/cat', 18:58:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:07 INFO - 'PWD': '/builds/slave/test', 18:58:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:58:07 INFO - 'SHELL': '/bin/bash', 18:58:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T7wRrpoa27/Listeners', 18:58:07 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 18:58:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:58:07 INFO - 'USER': 'cltbld', 18:58:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:58:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:07 INFO - 'XPC_FLAGS': '0x0', 18:58:07 INFO - 'XPC_SERVICE_NAME': '0', 18:58:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:58:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:07 INFO - Downloading/unpacking psutil>=3.1.1 18:58: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 18:58: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 18:58: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 18:58: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 18:58: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 18:58: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 18:58:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:58:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:58:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:58:10 INFO - Installing collected packages: psutil 18:58:10 INFO - Running setup.py install for psutil 18:58:11 INFO - building 'psutil._psutil_osx' extension 18:58:11 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 18:58:11 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 18:58:11 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 18:58:11 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 18:58:11 INFO - building 'psutil._psutil_posix' extension 18:58:11 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 18:58:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:58:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:58:11 INFO - ^ 18:58:11 INFO - 1 warning generated. 18:58:11 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 18:58:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:58:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:58:11 INFO - Successfully installed psutil 18:58:11 INFO - Cleaning up... 18:58:11 INFO - Return code: 0 18:58:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:58:11 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:11 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:11 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 0x104f5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ff0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8299dc4610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ebfd30>, '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 0x104c24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eb7b20>, '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.Rn8vQYkGKI/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.T7wRrpoa27/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 18:58:11 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 18:58:11 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 18:58:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rn8vQYkGKI/Render', 18:58:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:58:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:58:11 INFO - 'HOME': '/Users/cltbld', 18:58:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:58:11 INFO - 'LOGNAME': 'cltbld', 18:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:11 INFO - 'MOZ_NO_REMOTE': '1', 18:58:11 INFO - 'NO_EM_RESTART': '1', 18:58:11 INFO - 'PAGER': '/bin/cat', 18:58:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:11 INFO - 'PWD': '/builds/slave/test', 18:58:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:58:11 INFO - 'SHELL': '/bin/bash', 18:58:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T7wRrpoa27/Listeners', 18:58:11 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 18:58:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:58:11 INFO - 'USER': 'cltbld', 18:58:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:58:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:11 INFO - 'XPC_FLAGS': '0x0', 18:58:11 INFO - 'XPC_SERVICE_NAME': '0', 18:58:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:58:12 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 18:58:12 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 18:58:12 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 18:58:12 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 18:58:12 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 18:58:12 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 18:58:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:58:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:58:14 INFO - Installing collected packages: mozsystemmonitor 18:58:14 INFO - Running setup.py install for mozsystemmonitor 18:58:14 INFO - Successfully installed mozsystemmonitor 18:58:14 INFO - Cleaning up... 18:58:14 INFO - Return code: 0 18:58:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:58:14 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:14 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:14 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 0x104f5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ff0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8299dc4610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ebfd30>, '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 0x104c24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eb7b20>, '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.Rn8vQYkGKI/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.T7wRrpoa27/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 18:58:14 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 18:58:14 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 18:58:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rn8vQYkGKI/Render', 18:58:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:58:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:58:14 INFO - 'HOME': '/Users/cltbld', 18:58:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:58:14 INFO - 'LOGNAME': 'cltbld', 18:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:14 INFO - 'MOZ_NO_REMOTE': '1', 18:58:14 INFO - 'NO_EM_RESTART': '1', 18:58:14 INFO - 'PAGER': '/bin/cat', 18:58:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:14 INFO - 'PWD': '/builds/slave/test', 18:58:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:58:14 INFO - 'SHELL': '/bin/bash', 18:58:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T7wRrpoa27/Listeners', 18:58:14 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 18:58:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:58:14 INFO - 'USER': 'cltbld', 18:58:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:58:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:14 INFO - 'XPC_FLAGS': '0x0', 18:58:14 INFO - 'XPC_SERVICE_NAME': '0', 18:58:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:15 INFO - Downloading/unpacking jsonschema==2.5.1 18:58:15 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 18:58:15 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 18:58:15 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 18:58:15 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 18:58:15 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 18:58:15 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 18:58:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:58:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:58:17 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 18:58:17 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 18:58:17 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 18:58:17 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 18:58:17 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 18:58:17 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 18:58:18 INFO - Downloading functools32-3.2.3-2.tar.gz 18:58:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:58:18 INFO - warning: no files found matching '*.txt' 18:58:18 INFO - no previously-included directories found matching 'build' 18:58:18 INFO - no previously-included directories found matching 'dist' 18:58:18 INFO - no previously-included directories found matching '.git*' 18:58:18 INFO - Installing collected packages: jsonschema, functools32 18:58:18 INFO - Running setup.py install for functools32 18:58:18 INFO - warning: no files found matching '*.txt' 18:58:18 INFO - no previously-included directories found matching 'build' 18:58:18 INFO - no previously-included directories found matching 'dist' 18:58:18 INFO - no previously-included directories found matching '.git*' 18:58:18 INFO - Successfully installed jsonschema functools32 18:58:18 INFO - Cleaning up... 18:58:18 INFO - Return code: 0 18:58:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:18 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ff0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8299dc4610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ebfd30>, '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 0x104c24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eb7b20>, '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.Rn8vQYkGKI/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.T7wRrpoa27/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 18:58:18 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:58:18 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 functools32==3.2.3-2 18:58:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rn8vQYkGKI/Render', 18:58:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:58:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:58:18 INFO - 'HOME': '/Users/cltbld', 18:58:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:58:18 INFO - 'LOGNAME': 'cltbld', 18:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:18 INFO - 'MOZ_NO_REMOTE': '1', 18:58:18 INFO - 'NO_EM_RESTART': '1', 18:58:18 INFO - 'PAGER': '/bin/cat', 18:58:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:18 INFO - 'PWD': '/builds/slave/test', 18:58:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:58:18 INFO - 'SHELL': '/bin/bash', 18:58:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T7wRrpoa27/Listeners', 18:58:18 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 18:58:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:58:18 INFO - 'USER': 'cltbld', 18:58:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:58:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:18 INFO - 'XPC_FLAGS': '0x0', 18:58:18 INFO - 'XPC_SERVICE_NAME': '0', 18:58:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:58:18 INFO - Cleaning up... 18:58:18 INFO - Return code: 0 18:58:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:18 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 0x104f5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ff0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8299dc4610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ebfd30>, '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 0x104c24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eb7b20>, '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.Rn8vQYkGKI/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.T7wRrpoa27/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 18:58:18 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 18:58:18 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 18:58:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rn8vQYkGKI/Render', 18:58:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:58:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:58:18 INFO - 'HOME': '/Users/cltbld', 18:58:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:58:18 INFO - 'LOGNAME': 'cltbld', 18:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:18 INFO - 'MOZ_NO_REMOTE': '1', 18:58:18 INFO - 'NO_EM_RESTART': '1', 18:58:18 INFO - 'PAGER': '/bin/cat', 18:58:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:18 INFO - 'PWD': '/builds/slave/test', 18:58:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:58:18 INFO - 'SHELL': '/bin/bash', 18:58:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T7wRrpoa27/Listeners', 18:58:18 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 18:58:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:58:18 INFO - 'USER': 'cltbld', 18:58:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:58:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:18 INFO - 'XPC_FLAGS': '0x0', 18:58:18 INFO - 'XPC_SERVICE_NAME': '0', 18:58:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:18 INFO - Downloading/unpacking blobuploader==1.2.4 18:58:18 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 18:58:18 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 18:58:18 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 18:58:18 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 18:58:18 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 18:58:18 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 18:58:21 INFO - Downloading blobuploader-1.2.4.tar.gz 18:58:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:58:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:58:21 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 18:58:21 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 18:58:21 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 18:58:21 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 18:58:21 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 18:58:21 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 18:58:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:58:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:58:22 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 18:58:22 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 18:58:22 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 18:58:22 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 18:58:22 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 18:58:22 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 18:58:22 INFO - Downloading docopt-0.6.1.tar.gz 18:58:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:58:22 INFO - Installing collected packages: blobuploader, requests, docopt 18:58:22 INFO - Running setup.py install for blobuploader 18:58:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:58:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:58:22 INFO - Running setup.py install for requests 18:58:23 INFO - Running setup.py install for docopt 18:58:23 INFO - Successfully installed blobuploader requests docopt 18:58:23 INFO - Cleaning up... 18:58:23 INFO - Return code: 0 18:58:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:23 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 0x104f5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ff0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8299dc4610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ebfd30>, '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 0x104c24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eb7b20>, '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.Rn8vQYkGKI/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.T7wRrpoa27/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 18:58:23 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 18:58:23 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 18:58:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rn8vQYkGKI/Render', 18:58:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:58:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:58:23 INFO - 'HOME': '/Users/cltbld', 18:58:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:58:23 INFO - 'LOGNAME': 'cltbld', 18:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:23 INFO - 'MOZ_NO_REMOTE': '1', 18:58:23 INFO - 'NO_EM_RESTART': '1', 18:58:23 INFO - 'PAGER': '/bin/cat', 18:58:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:23 INFO - 'PWD': '/builds/slave/test', 18:58:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:58:23 INFO - 'SHELL': '/bin/bash', 18:58:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T7wRrpoa27/Listeners', 18:58:23 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 18:58:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:58:23 INFO - 'USER': 'cltbld', 18:58:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:58:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:23 INFO - 'XPC_FLAGS': '0x0', 18:58:23 INFO - 'XPC_SERVICE_NAME': '0', 18:58:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:58:23 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-N6ziIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:58:23 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-qqbeRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:58:23 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-5KbKKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:58:24 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-FM80VD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:58:24 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-hVlk0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:58:24 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-XqFJwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:58:24 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-rU3aYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:58:24 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-9Ry8UG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:58:24 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-sZuBSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:58:24 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-uopeuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:58:24 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-7ru5uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:58:24 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-ADrhNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:58:25 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-1e3QkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:58:25 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-R26sEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:58:25 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-t4QxBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:58:25 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-5bhF9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:58:25 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-vAZ2UG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:58:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:58:25 INFO - Running setup.py install for manifestparser 18:58:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:58:25 INFO - Running setup.py install for mozcrash 18:58:25 INFO - Running setup.py install for mozdebug 18:58:25 INFO - Running setup.py install for mozdevice 18:58:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:58:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:58:26 INFO - Running setup.py install for mozfile 18:58:26 INFO - Running setup.py install for mozhttpd 18:58:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:58:26 INFO - Running setup.py install for mozinfo 18:58:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:58:26 INFO - Running setup.py install for mozInstall 18:58:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:58:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:58:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:58:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:58:26 INFO - Running setup.py install for mozleak 18:58:26 INFO - Running setup.py install for mozlog 18:58:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:58:27 INFO - Running setup.py install for moznetwork 18:58:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:58:27 INFO - Running setup.py install for mozprocess 18:58:27 INFO - Running setup.py install for mozprofile 18:58:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:58:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:58:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:58:27 INFO - Running setup.py install for mozrunner 18:58:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:58:27 INFO - Running setup.py install for mozscreenshot 18:58:27 INFO - Running setup.py install for moztest 18:58:27 INFO - Running setup.py install for mozversion 18:58:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:58:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:58:28 INFO - Cleaning up... 18:58:28 INFO - Return code: 0 18:58:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:28 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 0x104f5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ff0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8299dc4610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ebfd30>, '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 0x104c24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eb7b20>, '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.Rn8vQYkGKI/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.T7wRrpoa27/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 18:58:28 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 18:58:28 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 18:58:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rn8vQYkGKI/Render', 18:58:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:58:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:58:28 INFO - 'HOME': '/Users/cltbld', 18:58:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:58:28 INFO - 'LOGNAME': 'cltbld', 18:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:28 INFO - 'MOZ_NO_REMOTE': '1', 18:58:28 INFO - 'NO_EM_RESTART': '1', 18:58:28 INFO - 'PAGER': '/bin/cat', 18:58:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:28 INFO - 'PWD': '/builds/slave/test', 18:58:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:58:28 INFO - 'SHELL': '/bin/bash', 18:58:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T7wRrpoa27/Listeners', 18:58:28 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 18:58:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:58:28 INFO - 'USER': 'cltbld', 18:58:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:58:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:28 INFO - 'XPC_FLAGS': '0x0', 18:58:28 INFO - 'XPC_SERVICE_NAME': '0', 18:58:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:58:28 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-OQG0D6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:58:28 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)) 18:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:58:28 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-0UMsa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:58:28 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)) 18:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:58:28 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-SRBD4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:58:28 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)) 18:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:58:28 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-SNiKP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:58:28 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)) 18:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:58:28 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-F2Aisu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:58:28 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)) 18:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:58:28 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-h4ndy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:58:29 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)) 18:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:58:29 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-FiU0h0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:58:29 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)) 18:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:58:29 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-Gg6WhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:58:29 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)) 18:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:58:29 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-asX3wK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:58:29 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)) 18:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:58:29 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-2LQzF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:58:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 18:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:58:29 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-zUIC6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:58:29 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)) 18:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:58:29 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-_4VE2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:58:29 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)) 18:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:58:29 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-RK8Q2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:58:29 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)) 18:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:58:29 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-BeOxGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:58:29 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)) 18:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:58:29 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-GSOnvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:58:29 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)) 18:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:58:29 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-nwcyvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:58:30 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)) 18:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:58:30 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-A1h2k4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:58:30 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)) 18:58:30 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)) 18:58:30 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)) 18:58:30 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)) 18:58:30 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)) 18:58:30 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)) 18:58:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:58:30 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 18:58:30 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 18:58:30 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 18:58:30 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 18:58:30 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 18:58:30 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 18:58:32 INFO - Downloading blessings-1.6.tar.gz 18:58:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:58:32 INFO - Installing collected packages: blessings 18:58:32 INFO - Running setup.py install for blessings 18:58:32 INFO - Successfully installed blessings 18:58:32 INFO - Cleaning up... 18:58:32 INFO - Return code: 0 18:58:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:58:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:58:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:58:33 INFO - Reading from file tmpfile_stdout 18:58:33 INFO - Current package versions: 18:58:33 INFO - blessings == 1.6 18:58:33 INFO - blobuploader == 1.2.4 18:58:33 INFO - docopt == 0.6.1 18:58:33 INFO - functools32 == 3.2.3-2 18:58:33 INFO - jsonschema == 2.5.1 18:58:33 INFO - manifestparser == 1.1 18:58:33 INFO - mozInstall == 1.12 18:58:33 INFO - mozcrash == 0.17 18:58:33 INFO - mozdebug == 0.1 18:58:33 INFO - mozdevice == 0.48 18:58:33 INFO - mozfile == 1.2 18:58:33 INFO - mozhttpd == 0.7 18:58:33 INFO - mozinfo == 0.9 18:58:33 INFO - mozleak == 0.1 18:58:33 INFO - mozlog == 3.3 18:58:33 INFO - moznetwork == 0.27 18:58:33 INFO - mozprocess == 0.23 18:58:33 INFO - mozprofile == 0.28 18:58:33 INFO - mozrunner == 6.12 18:58:33 INFO - mozscreenshot == 0.1 18:58:33 INFO - mozsystemmonitor == 0.3 18:58:33 INFO - moztest == 0.7 18:58:33 INFO - mozversion == 1.4 18:58:33 INFO - psutil == 3.1.1 18:58:33 INFO - requests == 1.2.3 18:58:33 INFO - wsgiref == 0.1.2 18:58:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:34 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 0x104f5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ff0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8299dc4610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ebfd30>, '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 0x104c24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eb7b20>, '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.Rn8vQYkGKI/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.T7wRrpoa27/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 18:58:34 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 18:58:34 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 18:58:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rn8vQYkGKI/Render', 18:58:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:58:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:58:34 INFO - 'HOME': '/Users/cltbld', 18:58:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:58:34 INFO - 'LOGNAME': 'cltbld', 18:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:34 INFO - 'MOZ_NO_REMOTE': '1', 18:58:34 INFO - 'NO_EM_RESTART': '1', 18:58:34 INFO - 'PAGER': '/bin/cat', 18:58:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:34 INFO - 'PWD': '/builds/slave/test', 18:58:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:58:34 INFO - 'SHELL': '/bin/bash', 18:58:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T7wRrpoa27/Listeners', 18:58:34 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 18:58:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:58:34 INFO - 'USER': 'cltbld', 18:58:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:58:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:34 INFO - 'XPC_FLAGS': '0x0', 18:58:34 INFO - 'XPC_SERVICE_NAME': '0', 18:58:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:34 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)) 18:58:34 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)) 18:58:34 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)) 18:58:34 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)) 18:58:34 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)) 18:58:34 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)) 18:58:34 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)) 18:58:34 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)) 18:58:34 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)) 18:58:34 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)) 18:58:34 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)) 18:58:34 INFO - Cleaning up... 18:58:34 INFO - Return code: 0 18:58:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:34 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 0x104f5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ff0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8299dc4610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ebfd30>, '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 0x104c24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eb7b20>, '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.Rn8vQYkGKI/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.T7wRrpoa27/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 18:58:34 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 18:58:34 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 18:58:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rn8vQYkGKI/Render', 18:58:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:58:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:58:34 INFO - 'HOME': '/Users/cltbld', 18:58:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:58:34 INFO - 'LOGNAME': 'cltbld', 18:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:34 INFO - 'MOZ_NO_REMOTE': '1', 18:58:34 INFO - 'NO_EM_RESTART': '1', 18:58:34 INFO - 'PAGER': '/bin/cat', 18:58:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:34 INFO - 'PWD': '/builds/slave/test', 18:58:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:58:34 INFO - 'SHELL': '/bin/bash', 18:58:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T7wRrpoa27/Listeners', 18:58:34 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 18:58:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:58:34 INFO - 'USER': 'cltbld', 18:58:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:58:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:34 INFO - 'XPC_FLAGS': '0x0', 18:58:34 INFO - 'XPC_SERVICE_NAME': '0', 18:58:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:58:34 INFO - Cleaning up... 18:58:34 INFO - Return code: 0 18:58:34 INFO - Running post-action listener: _resource_record_post_action 18:58:34 INFO - Running post-action listener: _start_resource_monitoring 18:58:34 INFO - Starting resource monitoring. 18:58:34 INFO - [mozharness: 2016-08-20 01:58:34.744974Z] Finished create-virtualenv step (success) 18:58:34 INFO - [mozharness: 2016-08-20 01:58:34.745970Z] Running install step. 18:58:34 INFO - Running pre-action listener: _resource_record_pre_action 18:58:34 INFO - Running main action method: install 18:58:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:58:35 INFO - Reading from file tmpfile_stdout 18:58:35 INFO - Detecting whether we're running mozinstall >=1.0... 18:58:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:58:35 INFO - Reading from file tmpfile_stdout 18:58:35 INFO - Output received: 18:58:35 INFO - Usage: mozinstall [options] installer 18:58:35 INFO - Options: 18:58:35 INFO - -h, --help show this help message and exit 18:58:35 INFO - -d DEST, --destination=DEST 18:58:35 INFO - Directory to install application into. [default: 18:58:35 INFO - "/builds/slave/test"] 18:58:35 INFO - --app=APP Application being installed. [default: firefox] 18:58:35 INFO - mkdir: /builds/slave/test/build/application 18:58:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:59:09 INFO - Reading from file tmpfile_stdout 18:59:09 INFO - Output received: 18:59:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:59:09 INFO - Running post-action listener: _resource_record_post_action 18:59:09 INFO - [mozharness: 2016-08-20 01:59:09.170139Z] Finished install step (success) 18:59:09 INFO - [mozharness: 2016-08-20 01:59:09.170262Z] Running run-tests step. 18:59:09 INFO - Running pre-action listener: _resource_record_pre_action 18:59:09 INFO - Running main action method: run_tests 18:59:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:59:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:59:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:59:09 INFO - 2016-08-19 18:59:09.185 screenresolution[2451:85664] starting screenresolution argv=screenresolution get 18:59:09 INFO - 2016-08-19 18:59:09.187 screenresolution[2451:85664] Display 0: 1600x1200x32@60 18:59:09 INFO - 2016-08-19 18:59:09.193 screenresolution[2452:85667] starting screenresolution argv=screenresolution list 18:59:09 INFO - Available Modes on Display 0 18:59:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:59:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:59:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:59:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:59:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:59:09 INFO - Intel Iris: 18:59:09 INFO - Chipset Model: Intel Iris 18:59:09 INFO - Type: GPU 18:59:09 INFO - Bus: Built-In 18:59:09 INFO - VRAM (Dynamic, Max): 1536 MB 18:59:09 INFO - Vendor: Intel (0x8086) 18:59:09 INFO - Device ID: 0x0a2e 18:59:09 INFO - Revision ID: 0x0009 18:59:09 INFO - Displays: 18:59:09 INFO - Display: 18:59:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:59:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:59:09 INFO - Display Serial Number: 1600x1200 60 18:59:09 INFO - Main Display: Yes 18:59:09 INFO - Mirror: Off 18:59:09 INFO - Online: Yes 18:59:09 INFO - Rotation: Supported 18:59:09 INFO - Return code: 0 18:59:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:59:09 INFO - Python 2.7.3 18:59:09 INFO - Return code: 0 18:59:09 INFO - grabbing minidump binary from tooltool 18:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:09 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 0x104ebfd30>, '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 0x104c24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eb7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:59:09 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 18:59:09 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 18:59:09 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 18:59:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:59:09 INFO - Return code: 0 18:59:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:59:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:59:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:59:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:59:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:59:09 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/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0047', '--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 18:59:09 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/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0047 --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 18:59:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rn8vQYkGKI/Render', 18:59:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:09 INFO - 'HOME': '/Users/cltbld', 18:59:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:09 INFO - 'LOGNAME': 'cltbld', 18:59:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:59:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:09 INFO - 'MOZ_NO_REMOTE': '1', 18:59:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:59:09 INFO - 'NO_EM_RESTART': '1', 18:59:09 INFO - 'PAGER': '/bin/cat', 18:59:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:09 INFO - 'PWD': '/builds/slave/test', 18:59:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:59:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:09 INFO - 'SHELL': '/bin/bash', 18:59:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T7wRrpoa27/Listeners', 18:59:09 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 18:59:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:09 INFO - 'USER': 'cltbld', 18:59:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:09 INFO - 'XPC_FLAGS': '0x0', 18:59:09 INFO - 'XPC_SERVICE_NAME': '0', 18:59:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:09 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/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0047', '--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 18:59:09 INFO - mozversion application_buildid: 20160819173814 18:59:09 INFO - mozversion application_changeset: 30fa88c82366a358f412ca2cc3268142c8991f0d 18:59:09 INFO - mozversion application_display_name: Nightly 18:59:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:59:09 INFO - mozversion application_name: Firefox 18:59:09 INFO - mozversion application_remotingname: firefox 18:59:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:59:09 INFO - mozversion application_vendor: Mozilla 18:59:09 INFO - mozversion application_version: 51.0a1 18:59:09 INFO - mozversion platform_buildid: 20160819173814 18:59:09 INFO - mozversion platform_changeset: 30fa88c82366a358f412ca2cc3268142c8991f0d 18:59:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:59:09 INFO - mozversion platform_version: 51.0a1 18:59:09 INFO - using testdate: 1471658349 18:59:09 INFO - actual date: 1471658349 18:59:09 INFO - starting webserver on 'localhost:61944' 18:59:09 INFO - SUITE-START | Running 2 tests 18:59:09 INFO - TEST-START | dromaeo_css 18:59:09 INFO - operating with platform_type : mac_ 18:59:09 INFO - Initialising browser for dromaeo_css test... 18:59:09 INFO - TEST-INFO | started process 2462 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmpKyYjgB/profile http://localhost:61944/getInfo.html) 18:59:12 INFO - PROCESS | 2462 | __metrics Screen width/height:1600/1200 18:59:12 INFO - PROCESS | 2462 | colorDepth:24 18:59:12 INFO - PROCESS | 2462 | Browser inner width/height: 1024/689 18:59:12 INFO - PROCESS | 2462 | __metrics 18:59:12 ERROR - PROCESS | 2462 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 18:59:13 INFO - TEST-INFO | 2462: exit 0 18:59:13 INFO - Browser initialized. 18:59:13 INFO - Running cycle 1/1 for dromaeo_css test... 18:59:13 INFO - TEST-INFO | started process 2465 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmpKyYjgB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:59:25 INFO - PROCESS | 2465 | RSS: Main: 239136768 18:59:25 INFO - PROCESS | 2465 | 19:00:15 INFO - PROCESS | 2465 | 1471658415351 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] 19:02:27 INFO - PROCESS | 2465 | Cycle 1(1): loaded http://localhost:61944/tests/dromaeo/cssquery-dojo.html (next: http://localhost:61944/tests/dromaeo/cssquery-ext.html) 19:02:28 INFO - PROCESS | 2465 | RSS: Main: 253894656 19:02:28 INFO - PROCESS | 2465 | 19:05:31 INFO - PROCESS | 2465 | Cycle 1(1): loaded http://localhost:61944/tests/dromaeo/cssquery-ext.html (next: http://localhost:61944/tests/dromaeo/cssquery-jquery.html) 19:05:31 INFO - PROCESS | 2465 | RSS: Main: 267067392 19:05:31 INFO - PROCESS | 2465 | 19:08:33 INFO - PROCESS | 2465 | Cycle 1(1): loaded http://localhost:61944/tests/dromaeo/cssquery-jquery.html (next: http://localhost:61944/tests/dromaeo/cssquery-mootools.html) 19:08:34 INFO - PROCESS | 2465 | RSS: Main: 271781888 19:08:34 INFO - PROCESS | 2465 | 19:11:36 INFO - PROCESS | 2465 | Cycle 1(1): loaded http://localhost:61944/tests/dromaeo/cssquery-mootools.html (next: http://localhost:61944/tests/dromaeo/cssquery-prototype.html) 19:11:37 INFO - PROCESS | 2465 | RSS: Main: 271208448 19:11:37 INFO - PROCESS | 2465 | 19:14:39 INFO - PROCESS | 2465 | Cycle 1(1): loaded http://localhost:61944/tests/dromaeo/cssquery-prototype.html (next: http://localhost:61944/tests/dromaeo/cssquery-yui.html) 19:14:40 INFO - PROCESS | 2465 | RSS: Main: 276602880 19:14:40 INFO - PROCESS | 2465 | 19:17:42 INFO - PROCESS | 2465 | Cycle 1(1): loaded http://localhost:61944/tests/dromaeo/cssquery-yui.html (next: http://localhost:61944/tests/dromaeo/cssquery-dojo.html) 19:17:43 INFO - PROCESS | 2465 | RSS: Main: 279396352 19:17:43 INFO - PROCESS | 2465 | 19:17:43 INFO - PROCESS | 2465 | __start_tp_report 19:17:43 INFO - PROCESS | 2465 | _x_x_mozilla_page_load 19:17:43 INFO - PROCESS | 2465 | _x_x_mozilla_page_load_details 19:17:43 INFO - PROCESS | 2465 | |i|pagename|runs| 19:17:43 INFO - PROCESS | 2465 | |0;dojo.html;3368.6294507604175;3395.55857738494;3398.524206611075;3404.55740753702;3423.1271025888395;4746.62027037837;5575;5715.885682286362;5757.625754325971;5764.5100166485845;5705.857353566163;5779.826605201851;5867.383924687911;5869.3837147099475;5877.206577112089;5193.480651934795;5203.141481655542;5294.047071527124;5302.558636456462;5354.491323324278;4752.976235118819;5145.871353216181;5383.623146379736;5411.864703382427;5420.91868621971;5084.288199652015;5152.613553983466;5213.817516386946;5271.130263506517;5310.1769225769685;5243.2659427680155;5262.92105618416;5279.762410691528;5282.286891269706;5282.947170528284;5147.150720131174;5202.557782588485;5215.452377500345;5259.105951988171;5263.842084737464;5426.9185962210595;5701.885962280731;5789;5793.7392817323325;5806.1581070744505;5186.896262074737;6232.626042437423;6255.12428260044;6284.214473190851;6292.5595208335435;6288.213973253343;6289.213848268966;6292.779752708633;6306.590071645328;6312.779052733133;5791.768329266824;5932.911006334908;5947.434993675594;5991.281046274387;6068.6358818471035;6405.231372235362;6412.67936603168;6412.839679008062;6413.839654008687;6414.10202571631;6161.661108639068;6228.283747369111;6259.0924315973925;6267.373262673787;6274.341194174637;6154.969225153845;6158.876822463526;6217.502599792006;6218.751249950042;6299.5275354348605;4897.828575999894;6246.781362652377;6267.1539342188225;6278.623282603058;6289.371062893674;5541.196526503634;6249.0626406039455;6250.312465628777;6263.937360626335;6281.152044474029;4520.796564154621;5011.899762004739;5032.798688052437;5037.3955125384455;5083.567896728746;4526.547345265447;4561.954380456219;4565.086982603492;4579.084183163381;4584.679072464962;5906.940930590639;5910.054391297372;5942.64344139353;5956.672383018976;5995.640261584319;6155.538334624921;6170.5372097092895;6191.81424557264;6203;6346.11154438379;5891.587588868823;5933.169356290123;5933.762649493972;5937.168796368512;5963.403659634088;5554.361248456479;5569.220309156722;5577.358603760619;5590.580706447033;5593.4617980055;6301.842453938597;6357;6381.266154392119;6408.03879418091;6505;6278.0896769967185;6278.497720182466;6288.434040936338;6293.779717709858;6322.8735425290315;5308.495692909168;6414.903776443264;6430.839229019312;6485.416312531895;6486.2216534016225;6109.11417844419;6174.228221472316;6200.0699895016105;6235.875282494416;6296.401841825019;4490.595846373842;5668.178114173505;6281.59169653971;6289.559730818982;6293.37066293367;5608;6051.636901785907;6192.876142477216;6200.0699895016105;6215.720292586754;5977.133315669116;6054.84862878414;6104.893811634979;6166.630002199882;6205.782797602063;5451;5509.201165831012;5512.5314348280845;6124.142620033288;6131.356207598138;6163.137160797582;6170.50635949132;6189.226346706661;6225.066240063846;6242;5838.970805145947;5849.824505264849;5873.2658417697785;5903.291605007426;5973 19:17:43 INFO - PROCESS | 2465 | |1;ext.html;474.8603351955307;484.41385923033107;501.8207213049332;515.9948400515995;525.1990714160904;29278;40319;40389.79805100974;40471.797641011755;40545.189096218055;41704.872134589874;41992.740217793515;42050.57949420505;42065;42100.36849447253;9765.316427850054;9974.551145198484;9979.201663866874;9993.200543956465;10010.54952527138;9794.804103917917;9916.752081197956;9926.900730992706;9930.404175749478;9960.05379488951;9937.40375577464;9938.20494360453;9941.900580994206;9944.453055081967;9962.003799620052;9824.36141650794;9879.110880020797;9897.86174589917;9902.603895844157;9904.306698531105;9688.854667179998;9767.560459779326;9772.95113524435;9777.657781977596;9780.853287200698;39069.63256286016;39288.41067383991;39293.60706392928;39565.80217098925;39577.80211098926;3325.7671962962604;3889;4156.480439945007;4174.227767862955;4284.892877678052;30567.541486877715;31350.21624459384;31665;31838.20404489883;32321.51517727236;3214.2285851395495;3342.4819153031076;3380.816714150028;3417.043227896168;3419.2990436960363;412775.93612032046;431334;439505;439615;444186;49661.50338496641;55885.72057139688;55938;55991.720041400346;56045.43954560484;57747;58239.70880145657;58431.41568584345;58452.12321815176;58486;15908.284127214303;16099.517014489584;16108.355665773237;16116.838831611534;16148;12520.31138287403;12533.31066791317;12648.304343261208;12659.303738294482;12662.113652044452;13448.1258718183;14622;14703.632409189642;14772.335244914004;14884.404623815142;3194.2493514024186;6155.795817970428;6433.099366088752;6436.742530298736;6440.6135631862235;912.6577533424966;985.6895078050535;1013.5894962540183;1051.4217180550665;1091.6179337231906;24643.507129857302;30115.247118821768;30569.69430305713;30961.91633292824;31009.68990310068;1029.9639512617023;1037.8547003419528;1082.1613249731522;1158.3571118029406;1193.5225909636042;14252.358643861051;15119.395224191128;15794.763078553831;15817.525474235792;16050.75923861143;464047;541717;542094;542148;542998;56321;56485.71757141188;56872.146917796264;56970.86058278894;57120.428795712345;1261.5773715805308;1390.2631605249235;1405.304374334711;1431.9284035798169;1437;27496.312592184557;29489.198526139982;29777.10668679943;29951.700482995762;30668.539971899994;49436.011279774924;49504.00991980212;49710;49932.750336248086;50033;594365;598587;599174;599619;600943;26130.693465327036;26259.606105908046;26595;26664.20007399781;26688.866555667875;47807.760961194974;48451.78870528265;48586.02827943492;48694.78263043452;48944.510554894;37704.622953771206;38567.03582410462;38978.66581754416;39418;40434.39348409835;38391.808040959615;38523.614763853126;38592.807035965765;39418.21163576655;40311.39532907067;37151;37600;37755.24489510249;38009;38091.047723807125;25662.61506077373;28703.282417938884;32163.391830408855;34514.309713806084;34669.653303467654;25560.360990975376;25593.744062559137;25632.359191020372;25983.87008065023;26176.34559136037 19:17:43 INFO - PROCESS | 2465 | |2;jquery.html;367.606660872866;379.7512629227855;384.5923321279444;385.1488211053572;402.4586930578373;18326.816731832678;19753.703694444594;19878.90060549695;20132.295369662064;20163.294284700038;18837;18999.62000759984;19509.70735438966;20195.899020504912;20528.486787830312;5380.811671591495;5731.799387021455;5734.340550836645;5940.643561386309;5954.374790646984;5940.61386009908;5975.611585246967;5980.073088671263;5999.880002399949;6009;5728.856778580527;5770.711464426783;5789.536837053026;5905.084711869667;5932.199153114318;5797.391273916221;5830.650160990333;5884.117382392633;5891.882162356729;5900;5097.592192624581;5117.206832940863;5136.229565565158;5137.40919794221;5143.125668636303;20632.07155677998;24346.26961191167;24740.628890566655;25702.48595028089;25925.351866203306;2188.627933251351;2317.073170731704;2430.3559556717482;2434.087217293515;3102.0693791862577;15392.538223853302;15557.688846223013;15662.530124096294;15888;16022.5994350141;1863.282636185065;1930.2747576031813;1938.108470103754;1974.0919177178514;1976.2391479280436;108033.45983270033;109844.4507777456;110084.34873476904;110439.23901902516;111567.44216278948;10723.03492685662;10801.297915635458;10954.835677464844;11025.062869656169;11249.83859272719;10914.853940336308;13553;13561.660958475919;13601.183928964294;13656.112352697042;8336.62485188168;8489.363297752694;8511.148885111563;8605.655773769104;8760.12398760119;6874.587524748531;8155.632996515053;8611.052784193733;8611.569421528899;8742.28989013408;6528.54300198991;6654.3345665434035;6688.030235615808;6693.397594216543;6694.062831203635;1499.5576304990054;1625.951221463358;1876.8123187681122;1900.657881581301;1923.8460923126117;839.5214727605206;839.954256950101;892.6250974590688;931.5668214280257;995.6017592962728;21374.465638358855;21979.670304945437;22006.44983875384;22130.668039979413;22154.338424617898;835.7409203147043;972.8881178664544;987.7975015121883;989.1690979577046;1041.286718597763;10416.791664166674;11133.832992505118;11592.118078968955;11786.823197652042;11791.410429478492;577684;579334;625275;630872;640395;139449.3027534876;143990.56009439772;145290.54709452981;146544;148286.51713482942;965.4400447740294;994.5275993902839;1012.4229189361993;1013.0629168019552;1022.867027286448;17700.02649854219;18906.43280701581;19850.205991760744;20088.497787554843;20337.59324813525;45343.31985020293;48454.27318590153;51345.973080538926;55836;59511.809763805344;64121.35878641154;84940.57529712311;85673.28653426773;86609.69226872899;88027.679584805;6990.475714321345;7137.430525010888;7930.276695634756;7939.491496615625;8079.272865441903;7140.678669459783;10818.513166907665;11272.492737826653;12739.872601273868;13306.201627902357;11103;11316.377599231791;11329.32024078525;11424.371659558805;11625.360605166798;8918.152775486318;8987.775305617412;11174.161937854857;11280.717982050186;11449.828252576051;11359.659210223706;11549.42252887369;11780.469878855301;11826.763464730486;11913.463894124612;6259.718312675849;7280;7474.402047836269;7479.925200747923;7539.9246007541415;9026.954865225633;11030.834537482106;11356.205065645325;11447.484863181011;11452.255603385753 19:17:43 INFO - PROCESS | 2465 | |3;mootools.html;1478.9482368117117;1503.781951617016;1716.8840253835006;1851.694470412382;1858.5260758506588;7894.447388682795;8383.496990180585;8540.871886921701;8952.060033696465;8958.059403762602;8626.525541095252;8797.164269394414;8821.691240806573;8828.77928051799;8848.336374771901;1950.9609807803836;1964.3321270767935;2396.7842894139526;2400.2919138853995;2410.433548116191;2352.952940941189;2380.821438392119;2410.144398738449;2417.0090262992176;2420.1408499982517;2396.9880150599224;2406.3142004528713;2409.4819613783034;2437.597796363598;2438.756124387565;1902.5719213177063;2061.9484512887148;2297.241910169657;2310.214527060799;2312.9537409251807;2384.5707772600927;2393.365758074112;2395.137750409851;2395.6406539019113;2400.2559206645997;7882.921170788276;8549.230569248797;8862.955685221597;8868.600912958933;8933.776655583597;4836.51634836517;5122.795088196468;5255.789768409259;5429.864253393657;5438.102713052342;3553.1472446612884;3623.963760362389;3751.6998640108727;3761.755485893408;3762.3039737648623;1074.425182527344;1106.8118419868642;1112.9554817807277;1135.4436326200184;1136.6135513925306;10833.512491937881;11589.942050289694;11680.182387232897;11700.590479333183;11765.176437649368;3654.8903532893523;4659.394278743742;4851.151048566558;4861.076395484846;4868.221084626513;9872.259580531489;9965.80068398628;9980.301378903407;9982.550785214682;9993.350432221881;5371;5375.596830237748;5378.139497680352;5385.623006389594;5389.784408623611;4059.939100913489;4272.401863739079;4371.125774845043;4870.561649451566;4895.657303988686;3816.0650640592676;3854.6723528500393;3918.0988372674447;3943.960560394359;3949.565547789741;1125.240462687699;1296.857345691973;1315.8420989481324;1317.5586178630074;1331.6803967047838;818.1286929420148;843.3716880923629;897.8148843526612;910.9544522773834;939.4222553129775;5085.389753229562;5594.41258667834;5902.704864756745;6129.877402451926;6168.228971378578;736.2637362637363;943.8537026760725;946.6970569417858;959.9680343630625;964.6527250190067;3404.5914490261325;3757.9436308455397;3962.702797290157;3974.960250397517;4126.938095928564;10140.13808826258;10607.41659208751;10639.734006649896;10655.094316983143;10684.038436540593;10321.329113607591;10397.116245119098;10559.102476289601;10568.727723539323;10576.94711526453;8083.838323233503;8206.958965205136;8209.507429554245;8209.876851847228;8215.671373145007;5809.157672137432;5860.120981852756;5952.613080149777;5962.07587823888;5992.610480318765;8025;9667.564959576695;9931.013797240435;10000.949995249977;10004.299699021;10229.028242316968;10254.436006019741;10256.230782691178;10310.948445258025;10313.329633573794;6549.115869357766;6928.861422771617;7043.225245223124;7056.08270924797;7219.205887352282;8479.830403392021;8479.982402111786;8562.229399354088;8563.95718021431;8585.65657373698;7462.179160292472;7533.510321829063;7536.886946695694;7618.923810761821;7686.57723825195;6769.627670478171;7345.595992220479;7430.256974302527;7514.023176986957;7547.924520754722;6931.549449285781;7070.681819318246;7073.2219455858785;7077.221505634273;7100.254473280231;4215.409842622097;4891.596488084635;4911.459739428731;5054.064997975386;5079.238114282887;4967.484289882761;4971.801127954841;5058.570021548209;5169.586433085269;5185.325907631984 19:17:43 INFO - PROCESS | 2465 | |4;prototype.html;292.2066589210295;305.5264340272577;312.8779775887404;314.317930091701;317.9602699173702;4631.305304204367;5396.3524377074755;5472.315960504937;5520.3565646673205;5688.691600931783;5226.451222621627;5529.861753456165;5597.3003374578175;5599.804006859761;5703.686297253649;3745.363288240992;3810.2379524095154;4230.323148296273;4233.576642335773;4265.722728022684;3814.141818090935;4083.4283200351974;4110.856120035799;4278.593533614302;4283.186194623027;3371.7134043606325;4145.792710364485;4184.560621134783;4216.64158546524;4223.936640950388;3805.6384643458828;4114.650254728352;4182.16356728654;4190.685698572619;4266.935995960063;3262.5106234064842;3348.8995330140133;3608.9458658120147;3675.8162091895565;3685.355062864015;5128.897152167593;5155.530673757961;5331.840044798662;5401.810936617238;5429.619926605139;4079.4696689430184;4512.796924138422;4772.928406073912;4850.53919877611;4865.3675022247235;5604.439556044363;5912.674802885839;5912.704364781744;5913.172155898178;5987.670678112702;3333.399988002159;3994.3009973254857;4025.416314634391;4029.61718636732;4053.4730485036757;5144.794208231704;5898.675572843492;6258.78094266703;6298.2442106947;6303.432691057781;3591.1560783215923;3931.8623848165175;4079.63283304504;4084.7344922579937;4135.379693046007;3222.4844024956365;3965.4646622705563;4133.0700592366475;4150.709450338447;4216.367544868233;3879.6120387960977;3974.8012599369918;4124.876253712393;4772.618190544748;4854.373784782067;4631.560001799824;5376.8118115865755;5628.380878103405;5727.6826329943515;6071.878562428727;1199.9680274963525;1211.2792888231488;1327.9668008299677;1418.4326269492285;1425.6293363725506;818.0388044048339;881.6164968238836;928.3223247029706;943.2972435535432;958.6836344006462;4335.956640433618;4759.762011899391;5429.909484848362;5465.977588292358;5467.343918729698;5825.88348233033;5900.468957793819;6031.155638210654;6031.2159419276095;6055.939440605625;5278.868028299246;5339.813106541253;5364.91952620711;5432.91850622241;5446.645968012146;2456.459578892641;2612.725663805311;2679.3033811209225;2681.2358477833723;2691.569348904166;4562.634989200922;4642;4901.50984901507;5268.341457317835;5281.3822531566;4200.319872051204;4917.434495033045;5253.973730131402;5464.836054918359;6269.802400775638;5694.743736531866;5786.218860453785;6279.6498752768375;6353.841153971188;6356.809295721136;5058.64589478733;5145.562627176732;5814.720761432478;5921.881562368642;6126.20359353299;4977.800887964441;5982.790602328898;6036.939630603638;6050.364711705208;6080.847978800565;5280.551153152025;5470.839018587715;5738.5696072795545;6374.298827129105;6375.6174629522375;3496;3960.702947279023;3974.1654252607277;3999.5200575931076;4000.579939106352;5029.54143298454;5743.324272465708;5918.644881307136;6122.816315510542;6141.263048434216;5647.05176714033;5681.551204442841;5723.227364305932;5938.465538101592;5960.821175364746;5522.944770552243;5559.19391688211;5824.009918313982;5913.704314784158;5947.256592925884;5115.672369072137;5616.522595579421;5703.287089113861;5733;5836.533077353886;4585.793639286173;5090.898182036412;5366.47775545493;5900.793472228452;6059.969910079996;4991.251312303184;5508.862278443071;5794.768209271582;5800;5815.423514538444 19:17:43 INFO - PROCESS | 2465 | |5;yui.html;607.419913982147;712.9394001509871;737.1743647115231;755.2447552447552;806.5523634382915;15155.469558565452;16074.83925160748;16092.919535402336;16170.7574386384;16206.594835129128;14151.575452736408;14450.349734261983;14563.854361456382;14596.270186490687;15080.49195080494;842.0568962761715;850.1328644782318;866.8526350520426;866.9436486628381;872.1148034744739;853.6372041882206;862.5040601654042;868.6351732272461;869.0787764969122;871.5163084488106;888.5557221389305;898.6091050393068;906.6056265524518;907.2107266677999;908.1009800297724;764.3044829205425;888.5201990924893;896.8161526886972;900.0279697926223;901.0088902207585;651.1209866679992;671.8018184635545;672.4687496877461;672.8586996730693;675.0313300413922;13028.609141725668;13078.869211307956;13084.476620935151;13084.607461776066;13098.148620339647;9780.462074585896;9995.450250236234;10042.799144017152;10054.849177262347;11829.053675705924;9181.540922953825;10903.672889813239;10922.672319830417;10971.890281097167;11463.36951467669;3291.703746662788;3788.1287303920253;3803.2583646189005;3956.8812935611977;4018.819153138116;76515.61742191309;78761;89554.65668014986;103713;112308.438457808;8892.777680557909;11368.261063030877;11477.024452921596;11513.424328783527;11618.76762464746;22172.55654886893;22523.099076037102;22525.4368640782;22584.66123008156;22584.983675734304;7854.6858125674335;7885.881711774328;8075.717349892843;8247.95876020628;8338.374621903382;3814;4483.708558943658;4596.448426188878;4621.930671039937;4623.190941585209;3648.1244501319493;3761.586225515191;3762.435634654824;3765.2657731742047;3773.2830762155104;585.7744768264164;587.0050264801121;595.6128516464333;605.6910975402488;606.915031895535;568.7440651706748;652.9249136349285;662.9237637671633;671.5064427645676;673.6160388578561;9173.357864949523;9458.337916345927;9532.52337383128;9689.24032646477;9860.30977831545;569.680978651948;587.9029960056629;626.4017862940881;640.276487569044;701.9824504387432;3860.3244432224246;4597.402337696078;4685.5782979532005;4710.481846996828;4743.501932297128;157786;159663;161132;162485.18757406136;168021.1598942022;53068.93862122736;114129;116493.41753291179;134371;137835;87857;111507;112355;114151;115815.99999999831;7401.0748656417945;9301.674441394518;9896.356736812084;10028.398296102258;10036.64871729486;46539.04418124362;52444.737776310874;56085.43914560802;56559.71720141373;56867.14699279431;72382.63808680922;84762.57618712114;85941.54642989142;86527;87530;10966.561337546409;12970.935145324212;13006.219626822422;13216.735665286447;13515.391807368494;13895.652608684864;14677.853221467649;14723.92638036803;14965.476208333092;15114;11195.216334856808;12048.277103373475;12953.611391658265;13674.794878077037;13887.652808679864;11937.4031298433;13462.259575723428;13547.051706380458;13566.796498052734;14303.459103872668;11952.940235298767;11953.820692689791;12254.632361029184;12391.380430978596;12680.619581412573;11248.200287953889;11333.546658133582;11495;11581.652550423501;11663.435363187049;7035.366816986496;10065;11430.485628146587;11791.351475668578;11838.704032399259 19:17:43 INFO - PROCESS | 2465 | __end_tp_report 19:17:43 INFO - PROCESS | 2465 | __start_cc_report 19:17:43 INFO - PROCESS | 2465 | _x_x_mozilla_cycle_collect,419 19:17:43 INFO - PROCESS | 2465 | __end_cc_report 19:17:43 INFO - PROCESS | 2465 | __startTimestamp1471659463242__endTimestamp 19:17:43 INFO - PROCESS | 2465 | 19:17:43 INFO - PROCESS | 2465 | ------- Summary: start ------- 19:17:43 INFO - PROCESS | 2465 | Number of tests: 6 19:17:43 INFO - PROCESS | 2465 | 19:17:43 INFO - PROCESS | 2465 | [#0] dojo.html Cycles:165 Average:5756.24 Median:5942.64 stddev:656.58 (11.0%) stddev-sans-first:631.32 19:17:43 INFO - PROCESS | 2465 | Values: 3368.6 3395.6 3398.5 3404.6 3423.1 4746.6 5575.0 5715.9 5757.6 5764.5 5705.9 5779.8 5867.4 5869.4 5877.2 5193.5 5203.1 5294.0 5302.6 5354.5 4753.0 5145.9 5383.6 5411.9 5420.9 5084.3 5152.6 5213.8 5271.1 5310.2 5243.3 5262.9 5279.8 5282.3 5282.9 5147.2 5202.6 5215.5 5259.1 5263.8 5426.9 5701.9 5789.0 5793.7 5806.2 5186.9 6232.6 6255.1 6284.2 6292.6 6288.2 6289.2 6292.8 6306.6 6312.8 5791.8 5932.9 5947.4 5991.3 6068.6 6405.2 6412.7 6412.8 6413.8 6414.1 6161.7 6228.3 6259.1 6267.4 6274.3 6155.0 6158.9 6217.5 6218.8 6299.5 4897.8 6246.8 6267.2 6278.6 6289.4 5541.2 6249.1 6250.3 6263.9 6281.2 4520.8 5011.9 5032.8 5037.4 5083.6 4526.5 4562.0 4565.1 4579.1 4584.7 5906.9 5910.1 5942.6 5956.7 5995.6 6155.5 6170.5 6191.8 6203.0 6346.1 5891.6 5933.2 5933.8 5937.2 5963.4 5554.4 5569.2 5577.4 5590.6 5593.5 6301.8 6357.0 6381.3 6408.0 6505.0 6278.1 6278.5 6288.4 6293.8 6322.9 5308.5 6414.9 6430.8 6485.4 6486.2 6109.1 6174.2 6200.1 6235.9 6296.4 4490.6 5668.2 6281.6 6289.6 6293.4 5608.0 6051.6 6192.9 6200.1 6215.7 5977.1 6054.8 6104.9 6166.6 6205.8 5451.0 5509.2 5512.5 6124.1 6131.4 6163.1 6170.5 6189.2 6225.1 6242.0 5839.0 5849.8 5873.3 5903.3 5973.0 19:17:43 INFO - PROCESS | 2465 | 19:17:43 INFO - PROCESS | 2465 | [#1] ext.html Cycles:180 Average:65579.07 Median:39944.60 stddev:139828.21 (350.1%) stddev-sans-first:140135.03 19:17:43 INFO - PROCESS | 2465 | Values: 474.9 484.4 501.8 516.0 525.2 29278.0 40319.0 40389.8 40471.8 40545.2 41704.9 41992.7 42050.6 42065.0 42100.4 9765.3 9974.6 9979.2 9993.2 10010.5 9794.8 9916.8 9926.9 9930.4 9960.1 9937.4 9938.2 9941.9 9944.5 9962.0 9824.4 9879.1 9897.9 9902.6 9904.3 9688.9 9767.6 9773.0 9777.7 9780.9 39069.6 39288.4 39293.6 39565.8 39577.8 3325.8 3889.0 4156.5 4174.2 4284.9 30567.5 31350.2 31665.0 31838.2 32321.5 3214.2 3342.5 3380.8 3417.0 3419.3 412775.9 431334.0 439505.0 439615.0 444186.0 49661.5 55885.7 55938.0 55991.7 56045.4 57747.0 58239.7 58431.4 58452.1 58486.0 15908.3 16099.5 16108.4 16116.8 16148.0 12520.3 12533.3 12648.3 12659.3 12662.1 13448.1 14622.0 14703.6 14772.3 14884.4 3194.2 6155.8 6433.1 6436.7 6440.6 912.7 985.7 1013.6 1051.4 1091.6 24643.5 30115.2 30569.7 30961.9 31009.7 1030.0 1037.9 1082.2 1158.4 1193.5 14252.4 15119.4 15794.8 15817.5 16050.8 464047.0 541717.0 542094.0 542148.0 542998.0 56321.0 56485.7 56872.1 56970.9 57120.4 1261.6 1390.3 1405.3 1431.9 1437.0 27496.3 29489.2 29777.1 29951.7 30668.5 49436.0 49504.0 49710.0 49932.8 50033.0 594365.0 598587.0 599174.0 599619.0 600943.0 26130.7 26259.6 26595.0 26664.2 26688.9 47807.8 48451.8 48586.0 48694.8 48944.5 37704.6 38567.0 38978.7 39418.0 40434.4 38391.8 38523.6 38592.8 39418.2 40311.4 37151.0 37600.0 37755.2 38009.0 38091.0 25662.6 28703.3 32163.4 34514.3 34669.7 25560.4 25593.7 25632.4 25983.9 26176.3 19:17:43 INFO - PROCESS | 2465 | 19:17:43 INFO - PROCESS | 2465 | [#2] jquery.html Cycles:180 Average:35744.90 Median:24543.45 stddev:102243.65 (416.6%) stddev-sans-first:102495.96 19:17:43 INFO - PROCESS | 2465 | Values: 367.6 379.8 384.6 385.1 402.5 18326.8 19753.7 19878.9 20132.3 20163.3 18837.0 18999.6 19509.7 20195.9 20528.5 5380.8 5731.8 5734.3 5940.6 5954.4 5940.6 5975.6 5980.1 5999.9 6009.0 5728.9 5770.7 5789.5 5905.1 5932.2 5797.4 5830.7 5884.1 5891.9 5900.0 5097.6 5117.2 5136.2 5137.4 5143.1 20632.1 24346.3 24740.6 25702.5 25925.4 2188.6 2317.1 2430.4 2434.1 3102.1 15392.5 15557.7 15662.5 15888.0 16022.6 1863.3 1930.3 1938.1 1974.1 1976.2 108033.5 109844.5 110084.3 110439.2 111567.4 10723.0 10801.3 10954.8 11025.1 11249.8 10914.9 13553.0 13561.7 13601.2 13656.1 8336.6 8489.4 8511.1 8605.7 8760.1 6874.6 8155.6 8611.1 8611.6 8742.3 6528.5 6654.3 6688.0 6693.4 6694.1 1499.6 1626.0 1876.8 1900.7 1923.8 839.5 840.0 892.6 931.6 995.6 21374.5 21979.7 22006.4 22130.7 22154.3 835.7 972.9 987.8 989.2 1041.3 10416.8 11133.8 11592.1 11786.8 11791.4 577684.0 579334.0 625275.0 630872.0 640395.0 139449.3 143990.6 145290.5 146544.0 148286.5 965.4 994.5 1012.4 1013.1 1022.9 17700.0 18906.4 19850.2 20088.5 20337.6 45343.3 48454.3 51346.0 55836.0 59511.8 64121.4 84940.6 85673.3 86609.7 88027.7 6990.5 7137.4 7930.3 7939.5 8079.3 7140.7 10818.5 11272.5 12739.9 13306.2 11103.0 11316.4 11329.3 11424.4 11625.4 8918.2 8987.8 11174.2 11280.7 11449.8 11359.7 11549.4 11780.5 11826.8 11913.5 6259.7 7280.0 7474.4 7479.9 7539.9 9027.0 11030.8 11356.2 11447.5 11452.3 19:17:43 INFO - PROCESS | 2465 | 19:17:43 INFO - PROCESS | 2465 | [#3] mootools.html Cycles:180 Average:5667.72 Median:4939.47 stddev:3174.36 (64.3%) stddev-sans-first:3167.66 19:17:43 INFO - PROCESS | 2465 | Values: 1478.9 1503.8 1716.9 1851.7 1858.5 7894.4 8383.5 8540.9 8952.1 8958.1 8626.5 8797.2 8821.7 8828.8 8848.3 1951.0 1964.3 2396.8 2400.3 2410.4 2353.0 2380.8 2410.1 2417.0 2420.1 2397.0 2406.3 2409.5 2437.6 2438.8 1902.6 2061.9 2297.2 2310.2 2313.0 2384.6 2393.4 2395.1 2395.6 2400.3 7882.9 8549.2 8863.0 8868.6 8933.8 4836.5 5122.8 5255.8 5429.9 5438.1 3553.1 3624.0 3751.7 3761.8 3762.3 1074.4 1106.8 1113.0 1135.4 1136.6 10833.5 11589.9 11680.2 11700.6 11765.2 3654.9 4659.4 4851.2 4861.1 4868.2 9872.3 9965.8 9980.3 9982.6 9993.4 5371.0 5375.6 5378.1 5385.6 5389.8 4059.9 4272.4 4371.1 4870.6 4895.7 3816.1 3854.7 3918.1 3944.0 3949.6 1125.2 1296.9 1315.8 1317.6 1331.7 818.1 843.4 897.8 911.0 939.4 5085.4 5594.4 5902.7 6129.9 6168.2 736.3 943.9 946.7 960.0 964.7 3404.6 3757.9 3962.7 3975.0 4126.9 10140.1 10607.4 10639.7 10655.1 10684.0 10321.3 10397.1 10559.1 10568.7 10576.9 8083.8 8207.0 8209.5 8209.9 8215.7 5809.2 5860.1 5952.6 5962.1 5992.6 8025.0 9667.6 9931.0 10000.9 10004.3 10229.0 10254.4 10256.2 10310.9 10313.3 6549.1 6928.9 7043.2 7056.1 7219.2 8479.8 8480.0 8562.2 8564.0 8585.7 7462.2 7533.5 7536.9 7618.9 7686.6 6769.6 7345.6 7430.3 7514.0 7547.9 6931.5 7070.7 7073.2 7077.2 7100.3 4215.4 4891.6 4911.5 5054.1 5079.2 4967.5 4971.8 5058.6 5169.6 5185.3 19:17:43 INFO - PROCESS | 2465 | 19:17:43 INFO - PROCESS | 2465 | [#4] prototype.html Cycles:180 Average:4638.31 Median:5240.21 stddev:1465.96 (28.0%) stddev-sans-first:1433.32 19:17:43 INFO - PROCESS | 2465 | Values: 292.2 305.5 312.9 314.3 318.0 4631.3 5396.4 5472.3 5520.4 5688.7 5226.5 5529.9 5597.3 5599.8 5703.7 3745.4 3810.2 4230.3 4233.6 4265.7 3814.1 4083.4 4110.9 4278.6 4283.2 3371.7 4145.8 4184.6 4216.6 4223.9 3805.6 4114.7 4182.2 4190.7 4266.9 3262.5 3348.9 3608.9 3675.8 3685.4 5128.9 5155.5 5331.8 5401.8 5429.6 4079.5 4512.8 4772.9 4850.5 4865.4 5604.4 5912.7 5912.7 5913.2 5987.7 3333.4 3994.3 4025.4 4029.6 4053.5 5144.8 5898.7 6258.8 6298.2 6303.4 3591.2 3931.9 4079.6 4084.7 4135.4 3222.5 3965.5 4133.1 4150.7 4216.4 3879.6 3974.8 4124.9 4772.6 4854.4 4631.6 5376.8 5628.4 5727.7 6071.9 1200.0 1211.3 1328.0 1418.4 1425.6 818.0 881.6 928.3 943.3 958.7 4336.0 4759.8 5429.9 5466.0 5467.3 5825.9 5900.5 6031.2 6031.2 6055.9 5278.9 5339.8 5364.9 5432.9 5446.6 2456.5 2612.7 2679.3 2681.2 2691.6 4562.6 4642.0 4901.5 5268.3 5281.4 4200.3 4917.4 5254.0 5464.8 6269.8 5694.7 5786.2 6279.6 6353.8 6356.8 5058.6 5145.6 5814.7 5921.9 6126.2 4977.8 5982.8 6036.9 6050.4 6080.8 5280.6 5470.8 5738.6 6374.3 6375.6 3496.0 3960.7 3974.2 3999.5 4000.6 5029.5 5743.3 5918.6 6122.8 6141.3 5647.1 5681.6 5723.2 5938.5 5960.8 5522.9 5559.2 5824.0 5913.7 5947.3 5115.7 5616.5 5703.3 5733.0 5836.5 4585.8 5090.9 5366.5 5900.8 6060.0 4991.3 5508.9 5794.8 5800.0 5815.4 19:17:43 INFO - PROCESS | 2465 | 19:17:43 INFO - PROCESS | 2465 | [#5] yui.html Cycles:180 Average:23515.01 Median:3837.16 stddev:38450.42 (1002.1%) stddev-sans-first:38519.82 19:17:43 INFO - PROCESS | 2465 | Values: 607.4 712.9 737.2 755.2 806.6 15155.5 16074.8 16092.9 16170.8 16206.6 14151.6 14450.3 14563.9 14596.3 15080.5 842.1 850.1 866.9 866.9 872.1 853.6 862.5 868.6 869.1 871.5 888.6 898.6 906.6 907.2 908.1 764.3 888.5 896.8 900.0 901.0 651.1 671.8 672.5 672.9 675.0 13028.6 13078.9 13084.5 13084.6 13098.1 9780.5 9995.5 10042.8 10054.8 11829.1 9181.5 10903.7 10922.7 10971.9 11463.4 3291.7 3788.1 3803.3 3956.9 4018.8 76515.6 78761.0 89554.7 103713.0 112308.4 8892.8 11368.3 11477.0 11513.4 11618.8 22172.6 22523.1 22525.4 22584.7 22585.0 7854.7 7885.9 8075.7 8248.0 8338.4 3814.0 4483.7 4596.4 4621.9 4623.2 3648.1 3761.6 3762.4 3765.3 3773.3 585.8 587.0 595.6 605.7 606.9 568.7 652.9 662.9 671.5 673.6 9173.4 9458.3 9532.5 9689.2 9860.3 569.7 587.9 626.4 640.3 702.0 3860.3 4597.4 4685.6 4710.5 4743.5 157786.0 159663.0 161132.0 162485.2 168021.2 53068.9 114129.0 116493.4 134371.0 137835.0 87857.0 111507.0 112355.0 114151.0 115816.0 7401.1 9301.7 9896.4 10028.4 10036.6 46539.0 52444.7 56085.4 56559.7 56867.1 72382.6 84762.6 85941.5 86527.0 87530.0 10966.6 12970.9 13006.2 13216.7 13515.4 13895.7 14677.9 14723.9 14965.5 15114.0 11195.2 12048.3 12953.6 13674.8 13887.7 11937.4 13462.3 13547.1 13566.8 14303.5 11952.9 11953.8 12254.6 12391.4 12680.6 11248.2 11333.5 11495.0 11581.7 11663.4 7035.4 10065.0 11430.5 11791.4 11838.7 19:17:43 INFO - PROCESS | 2465 | -------- Summary: end -------- 19:17:43 INFO - PROCESS | 2465 | 19:17:43 INFO - TEST-INFO | 2465: exit 0 19:17:43 INFO - TEST-OK | dromaeo_css | took 1114154ms 19:17:43 INFO - TEST-START | kraken 19:17:43 INFO - operating with platform_type : mac_ 19:17:43 INFO - Initialising browser for kraken test... 19:17:43 INFO - TEST-INFO | started process 2469 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmpu2HUmu/profile http://localhost:61944/getInfo.html) 19:17:46 INFO - PROCESS | 2469 | __metrics Screen width/height:1600/1200 19:17:46 INFO - PROCESS | 2469 | colorDepth:24 19:17:46 INFO - PROCESS | 2469 | Browser inner width/height: 1024/689 19:17:46 INFO - PROCESS | 2469 | __metrics 19:17:46 ERROR - PROCESS | 2469 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 19:17:47 INFO - TEST-INFO | 2469: exit 0 19:17:47 INFO - Browser initialized. 19:17:47 INFO - Running cycle 1/1 for kraken test... 19:17:47 INFO - TEST-INFO | started process 2471 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmpu2HUmu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:17:59 INFO - PROCESS | 2471 | RSS: Main: 239140864 19:17:59 INFO - PROCESS | 2471 | 19:18:02 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:61944/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:61944/tests/kraken/driver.html?testName=audio-beat-detection) 19:18:03 INFO - PROCESS | 2471 | RSS: Main: 251965440 19:18:03 INFO - PROCESS | 2471 | 19:18:06 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:61944/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:61944/tests/kraken/driver.html?testName=audio-dft) 19:18:07 INFO - PROCESS | 2471 | RSS: Main: 260644864 19:18:07 INFO - PROCESS | 2471 | 19:18:10 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:61944/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:61944/tests/kraken/driver.html?testName=audio-fft) 19:18:11 INFO - PROCESS | 2471 | RSS: Main: 263823360 19:18:11 INFO - PROCESS | 2471 | 19:18:13 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:61944/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:61944/tests/kraken/driver.html?testName=audio-oscillator) 19:18:14 INFO - PROCESS | 2471 | RSS: Main: 266076160 19:18:14 INFO - PROCESS | 2471 | 19:18:16 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:61944/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:61944/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:18:16 INFO - PROCESS | 2471 | RSS: Main: 266452992 19:18:16 INFO - PROCESS | 2471 | 19:18:19 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:61944/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:61944/tests/kraken/driver.html?testName=imaging-darkroom) 19:18:20 INFO - PROCESS | 2471 | RSS: Main: 266543104 19:18:20 INFO - PROCESS | 2471 | 19:18:23 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:61944/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:61944/tests/kraken/driver.html?testName=imaging-desaturate) 19:18:23 INFO - PROCESS | 2471 | RSS: Main: 266870784 19:18:23 INFO - PROCESS | 2471 | 19:18:27 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:61944/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:61944/tests/kraken/driver.html?testName=json-parse-financial) 19:18:27 INFO - PROCESS | 2471 | RSS: Main: 267010048 19:18:27 INFO - PROCESS | 2471 | 19:18:29 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:61944/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:61944/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:18:30 INFO - PROCESS | 2471 | RSS: Main: 266891264 19:18:30 INFO - PROCESS | 2471 | 19:18:31 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:61944/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:61944/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:18:32 INFO - PROCESS | 2471 | RSS: Main: 266878976 19:18:32 INFO - PROCESS | 2471 | 19:18:34 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:61944/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:61944/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:18:35 INFO - PROCESS | 2471 | RSS: Main: 266956800 19:18:35 INFO - PROCESS | 2471 | 19:18:38 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:61944/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:61944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:18:39 INFO - PROCESS | 2471 | RSS: Main: 267046912 19:18:39 INFO - PROCESS | 2471 | 19:18:41 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:61944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:61944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:18:42 INFO - PROCESS | 2471 | RSS: Main: 267046912 19:18:42 INFO - PROCESS | 2471 | 19:18:44 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:61944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:61944/tests/kraken/driver.html?testName=ai-astar) 19:18:44 INFO - PROCESS | 2471 | RSS: Main: 268206080 19:18:44 INFO - PROCESS | 2471 | 19:18:44 INFO - PROCESS | 2471 | __start_tp_report 19:18:44 INFO - PROCESS | 2471 | _x_x_mozilla_page_load 19:18:44 INFO - PROCESS | 2471 | _x_x_mozilla_page_load_details 19:18:44 INFO - PROCESS | 2471 | |i|pagename|runs| 19:18:44 INFO - PROCESS | 2471 | |0;ai-astar;107;118;109;129;116;117;124;121;173;100 19:18:44 INFO - PROCESS | 2471 | |1;audio-beat-detection;146;117;144;162;113;132;130;127;167;113 19:18:44 INFO - PROCESS | 2471 | |2;audio-dft;212;275;167;244;188;277;270;196;187;206 19:18:44 INFO - PROCESS | 2471 | |3;audio-fft;76;87;79;155;51;58;64;90;167;82 19:18:44 INFO - PROCESS | 2471 | |4;audio-oscillator;70;76;136;72;71;75;116;72;79;140 19:18:44 INFO - PROCESS | 2471 | |5;imaging-gaussian-blur;136;86;130;131;88;85;92;84;114;87 19:18:44 INFO - PROCESS | 2471 | |6;imaging-darkroom;96;151;95;95;95;95;105;125;96;96 19:18:44 INFO - PROCESS | 2471 | |7;imaging-desaturate;93;93;99;92;144;131;155;91;91;92 19:18:44 INFO - PROCESS | 2471 | |8;json-parse-financial;57;53;76;91;93;86;58;59;56;57 19:18:44 INFO - PROCESS | 2471 | |9;json-stringify-tinderbox;66;65;67;74;77;79;76;73;72;70 19:18:44 INFO - PROCESS | 2471 | |10;stanford-crypto-aes;86;94;110;107;86;91;90;90;85;86 19:18:44 INFO - PROCESS | 2471 | |11;stanford-crypto-ccm;169;159;154;141;141;140;141;143;158;148 19:18:44 INFO - PROCESS | 2471 | |12;stanford-crypto-pbkdf2;170;173;169;166;171;169;192;219;171;170 19:18:44 INFO - PROCESS | 2471 | |13;stanford-crypto-sha256-iterative;68;67;70;63;68;85;69;68;68;67 19:18:44 INFO - PROCESS | 2471 | __end_tp_report 19:18:44 INFO - PROCESS | 2471 | __start_cc_report 19:18:44 INFO - PROCESS | 2471 | _x_x_mozilla_cycle_collect,1070 19:18:44 INFO - PROCESS | 2471 | __end_cc_report 19:18:44 INFO - PROCESS | 2471 | __startTimestamp1471659524528__endTimestamp 19:18:44 INFO - PROCESS | 2471 | 19:18:44 INFO - PROCESS | 2471 | ------- Summary: start ------- 19:18:44 INFO - PROCESS | 2471 | Number of tests: 14 19:18:44 INFO - PROCESS | 2471 | 19:18:44 INFO - PROCESS | 2471 | [#0] ai-astar Cycles:10 Average:121.40 Median:119.50 stddev:20.02 (16.8%) stddev-sans-first:20.54 19:18:44 INFO - PROCESS | 2471 | Values: 107.0 118.0 109.0 129.0 116.0 117.0 124.0 121.0 173.0 100.0 19:18:44 INFO - PROCESS | 2471 | 19:18:44 INFO - PROCESS | 2471 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:138.00 stddev:19.28 (14.0%) stddev-sans-first:20.04 19:18:44 INFO - PROCESS | 2471 | Values: 146.0 117.0 144.0 162.0 113.0 132.0 130.0 127.0 167.0 113.0 19:18:44 INFO - PROCESS | 2471 | 19:18:44 INFO - PROCESS | 2471 | [#2] audio-dft Cycles:10 Average:222.20 Median:228.00 stddev:40.91 (17.9%) stddev-sans-first:43.22 19:18:44 INFO - PROCESS | 2471 | Values: 212.0 275.0 167.0 244.0 188.0 277.0 270.0 196.0 187.0 206.0 19:18:44 INFO - PROCESS | 2471 | 19:18:44 INFO - PROCESS | 2471 | [#3] audio-fft Cycles:10 Average:90.90 Median:77.50 stddev:39.10 (50.4%) stddev-sans-first:41.09 19:18:44 INFO - PROCESS | 2471 | Values: 76.0 87.0 79.0 155.0 51.0 58.0 64.0 90.0 167.0 82.0 19:18:44 INFO - PROCESS | 2471 | 19:18:44 INFO - PROCESS | 2471 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:72.00 stddev:28.36 (39.4%) stddev-sans-first:29.07 19:18:44 INFO - PROCESS | 2471 | Values: 70.0 76.0 136.0 72.0 71.0 75.0 116.0 72.0 79.0 140.0 19:18:44 INFO - PROCESS | 2471 | 19:18:44 INFO - PROCESS | 2471 | [#5] imaging-gaussian-blur Cycles:10 Average:103.30 Median:85.50 stddev:21.85 (25.6%) stddev-sans-first:19.72 19:18:44 INFO - PROCESS | 2471 | Values: 136.0 86.0 130.0 131.0 88.0 85.0 92.0 84.0 114.0 87.0 19:18:44 INFO - PROCESS | 2471 | 19:18:44 INFO - PROCESS | 2471 | [#6] imaging-darkroom Cycles:10 Average:104.90 Median:95.00 stddev:18.73 (19.7%) stddev-sans-first:19.59 19:18:44 INFO - PROCESS | 2471 | Values: 96.0 151.0 95.0 95.0 95.0 95.0 105.0 125.0 96.0 96.0 19:18:44 INFO - PROCESS | 2471 | 19:18:44 INFO - PROCESS | 2471 | [#7] imaging-desaturate Cycles:10 Average:108.10 Median:92.00 stddev:25.07 (27.2%) stddev-sans-first:25.98 19:18:44 INFO - PROCESS | 2471 | Values: 93.0 93.0 99.0 92.0 144.0 131.0 155.0 91.0 91.0 92.0 19:18:44 INFO - PROCESS | 2471 | 19:18:44 INFO - PROCESS | 2471 | [#8] json-parse-financial Cycles:10 Average:68.60 Median:67.50 stddev:16.09 (23.8%) stddev-sans-first:16.51 19:18:44 INFO - PROCESS | 2471 | Values: 57.0 53.0 76.0 91.0 93.0 86.0 58.0 59.0 56.0 57.0 19:18:44 INFO - PROCESS | 2471 | 19:18:44 INFO - PROCESS | 2471 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:73.50 stddev:4.82 (6.6%) stddev-sans-first:4.61 19:18:44 INFO - PROCESS | 2471 | Values: 66.0 65.0 67.0 74.0 77.0 79.0 76.0 73.0 72.0 70.0 19:18:44 INFO - PROCESS | 2471 | 19:18:44 INFO - PROCESS | 2471 | [#10] stanford-crypto-aes Cycles:10 Average:92.50 Median:88.00 stddev:8.92 (10.1%) stddev-sans-first:9.15 19:18:44 INFO - PROCESS | 2471 | Values: 86.0 94.0 110.0 107.0 86.0 91.0 90.0 90.0 85.0 86.0 19:18:44 INFO - PROCESS | 2471 | 19:18:44 INFO - PROCESS | 2471 | [#11] stanford-crypto-ccm Cycles:10 Average:149.40 Median:151.00 stddev:10.08 (6.7%) stddev-sans-first:7.81 19:18:44 INFO - PROCESS | 2471 | Values: 169.0 159.0 154.0 141.0 141.0 140.0 141.0 143.0 158.0 148.0 19:18:44 INFO - PROCESS | 2471 | 19:18:44 INFO - PROCESS | 2471 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.00 Median:171.00 stddev:16.41 (9.6%) stddev-sans-first:17.21 19:18:44 INFO - PROCESS | 2471 | Values: 170.0 173.0 169.0 166.0 171.0 169.0 192.0 219.0 171.0 170.0 19:18:44 INFO - PROCESS | 2471 | 19:18:44 INFO - PROCESS | 2471 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:68.00 stddev:5.81 (8.5%) stddev-sans-first:6.15 19:18:44 INFO - PROCESS | 2471 | Values: 68.0 67.0 70.0 63.0 68.0 85.0 69.0 68.0 68.0 67.0 19:18:44 INFO - PROCESS | 2471 | -------- Summary: end -------- 19:18:44 INFO - PROCESS | 2471 | 19:18:45 INFO - TEST-INFO | 2471: exit 0 19:18:45 INFO - TEST-OK | kraken | took 61450ms 19:18:45 INFO - SUITE-END | took 1175s 19:18:45 INFO - Completed test suite (00:19:35) 19:18:45 INFO - javascript benchmark 19:18:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7335.734979550771, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3368.6294507604175, 3395.55857738494, 3398.524206611075, 3404.55740753702, 3423.1271025888395, 4746.62027037837, 5575.0, 5715.885682286362, 5757.625754325971, 5764.5100166485845, 5705.857353566163, 5779.826605201851, 5867.383924687911, 5869.3837147099475, 5877.206577112089, 5193.480651934795, 5203.141481655542, 5294.047071527124, 5302.558636456462, 5354.491323324278, 4752.976235118819, 5145.871353216181, 5383.623146379736, 5411.864703382427, 5420.91868621971, 5084.288199652015, 5152.613553983466, 5213.817516386946, 5271.130263506517, 5310.1769225769685, 5243.2659427680155, 5262.92105618416, 5279.762410691528, 5282.286891269706, 5282.947170528284, 5147.150720131174, 5202.557782588485, 5215.452377500345, 5259.105951988171, 5263.842084737464, 5426.9185962210595, 5701.885962280731, 5789.0, 5793.7392817323325, 5806.1581070744505, 5186.896262074737, 6232.626042437423, 6255.12428260044, 6284.214473190851, 6292.5595208335435, 6288.213973253343, 6289.213848268966, 6292.779752708633, 6306.590071645328, 6312.779052733133, 5791.768329266824, 5932.911006334908, 5947.434993675594, 5991.281046274387, 6068.6358818471035, 6405.231372235362, 6412.67936603168, 6412.839679008062, 6413.839654008687, 6414.10202571631, 6161.661108639068, 6228.283747369111, 6259.0924315973925, 6267.373262673787, 6274.341194174637, 6154.969225153845, 6158.876822463526, 6217.502599792006, 6218.751249950042, 6299.5275354348605, 4897.828575999894, 6246.781362652377, 6267.1539342188225, 6278.623282603058, 6289.371062893674, 5541.196526503634, 6249.0626406039455, 6250.312465628777, 6263.937360626335, 6281.152044474029, 4520.796564154621, 5011.899762004739, 5032.798688052437, 5037.3955125384455, 5083.567896728746, 4526.547345265447, 4561.954380456219, 4565.086982603492, 4579.084183163381, 4584.679072464962, 5906.940930590639, 5910.054391297372, 5942.64344139353, 5956.672383018976, 5995.640261584319, 6155.538334624921, 6170.5372097092895, 6191.81424557264, 6203.0, 6346.11154438379, 5891.587588868823, 5933.169356290123, 5933.762649493972, 5937.168796368512, 5963.403659634088, 5554.361248456479, 5569.220309156722, 5577.358603760619, 5590.580706447033, 5593.4617980055, 6301.842453938597, 6357.0, 6381.266154392119, 6408.03879418091, 6505.0, 6278.0896769967185, 6278.497720182466, 6288.434040936338, 6293.779717709858, 6322.8735425290315, 5308.495692909168, 6414.903776443264, 6430.839229019312, 6485.416312531895, 6486.2216534016225, 6109.11417844419, 6174.228221472316, 6200.0699895016105, 6235.875282494416, 6296.401841825019, 4490.595846373842, 5668.178114173505, 6281.59169653971, 6289.559730818982, 6293.37066293367, 5608.0, 6051.636901785907, 6192.876142477216, 6200.0699895016105, 6215.720292586754, 5977.133315669116, 6054.84862878414, 6104.893811634979, 6166.630002199882, 6205.782797602063, 5451.0, 5509.201165831012, 5512.5314348280845, 6124.142620033288, 6131.356207598138, 6163.137160797582, 6170.50635949132, 6189.226346706661, 6225.066240063846, 6242.0, 5838.970805145947, 5849.824505264849, 5873.2658417697785, 5903.291605007426, 5973.0], "value": 5717.371128124003, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.8603351955307, 484.41385923033107, 501.8207213049332, 515.9948400515995, 525.1990714160904, 29278.0, 40319.0, 40389.79805100974, 40471.797641011755, 40545.189096218055, 41704.872134589874, 41992.740217793515, 42050.57949420505, 42065.0, 42100.36849447253, 9765.316427850054, 9974.551145198484, 9979.201663866874, 9993.200543956465, 10010.54952527138, 9794.804103917917, 9916.752081197956, 9926.900730992706, 9930.404175749478, 9960.05379488951, 9937.40375577464, 9938.20494360453, 9941.900580994206, 9944.453055081967, 9962.003799620052, 9824.36141650794, 9879.110880020797, 9897.86174589917, 9902.603895844157, 9904.306698531105, 9688.854667179998, 9767.560459779326, 9772.95113524435, 9777.657781977596, 9780.853287200698, 39069.63256286016, 39288.41067383991, 39293.60706392928, 39565.80217098925, 39577.80211098926, 3325.7671962962604, 3889.0, 4156.480439945007, 4174.227767862955, 4284.892877678052, 30567.541486877715, 31350.21624459384, 31665.0, 31838.20404489883, 32321.51517727236, 3214.2285851395495, 3342.4819153031076, 3380.816714150028, 3417.043227896168, 3419.2990436960363, 412775.93612032046, 431334.0, 439505.0, 439615.0, 444186.0, 49661.50338496641, 55885.72057139688, 55938.0, 55991.720041400346, 56045.43954560484, 57747.0, 58239.70880145657, 58431.41568584345, 58452.12321815176, 58486.0, 15908.284127214303, 16099.517014489584, 16108.355665773237, 16116.838831611534, 16148.0, 12520.31138287403, 12533.31066791317, 12648.304343261208, 12659.303738294482, 12662.113652044452, 13448.1258718183, 14622.0, 14703.632409189642, 14772.335244914004, 14884.404623815142, 3194.2493514024186, 6155.795817970428, 6433.099366088752, 6436.742530298736, 6440.6135631862235, 912.6577533424966, 985.6895078050535, 1013.5894962540183, 1051.4217180550665, 1091.6179337231906, 24643.507129857302, 30115.247118821768, 30569.69430305713, 30961.91633292824, 31009.68990310068, 1029.9639512617023, 1037.8547003419528, 1082.1613249731522, 1158.3571118029406, 1193.5225909636042, 14252.358643861051, 15119.395224191128, 15794.763078553831, 15817.525474235792, 16050.75923861143, 464047.0, 541717.0, 542094.0, 542148.0, 542998.0, 56321.0, 56485.71757141188, 56872.146917796264, 56970.86058278894, 57120.428795712345, 1261.5773715805308, 1390.2631605249235, 1405.304374334711, 1431.9284035798169, 1437.0, 27496.312592184557, 29489.198526139982, 29777.10668679943, 29951.700482995762, 30668.539971899994, 49436.011279774924, 49504.00991980212, 49710.0, 49932.750336248086, 50033.0, 594365.0, 598587.0, 599174.0, 599619.0, 600943.0, 26130.693465327036, 26259.606105908046, 26595.0, 26664.20007399781, 26688.866555667875, 47807.760961194974, 48451.78870528265, 48586.02827943492, 48694.78263043452, 48944.510554894, 37704.622953771206, 38567.03582410462, 38978.66581754416, 39418.0, 40434.39348409835, 38391.808040959615, 38523.614763853126, 38592.807035965765, 39418.21163576655, 40311.39532907067, 37151.0, 37600.0, 37755.24489510249, 38009.0, 38091.047723807125, 25662.61506077373, 28703.282417938884, 32163.391830408855, 34514.309713806084, 34669.653303467654, 25560.360990975376, 25593.744062559137, 25632.359191020372, 25983.87008065023, 26176.34559136037], "value": 19576.358310064224, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.606660872866, 379.7512629227855, 384.5923321279444, 385.1488211053572, 402.4586930578373, 18326.816731832678, 19753.703694444594, 19878.90060549695, 20132.295369662064, 20163.294284700038, 18837.0, 18999.62000759984, 19509.70735438966, 20195.899020504912, 20528.486787830312, 5380.811671591495, 5731.799387021455, 5734.340550836645, 5940.643561386309, 5954.374790646984, 5940.61386009908, 5975.611585246967, 5980.073088671263, 5999.880002399949, 6009.0, 5728.856778580527, 5770.711464426783, 5789.536837053026, 5905.084711869667, 5932.199153114318, 5797.391273916221, 5830.650160990333, 5884.117382392633, 5891.882162356729, 5900.0, 5097.592192624581, 5117.206832940863, 5136.229565565158, 5137.40919794221, 5143.125668636303, 20632.07155677998, 24346.26961191167, 24740.628890566655, 25702.48595028089, 25925.351866203306, 2188.627933251351, 2317.073170731704, 2430.3559556717482, 2434.087217293515, 3102.0693791862577, 15392.538223853302, 15557.688846223013, 15662.530124096294, 15888.0, 16022.5994350141, 1863.282636185065, 1930.2747576031813, 1938.108470103754, 1974.0919177178514, 1976.2391479280436, 108033.45983270033, 109844.4507777456, 110084.34873476904, 110439.23901902516, 111567.44216278948, 10723.03492685662, 10801.297915635458, 10954.835677464844, 11025.062869656169, 11249.83859272719, 10914.853940336308, 13553.0, 13561.660958475919, 13601.183928964294, 13656.112352697042, 8336.62485188168, 8489.363297752694, 8511.148885111563, 8605.655773769104, 8760.12398760119, 6874.587524748531, 8155.632996515053, 8611.052784193733, 8611.569421528899, 8742.28989013408, 6528.54300198991, 6654.3345665434035, 6688.030235615808, 6693.397594216543, 6694.062831203635, 1499.5576304990054, 1625.951221463358, 1876.8123187681122, 1900.657881581301, 1923.8460923126117, 839.5214727605206, 839.954256950101, 892.6250974590688, 931.5668214280257, 995.6017592962728, 21374.465638358855, 21979.670304945437, 22006.44983875384, 22130.668039979413, 22154.338424617898, 835.7409203147043, 972.8881178664544, 987.7975015121883, 989.1690979577046, 1041.286718597763, 10416.791664166674, 11133.832992505118, 11592.118078968955, 11786.823197652042, 11791.410429478492, 577684.0, 579334.0, 625275.0, 630872.0, 640395.0, 139449.3027534876, 143990.56009439772, 145290.54709452981, 146544.0, 148286.51713482942, 965.4400447740294, 994.5275993902839, 1012.4229189361993, 1013.0629168019552, 1022.867027286448, 17700.02649854219, 18906.43280701581, 19850.205991760744, 20088.497787554843, 20337.59324813525, 45343.31985020293, 48454.27318590153, 51345.973080538926, 55836.0, 59511.809763805344, 64121.35878641154, 84940.57529712311, 85673.28653426773, 86609.69226872899, 88027.679584805, 6990.475714321345, 7137.430525010888, 7930.276695634756, 7939.491496615625, 8079.272865441903, 7140.678669459783, 10818.513166907665, 11272.492737826653, 12739.872601273868, 13306.201627902357, 11103.0, 11316.377599231791, 11329.32024078525, 11424.371659558805, 11625.360605166798, 8918.152775486318, 8987.775305617412, 11174.161937854857, 11280.717982050186, 11449.828252576051, 11359.659210223706, 11549.42252887369, 11780.469878855301, 11826.763464730486, 11913.463894124612, 6259.718312675849, 7280.0, 7474.402047836269, 7479.925200747923, 7539.9246007541415, 9026.954865225633, 11030.834537482106, 11356.205065645325, 11447.484863181011, 11452.255603385753], "value": 9676.210194885827, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.9482368117117, 1503.781951617016, 1716.8840253835006, 1851.694470412382, 1858.5260758506588, 7894.447388682795, 8383.496990180585, 8540.871886921701, 8952.060033696465, 8958.059403762602, 8626.525541095252, 8797.164269394414, 8821.691240806573, 8828.77928051799, 8848.336374771901, 1950.9609807803836, 1964.3321270767935, 2396.7842894139526, 2400.2919138853995, 2410.433548116191, 2352.952940941189, 2380.821438392119, 2410.144398738449, 2417.0090262992176, 2420.1408499982517, 2396.9880150599224, 2406.3142004528713, 2409.4819613783034, 2437.597796363598, 2438.756124387565, 1902.5719213177063, 2061.9484512887148, 2297.241910169657, 2310.214527060799, 2312.9537409251807, 2384.5707772600927, 2393.365758074112, 2395.137750409851, 2395.6406539019113, 2400.2559206645997, 7882.921170788276, 8549.230569248797, 8862.955685221597, 8868.600912958933, 8933.776655583597, 4836.51634836517, 5122.795088196468, 5255.789768409259, 5429.864253393657, 5438.102713052342, 3553.1472446612884, 3623.963760362389, 3751.6998640108727, 3761.755485893408, 3762.3039737648623, 1074.425182527344, 1106.8118419868642, 1112.9554817807277, 1135.4436326200184, 1136.6135513925306, 10833.512491937881, 11589.942050289694, 11680.182387232897, 11700.590479333183, 11765.176437649368, 3654.8903532893523, 4659.394278743742, 4851.151048566558, 4861.076395484846, 4868.221084626513, 9872.259580531489, 9965.80068398628, 9980.301378903407, 9982.550785214682, 9993.350432221881, 5371.0, 5375.596830237748, 5378.139497680352, 5385.623006389594, 5389.784408623611, 4059.939100913489, 4272.401863739079, 4371.125774845043, 4870.561649451566, 4895.657303988686, 3816.0650640592676, 3854.6723528500393, 3918.0988372674447, 3943.960560394359, 3949.565547789741, 1125.240462687699, 1296.857345691973, 1315.8420989481324, 1317.5586178630074, 1331.6803967047838, 818.1286929420148, 843.3716880923629, 897.8148843526612, 910.9544522773834, 939.4222553129775, 5085.389753229562, 5594.41258667834, 5902.704864756745, 6129.877402451926, 6168.228971378578, 736.2637362637363, 943.8537026760725, 946.6970569417858, 959.9680343630625, 964.6527250190067, 3404.5914490261325, 3757.9436308455397, 3962.702797290157, 3974.960250397517, 4126.938095928564, 10140.13808826258, 10607.41659208751, 10639.734006649896, 10655.094316983143, 10684.038436540593, 10321.329113607591, 10397.116245119098, 10559.102476289601, 10568.727723539323, 10576.94711526453, 8083.838323233503, 8206.958965205136, 8209.507429554245, 8209.876851847228, 8215.671373145007, 5809.157672137432, 5860.120981852756, 5952.613080149777, 5962.07587823888, 5992.610480318765, 8025.0, 9667.564959576695, 9931.013797240435, 10000.949995249977, 10004.299699021, 10229.028242316968, 10254.436006019741, 10256.230782691178, 10310.948445258025, 10313.329633573794, 6549.115869357766, 6928.861422771617, 7043.225245223124, 7056.08270924797, 7219.205887352282, 8479.830403392021, 8479.982402111786, 8562.229399354088, 8563.95718021431, 8585.65657373698, 7462.179160292472, 7533.510321829063, 7536.886946695694, 7618.923810761821, 7686.57723825195, 6769.627670478171, 7345.595992220479, 7430.256974302527, 7514.023176986957, 7547.924520754722, 6931.549449285781, 7070.681819318246, 7073.2219455858785, 7077.221505634273, 7100.254473280231, 4215.409842622097, 4891.596488084635, 4911.459739428731, 5054.064997975386, 5079.238114282887, 4967.484289882761, 4971.801127954841, 5058.570021548209, 5169.586433085269, 5185.325907631984], "value": 4559.724764258323, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.2066589210295, 305.5264340272577, 312.8779775887404, 314.317930091701, 317.9602699173702, 4631.305304204367, 5396.3524377074755, 5472.315960504937, 5520.3565646673205, 5688.691600931783, 5226.451222621627, 5529.861753456165, 5597.3003374578175, 5599.804006859761, 5703.686297253649, 3745.363288240992, 3810.2379524095154, 4230.323148296273, 4233.576642335773, 4265.722728022684, 3814.141818090935, 4083.4283200351974, 4110.856120035799, 4278.593533614302, 4283.186194623027, 3371.7134043606325, 4145.792710364485, 4184.560621134783, 4216.64158546524, 4223.936640950388, 3805.6384643458828, 4114.650254728352, 4182.16356728654, 4190.685698572619, 4266.935995960063, 3262.5106234064842, 3348.8995330140133, 3608.9458658120147, 3675.8162091895565, 3685.355062864015, 5128.897152167593, 5155.530673757961, 5331.840044798662, 5401.810936617238, 5429.619926605139, 4079.4696689430184, 4512.796924138422, 4772.928406073912, 4850.53919877611, 4865.3675022247235, 5604.439556044363, 5912.674802885839, 5912.704364781744, 5913.172155898178, 5987.670678112702, 3333.399988002159, 3994.3009973254857, 4025.416314634391, 4029.61718636732, 4053.4730485036757, 5144.794208231704, 5898.675572843492, 6258.78094266703, 6298.2442106947, 6303.432691057781, 3591.1560783215923, 3931.8623848165175, 4079.63283304504, 4084.7344922579937, 4135.379693046007, 3222.4844024956365, 3965.4646622705563, 4133.0700592366475, 4150.709450338447, 4216.367544868233, 3879.6120387960977, 3974.8012599369918, 4124.876253712393, 4772.618190544748, 4854.373784782067, 4631.560001799824, 5376.8118115865755, 5628.380878103405, 5727.6826329943515, 6071.878562428727, 1199.9680274963525, 1211.2792888231488, 1327.9668008299677, 1418.4326269492285, 1425.6293363725506, 818.0388044048339, 881.6164968238836, 928.3223247029706, 943.2972435535432, 958.6836344006462, 4335.956640433618, 4759.762011899391, 5429.909484848362, 5465.977588292358, 5467.343918729698, 5825.88348233033, 5900.468957793819, 6031.155638210654, 6031.2159419276095, 6055.939440605625, 5278.868028299246, 5339.813106541253, 5364.91952620711, 5432.91850622241, 5446.645968012146, 2456.459578892641, 2612.725663805311, 2679.3033811209225, 2681.2358477833723, 2691.569348904166, 4562.634989200922, 4642.0, 4901.50984901507, 5268.341457317835, 5281.3822531566, 4200.319872051204, 4917.434495033045, 5253.973730131402, 5464.836054918359, 6269.802400775638, 5694.743736531866, 5786.218860453785, 6279.6498752768375, 6353.841153971188, 6356.809295721136, 5058.64589478733, 5145.562627176732, 5814.720761432478, 5921.881562368642, 6126.20359353299, 4977.800887964441, 5982.790602328898, 6036.939630603638, 6050.364711705208, 6080.847978800565, 5280.551153152025, 5470.839018587715, 5738.5696072795545, 6374.298827129105, 6375.6174629522375, 3496.0, 3960.702947279023, 3974.1654252607277, 3999.5200575931076, 4000.579939106352, 5029.54143298454, 5743.324272465708, 5918.644881307136, 6122.816315510542, 6141.263048434216, 5647.05176714033, 5681.551204442841, 5723.227364305932, 5938.465538101592, 5960.821175364746, 5522.944770552243, 5559.19391688211, 5824.009918313982, 5913.704314784158, 5947.256592925884, 5115.672369072137, 5616.522595579421, 5703.287089113861, 5733.0, 5836.533077353886, 4585.793639286173, 5090.898182036412, 5366.47775545493, 5900.793472228452, 6059.969910079996, 4991.251312303184, 5508.862278443071, 5794.768209271582, 5800.0, 5815.423514538444], "value": 4170.873895051428, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.419913982147, 712.9394001509871, 737.1743647115231, 755.2447552447552, 806.5523634382915, 15155.469558565452, 16074.83925160748, 16092.919535402336, 16170.7574386384, 16206.594835129128, 14151.575452736408, 14450.349734261983, 14563.854361456382, 14596.270186490687, 15080.49195080494, 842.0568962761715, 850.1328644782318, 866.8526350520426, 866.9436486628381, 872.1148034744739, 853.6372041882206, 862.5040601654042, 868.6351732272461, 869.0787764969122, 871.5163084488106, 888.5557221389305, 898.6091050393068, 906.6056265524518, 907.2107266677999, 908.1009800297724, 764.3044829205425, 888.5201990924893, 896.8161526886972, 900.0279697926223, 901.0088902207585, 651.1209866679992, 671.8018184635545, 672.4687496877461, 672.8586996730693, 675.0313300413922, 13028.609141725668, 13078.869211307956, 13084.476620935151, 13084.607461776066, 13098.148620339647, 9780.462074585896, 9995.450250236234, 10042.799144017152, 10054.849177262347, 11829.053675705924, 9181.540922953825, 10903.672889813239, 10922.672319830417, 10971.890281097167, 11463.36951467669, 3291.703746662788, 3788.1287303920253, 3803.2583646189005, 3956.8812935611977, 4018.819153138116, 76515.61742191309, 78761.0, 89554.65668014986, 103713.0, 112308.438457808, 8892.777680557909, 11368.261063030877, 11477.024452921596, 11513.424328783527, 11618.76762464746, 22172.55654886893, 22523.099076037102, 22525.4368640782, 22584.66123008156, 22584.983675734304, 7854.6858125674335, 7885.881711774328, 8075.717349892843, 8247.95876020628, 8338.374621903382, 3814.0, 4483.708558943658, 4596.448426188878, 4621.930671039937, 4623.190941585209, 3648.1244501319493, 3761.586225515191, 3762.435634654824, 3765.2657731742047, 3773.2830762155104, 585.7744768264164, 587.0050264801121, 595.6128516464333, 605.6910975402488, 606.915031895535, 568.7440651706748, 652.9249136349285, 662.9237637671633, 671.5064427645676, 673.6160388578561, 9173.357864949523, 9458.337916345927, 9532.52337383128, 9689.24032646477, 9860.30977831545, 569.680978651948, 587.9029960056629, 626.4017862940881, 640.276487569044, 701.9824504387432, 3860.3244432224246, 4597.402337696078, 4685.5782979532005, 4710.481846996828, 4743.501932297128, 157786.0, 159663.0, 161132.0, 162485.18757406136, 168021.1598942022, 53068.93862122736, 114129.0, 116493.41753291179, 134371.0, 137835.0, 87857.0, 111507.0, 112355.0, 114151.0, 115815.99999999831, 7401.0748656417945, 9301.674441394518, 9896.356736812084, 10028.398296102258, 10036.64871729486, 46539.04418124362, 52444.737776310874, 56085.43914560802, 56559.71720141373, 56867.14699279431, 72382.63808680922, 84762.57618712114, 85941.54642989142, 86527.0, 87530.0, 10966.561337546409, 12970.935145324212, 13006.219626822422, 13216.735665286447, 13515.391807368494, 13895.652608684864, 14677.853221467649, 14723.92638036803, 14965.476208333092, 15114.0, 11195.216334856808, 12048.277103373475, 12953.611391658265, 13674.794878077037, 13887.652808679864, 11937.4031298433, 13462.259575723428, 13547.051706380458, 13566.796498052734, 14303.459103872668, 11952.940235298767, 11953.820692689791, 12254.632361029184, 12391.380430978596, 12680.619581412573, 11248.200287953889, 11333.546658133582, 11495.0, 11581.652550423501, 11663.435363187049, 7035.366816986496, 10065.0, 11430.485628146587, 11791.351475668578, 11838.704032399259], "value": 7565.1570498904275, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1605.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 118.0, 109.0, 129.0, 116.0, 117.0, 124.0, 121.0, 173.0, 100.0], "value": 121.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 117.0, 144.0, 162.0, 113.0, 132.0, 130.0, 127.0, 167.0, 113.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [212.0, 275.0, 167.0, 244.0, 188.0, 277.0, 270.0, 196.0, 187.0, 206.0], "value": 222.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 87.0, 79.0, 155.0, 51.0, 58.0, 64.0, 90.0, 167.0, 82.0], "value": 90.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 76.0, 136.0, 72.0, 71.0, 75.0, 116.0, 72.0, 79.0, 140.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 86.0, 130.0, 131.0, 88.0, 85.0, 92.0, 84.0, 114.0, 87.0], "value": 103.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 151.0, 95.0, 95.0, 95.0, 95.0, 105.0, 125.0, 96.0, 96.0], "value": 104.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 99.0, 92.0, 144.0, 131.0, 155.0, 91.0, 91.0, 92.0], "value": 108.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 76.0, 91.0, 93.0, 86.0, 58.0, 59.0, 56.0, 57.0], "value": 68.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 74.0, 77.0, 79.0, 76.0, 73.0, 72.0, 70.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 94.0, 110.0, 107.0, 86.0, 91.0, 90.0, 90.0, 85.0, 86.0], "value": 92.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 159.0, 154.0, 141.0, 141.0, 140.0, 141.0, 143.0, 158.0, 148.0], "value": 149.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 173.0, 169.0, 166.0, 171.0, 169.0, 192.0, 219.0, 171.0, 170.0], "value": 177.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 70.0, 63.0, 68.0, 85.0, 69.0, 68.0, 68.0, 67.0], "value": 69.3, "unit": "score"}]}]} 19:18:45 INFO - Return code: 0 19:18:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:18:45 ERROR - # TBPL SUCCESS # 19:18:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:18:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:18:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:18:45 INFO - 2016-08-19 19:18:45.888 screenresolution[2476:88264] starting screenresolution argv=screenresolution get 19:18:45 INFO - 2016-08-19 19:18:45.890 screenresolution[2476:88264] Display 0: 1600x1200x32@60 19:18:45 INFO - 2016-08-19 19:18:45.896 screenresolution[2477:88267] starting screenresolution argv=screenresolution list 19:18:45 INFO - Available Modes on Display 0 19:18:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:18:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:18:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:18:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:18:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:18:46 INFO - Intel Iris: 19:18:46 INFO - Chipset Model: Intel Iris 19:18:46 INFO - Type: GPU 19:18:46 INFO - Bus: Built-In 19:18:46 INFO - VRAM (Dynamic, Max): 1536 MB 19:18:46 INFO - Vendor: Intel (0x8086) 19:18:46 INFO - Device ID: 0x0a2e 19:18:46 INFO - Revision ID: 0x0009 19:18:46 INFO - Displays: 19:18:46 INFO - Display: 19:18:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:18:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:18:46 INFO - Display Serial Number: 1600x1200 60 19:18:46 INFO - Main Display: Yes 19:18:46 INFO - Mirror: Off 19:18:46 INFO - Online: Yes 19:18:46 INFO - Rotation: Supported 19:18:46 INFO - Return code: 0 19:18:46 INFO - Running post-action listener: _resource_record_post_action 19:18:46 INFO - [mozharness: 2016-08-20 02:18:46.131714Z] Finished run-tests step (success) 19:18:46 INFO - Running post-run listener: _resource_record_post_run 19:18:46 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 0; Write bytes: 705276416; Read time: 0; Write time: 2156 19:18:46 INFO - TinderboxPrint: CPU usage
54.2% 19:18:46 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:18:46 INFO - TinderboxPrint: I/O write bytes / time
705,276,416 / 2,156 19:18:46 INFO - TinderboxPrint: CPU idle
2,217.3 (45.8%) 19:18:46 INFO - TinderboxPrint: CPU system
979.7 (20.2%) 19:18:46 INFO - TinderboxPrint: CPU user
1,644.7 (34.0%) 19:18:46 INFO - TinderboxPrint: Swap in / out
405,524,480 / 0 19:18:46 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399360512; Write bytes: 392959488; Read time: 29487; Write time: 728 19:18:46 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 0; Write bytes: 296346624; Read time: 0; Write time: 1385 19:18:46 INFO - Running post-run listener: _upload_blobber_files 19:18:46 INFO - Blob upload gear active. 19:18:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:18:46 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 19:18:46 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'] 19:18:46 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 19:18:47 INFO - (blobuploader) - INFO - Open directory for files ... 19:18:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:18:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:18:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:18:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:18:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:18:49 INFO - (blobuploader) - INFO - Done attempting. 19:18:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:18:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:18:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:18:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:18:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:18:49 INFO - (blobuploader) - INFO - Done attempting. 19:18:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:18:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:18:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:18:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:18:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:18:52 INFO - (blobuploader) - INFO - Done attempting. 19:18:52 INFO - (blobuploader) - INFO - Iteration through files over. 19:18:52 INFO - Return code: 0 19:18:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:18:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:18:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1afc4aca9e0d77e953d064bb66600f265201ba06401b5338fd25b1e4fa0c7d890ed4cc9c1e29789ddd777668f1b35885c42f447c51cd450405a00777772f4d52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6460835306367e8a2d9e49573be3a5d5499f1dc58ed05beadd741843ce3d20671c8cf697215537d7f646648407f58058d7acacdaeba559dbf2b0a7f16157f20f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35dacec179af86412d62fe635b3b3c1614e8c65a44032bbf0ab345789ba98dc06d3cc321260dcfcdee2a05f6b423e4e9a120da44283a488f7a99e16c93f78210"} 19:18:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:18:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:18:52 INFO - Contents: 19:18:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1afc4aca9e0d77e953d064bb66600f265201ba06401b5338fd25b1e4fa0c7d890ed4cc9c1e29789ddd777668f1b35885c42f447c51cd450405a00777772f4d52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6460835306367e8a2d9e49573be3a5d5499f1dc58ed05beadd741843ce3d20671c8cf697215537d7f646648407f58058d7acacdaeba559dbf2b0a7f16157f20f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35dacec179af86412d62fe635b3b3c1614e8c65a44032bbf0ab345789ba98dc06d3cc321260dcfcdee2a05f6b423e4e9a120da44283a488f7a99e16c93f78210"} 19:18:52 INFO - Running post-run listener: copy_logs_to_upload_dir 19:18:52 INFO - Copying logs to upload dir... 19:18:52 INFO - mkdir: /builds/slave/test/build/upload/logs 19:18:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.817261 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-19 19:18:52.250638) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 19:18:52.254166) ========= 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.Rn8vQYkGKI/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.T7wRrpoa27/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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/1afc4aca9e0d77e953d064bb66600f265201ba06401b5338fd25b1e4fa0c7d890ed4cc9c1e29789ddd777668f1b35885c42f447c51cd450405a00777772f4d52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6460835306367e8a2d9e49573be3a5d5499f1dc58ed05beadd741843ce3d20671c8cf697215537d7f646648407f58058d7acacdaeba559dbf2b0a7f16157f20f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35dacec179af86412d62fe635b3b3c1614e8c65a44032bbf0ab345789ba98dc06d3cc321260dcfcdee2a05f6b423e4e9a120da44283a488f7a99e16c93f78210"} build_url:https://queue.taskcluster.net/v1/task/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011485 build_url: 'https://queue.taskcluster.net/v1/task/Q0qy8lSHSVyMxvwgjZ7Lmg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1afc4aca9e0d77e953d064bb66600f265201ba06401b5338fd25b1e4fa0c7d890ed4cc9c1e29789ddd777668f1b35885c42f447c51cd450405a00777772f4d52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6460835306367e8a2d9e49573be3a5d5499f1dc58ed05beadd741843ce3d20671c8cf697215537d7f646648407f58058d7acacdaeba559dbf2b0a7f16157f20f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35dacec179af86412d62fe635b3b3c1614e8c65a44032bbf0ab345789ba98dc06d3cc321260dcfcdee2a05f6b423e4e9a120da44283a488f7a99e16c93f78210"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 19:18:52.286337) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 19:18:52.286680) ========= 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.Rn8vQYkGKI/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.T7wRrpoa27/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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.005282 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 19:18:52.335667) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 19:18:52.335999) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 19:18:52.336327) ========= ========= Total master_lag: 0.19 =========