builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0105 starttime: 1471394025.66 results: success (0) buildid: 20160816152615 builduid: 9eaa5fbcfb664d47af209bfb1e29f74c revision: 14974aa2862f2dd9fac16cd78cd88a6208c951d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 17:33:45.661419) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 17:33:45.662043) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 17:33:45.662498) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 17:33:45.727923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:33:45.728410) ========= 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.A36P8Q0sMM/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.1VjepzQDh3/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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-16 17:33:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.2M=0.001s 2016-08-16 17:33:45 (18.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147638 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:33:45.903571) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:33:45.903856) ========= 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.A36P8Q0sMM/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.1VjepzQDh3/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.028192 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:33:45.991914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 17:33:45.992274) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 14974aa2862f2dd9fac16cd78cd88a6208c951d6 --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 14974aa2862f2dd9fac16cd78cd88a6208c951d6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.A36P8Q0sMM/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.1VjepzQDh3/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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-16 17:33:46,072 truncating revision to first 12 chars 2016-08-16 17:33:46,073 Setting DEBUG logging. 2016-08-16 17:33:46,073 attempt 1/10 2016-08-16 17:33:46,073 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/14974aa2862f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 17:33:46,868 unpacking tar archive at: mozilla-central-14974aa2862f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.080045 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 17:33:47.099874) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 17:33:47.100162) ========= script_repo_revision: 14974aa2862f2dd9fac16cd78cd88a6208c951d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 17:33:47.100536) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 17:33:47.100811) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 17:33:47.152556) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-16 17:33:47.152861) ========= /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.A36P8Q0sMM/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.1VjepzQDh3/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 17:33:47 INFO - MultiFileLogger online at 20160816 17:33:47 in /builds/slave/test 17:33:47 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 17:33:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:33:47 INFO - {'append_to_log': False, 17:33:47 INFO - 'base_work_dir': '/builds/slave/test', 17:33:47 INFO - 'blob_upload_branch': 'Firefox', 17:33:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:33:47 INFO - 'branch': 'Firefox', 17:33:47 INFO - 'buildbot_json_path': 'buildprops.json', 17:33:47 INFO - 'config_files': ('talos/mac_config.py',), 17:33:47 INFO - 'default_actions': ('clobber', 17:33:47 INFO - 'read-buildbot-config', 17:33:47 INFO - 'download-and-extract', 17:33:47 INFO - 'populate-webroot', 17:33:47 INFO - 'create-virtualenv', 17:33:47 INFO - 'install', 17:33:47 INFO - 'run-tests'), 17:33:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:33:47 INFO - 'download_minidump_stackwalk': True, 17:33:47 INFO - 'download_symbols': 'ondemand', 17:33:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:33:47 INFO - 'tooltool.py': '/tools/tooltool.py', 17:33:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:33:47 INFO - '/tools/misc-python/virtualenv.py')}, 17:33:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:33:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:33:47 INFO - 'installer_path': 'installer.exe', 17:33:47 INFO - 'log_level': 'info', 17:33:47 INFO - 'log_name': 'talos', 17:33:47 INFO - 'log_to_console': True, 17:33:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:33:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:33:47 INFO - 'opt_config_files': (), 17:33:47 INFO - 'pip_index': False, 17:33:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:33:47 INFO - 'cmd': ('bash', 17:33:47 INFO - '-c', 17:33:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:33:47 INFO - 'enabled': True, 17:33:47 INFO - 'halt_on_failure': False, 17:33:47 INFO - 'name': 'check_screen_resolution'},), 17:33:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:33:47 INFO - 'cmd': ('bash', 17:33:47 INFO - '-c', 17:33:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:33:47 INFO - 'enabled': True, 17:33:47 INFO - 'halt_on_failure': False, 17:33:47 INFO - 'name': 'check_screen_resolution'},), 17:33:47 INFO - 'run_cmd_checks_enabled': True, 17:33:47 INFO - 'sps_profile': False, 17:33:47 INFO - 'sps_profile_interval': 0, 17:33:47 INFO - 'suite': 'dromaeojs-e10s', 17:33:47 INFO - 'system_bits': '32', 17:33:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:33:47 INFO - 'title': 't-yosemite-r7-0105', 17:33:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:33:47 INFO - 'use_talos_json': True, 17:33:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:33:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:33:47 INFO - 'work_dir': 'build'} 17:33:47 INFO - [mozharness: 2016-08-17 00:33:47.347822Z] Running clobber step. 17:33:47 INFO - Running pre-action listener: _resource_record_pre_action 17:33:47 INFO - Running main action method: clobber 17:33:47 INFO - rmtree: /builds/slave/test/build 17:33:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:33:49 INFO - Running post-action listener: _resource_record_post_action 17:33:49 INFO - [mozharness: 2016-08-17 00:33:49.491346Z] Finished clobber step (success) 17:33:49 INFO - [mozharness: 2016-08-17 00:33:49.491501Z] Running read-buildbot-config step. 17:33:49 INFO - Running pre-action listener: _resource_record_pre_action 17:33:49 INFO - Running main action method: read_buildbot_config 17:33:49 INFO - Using buildbot properties: 17:33:49 INFO - { 17:33:49 INFO - "project": "", 17:33:49 INFO - "product": "firefox", 17:33:49 INFO - "script_repo_revision": "production", 17:33:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:33:49 INFO - "repository": "", 17:33:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:33:49 INFO - "buildid": "20160816152615", 17:33:49 INFO - "pgo_build": "False", 17:33:49 INFO - "basedir": "/builds/slave/test", 17:33:49 INFO - "buildnumber": 59, 17:33:49 INFO - "slavename": "t-yosemite-r7-0105", 17:33:49 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 17:33:49 INFO - "platform": "yosemite_r7", 17:33:49 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:33:49 INFO - "branch": "mozilla-central", 17:33:49 INFO - "repo_path": "mozilla-central", 17:33:49 INFO - "revision": "14974aa2862f2dd9fac16cd78cd88a6208c951d6", 17:33:49 INFO - "stage_platform": "macosx64", 17:33:49 INFO - "builduid": "9eaa5fbcfb664d47af209bfb1e29f74c", 17:33:49 INFO - "slavebuilddir": "test" 17:33:49 INFO - } 17:33:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/f6oP3JAMQ9-n74BaQOwEWg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 17:33:49 INFO - Running post-action listener: _resource_record_post_action 17:33:49 INFO - [mozharness: 2016-08-17 00:33:49.494881Z] Finished read-buildbot-config step (success) 17:33:49 INFO - [mozharness: 2016-08-17 00:33:49.495006Z] Running download-and-extract step. 17:33:49 INFO - Running pre-action listener: _resource_record_pre_action 17:33:49 INFO - Running main action method: download_and_extract 17:33:49 INFO - mkdir: /builds/slave/test/build/tests 17:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:49 INFO - trying https://queue.taskcluster.net/v1/task/f6oP3JAMQ9-n74BaQOwEWg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 17:33:49 INFO - Downloading https://queue.taskcluster.net/v1/task/f6oP3JAMQ9-n74BaQOwEWg/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 17:33:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f6oP3JAMQ9-n74BaQOwEWg/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 17:33:50 INFO - Downloaded 1199 bytes. 17:33:50 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:33:50 INFO - Using the following test package requirements: 17:33:50 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:33:50 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:33:50 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 17:33:50 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:33:50 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 17:33:50 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:33:50 INFO - u'jsshell-mac.zip'], 17:33:50 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:33:50 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 17:33:50 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:33:50 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:33:50 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 17:33:50 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:33:50 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 17:33:50 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:33:50 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 17:33:50 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:33:50 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 17:33:50 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:33: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')]} 17:33:50 INFO - trying https://queue.taskcluster.net/v1/task/f6oP3JAMQ9-n74BaQOwEWg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:33:50 INFO - Downloading https://queue.taskcluster.net/v1/task/f6oP3JAMQ9-n74BaQOwEWg/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 17:33:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f6oP3JAMQ9-n74BaQOwEWg/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 17:33:51 INFO - Downloaded 16333035 bytes. 17:33: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 17:33:58 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 17:33: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')]} 17:33:58 INFO - trying https://queue.taskcluster.net/v1/task/f6oP3JAMQ9-n74BaQOwEWg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:33:58 INFO - Downloading https://queue.taskcluster.net/v1/task/f6oP3JAMQ9-n74BaQOwEWg/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 17:33:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f6oP3JAMQ9-n74BaQOwEWg/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 17:34:00 INFO - Downloaded 16333035 bytes. 17:34:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 17:34:06 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')]} 17:34:06 INFO - trying https://queue.taskcluster.net/v1/task/f6oP3JAMQ9-n74BaQOwEWg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 17:34:06 INFO - Downloading https://queue.taskcluster.net/v1/task/f6oP3JAMQ9-n74BaQOwEWg/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 17:34:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f6oP3JAMQ9-n74BaQOwEWg/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 17:34:08 INFO - Downloaded 14413719 bytes. 17:34:08 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 17:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:08 INFO - trying https://queue.taskcluster.net/v1/task/f6oP3JAMQ9-n74BaQOwEWg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:34:08 INFO - Downloading https://queue.taskcluster.net/v1/task/f6oP3JAMQ9-n74BaQOwEWg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 17:34:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f6oP3JAMQ9-n74BaQOwEWg/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 17:34:15 INFO - Downloaded 111004956 bytes. 17:34:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f6oP3JAMQ9-n74BaQOwEWg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:34:15 INFO - mkdir: /builds/slave/test/properties 17:34:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:34:15 INFO - Writing to file /builds/slave/test/properties/build_url 17:34:15 INFO - Contents: 17:34:15 INFO - build_url:https://queue.taskcluster.net/v1/task/f6oP3JAMQ9-n74BaQOwEWg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:34:16 INFO - Running post-action listener: _resource_record_post_action 17:34:16 INFO - Running post-action listener: set_extra_try_arguments 17:34:16 INFO - [mozharness: 2016-08-17 00:34:16.007654Z] Finished download-and-extract step (success) 17:34:16 INFO - [mozharness: 2016-08-17 00:34:16.007773Z] Running populate-webroot step. 17:34:16 INFO - Running pre-action listener: _resource_record_pre_action 17:34:16 INFO - Running main action method: populate_webroot 17:34:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:34:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:34:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:34:16 INFO - '--tppagecycles', 17:34:16 INFO - '7'], 17:34:16 INFO - 'tests': ['tsvgm']}}, 17:34:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:34:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:34:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:34:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:34:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:34:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:34:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:16 INFO - 'talos_options': ['--disable-e10s'], 17:34:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:16 INFO - 'talos_options': ['--disable-e10s'], 17:34:16 INFO - 'tests': ['damp', 'tps']}, 17:34:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:16 INFO - 'tests': ['damp', 'tps']}, 17:34:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:34:16 INFO - 'tests': ['dromaeo_dom']}, 17:34:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:34:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:34:16 INFO - 'tests': ['basic_compositor_video']}, 17:34:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:34:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:34:16 INFO - 'tests': ['a11yr', 17:34:16 INFO - 'ts_paint', 17:34:16 INFO - 'tpaint', 17:34:16 INFO - 'sessionrestore', 17:34:16 INFO - 'sessionrestore_no_auto_restore', 17:34:16 INFO - 'tabpaint']}, 17:34:16 INFO - 'other-e10s': {'tests': ['a11yr', 17:34:16 INFO - 'ts_paint', 17:34:16 INFO - 'tpaint', 17:34:16 INFO - 'sessionrestore', 17:34:16 INFO - 'sessionrestore_no_auto_restore', 17:34:16 INFO - 'tabpaint']}, 17:34:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:34:16 INFO - 'ts_paint', 17:34:16 INFO - 'tpaint', 17:34:16 INFO - 'sessionrestore', 17:34:16 INFO - 'sessionrestore_no_auto_restore', 17:34:16 INFO - 'tabpaint']}, 17:34:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:34:16 INFO - 'ts_paint', 17:34:16 INFO - 'tpaint', 17:34:16 INFO - 'sessionrestore', 17:34:16 INFO - 'sessionrestore_no_auto_restore', 17:34:16 INFO - 'tabpaint']}, 17:34:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:34:16 INFO - 'tests': ['a11yr', 17:34:16 INFO - 'ts_paint', 17:34:16 INFO - 'tpaint', 17:34:16 INFO - 'sessionrestore', 17:34:16 INFO - 'sessionrestore_no_auto_restore', 17:34:16 INFO - 'tabpaint']}, 17:34:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:34:16 INFO - 'tests': ['a11yr', 17:34:16 INFO - 'ts_paint', 17:34:16 INFO - 'tpaint', 17:34:16 INFO - 'sessionrestore', 17:34:16 INFO - 'sessionrestore_no_auto_restore', 17:34:16 INFO - 'tabpaint']}, 17:34:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:34:16 INFO - 'tests': ['tsvgx', 17:34:16 INFO - 'tsvgr_opacity', 17:34:16 INFO - 'tart', 17:34:16 INFO - 'tscrollx', 17:34:16 INFO - 'cart']}, 17:34:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:34:16 INFO - 'tsvgr_opacity', 17:34:16 INFO - 'tart', 17:34:16 INFO - 'tscrollx', 17:34:16 INFO - 'cart']}, 17:34:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:16 INFO - 'talos_options': ['--disable-e10s'], 17:34:16 INFO - 'tests': ['tp5o']}, 17:34:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:16 INFO - 'tests': ['tp5o']}, 17:34:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:16 INFO - 'talos_options': ['--disable-e10s', 17:34:16 INFO - '--xperf_path', 17:34:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:16 INFO - 'tests': ['tp5n']}, 17:34:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:16 INFO - 'talos_options': ['--xperf_path', 17:34:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:16 INFO - 'tests': ['tp5n']}}, 17:34:16 INFO - 'talos.zip': {'path': '', 17:34:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:34:16 INFO - Running post-action listener: _resource_record_post_action 17:34:16 INFO - [mozharness: 2016-08-17 00:34:16.026871Z] Finished populate-webroot step (success) 17:34:16 INFO - [mozharness: 2016-08-17 00:34:16.026958Z] Running create-virtualenv step. 17:34:16 INFO - Running pre-action listener: _resource_record_pre_action 17:34:16 INFO - Running main action method: create_virtualenv 17:34:16 INFO - Creating virtualenv /builds/slave/test/build/venv 17:34:16 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 17:34:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:34:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:34:16 INFO - Using real prefix '/tools/python27' 17:34:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:34:16 INFO - Installing distribute.............................................................................................................................................................................................done. 17:34:19 INFO - Installing pip.................done. 17:34:19 INFO - Return code: 0 17:34:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:34:19 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')]} 17:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:19 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')]} 17:34:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:19 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 0x10e2b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e349618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf9d972f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e218d30>, '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 0x10df7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e210b20>, '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.A36P8Q0sMM/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.1VjepzQDh3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 17:34:19 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 17:34:19 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 17:34:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A36P8Q0sMM/Render', 17:34:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:19 INFO - 'HOME': '/Users/cltbld', 17:34:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:19 INFO - 'LOGNAME': 'cltbld', 17:34:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:19 INFO - 'MOZ_NO_REMOTE': '1', 17:34:19 INFO - 'NO_EM_RESTART': '1', 17:34:19 INFO - 'PAGER': '/bin/cat', 17:34:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:19 INFO - 'PWD': '/builds/slave/test', 17:34:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:19 INFO - 'SHELL': '/bin/bash', 17:34:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VjepzQDh3/Listeners', 17:34:19 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 17:34:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:19 INFO - 'USER': 'cltbld', 17:34:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:19 INFO - 'XPC_FLAGS': '0x0', 17:34:19 INFO - 'XPC_SERVICE_NAME': '0', 17:34:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:19 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 17:34:19 INFO - Cleaning up... 17:34:19 INFO - Return code: 0 17:34:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:34:19 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')]} 17:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:19 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')]} 17:34:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:20 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 0x10e2b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e349618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf9d972f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e218d30>, '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 0x10df7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e210b20>, '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.A36P8Q0sMM/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.1VjepzQDh3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 17:34:20 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 17:34:20 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 17:34:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A36P8Q0sMM/Render', 17:34:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:20 INFO - 'HOME': '/Users/cltbld', 17:34:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:20 INFO - 'LOGNAME': 'cltbld', 17:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:20 INFO - 'MOZ_NO_REMOTE': '1', 17:34:20 INFO - 'NO_EM_RESTART': '1', 17:34:20 INFO - 'PAGER': '/bin/cat', 17:34:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:20 INFO - 'PWD': '/builds/slave/test', 17:34:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:20 INFO - 'SHELL': '/bin/bash', 17:34:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VjepzQDh3/Listeners', 17:34:20 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 17:34:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:20 INFO - 'USER': 'cltbld', 17:34:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:20 INFO - 'XPC_FLAGS': '0x0', 17:34:20 INFO - 'XPC_SERVICE_NAME': '0', 17:34:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:20 INFO - Downloading/unpacking psutil>=3.1.1 17:34:20 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 17:34:20 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 17:34:20 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 17:34:20 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 17:34:20 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 17:34:20 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 17:34:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:34:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:22 INFO - Installing collected packages: psutil 17:34:22 INFO - Running setup.py install for psutil 17:34:22 INFO - building 'psutil._psutil_osx' extension 17:34:22 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 17:34:23 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 17:34:23 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 17:34:23 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 17:34:23 INFO - building 'psutil._psutil_posix' extension 17:34:23 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 17:34:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:34:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:34:23 INFO - ^ 17:34:23 INFO - 1 warning generated. 17:34:23 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 17:34:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:23 INFO - Successfully installed psutil 17:34:23 INFO - Cleaning up... 17:34:24 INFO - Return code: 0 17:34:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:34:24 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')]} 17:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:24 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')]} 17:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:24 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 0x10e2b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e349618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf9d972f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e218d30>, '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 0x10df7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e210b20>, '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.A36P8Q0sMM/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.1VjepzQDh3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 17:34:24 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 17:34:24 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 17:34:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A36P8Q0sMM/Render', 17:34:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:24 INFO - 'HOME': '/Users/cltbld', 17:34:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:24 INFO - 'LOGNAME': 'cltbld', 17:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:24 INFO - 'MOZ_NO_REMOTE': '1', 17:34:24 INFO - 'NO_EM_RESTART': '1', 17:34:24 INFO - 'PAGER': '/bin/cat', 17:34:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:24 INFO - 'PWD': '/builds/slave/test', 17:34:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:24 INFO - 'SHELL': '/bin/bash', 17:34:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VjepzQDh3/Listeners', 17:34:24 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 17:34:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:24 INFO - 'USER': 'cltbld', 17:34:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:24 INFO - 'XPC_FLAGS': '0x0', 17:34:24 INFO - 'XPC_SERVICE_NAME': '0', 17:34:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:34:24 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 17:34:24 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 17:34:24 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 17:34:24 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 17:34:24 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 17:34:24 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 17:34:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:34:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:34:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:34:26 INFO - Installing collected packages: mozsystemmonitor 17:34:26 INFO - Running setup.py install for mozsystemmonitor 17:34:27 INFO - Successfully installed mozsystemmonitor 17:34:27 INFO - Cleaning up... 17:34:27 INFO - Return code: 0 17:34:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e2b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e349618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf9d972f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e218d30>, '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 0x10df7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e210b20>, '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.A36P8Q0sMM/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.1VjepzQDh3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 17:34:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:34:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:34:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A36P8Q0sMM/Render', 17:34:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:27 INFO - 'HOME': '/Users/cltbld', 17:34:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:27 INFO - 'LOGNAME': 'cltbld', 17:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:27 INFO - 'MOZ_NO_REMOTE': '1', 17:34:27 INFO - 'NO_EM_RESTART': '1', 17:34:27 INFO - 'PAGER': '/bin/cat', 17:34:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:27 INFO - 'PWD': '/builds/slave/test', 17:34:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:27 INFO - 'SHELL': '/bin/bash', 17:34:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VjepzQDh3/Listeners', 17:34:27 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 17:34:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:27 INFO - 'USER': 'cltbld', 17:34:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:27 INFO - 'XPC_FLAGS': '0x0', 17:34:27 INFO - 'XPC_SERVICE_NAME': '0', 17:34:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:27 INFO - Downloading/unpacking jsonschema==2.5.1 17:34:27 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 17:34:27 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 17:34:27 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 17:34:27 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 17:34:27 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 17:34:27 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 17:34:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:34:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:34:29 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 17:34:29 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 17:34:29 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 17:34:29 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 17:34:29 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 17:34:29 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 17:34:30 INFO - Downloading functools32-3.2.3-2.tar.gz 17:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:34:30 INFO - warning: no files found matching '*.txt' 17:34:30 INFO - no previously-included directories found matching 'build' 17:34:30 INFO - no previously-included directories found matching 'dist' 17:34:30 INFO - no previously-included directories found matching '.git*' 17:34:30 INFO - Installing collected packages: jsonschema, functools32 17:34:30 INFO - Running setup.py install for functools32 17:34:30 INFO - warning: no files found matching '*.txt' 17:34:30 INFO - no previously-included directories found matching 'build' 17:34:30 INFO - no previously-included directories found matching 'dist' 17:34:30 INFO - no previously-included directories found matching '.git*' 17:34:30 INFO - Successfully installed jsonschema functools32 17:34:30 INFO - Cleaning up... 17:34:30 INFO - Return code: 0 17:34:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:34:30 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')]} 17:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:30 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')]} 17:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:30 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 0x10e2b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e349618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf9d972f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e218d30>, '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 0x10df7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e210b20>, '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.A36P8Q0sMM/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.1VjepzQDh3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 17:34:30 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 17:34:30 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 17:34:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A36P8Q0sMM/Render', 17:34:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:30 INFO - 'HOME': '/Users/cltbld', 17:34:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:30 INFO - 'LOGNAME': 'cltbld', 17:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:30 INFO - 'MOZ_NO_REMOTE': '1', 17:34:30 INFO - 'NO_EM_RESTART': '1', 17:34:30 INFO - 'PAGER': '/bin/cat', 17:34:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:30 INFO - 'PWD': '/builds/slave/test', 17:34:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:30 INFO - 'SHELL': '/bin/bash', 17:34:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VjepzQDh3/Listeners', 17:34:30 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 17:34:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:30 INFO - 'USER': 'cltbld', 17:34:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:30 INFO - 'XPC_FLAGS': '0x0', 17:34:30 INFO - 'XPC_SERVICE_NAME': '0', 17:34:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:34:30 INFO - Cleaning up... 17:34:30 INFO - Return code: 0 17:34:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:34:30 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')]} 17:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:30 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')]} 17:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:30 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 0x10e2b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e349618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf9d972f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e218d30>, '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 0x10df7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e210b20>, '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.A36P8Q0sMM/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.1VjepzQDh3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 17:34:30 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 17:34:30 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 17:34:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A36P8Q0sMM/Render', 17:34:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:30 INFO - 'HOME': '/Users/cltbld', 17:34:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:30 INFO - 'LOGNAME': 'cltbld', 17:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:30 INFO - 'MOZ_NO_REMOTE': '1', 17:34:30 INFO - 'NO_EM_RESTART': '1', 17:34:30 INFO - 'PAGER': '/bin/cat', 17:34:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:30 INFO - 'PWD': '/builds/slave/test', 17:34:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:30 INFO - 'SHELL': '/bin/bash', 17:34:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VjepzQDh3/Listeners', 17:34:30 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 17:34:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:30 INFO - 'USER': 'cltbld', 17:34:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:30 INFO - 'XPC_FLAGS': '0x0', 17:34:30 INFO - 'XPC_SERVICE_NAME': '0', 17:34:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:31 INFO - Downloading/unpacking blobuploader==1.2.4 17:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:33 INFO - Downloading blobuploader-1.2.4.tar.gz 17:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:34:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:34:33 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 17:34:33 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 17:34:33 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 17:34:33 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 17:34:33 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 17:34:33 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 17:34:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:34:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:34:34 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 17:34:34 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 17:34:34 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 17:34:34 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 17:34:34 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 17:34:34 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 17:34:34 INFO - Downloading docopt-0.6.1.tar.gz 17:34:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:34:34 INFO - Installing collected packages: blobuploader, requests, docopt 17:34:34 INFO - Running setup.py install for blobuploader 17:34:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:34:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:34:34 INFO - Running setup.py install for requests 17:34:35 INFO - Running setup.py install for docopt 17:34:35 INFO - Successfully installed blobuploader requests docopt 17:34:35 INFO - Cleaning up... 17:34:35 INFO - Return code: 0 17:34:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:35 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 0x10e2b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e349618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf9d972f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e218d30>, '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 0x10df7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e210b20>, '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.A36P8Q0sMM/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.1VjepzQDh3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 17:34:35 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 17:34:35 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 17:34:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A36P8Q0sMM/Render', 17:34:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:35 INFO - 'HOME': '/Users/cltbld', 17:34:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:35 INFO - 'LOGNAME': 'cltbld', 17:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:35 INFO - 'MOZ_NO_REMOTE': '1', 17:34:35 INFO - 'NO_EM_RESTART': '1', 17:34:35 INFO - 'PAGER': '/bin/cat', 17:34:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:35 INFO - 'PWD': '/builds/slave/test', 17:34:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:35 INFO - 'SHELL': '/bin/bash', 17:34:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VjepzQDh3/Listeners', 17:34:35 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 17:34:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:35 INFO - 'USER': 'cltbld', 17:34:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:35 INFO - 'XPC_FLAGS': '0x0', 17:34:35 INFO - 'XPC_SERVICE_NAME': '0', 17:34:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:34:35 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-qzpoiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:34:36 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-msfHmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:34:36 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-eBnlJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:34:36 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-CDuO8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:34:36 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-PX7UXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:34:36 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-rKNgzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:34:36 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-DupDTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:34:36 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-YSCLnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:34:36 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-9WRO8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:34:36 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-chxk9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:34:36 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-MF6xST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:34:37 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-VQaRDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:34:37 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-eS69za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:34:37 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-YuVHQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:34:37 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-YJ50hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:34:37 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-NhDyYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:34:37 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-4D34wF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:34:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:34:37 INFO - Running setup.py install for manifestparser 17:34:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:34:37 INFO - Running setup.py install for mozcrash 17:34:37 INFO - Running setup.py install for mozdebug 17:34:38 INFO - Running setup.py install for mozdevice 17:34:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:34:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:34:38 INFO - Running setup.py install for mozfile 17:34:38 INFO - Running setup.py install for mozhttpd 17:34:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:34:38 INFO - Running setup.py install for mozinfo 17:34:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:34:38 INFO - Running setup.py install for mozInstall 17:34:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:34:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:34:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:34:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:34:38 INFO - Running setup.py install for mozleak 17:34:38 INFO - Running setup.py install for mozlog 17:34:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:34:39 INFO - Running setup.py install for moznetwork 17:34:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:34:39 INFO - Running setup.py install for mozprocess 17:34:39 INFO - Running setup.py install for mozprofile 17:34:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:34:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:34:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:34:39 INFO - Running setup.py install for mozrunner 17:34:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:34:39 INFO - Running setup.py install for mozscreenshot 17:34:39 INFO - Running setup.py install for moztest 17:34:40 INFO - Running setup.py install for mozversion 17:34:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:34:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:34:40 INFO - Cleaning up... 17:34:40 INFO - Return code: 0 17:34:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:40 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 0x10e2b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e349618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf9d972f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e218d30>, '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 0x10df7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e210b20>, '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.A36P8Q0sMM/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.1VjepzQDh3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 17:34:40 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 17:34:40 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 17:34:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A36P8Q0sMM/Render', 17:34:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:40 INFO - 'HOME': '/Users/cltbld', 17:34:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:40 INFO - 'LOGNAME': 'cltbld', 17:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:40 INFO - 'MOZ_NO_REMOTE': '1', 17:34:40 INFO - 'NO_EM_RESTART': '1', 17:34:40 INFO - 'PAGER': '/bin/cat', 17:34:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:40 INFO - 'PWD': '/builds/slave/test', 17:34:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:40 INFO - 'SHELL': '/bin/bash', 17:34:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VjepzQDh3/Listeners', 17:34:40 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 17:34:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:40 INFO - 'USER': 'cltbld', 17:34:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:40 INFO - 'XPC_FLAGS': '0x0', 17:34:40 INFO - 'XPC_SERVICE_NAME': '0', 17:34:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:34:40 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-sA85Hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:34:40 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)) 17:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:34:40 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-xWApE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:34:40 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)) 17:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:34:40 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-BvID9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:34:40 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)) 17:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:34:40 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-YxHrOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:34:40 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)) 17:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:34:40 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-QVeP_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:34:41 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)) 17:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:34:41 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-mMQx0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:34:41 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)) 17:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:34:41 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-22AJxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:34:41 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)) 17:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:34:41 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-5B7ZOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:34:41 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)) 17:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:34:41 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-7MNBio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:34:41 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)) 17:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:34:41 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-qRJd4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:34:41 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)) 17:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:34:41 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-FYkZo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:34:41 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)) 17:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:34:41 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-vN8XkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:34:41 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)) 17:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:34:41 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-W6XTWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:34:41 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)) 17:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:34:41 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-B8z70B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:34:42 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)) 17:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:34:42 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-b5q2Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:34:42 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)) 17:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:34:42 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-uTWfld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:34:42 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)) 17:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:34:42 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-ltjRmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:34:42 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)) 17:34:42 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)) 17:34:42 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)) 17:34:42 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)) 17:34:42 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)) 17:34:42 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)) 17:34:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:44 INFO - Downloading blessings-1.6.tar.gz 17:34:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:34:44 INFO - Installing collected packages: blessings 17:34:44 INFO - Running setup.py install for blessings 17:34:45 INFO - Successfully installed blessings 17:34:45 INFO - Cleaning up... 17:34:45 INFO - Return code: 0 17:34:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:34:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:34:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:34:45 INFO - Reading from file tmpfile_stdout 17:34:45 INFO - Current package versions: 17:34:45 INFO - blessings == 1.6 17:34:45 INFO - blobuploader == 1.2.4 17:34:45 INFO - docopt == 0.6.1 17:34:45 INFO - functools32 == 3.2.3-2 17:34:45 INFO - jsonschema == 2.5.1 17:34:45 INFO - manifestparser == 1.1 17:34:45 INFO - mozInstall == 1.12 17:34:45 INFO - mozcrash == 0.17 17:34:45 INFO - mozdebug == 0.1 17:34:45 INFO - mozdevice == 0.48 17:34:45 INFO - mozfile == 1.2 17:34:45 INFO - mozhttpd == 0.7 17:34:45 INFO - mozinfo == 0.9 17:34:45 INFO - mozleak == 0.1 17:34:45 INFO - mozlog == 3.3 17:34:45 INFO - moznetwork == 0.27 17:34:45 INFO - mozprocess == 0.23 17:34:45 INFO - mozprofile == 0.28 17:34:45 INFO - mozrunner == 6.12 17:34:45 INFO - mozscreenshot == 0.1 17:34:45 INFO - mozsystemmonitor == 0.3 17:34:45 INFO - moztest == 0.7 17:34:45 INFO - mozversion == 1.4 17:34:45 INFO - psutil == 3.1.1 17:34:45 INFO - requests == 1.2.3 17:34:45 INFO - wsgiref == 0.1.2 17:34:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:45 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 0x10e2b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e349618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf9d972f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e218d30>, '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 0x10df7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e210b20>, '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.A36P8Q0sMM/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.1VjepzQDh3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 17:34:45 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 17:34:45 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 17:34:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A36P8Q0sMM/Render', 17:34:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:45 INFO - 'HOME': '/Users/cltbld', 17:34:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:45 INFO - 'LOGNAME': 'cltbld', 17:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:45 INFO - 'MOZ_NO_REMOTE': '1', 17:34:45 INFO - 'NO_EM_RESTART': '1', 17:34:45 INFO - 'PAGER': '/bin/cat', 17:34:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:45 INFO - 'PWD': '/builds/slave/test', 17:34:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:45 INFO - 'SHELL': '/bin/bash', 17:34:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VjepzQDh3/Listeners', 17:34:45 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 17:34:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:45 INFO - 'USER': 'cltbld', 17:34:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:45 INFO - 'XPC_FLAGS': '0x0', 17:34:45 INFO - 'XPC_SERVICE_NAME': '0', 17:34:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:45 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)) 17:34:45 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)) 17:34:45 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)) 17:34:45 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)) 17:34:45 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)) 17:34:45 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)) 17:34:45 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)) 17:34:45 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)) 17:34:45 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)) 17:34:45 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)) 17:34:45 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)) 17:34:45 INFO - Cleaning up... 17:34:45 INFO - Return code: 0 17:34:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e349618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf9d972f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e218d30>, '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 0x10df7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e210b20>, '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.A36P8Q0sMM/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.1VjepzQDh3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 17:34:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:34:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:34:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A36P8Q0sMM/Render', 17:34:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:45 INFO - 'HOME': '/Users/cltbld', 17:34:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:45 INFO - 'LOGNAME': 'cltbld', 17:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:45 INFO - 'MOZ_NO_REMOTE': '1', 17:34:45 INFO - 'NO_EM_RESTART': '1', 17:34:45 INFO - 'PAGER': '/bin/cat', 17:34:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:45 INFO - 'PWD': '/builds/slave/test', 17:34:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:45 INFO - 'SHELL': '/bin/bash', 17:34:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VjepzQDh3/Listeners', 17:34:45 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 17:34:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:45 INFO - 'USER': 'cltbld', 17:34:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:45 INFO - 'XPC_FLAGS': '0x0', 17:34:45 INFO - 'XPC_SERVICE_NAME': '0', 17:34:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:34:45 INFO - Cleaning up... 17:34:45 INFO - Return code: 0 17:34:45 INFO - Running post-action listener: _resource_record_post_action 17:34:45 INFO - Running post-action listener: _start_resource_monitoring 17:34:45 INFO - Starting resource monitoring. 17:34:45 INFO - [mozharness: 2016-08-17 00:34:45.937567Z] Finished create-virtualenv step (success) 17:34:45 INFO - [mozharness: 2016-08-17 00:34:45.938537Z] Running install step. 17:34:45 INFO - Running pre-action listener: _resource_record_pre_action 17:34:45 INFO - Running main action method: install 17:34:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:34:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:34:46 INFO - Reading from file tmpfile_stdout 17:34:46 INFO - Detecting whether we're running mozinstall >=1.0... 17:34:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:34:46 INFO - Reading from file tmpfile_stdout 17:34:46 INFO - Output received: 17:34:46 INFO - Usage: mozinstall [options] installer 17:34:46 INFO - Options: 17:34:46 INFO - -h, --help show this help message and exit 17:34:46 INFO - -d DEST, --destination=DEST 17:34:46 INFO - Directory to install application into. [default: 17:34:46 INFO - "/builds/slave/test"] 17:34:46 INFO - --app=APP Application being installed. [default: firefox] 17:34:46 INFO - mkdir: /builds/slave/test/build/application 17:34:46 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'] 17:34:46 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 17:35:20 INFO - Reading from file tmpfile_stdout 17:35:20 INFO - Output received: 17:35:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:35:20 INFO - Running post-action listener: _resource_record_post_action 17:35:20 INFO - [mozharness: 2016-08-17 00:35:20.561205Z] Finished install step (success) 17:35:20 INFO - [mozharness: 2016-08-17 00:35:20.561363Z] Running run-tests step. 17:35:20 INFO - Running pre-action listener: _resource_record_pre_action 17:35:20 INFO - Running main action method: run_tests 17:35:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:35:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:35:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:35:20 INFO - 2016-08-16 17:35:20.575 screenresolution[1642:8056] starting screenresolution argv=screenresolution get 17:35:20 INFO - 2016-08-16 17:35:20.578 screenresolution[1642:8056] Display 0: 1600x1200x32@60 17:35:20 INFO - 2016-08-16 17:35:20.584 screenresolution[1643:8058] starting screenresolution argv=screenresolution list 17:35:20 INFO - Available Modes on Display 0 17:35:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:35:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:35:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:35:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:35:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:35:20 INFO - Intel Iris: 17:35:20 INFO - Chipset Model: Intel Iris 17:35:20 INFO - Type: GPU 17:35:20 INFO - Bus: Built-In 17:35:20 INFO - VRAM (Dynamic, Max): 1536 MB 17:35:20 INFO - Vendor: Intel (0x8086) 17:35:20 INFO - Device ID: 0x0a2e 17:35:20 INFO - Revision ID: 0x0009 17:35:20 INFO - Displays: 17:35:20 INFO - Display: 17:35:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:35:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:35:20 INFO - Display Serial Number: 1600x1200 60 17:35:20 INFO - Main Display: Yes 17:35:20 INFO - Mirror: Off 17:35:20 INFO - Online: Yes 17:35:20 INFO - Rotation: Supported 17:35:20 INFO - Return code: 0 17:35:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:35:20 INFO - Python 2.7.3 17:35:20 INFO - Return code: 0 17:35:20 INFO - grabbing minidump binary from tooltool 17:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e218d30>, '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 0x10df7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e210b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:35:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:35:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 17:35:20 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 17:35:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:35:20 INFO - Return code: 0 17:35:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:35:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:35:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:35:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:35:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:35:20 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/f6oP3JAMQ9-n74BaQOwEWg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0105', '--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 17:35:20 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/f6oP3JAMQ9-n74BaQOwEWg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0105 --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 17:35:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A36P8Q0sMM/Render', 17:35:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:20 INFO - 'HOME': '/Users/cltbld', 17:35:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:20 INFO - 'LOGNAME': 'cltbld', 17:35:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:35:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:20 INFO - 'MOZ_NO_REMOTE': '1', 17:35:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:35:20 INFO - 'NO_EM_RESTART': '1', 17:35:20 INFO - 'PAGER': '/bin/cat', 17:35:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:20 INFO - 'PWD': '/builds/slave/test', 17:35:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:35:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:20 INFO - 'SHELL': '/bin/bash', 17:35:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VjepzQDh3/Listeners', 17:35:20 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 17:35:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:20 INFO - 'USER': 'cltbld', 17:35:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:20 INFO - 'XPC_FLAGS': '0x0', 17:35:20 INFO - 'XPC_SERVICE_NAME': '0', 17:35:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:20 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/f6oP3JAMQ9-n74BaQOwEWg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0105', '--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 17:35:21 INFO - mozversion application_buildid: 20160816152615 17:35:21 INFO - mozversion application_changeset: 14974aa2862f2dd9fac16cd78cd88a6208c951d6 17:35:21 INFO - mozversion application_display_name: Nightly 17:35:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:35:21 INFO - mozversion application_name: Firefox 17:35:21 INFO - mozversion application_remotingname: firefox 17:35:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:35:21 INFO - mozversion application_vendor: Mozilla 17:35:21 INFO - mozversion application_version: 51.0a1 17:35:21 INFO - mozversion platform_buildid: 20160816152615 17:35:21 INFO - mozversion platform_changeset: 14974aa2862f2dd9fac16cd78cd88a6208c951d6 17:35:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:35:21 INFO - mozversion platform_version: 51.0a1 17:35:21 INFO - using testdate: 1471394121 17:35:21 INFO - actual date: 1471394121 17:35:21 INFO - starting webserver on 'localhost:49267' 17:35:21 INFO - SUITE-START | Running 2 tests 17:35:21 INFO - TEST-START | dromaeo_css 17:35:21 INFO - operating with platform_type : mac_ 17:35:21 INFO - Initialising browser for dromaeo_css test... 17:35:21 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpTNaLSx/profile http://localhost:49267/getInfo.html) 17:35:24 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 17:35:24 INFO - PROCESS | 1653 | colorDepth:24 17:35:24 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 17:35:24 INFO - PROCESS | 1653 | __metrics 17:35:24 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 17:35:24 INFO - TEST-INFO | 1653: exit 0 17:35:24 INFO - Browser initialized. 17:35:24 INFO - Running cycle 1/1 for dromaeo_css test... 17:35:24 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpTNaLSx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:36 INFO - PROCESS | 1657 | RSS: Main: 239345664 17:35:36 INFO - PROCESS | 1657 | 17:36:26 INFO - PROCESS | 1657 | 1471394186462 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] 17:38:38 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 17:38:39 INFO - PROCESS | 1657 | RSS: Main: 255983616 17:38:39 INFO - PROCESS | 1657 | 17:41:42 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 17:41:42 INFO - PROCESS | 1657 | RSS: Main: 266379264 17:41:42 INFO - PROCESS | 1657 | 17:44:44 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 17:44:45 INFO - PROCESS | 1657 | RSS: Main: 272003072 17:44:45 INFO - PROCESS | 1657 | 17:47:47 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 17:47:47 INFO - PROCESS | 1657 | RSS: Main: 271319040 17:47:47 INFO - PROCESS | 1657 | 17:50:50 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 17:50:51 INFO - PROCESS | 1657 | RSS: Main: 276688896 17:50:51 INFO - PROCESS | 1657 | 17:53:53 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 17:53:54 INFO - PROCESS | 1657 | RSS: Main: 279490560 17:53:54 INFO - PROCESS | 1657 | 17:53:54 INFO - PROCESS | 1657 | __start_tp_report 17:53:54 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 17:53:54 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 17:53:54 INFO - PROCESS | 1657 | |i|pagename|runs| 17:53:54 INFO - PROCESS | 1657 | |0;dojo.html;3040.832754198519;3367.1582104473864;3384.289299247158;3396.2188696599796;3414.6926776590108;4689.765511724413;5365.490278423548;5612.663240205586;5688.203651488784;5758.884822303551;4694.718316900989;5462.808801691942;5573.804916827912;5624.3531993820725;5631.831045068644;3768.2840260350513;4330.956690433087;5185.974070129644;5213.191955246943;5228;5130.5126013028885;5201.0898092833795;5206.245094461301;5227.372715274172;5240.44975277596;5172.715500647463;5179.637425380225;5199.246109314147;5200.3759548854005;5241.711705856176;5218.843434696965;5219.947800521984;5252.947470525322;5267.578593712494;5321.547668448186;4161.812718427648;5079.5428411443145;5169.508896654812;5220.164773636238;5231.450697676727;5481.534069604048;5568.109102543614;5576.470235327637;5596;5672.602917795756;6160.44555989963;6215.68921553925;6226.782062627786;6247.406496382836;6266.78066267683;6079.20970273866;6174.25908890936;6254.937450625481;6271.122042913996;6294.150289710922;5697.344805347397;5699;5708.80019199326;5736.913946290809;5840.299164100293;6258.280297765815;6270.372962703693;6276.215473065867;6281.7173227204885;6308.179936608303;6049.667268300285;6082.847928801727;6112.8777424452155;6113.541484388688;6127.662978536223;6195.721192546256;6213.471854892385;6221.471174950089;6233.812985610439;6265.028920517327;6162.106494558264;6219.720112594944;6224.284207316216;6225.470834979077;6229.937700623026;6023.969880150571;6133.640713961371;6138.171346868205;6161.44546990773;6232.657203853832;4892.706437613754;4894.608431325485;4921.606271498272;4930.728809915489;4933.186024305949;4355.62977146946;4366.104948485553;4378.912421751547;4404.163208990281;4430.689851710349;5473.507384335429;5607.214989901417;5709.685967271756;5727.713614319267;5770.6249093808765;6137.294211165684;6213.596116252429;6239.313675495692;6251.6561589113035;6271.686415679198;5685.204071430003;5692.48767610917;5719.256496655408;5729.9713501432225;5736.225609542658;5212.009718153538;5341.332333458317;5392.5416339611575;5401.351837779492;5434.673919564839;6290.905636415366;6298.874022519615;6314.02132669437;6352.428281454691;6353.015282631107;6176.28972668131;6278.121063051268;6299.307076221704;6305.211848518935;6307.400796924285;6143.204841796883;6208.565400421927;6283.120363149072;6313.589616674902;6313.810585682437;6108.786192483241;6147.907781383194;6169.96915015422;6176.6911654418;6232.189815323979;6208.844778880564;6224.1597384354345;6244.906326405016;6252.406021427957;6256.155419018374;5312.787488500417;5892;6029;6095.085737139288;6143.354947730424;5138.794448222179;6037.18498002764;6063.696815159313;6078.878422431439;6113.266408031065;5169.638125331191;5787.565932554991;5866.970665146647;5939.049752039826;5951.732172052181;5049.192129259448;5882.323532793784;6033.758649653964;6073.392660733891;6114.631938157225;5201.81793637236;5451.182322651634;5474.835754927359;5941.405859414197;5968.940310596839 17:53:54 INFO - PROCESS | 1657 | |1;ext.html;489.54227797009787;499.6452518711717;523.6988731479399;531.6464551073536;540.2058973309234;31356.843215783945;31449.37101257979;36240.45639315413;38241.80879095604;38285;38724.612753872454;39265.41101883474;39272;39313.80343098281;39317.606823931754;8945.105489451067;9138.177564019237;9471.289653275997;9671.903280967206;9675.080867317594;9531.428114313163;9544.713658590254;9594.952025239863;9612.663556775515;9613.182879455255;9598.424094554313;9610.231181505498;9639;9659.130678238957;9697.709068727914;9576.138147566717;9612.51937403134;9613.951930240304;9633.03669633038;9648.324617276794;9506.904930950672;9582;9598.520073996273;9601.039896010343;9629.277804164716;37796.62203377986;38218.61781382179;38264.80867595672;38298.42552361717;38299.23401531982;3458.3083383323437;3467.9653203467897;3545.7517973741847;3600.5859326177565;4020.4572382728543;30431.543526847116;30902.536461952863;31183.220419489695;31323.53014704781;31630.841845790856;3264.5266436366833;3295.522149288364;3297.4559197732347;3352.5641666583433;3410.658934106594;482090;497267;497899;498155;501833.49083254713;32108.839455803038;54930.725346373016;55032;55564.444355556734;55699.16451253234;33690.326193475994;34146.31707365889;34340.48489272663;34385.65614343875;34418.35352227467;14492.85507144915;14655.047421917541;14677.926610367093;14724.263786810616;14735.263236838115;12350.320732359627;12382.938085309695;12446.25322480654;12468.937655311665;12486.81269780954;7684.500507466997;7707.036620422447;7762.650680719381;7765.495242809199;7767.495112817762;2921.8246905185756;2926.634170728659;3236.5954255718034;3313.5029745538363;3314.751393645486;954.6515521834481;1009.7172791618211;1020.8468729690605;1034.2036631793628;1183.893449589541;30016.39967200644;30766.692333076382;31540.52689209618;31898.36203275968;32564.348713025607;1046.4715318764127;1046.5656752447649;1062.0972173652333;1075.5805235957982;1128.8306753986803;13546.119502232323;14797.556073317817;14884.627884302763;15112.471063512725;15344.386224551115;674867;679410;679877;680131;680994;53409.664758381354;53918.7304063485;54083.91832163335;54160.72919635456;54214.457855420944;1225.3383173086434;1328.156620545941;1348.4875747216192;1382.5506710319187;1383.75784237758;22187.55624887461;28696.713032869404;28859.42281154323;29154;29561.26096847596;46842.76578617085;47063.529364705915;47253.52746472491;47303.76348118375;47415.52584474111;525411.3729431329;525530;526319;527279;527336;25269.368265793502;25273.87363063173;25342.239732808044;25529.23412297634;25578.87210563935;43113.78443107764;43902.78048609736;44534.55465445304;44932.77533612311;44955.32567011432;36359.81820090988;36861;37126.88619341424;37318.44022339613;37924.62075379211;34972.9508114757;35939;36328;37201.627983719816;37273.25453490861;30460;34304.82847585746;41097.58902411057;41878.74363769092;41974.370384443646;37759.62240377671;37991.62008379991;40353.596464034985;40390.19219615532;41415.58584414118;25956.480870382864;31169;31605.261710606137;32242.516362254115;32377 17:53:54 INFO - PROCESS | 1657 | |2;jquery.html;372.51758972131086;376.76640482900604;381.7823840410967;387.6937219596519;401.5803485357801;17287.65424691507;19539.609207815836;20556.38330850073;20887.268945586908;21158.471038224052;20240.49398765028;20627.38117856463;20853.27013554526;20895.955202239864;21077.94610269484;5783.277090363705;5956.761729530814;5999.640021598707;6858.554193977376;6934.549254298479;6921.169459664848;6940.583564986117;6961.825954351131;6981.7207311707725;6990.685419156151;6668.699908504129;6805.523613347043;6816.420604248645;6873.41575966041;6899.862002759942;6739.831504212385;6763.917773156296;6806.829829254259;6820.215675197366;6830.931690683079;5814.941850581482;5855.707214639294;5862.237909071836;5862.882742345172;5873.823785286449;13194.868051319556;13369.465221391132;23024.769752302596;23564;24054.87972560126;2145.292053622301;2250.1561914282142;2314.456102815837;2314.7916687498036;2538.8857501412294;9789.321101646105;9928.106470417624;10107.039831216096;10243.7439064024;13048.804267935893;1690.4928521443642;1730.4030109612163;1837.9523671507245;1851.6019055903046;1885.9339923102625;101441.4927925363;115342.84657153404;129408.35295823555;130222.3488882559;131720;8831.470111793313;9829.262805289633;10924.617638382619;11256.718582035352;11341.149413793999;14226.644333891736;14298.428062877369;14326.713465730836;14332.49836255726;14379.568612941628;8452.957735211285;8642.357951989103;8650.6972255972;8712.564371781385;8714.912850871537;8522.360822938304;8571.442856214326;8616.913830861611;8727.519986400808;8768.912310876936;4436.44544431946;4459.331100334975;4461.906832825978;4495.797689103998;4623.745693986863;1889.7354370388157;1899.43017094871;1923.2595450751562;1933.58427937994;1939.350317643577;861.3109512390188;952.828490871636;966.9468179250068;971.183886132936;1055.1400608504046;19679;20439;20865;20895.37313880586;20960.685589716166;409.6456565071192;409.745957506342;420.22888000518776;445.62122196133026;966.5070813884969;4777.880552986203;5748.109043098327;5997.610155339889;5998.910016349758;6032.547558933097;545834;559947;595512;602988;615038;112159;117051.41474292574;122566;124307;135072;400.8617027125637;434.2184068676433;439.99560004399547;453.055379533676;455.214754548408;11314.094872410024;11402.942985285352;11454.255473394203;11508.021818145551;11605.30368177912;48106.75946620244;53189.468105318454;55315;56974.43025569857;57789.84420311486;68480;78519.42961140859;78930.6053469752;79461.60269198618;81149.59425203073;7916.6437510311025;7988.960055199686;8176.182381762014;8243;8438.409311348147;9184.678536251198;11673.591424300108;11726.120540959291;12745.10784245094;12770.23378597287;10930.672079837617;10995.85580811766;11085.889141108808;11132.88867111351;11401.543938242377;8583.313334933066;9621.941586425628;9643.855342169732;9721.979192184719;10876.945615271872;9763.316567840184;10533.9473302633;10890.673279801302;11254.268472549258;11378.715532111764;7937.722179723682;7965.920340796518;8007.559584222924;8073.919260807552;8353.457025293337;10684.358938463716;10965.725856853323;10971.561137554409;11187.776244475228;11247.212695111592 17:53:54 INFO - PROCESS | 1657 | |3;mootools.html;1344.3815844711432;1396.7150221795946;1437.6837095838919;1751.5883767314679;1833.1384249402777;7685.654145563449;8017.118117007125;8495.957520212398;9048.63805447782;9074.591643376047;8647.264982476481;8851.159139881716;8883.51140687262;8899.199072083511;8901.599428025755;2364.6334818103223;2377.904883804654;2384.3919800450863;2390;2403.3390817525146;2350.1421980976993;2378.881055947196;2394.1381102802975;2396.305071529263;2401.0635852017726;2368.976310236893;2374.536965291769;2380.940476488093;2384.2132096408145;2385.7733515316017;2332.2187067332466;2340.578695834749;2350.4241460842204;2355.528894221154;2366.0890557135453;2339.181286549711;2347.507023525062;2361.7520160383083;2369.763023697634;2369.763023697634;8975;9009.144131307516;9028.09719028092;9037.819243615157;9051.23064539515;5308.681479111266;5406.783728650849;5466.207399927028;5473.124300112003;5487.670739755587;3568.8750893718857;3675.4303083022173;3703.2038111805823;3704.759190652599;3770.773753574767;1113;1115.9330440173615;1122.2480937771713;1130.6381957773515;1133.6372360844532;11702.414879256088;11782.764344713058;11876.287422754749;11888.524459021628;11950.581729639507;4412.42638457005;4531.932021019687;4645.5354464553275;4659.4175728034;4687.718736875799;8240.793980150544;9255.86116208244;9302.627894884265;9322.533873306444;9324.487153206503;5305;5327.174287985291;5331.226972089025;5337.306150200527;5360.0351936650995;3932;4771.188897887368;4873.70846725618;4910.189818679949;4941.950580494221;3376.037829218661;3742.1580144467275;3814.8664796731982;3873.0898238913833;3903.434002069684;1199.184554502929;1210.7154818617619;1217.6286232699113;1221.9633410997685;1223.4494477485168;780.0366547314063;874.4447275979799;916.8853893263342;923.5290002098978;940.3229674634252;5220.92168617471;5523.602875245796;5927.644341339534;6116;6226.59527130735;913.6162811619135;914.1955079530104;941.7363138321281;982.2436723722693;1016.506994107857;3972.6027397260623;4027.939580906289;4049.2913740095364;4158.563350848118;4198.454200953856;8946.776330591787;9538.809223815484;10956.890431095746;11011.559537618405;11029.83455248172;10834.187435942336;10981.505832237408;11011.229213954946;11020.44897755125;11075;8250.54621995784;8337.874931876027;8353.874691879626;8356.749297521084;8366.539840308842;4738.763061846825;5235.921461178009;5749.712514374348;5951.256092988377;5971.850703732268;9961.35251208669;10045.648402305884;10215.642452514126;10227.539760710935;10275.794484110425;9737.367071140354;10208.693739187836;10251.846222306522;10335.276530642783;10343.327683700536;6976.337247961435;7388.482806203514;7577;7618;7778.416618753503;8538.573071346533;8609.956950215208;8615.483071015758;8628.956855215683;8631.611577479154;7385.7045718170675;7433.479656423999;7540.698372065056;7599.924000759922;7685;6295.874082518232;7344.742933997284;7448.068991376078;7551.395888329031;7585.355244804033;7062.505624606229;7065.788026359218;7144.9642751785905;7158.391536719437;7168.068151140318;4822.758862056813;4895.290182923527;4905.117078925828;4926.5073492650445;4969.204927211629;4454.4877339106415;4897.706137631753;4954.405471343462;4974.825881094144;5006.549410553068 17:53:54 INFO - PROCESS | 1657 | |4;prototype.html;299.3414488126123;305.75845082384916;313.78819296974564;314.1690229343386;315.37240890627646;5347.652402593839;5419.674819510822;5600.719964001799;5648.717564121798;5718.2566266385365;4641.953580464195;5415.160650099241;5457.072297709389;5553.305836770403;5563.304586926634;3707.721920855933;3717.962820371789;4266.679999000087;4266.829326826931;4272.380504826799;3304.5704058472365;3490.389181893171;3864.3237433449176;4283.250431174532;4285.421468101813;3450.808736452346;3522.1898963238473;3783.9810800945957;4128;4159.916801663965;4010.8796736097966;4162.708610397289;4194.4337514435465;4216.219999300109;4226.619604235603;2962.0077274113196;3155.7790954633183;3611.512445819807;3620.294042661682;3627.8548858045647;5200.529748369532;5394.865128371783;5412.377576578704;5412.512873841334;5513.972430137824;4147.834086636531;4776.211925032366;4833.226683730586;4854.980454104642;4886.731229782361;5042.3949126104735;5922.230110085704;5925.644461332291;5949.6727679977585;5957.914729844563;3165.5884734984534;3269.199046233688;3341.916452088693;3804.6385593368864;3962.7820469874146;5910.97044514779;6128.111423843562;6140.692965351759;6155.230596175478;6194.318624951252;3904.7266691331333;4006.4791577095375;4021.7184797063924;4030.5969403060044;4071.8371265149062;3504.684578387957;3545.9290814183573;3919.627635374635;4022.135240923157;4040.8585699500377;4277.486701595766;4429.800658970354;4787.688800227974;4798.712077275305;4814.470408255089;4991.750412479361;5208.713520756319;5237.711925844039;5257.447967963385;5955.034838503284;1292.1859228685869;1348.710027344106;1361.0608680010762;1370.7320728326258;1378.3315092180285;693.1681981622073;833.3832963606887;853.8728877881138;899.5412339706796;934.2105920497169;4725.881852953635;4924.212126059813;5126.333576635014;5147.279380886679;5390.784368625289;5133.512316329943;5771.451712087345;5844;5994.880102397928;6004.24734540912;5206.943257413301;5465.945340546623;5492.395836457987;5497.680556666452;5594.888102238014;2666.7466590673853;2712.362594790223;2850.0737260390456;2933.6479622445445;3198.3603279344225;5391.29913111293;5851.64890106595;6371.808845734636;6402.519811014193;6433.260175079832;5271.077561426735;5695.063678349298;5968.731407086691;6278.46633036197;6326.557141000086;6286.465650419766;6385.361463853577;6388.2653494847755;6389.166500099996;6406.615603063831;5363.329583802025;5413.864653383697;6010.827888561864;6151.815445536641;6175.289841668086;5499.780008799603;6012.849678758066;6030.39696030411;6058.212432383762;6072.419221830793;5222.712750798591;5898.675572843535;6140.662263575367;6355.3644635536075;6478.384553467413;3929.19451512445;3933.350997085449;3948.5853985331128;3988.660963818108;3994.940075898806;5187.948120518747;5529.949309631157;5694.943050569607;6071.939280607137;6093.6039157454625;5154.458781827854;5232.3982741985155;5451.37309209446;5831.0378787499585;5849.298084229919;4820.927686084781;5144.250954675428;5868.735906884286;5905.11036468326;5955.970220148872;5297.867553311198;5308.389535203501;5463.399026107046;5521.972390138024;5647.830565083054;4857.417109946829;5566.610337276352;5728.914066289092;5777.959967205943;5868.853278668067;4974.9751251243515;5282.9471705283995;5720.74256658443;5728.937582470391;5771.538276937918 17:53:54 INFO - PROCESS | 1657 | |5;yui.html;706.4630880530797;722.8373615936415;734.5299008634471;764.6826566974702;819.1439945257207;11821.468033938472;15094.471693490716;15374.69250614987;15605.531834044968;15680.686386272268;13740.10689305197;14137.57587272381;14197.71604567908;14267.714645707105;14278.000539962206;839.2530647723515;860.7417774667574;862.4178679391417;866.969656062038;867.1588559097696;686.4199751210219;829.8008477965305;851.4976164063202;852.9658813647446;863.1584205399748;903.6656437118276;904.5703290936785;905.6377449020379;908.9818203635923;909.1181553892714;883.7260449260685;893.3032234856822;901.7880798012462;902.1159263921328;902.8690839828221;664.6278084272774;665.1386454541381;673.5386260411634;675.2100042949761;676.7326905872153;15141.318640661086;15199.01206421579;15215.08709477435;15215.61960950974;15250.694986100327;14658.853411465961;14677.266136693122;14710;15017.549473515703;15026.098434093989;11950.521979120826;12112.81830772539;12321.322327271997;12380.690482737913;12607.936960315139;3852.2680690668685;3853.325668008087;4058;4081.7755023473696;4090.0592863641527;119212;120168.79831201663;121369;121580;122065.38967305195;9950.701478955498;11282.94358528202;11399.601013964637;11536.365499897585;11891.643250702493;23469.061237550308;24107.27678169658;24113.15603953853;24141;24378.512429751307;8113.269805717514;8153.347732181412;8216.794580135425;8230.753077407688;8285.378596605278;4424.6239069678795;4533.5013148553635;4549.909001819945;4551.544845515422;4594.2419500782;3541.557305336833;3584.731145164123;3674.375356189454;3674.761140525857;3677.485152078711;625.4902254662527;629.7292164369366;643.6620774093544;657.283560918601;660.3627499463041;606.4299558415075;606.5814587934311;662.2615783401473;676.090658064902;686.1183379357502;9108.956211534032;9228.354015219005;9447.291453140904;9606.231501479864;9645.758856028515;624.1106423346713;630.8864404407251;639.4149353341734;642.9903551446732;693.9757108501178;4396.780160992002;4663.533646635309;4672.43930728308;4727.763611819395;4744.572988431058;112040.31939520914;135948;155318.44681553266;156760;157765.8446831057;93977.530112349;97095.0290497086;99020;127536.36231818782;131508;103968.48015759872;105965.47017265018;110686.44656776826;110911.33632995511;112541;9631.83283761148;9987.350822196535;10000.099991000845;10166.847497287694;10226;56667.433325666214;58024.709876450346;60140.69929650324;60240.09639855493;61422.385776141666;63089.684551576946;79454.205457947;81489;82292.17707822846;82493.17506824854;13351.198928064347;13365.86634133685;13416.865831341953;13658.317084145554;13855.307234638429;12491.75016499683;14701.33843977045;15023;15027.183906332084;15323.46367877119;13351.198928064347;13465;13567.932160339134;13611.591652250449;14010.78983815264;13821.585352439442;13864.376103075185;13988.300584970508;14028.438862445388;14486.177045518112;11622.70943226426;13192.538261160813;13436.664083397993;13581.932090339486;13885.444582217002;10619.239774821961;10786.406747628957;11446.42767861587;11472.369019703996;11918.821217681569;9866.506674666382;10493.370397776158;10636.627718030142;11383.747787743507;11643.708907277385 17:53:54 INFO - PROCESS | 1657 | __end_tp_report 17:53:54 INFO - PROCESS | 1657 | __start_cc_report 17:53:54 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,409 17:53:54 INFO - PROCESS | 1657 | __end_cc_report 17:53:54 INFO - PROCESS | 1657 | __startTimestamp1471395234054__endTimestamp 17:53:54 INFO - PROCESS | 1657 | 17:53:54 INFO - PROCESS | 1657 | ------- Summary: start ------- 17:53:54 INFO - PROCESS | 1657 | Number of tests: 6 17:53:54 INFO - PROCESS | 1657 | 17:53:54 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5657.16 Median:5840.30 stddev:687.18 (11.8%) stddev-sans-first:657.93 17:53:54 INFO - PROCESS | 1657 | Values: 3040.8 3367.2 3384.3 3396.2 3414.7 4689.8 5365.5 5612.7 5688.2 5758.9 4694.7 5462.8 5573.8 5624.4 5631.8 3768.3 4331.0 5186.0 5213.2 5228.0 5130.5 5201.1 5206.2 5227.4 5240.4 5172.7 5179.6 5199.2 5200.4 5241.7 5218.8 5219.9 5252.9 5267.6 5321.5 4161.8 5079.5 5169.5 5220.2 5231.5 5481.5 5568.1 5576.5 5596.0 5672.6 6160.4 6215.7 6226.8 6247.4 6266.8 6079.2 6174.3 6254.9 6271.1 6294.2 5697.3 5699.0 5708.8 5736.9 5840.3 6258.3 6270.4 6276.2 6281.7 6308.2 6049.7 6082.8 6112.9 6113.5 6127.7 6195.7 6213.5 6221.5 6233.8 6265.0 6162.1 6219.7 6224.3 6225.5 6229.9 6024.0 6133.6 6138.2 6161.4 6232.7 4892.7 4894.6 4921.6 4930.7 4933.2 4355.6 4366.1 4378.9 4404.2 4430.7 5473.5 5607.2 5709.7 5727.7 5770.6 6137.3 6213.6 6239.3 6251.7 6271.7 5685.2 5692.5 5719.3 5730.0 5736.2 5212.0 5341.3 5392.5 5401.4 5434.7 6290.9 6298.9 6314.0 6352.4 6353.0 6176.3 6278.1 6299.3 6305.2 6307.4 6143.2 6208.6 6283.1 6313.6 6313.8 6108.8 6147.9 6170.0 6176.7 6232.2 6208.8 6224.2 6244.9 6252.4 6256.2 5312.8 5892.0 6029.0 6095.1 6143.4 5138.8 6037.2 6063.7 6078.9 6113.3 5169.6 5787.6 5867.0 5939.0 5951.7 5049.2 5882.3 6033.8 6073.4 6114.6 5201.8 5451.2 5474.8 5941.4 5968.9 17:53:54 INFO - PROCESS | 1657 | 17:53:54 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:68117.77 Median:37958.12 stddev:153453.27 (404.3%) stddev-sans-first:153799.74 17:53:54 INFO - PROCESS | 1657 | Values: 489.5 499.6 523.7 531.6 540.2 31356.8 31449.4 36240.5 38241.8 38285.0 38724.6 39265.4 39272.0 39313.8 39317.6 8945.1 9138.2 9471.3 9671.9 9675.1 9531.4 9544.7 9595.0 9612.7 9613.2 9598.4 9610.2 9639.0 9659.1 9697.7 9576.1 9612.5 9614.0 9633.0 9648.3 9506.9 9582.0 9598.5 9601.0 9629.3 37796.6 38218.6 38264.8 38298.4 38299.2 3458.3 3468.0 3545.8 3600.6 4020.5 30431.5 30902.5 31183.2 31323.5 31630.8 3264.5 3295.5 3297.5 3352.6 3410.7 482090.0 497267.0 497899.0 498155.0 501833.5 32108.8 54930.7 55032.0 55564.4 55699.2 33690.3 34146.3 34340.5 34385.7 34418.4 14492.9 14655.0 14677.9 14724.3 14735.3 12350.3 12382.9 12446.3 12468.9 12486.8 7684.5 7707.0 7762.7 7765.5 7767.5 2921.8 2926.6 3236.6 3313.5 3314.8 954.7 1009.7 1020.8 1034.2 1183.9 30016.4 30766.7 31540.5 31898.4 32564.3 1046.5 1046.6 1062.1 1075.6 1128.8 13546.1 14797.6 14884.6 15112.5 15344.4 674867.0 679410.0 679877.0 680131.0 680994.0 53409.7 53918.7 54083.9 54160.7 54214.5 1225.3 1328.2 1348.5 1382.6 1383.8 22187.6 28696.7 28859.4 29154.0 29561.3 46842.8 47063.5 47253.5 47303.8 47415.5 525411.4 525530.0 526319.0 527279.0 527336.0 25269.4 25273.9 25342.2 25529.2 25578.9 43113.8 43902.8 44534.6 44932.8 44955.3 36359.8 36861.0 37126.9 37318.4 37924.6 34973.0 35939.0 36328.0 37201.6 37273.3 30460.0 34304.8 41097.6 41878.7 41974.4 37759.6 37991.6 40353.6 40390.2 41415.6 25956.5 31169.0 31605.3 32242.5 32377.0 17:53:54 INFO - PROCESS | 1657 | 17:53:54 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:34048.14 Median:437.11 stddev:97756.31 (22364.4%) stddev-sans-first:97997.84 17:53:54 INFO - PROCESS | 1657 | Values: 372.5 376.8 381.8 387.7 401.6 17287.7 19539.6 20556.4 20887.3 21158.5 20240.5 20627.4 20853.3 20896.0 21077.9 5783.3 5956.8 5999.6 6858.6 6934.5 6921.2 6940.6 6961.8 6981.7 6990.7 6668.7 6805.5 6816.4 6873.4 6899.9 6739.8 6763.9 6806.8 6820.2 6830.9 5814.9 5855.7 5862.2 5862.9 5873.8 13194.9 13369.5 23024.8 23564.0 24054.9 2145.3 2250.2 2314.5 2314.8 2538.9 9789.3 9928.1 10107.0 10243.7 13048.8 1690.5 1730.4 1838.0 1851.6 1885.9 101441.5 115342.8 129408.4 130222.3 131720.0 8831.5 9829.3 10924.6 11256.7 11341.1 14226.6 14298.4 14326.7 14332.5 14379.6 8453.0 8642.4 8650.7 8712.6 8714.9 8522.4 8571.4 8616.9 8727.5 8768.9 4436.4 4459.3 4461.9 4495.8 4623.7 1889.7 1899.4 1923.3 1933.6 1939.4 861.3 952.8 966.9 971.2 1055.1 19679.0 20439.0 20865.0 20895.4 20960.7 409.6 409.7 420.2 445.6 966.5 4777.9 5748.1 5997.6 5998.9 6032.5 545834.0 559947.0 595512.0 602988.0 615038.0 112159.0 117051.4 122566.0 124307.0 135072.0 400.9 434.2 440.0 453.1 455.2 11314.1 11402.9 11454.3 11508.0 11605.3 48106.8 53189.5 55315.0 56974.4 57789.8 68480.0 78519.4 78930.6 79461.6 81149.6 7916.6 7989.0 8176.2 8243.0 8438.4 9184.7 11673.6 11726.1 12745.1 12770.2 10930.7 10995.9 11085.9 11132.9 11401.5 8583.3 9621.9 9643.9 9722.0 10876.9 9763.3 10533.9 10890.7 11254.3 11378.7 7937.7 7965.9 8007.6 8073.9 8353.5 10684.4 10965.7 10971.6 11187.8 11247.2 17:53:54 INFO - PROCESS | 1657 | 17:53:54 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5704.79 Median:4907.65 stddev:3209.96 (65.4%) stddev-sans-first:3202.24 17:53:54 INFO - PROCESS | 1657 | Values: 1344.4 1396.7 1437.7 1751.6 1833.1 7685.7 8017.1 8496.0 9048.6 9074.6 8647.3 8851.2 8883.5 8899.2 8901.6 2364.6 2377.9 2384.4 2390.0 2403.3 2350.1 2378.9 2394.1 2396.3 2401.1 2369.0 2374.5 2380.9 2384.2 2385.8 2332.2 2340.6 2350.4 2355.5 2366.1 2339.2 2347.5 2361.8 2369.8 2369.8 8975.0 9009.1 9028.1 9037.8 9051.2 5308.7 5406.8 5466.2 5473.1 5487.7 3568.9 3675.4 3703.2 3704.8 3770.8 1113.0 1115.9 1122.2 1130.6 1133.6 11702.4 11782.8 11876.3 11888.5 11950.6 4412.4 4531.9 4645.5 4659.4 4687.7 8240.8 9255.9 9302.6 9322.5 9324.5 5305.0 5327.2 5331.2 5337.3 5360.0 3932.0 4771.2 4873.7 4910.2 4942.0 3376.0 3742.2 3814.9 3873.1 3903.4 1199.2 1210.7 1217.6 1222.0 1223.4 780.0 874.4 916.9 923.5 940.3 5220.9 5523.6 5927.6 6116.0 6226.6 913.6 914.2 941.7 982.2 1016.5 3972.6 4027.9 4049.3 4158.6 4198.5 8946.8 9538.8 10956.9 11011.6 11029.8 10834.2 10981.5 11011.2 11020.4 11075.0 8250.5 8337.9 8353.9 8356.7 8366.5 4738.8 5235.9 5749.7 5951.3 5971.9 9961.4 10045.6 10215.6 10227.5 10275.8 9737.4 10208.7 10251.8 10335.3 10343.3 6976.3 7388.5 7577.0 7618.0 7778.4 8538.6 8610.0 8615.5 8629.0 8631.6 7385.7 7433.5 7540.7 7599.9 7685.0 6295.9 7344.7 7448.1 7551.4 7585.4 7062.5 7065.8 7145.0 7158.4 7168.1 4822.8 4895.3 4905.1 4926.5 4969.2 4454.5 4897.7 4954.4 4974.8 5006.5 17:53:54 INFO - PROCESS | 1657 | 17:53:54 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4676.79 Median:5264.26 stddev:1499.15 (28.5%) stddev-sans-first:1466.91 17:53:54 INFO - PROCESS | 1657 | Values: 299.3 305.8 313.8 314.2 315.4 5347.7 5419.7 5600.7 5648.7 5718.3 4642.0 5415.2 5457.1 5553.3 5563.3 3707.7 3718.0 4266.7 4266.8 4272.4 3304.6 3490.4 3864.3 4283.3 4285.4 3450.8 3522.2 3784.0 4128.0 4159.9 4010.9 4162.7 4194.4 4216.2 4226.6 2962.0 3155.8 3611.5 3620.3 3627.9 5200.5 5394.9 5412.4 5412.5 5514.0 4147.8 4776.2 4833.2 4855.0 4886.7 5042.4 5922.2 5925.6 5949.7 5957.9 3165.6 3269.2 3341.9 3804.6 3962.8 5911.0 6128.1 6140.7 6155.2 6194.3 3904.7 4006.5 4021.7 4030.6 4071.8 3504.7 3545.9 3919.6 4022.1 4040.9 4277.5 4429.8 4787.7 4798.7 4814.5 4991.8 5208.7 5237.7 5257.4 5955.0 1292.2 1348.7 1361.1 1370.7 1378.3 693.2 833.4 853.9 899.5 934.2 4725.9 4924.2 5126.3 5147.3 5390.8 5133.5 5771.5 5844.0 5994.9 6004.2 5206.9 5465.9 5492.4 5497.7 5594.9 2666.7 2712.4 2850.1 2933.6 3198.4 5391.3 5851.6 6371.8 6402.5 6433.3 5271.1 5695.1 5968.7 6278.5 6326.6 6286.5 6385.4 6388.3 6389.2 6406.6 5363.3 5413.9 6010.8 6151.8 6175.3 5499.8 6012.8 6030.4 6058.2 6072.4 5222.7 5898.7 6140.7 6355.4 6478.4 3929.2 3933.4 3948.6 3988.7 3994.9 5187.9 5529.9 5694.9 6071.9 6093.6 5154.5 5232.4 5451.4 5831.0 5849.3 4820.9 5144.3 5868.7 5905.1 5956.0 5297.9 5308.4 5463.4 5522.0 5647.8 4857.4 5566.6 5728.9 5778.0 5868.9 4975.0 5282.9 5720.7 5728.9 5771.5 17:53:54 INFO - PROCESS | 1657 | 17:53:54 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:24129.33 Median:3674.57 stddev:37974.33 (1033.4%) stddev-sans-first:38040.13 17:53:54 INFO - PROCESS | 1657 | Values: 706.5 722.8 734.5 764.7 819.1 11821.5 15094.5 15374.7 15605.5 15680.7 13740.1 14137.6 14197.7 14267.7 14278.0 839.3 860.7 862.4 867.0 867.2 686.4 829.8 851.5 853.0 863.2 903.7 904.6 905.6 909.0 909.1 883.7 893.3 901.8 902.1 902.9 664.6 665.1 673.5 675.2 676.7 15141.3 15199.0 15215.1 15215.6 15250.7 14658.9 14677.3 14710.0 15017.5 15026.1 11950.5 12112.8 12321.3 12380.7 12607.9 3852.3 3853.3 4058.0 4081.8 4090.1 119212.0 120168.8 121369.0 121580.0 122065.4 9950.7 11282.9 11399.6 11536.4 11891.6 23469.1 24107.3 24113.2 24141.0 24378.5 8113.3 8153.3 8216.8 8230.8 8285.4 4424.6 4533.5 4549.9 4551.5 4594.2 3541.6 3584.7 3674.4 3674.8 3677.5 625.5 629.7 643.7 657.3 660.4 606.4 606.6 662.3 676.1 686.1 9109.0 9228.4 9447.3 9606.2 9645.8 624.1 630.9 639.4 643.0 694.0 4396.8 4663.5 4672.4 4727.8 4744.6 112040.3 135948.0 155318.4 156760.0 157765.8 93977.5 97095.0 99020.0 127536.4 131508.0 103968.5 105965.5 110686.4 110911.3 112541.0 9631.8 9987.4 10000.1 10166.8 10226.0 56667.4 58024.7 60140.7 60240.1 61422.4 63089.7 79454.2 81489.0 82292.2 82493.2 13351.2 13365.9 13416.9 13658.3 13855.3 12491.8 14701.3 15023.0 15027.2 15323.5 13351.2 13465.0 13567.9 13611.6 14010.8 13821.6 13864.4 13988.3 14028.4 14486.2 11622.7 13192.5 13436.7 13581.9 13885.4 10619.2 10786.4 11446.4 11472.4 11918.8 9866.5 10493.4 10636.6 11383.7 11643.7 17:53:54 INFO - PROCESS | 1657 | -------- Summary: end -------- 17:53:54 INFO - PROCESS | 1657 | 17:53:54 INFO - TEST-INFO | 1657: exit 0 17:53:54 INFO - TEST-OK | dromaeo_css | took 1113513ms 17:53:54 INFO - TEST-START | kraken 17:53:54 INFO - operating with platform_type : mac_ 17:53:54 INFO - Initialising browser for kraken test... 17:53:54 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmp_0au0C/profile http://localhost:49267/getInfo.html) 17:53:57 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 17:53:57 INFO - PROCESS | 1664 | colorDepth:24 17:53:57 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 17:53:57 INFO - PROCESS | 1664 | __metrics 17:53:57 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 17:53:58 INFO - TEST-INFO | 1664: exit 0 17:53:58 INFO - Browser initialized. 17:53:58 INFO - Running cycle 1/1 for kraken test... 17:53:58 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmp_0au0C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:54:10 INFO - PROCESS | 1666 | RSS: Main: 238927872 17:54:10 INFO - PROCESS | 1666 | 17:54:13 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 17:54:14 INFO - PROCESS | 1666 | RSS: Main: 251875328 17:54:14 INFO - PROCESS | 1666 | 17:54:16 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 17:54:17 INFO - PROCESS | 1666 | RSS: Main: 260517888 17:54:17 INFO - PROCESS | 1666 | 17:54:20 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 17:54:21 INFO - PROCESS | 1666 | RSS: Main: 263495680 17:54:21 INFO - PROCESS | 1666 | 17:54:23 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 17:54:23 INFO - PROCESS | 1666 | RSS: Main: 265031680 17:54:23 INFO - PROCESS | 1666 | 17:54:25 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:54:26 INFO - PROCESS | 1666 | RSS: Main: 266555392 17:54:26 INFO - PROCESS | 1666 | 17:54:29 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 17:54:29 INFO - PROCESS | 1666 | RSS: Main: 266665984 17:54:29 INFO - PROCESS | 1666 | 17:54:32 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 17:54:33 INFO - PROCESS | 1666 | RSS: Main: 266645504 17:54:33 INFO - PROCESS | 1666 | 17:54:36 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 17:54:37 INFO - PROCESS | 1666 | RSS: Main: 267210752 17:54:37 INFO - PROCESS | 1666 | 17:54:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:54:39 INFO - PROCESS | 1666 | RSS: Main: 266649600 17:54:39 INFO - PROCESS | 1666 | 17:54:41 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:54:42 INFO - PROCESS | 1666 | RSS: Main: 266858496 17:54:42 INFO - PROCESS | 1666 | 17:54:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:54:45 INFO - PROCESS | 1666 | RSS: Main: 266903552 17:54:45 INFO - PROCESS | 1666 | 17:54:47 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:54:48 INFO - PROCESS | 1666 | RSS: Main: 266870784 17:54:48 INFO - PROCESS | 1666 | 17:54:51 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:54:52 INFO - PROCESS | 1666 | RSS: Main: 267227136 17:54:52 INFO - PROCESS | 1666 | 17:54:54 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 17:54:54 INFO - PROCESS | 1666 | RSS: Main: 267988992 17:54:54 INFO - PROCESS | 1666 | 17:54:54 INFO - PROCESS | 1666 | __start_tp_report 17:54:54 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 17:54:54 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 17:54:54 INFO - PROCESS | 1666 | |i|pagename|runs| 17:54:54 INFO - PROCESS | 1666 | |0;ai-astar;103;98;152;166;163;117;119;118;126;159 17:54:54 INFO - PROCESS | 1666 | |1;audio-beat-detection;174;129;152;189;137;136;129;111;162;110 17:54:54 INFO - PROCESS | 1666 | |2;audio-dft;190;214;205;231;201;196;197;195;207;196 17:54:54 INFO - PROCESS | 1666 | |3;audio-fft;71;84;77;145;58;59;59;63;135;58 17:54:54 INFO - PROCESS | 1666 | |4;audio-oscillator;70;73;131;71;72;76;111;70;73;115 17:54:54 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;91;89;91;87;92;88;91;89;91;86 17:54:54 INFO - PROCESS | 1666 | |6;imaging-darkroom;97;131;117;97;96;96;118;137;124;106 17:54:54 INFO - PROCESS | 1666 | |7;imaging-desaturate;104;87;90;136;140;87;137;140;119;95 17:54:54 INFO - PROCESS | 1666 | |8;json-parse-financial;56;58;60;56;59;58;64;65;81;84 17:54:54 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;65;73;67;77;72;83;71;69;68;72 17:54:54 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;86;91;91;88;87;91;81;105;90;86 17:54:54 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;141;138;141;140;140;140;139;143;152;183 17:54:54 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;173;184;232;214;177;200;173;174;170;177 17:54:54 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;94;86;87;72;63;89;85;87;91;69 17:54:54 INFO - PROCESS | 1666 | __end_tp_report 17:54:54 INFO - PROCESS | 1666 | __start_cc_report 17:54:54 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1064 17:54:54 INFO - PROCESS | 1666 | __end_cc_report 17:54:54 INFO - PROCESS | 1666 | __startTimestamp1471395294415__endTimestamp 17:54:54 INFO - PROCESS | 1666 | 17:54:54 INFO - PROCESS | 1666 | ------- Summary: start ------- 17:54:54 INFO - PROCESS | 1666 | Number of tests: 14 17:54:54 INFO - PROCESS | 1666 | 17:54:54 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:132.10 Median:155.50 stddev:25.54 (16.4%) stddev-sans-first:24.82 17:54:54 INFO - PROCESS | 1666 | Values: 103.0 98.0 152.0 166.0 163.0 117.0 119.0 118.0 126.0 159.0 17:54:54 INFO - PROCESS | 1666 | 17:54:54 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:144.50 stddev:26.05 (18.0%) stddev-sans-first:25.09 17:54:54 INFO - PROCESS | 1666 | Values: 174.0 129.0 152.0 189.0 137.0 136.0 129.0 111.0 162.0 110.0 17:54:54 INFO - PROCESS | 1666 | 17:54:54 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:203.20 Median:203.00 stddev:12.00 (5.9%) stddev-sans-first:11.74 17:54:54 INFO - PROCESS | 1666 | Values: 190.0 214.0 205.0 231.0 201.0 196.0 197.0 195.0 207.0 196.0 17:54:54 INFO - PROCESS | 1666 | 17:54:54 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:80.90 Median:61.00 stddev:32.47 (53.2%) stddev-sans-first:34.24 17:54:54 INFO - PROCESS | 1666 | Values: 71.0 84.0 77.0 145.0 58.0 59.0 59.0 63.0 135.0 58.0 17:54:54 INFO - PROCESS | 1666 | 17:54:54 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:86.20 Median:71.50 stddev:23.24 (32.5%) stddev-sans-first:23.90 17:54:54 INFO - PROCESS | 1666 | Values: 70.0 73.0 131.0 71.0 72.0 76.0 111.0 70.0 73.0 115.0 17:54:54 INFO - PROCESS | 1666 | 17:54:54 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:89.50 Median:91.00 stddev:2.01 (2.2%) stddev-sans-first:2.06 17:54:54 INFO - PROCESS | 1666 | Values: 91.0 89.0 91.0 87.0 92.0 88.0 91.0 89.0 91.0 86.0 17:54:54 INFO - PROCESS | 1666 | 17:54:54 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:111.90 Median:116.50 stddev:15.60 (13.4%) stddev-sans-first:15.58 17:54:54 INFO - PROCESS | 1666 | Values: 97.0 131.0 117.0 97.0 96.0 96.0 118.0 137.0 124.0 106.0 17:54:54 INFO - PROCESS | 1666 | 17:54:54 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:113.50 Median:113.50 stddev:23.29 (20.5%) stddev-sans-first:24.45 17:54:54 INFO - PROCESS | 1666 | Values: 104.0 87.0 90.0 136.0 140.0 87.0 137.0 140.0 119.0 95.0 17:54:54 INFO - PROCESS | 1666 | 17:54:54 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:62.00 stddev:10.17 (16.4%) stddev-sans-first:10.36 17:54:54 INFO - PROCESS | 1666 | Values: 56.0 58.0 60.0 56.0 59.0 58.0 64.0 65.0 81.0 84.0 17:54:54 INFO - PROCESS | 1666 | 17:54:54 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.00 stddev:5.23 (7.3%) stddev-sans-first:4.95 17:54:54 INFO - PROCESS | 1666 | Values: 65.0 73.0 67.0 77.0 72.0 83.0 71.0 69.0 68.0 72.0 17:54:54 INFO - PROCESS | 1666 | 17:54:54 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:89.00 stddev:6.26 (7.0%) stddev-sans-first:6.50 17:54:54 INFO - PROCESS | 1666 | Values: 86.0 91.0 91.0 88.0 87.0 91.0 81.0 105.0 90.0 86.0 17:54:54 INFO - PROCESS | 1666 | 17:54:54 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:145.70 Median:141.00 stddev:13.68 (9.7%) stddev-sans-first:14.40 17:54:54 INFO - PROCESS | 1666 | Values: 141.0 138.0 141.0 140.0 140.0 140.0 139.0 143.0 152.0 183.0 17:54:54 INFO - PROCESS | 1666 | 17:54:54 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.40 Median:180.50 stddev:21.03 (11.7%) stddev-sans-first:21.65 17:54:54 INFO - PROCESS | 1666 | Values: 173.0 184.0 232.0 214.0 177.0 200.0 173.0 174.0 170.0 177.0 17:54:54 INFO - PROCESS | 1666 | 17:54:54 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.30 Median:87.00 stddev:10.42 (12.0%) stddev-sans-first:10.16 17:54:54 INFO - PROCESS | 1666 | Values: 94.0 86.0 87.0 72.0 63.0 89.0 85.0 87.0 91.0 69.0 17:54:54 INFO - PROCESS | 1666 | -------- Summary: end -------- 17:54:54 INFO - PROCESS | 1666 | 17:54:55 INFO - TEST-INFO | 1666: exit 0 17:54:55 INFO - TEST-OK | kraken | took 60520ms 17:54:55 INFO - SUITE-END | took 1174s 17:54:55 INFO - Completed test suite (00:19:34) 17:54:55 INFO - javascript benchmark 17:54:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7200.601931746403, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3040.832754198519, 3367.1582104473864, 3384.289299247158, 3396.2188696599796, 3414.6926776590108, 4689.765511724413, 5365.490278423548, 5612.663240205586, 5688.203651488784, 5758.884822303551, 4694.718316900989, 5462.808801691942, 5573.804916827912, 5624.3531993820725, 5631.831045068644, 3768.2840260350513, 4330.956690433087, 5185.974070129644, 5213.191955246943, 5228.0, 5130.5126013028885, 5201.0898092833795, 5206.245094461301, 5227.372715274172, 5240.44975277596, 5172.715500647463, 5179.637425380225, 5199.246109314147, 5200.3759548854005, 5241.711705856176, 5218.843434696965, 5219.947800521984, 5252.947470525322, 5267.578593712494, 5321.547668448186, 4161.812718427648, 5079.5428411443145, 5169.508896654812, 5220.164773636238, 5231.450697676727, 5481.534069604048, 5568.109102543614, 5576.470235327637, 5596.0, 5672.602917795756, 6160.44555989963, 6215.68921553925, 6226.782062627786, 6247.406496382836, 6266.78066267683, 6079.20970273866, 6174.25908890936, 6254.937450625481, 6271.122042913996, 6294.150289710922, 5697.344805347397, 5699.0, 5708.80019199326, 5736.913946290809, 5840.299164100293, 6258.280297765815, 6270.372962703693, 6276.215473065867, 6281.7173227204885, 6308.179936608303, 6049.667268300285, 6082.847928801727, 6112.8777424452155, 6113.541484388688, 6127.662978536223, 6195.721192546256, 6213.471854892385, 6221.471174950089, 6233.812985610439, 6265.028920517327, 6162.106494558264, 6219.720112594944, 6224.284207316216, 6225.470834979077, 6229.937700623026, 6023.969880150571, 6133.640713961371, 6138.171346868205, 6161.44546990773, 6232.657203853832, 4892.706437613754, 4894.608431325485, 4921.606271498272, 4930.728809915489, 4933.186024305949, 4355.62977146946, 4366.104948485553, 4378.912421751547, 4404.163208990281, 4430.689851710349, 5473.507384335429, 5607.214989901417, 5709.685967271756, 5727.713614319267, 5770.6249093808765, 6137.294211165684, 6213.596116252429, 6239.313675495692, 6251.6561589113035, 6271.686415679198, 5685.204071430003, 5692.48767610917, 5719.256496655408, 5729.9713501432225, 5736.225609542658, 5212.009718153538, 5341.332333458317, 5392.5416339611575, 5401.351837779492, 5434.673919564839, 6290.905636415366, 6298.874022519615, 6314.02132669437, 6352.428281454691, 6353.015282631107, 6176.28972668131, 6278.121063051268, 6299.307076221704, 6305.211848518935, 6307.400796924285, 6143.204841796883, 6208.565400421927, 6283.120363149072, 6313.589616674902, 6313.810585682437, 6108.786192483241, 6147.907781383194, 6169.96915015422, 6176.6911654418, 6232.189815323979, 6208.844778880564, 6224.1597384354345, 6244.906326405016, 6252.406021427957, 6256.155419018374, 5312.787488500417, 5892.0, 6029.0, 6095.085737139288, 6143.354947730424, 5138.794448222179, 6037.18498002764, 6063.696815159313, 6078.878422431439, 6113.266408031065, 5169.638125331191, 5787.565932554991, 5866.970665146647, 5939.049752039826, 5951.732172052181, 5049.192129259448, 5882.323532793784, 6033.758649653964, 6073.392660733891, 6114.631938157225, 5201.81793637236, 5451.182322651634, 5474.835754927359, 5941.405859414197, 5968.940310596839], "value": 5613.111525484103, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.54227797009787, 499.6452518711717, 523.6988731479399, 531.6464551073536, 540.2058973309234, 31356.843215783945, 31449.37101257979, 36240.45639315413, 38241.80879095604, 38285.0, 38724.612753872454, 39265.41101883474, 39272.0, 39313.80343098281, 39317.606823931754, 8945.105489451067, 9138.177564019237, 9471.289653275997, 9671.903280967206, 9675.080867317594, 9531.428114313163, 9544.713658590254, 9594.952025239863, 9612.663556775515, 9613.182879455255, 9598.424094554313, 9610.231181505498, 9639.0, 9659.130678238957, 9697.709068727914, 9576.138147566717, 9612.51937403134, 9613.951930240304, 9633.03669633038, 9648.324617276794, 9506.904930950672, 9582.0, 9598.520073996273, 9601.039896010343, 9629.277804164716, 37796.62203377986, 38218.61781382179, 38264.80867595672, 38298.42552361717, 38299.23401531982, 3458.3083383323437, 3467.9653203467897, 3545.7517973741847, 3600.5859326177565, 4020.4572382728543, 30431.543526847116, 30902.536461952863, 31183.220419489695, 31323.53014704781, 31630.841845790856, 3264.5266436366833, 3295.522149288364, 3297.4559197732347, 3352.5641666583433, 3410.658934106594, 482090.0, 497267.0, 497899.0, 498155.0, 501833.49083254713, 32108.839455803038, 54930.725346373016, 55032.0, 55564.444355556734, 55699.16451253234, 33690.326193475994, 34146.31707365889, 34340.48489272663, 34385.65614343875, 34418.35352227467, 14492.85507144915, 14655.047421917541, 14677.926610367093, 14724.263786810616, 14735.263236838115, 12350.320732359627, 12382.938085309695, 12446.25322480654, 12468.937655311665, 12486.81269780954, 7684.500507466997, 7707.036620422447, 7762.650680719381, 7765.495242809199, 7767.495112817762, 2921.8246905185756, 2926.634170728659, 3236.5954255718034, 3313.5029745538363, 3314.751393645486, 954.6515521834481, 1009.7172791618211, 1020.8468729690605, 1034.2036631793628, 1183.893449589541, 30016.39967200644, 30766.692333076382, 31540.52689209618, 31898.36203275968, 32564.348713025607, 1046.4715318764127, 1046.5656752447649, 1062.0972173652333, 1075.5805235957982, 1128.8306753986803, 13546.119502232323, 14797.556073317817, 14884.627884302763, 15112.471063512725, 15344.386224551115, 674867.0, 679410.0, 679877.0, 680131.0, 680994.0, 53409.664758381354, 53918.7304063485, 54083.91832163335, 54160.72919635456, 54214.457855420944, 1225.3383173086434, 1328.156620545941, 1348.4875747216192, 1382.5506710319187, 1383.75784237758, 22187.55624887461, 28696.713032869404, 28859.42281154323, 29154.0, 29561.26096847596, 46842.76578617085, 47063.529364705915, 47253.52746472491, 47303.76348118375, 47415.52584474111, 525411.3729431329, 525530.0, 526319.0, 527279.0, 527336.0, 25269.368265793502, 25273.87363063173, 25342.239732808044, 25529.23412297634, 25578.87210563935, 43113.78443107764, 43902.78048609736, 44534.55465445304, 44932.77533612311, 44955.32567011432, 36359.81820090988, 36861.0, 37126.88619341424, 37318.44022339613, 37924.62075379211, 34972.9508114757, 35939.0, 36328.0, 37201.627983719816, 37273.25453490861, 30460.0, 34304.82847585746, 41097.58902411057, 41878.74363769092, 41974.370384443646, 37759.62240377671, 37991.62008379991, 40353.596464034985, 40390.19219615532, 41415.58584414118, 25956.480870382864, 31169.0, 31605.261710606137, 32242.516362254115, 32377.0], "value": 18447.866343312457, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.51758972131086, 376.76640482900604, 381.7823840410967, 387.6937219596519, 401.5803485357801, 17287.65424691507, 19539.609207815836, 20556.38330850073, 20887.268945586908, 21158.471038224052, 20240.49398765028, 20627.38117856463, 20853.27013554526, 20895.955202239864, 21077.94610269484, 5783.277090363705, 5956.761729530814, 5999.640021598707, 6858.554193977376, 6934.549254298479, 6921.169459664848, 6940.583564986117, 6961.825954351131, 6981.7207311707725, 6990.685419156151, 6668.699908504129, 6805.523613347043, 6816.420604248645, 6873.41575966041, 6899.862002759942, 6739.831504212385, 6763.917773156296, 6806.829829254259, 6820.215675197366, 6830.931690683079, 5814.941850581482, 5855.707214639294, 5862.237909071836, 5862.882742345172, 5873.823785286449, 13194.868051319556, 13369.465221391132, 23024.769752302596, 23564.0, 24054.87972560126, 2145.292053622301, 2250.1561914282142, 2314.456102815837, 2314.7916687498036, 2538.8857501412294, 9789.321101646105, 9928.106470417624, 10107.039831216096, 10243.7439064024, 13048.804267935893, 1690.4928521443642, 1730.4030109612163, 1837.9523671507245, 1851.6019055903046, 1885.9339923102625, 101441.4927925363, 115342.84657153404, 129408.35295823555, 130222.3488882559, 131720.0, 8831.470111793313, 9829.262805289633, 10924.617638382619, 11256.718582035352, 11341.149413793999, 14226.644333891736, 14298.428062877369, 14326.713465730836, 14332.49836255726, 14379.568612941628, 8452.957735211285, 8642.357951989103, 8650.6972255972, 8712.564371781385, 8714.912850871537, 8522.360822938304, 8571.442856214326, 8616.913830861611, 8727.519986400808, 8768.912310876936, 4436.44544431946, 4459.331100334975, 4461.906832825978, 4495.797689103998, 4623.745693986863, 1889.7354370388157, 1899.43017094871, 1923.2595450751562, 1933.58427937994, 1939.350317643577, 861.3109512390188, 952.828490871636, 966.9468179250068, 971.183886132936, 1055.1400608504046, 19679.0, 20439.0, 20865.0, 20895.37313880586, 20960.685589716166, 409.6456565071192, 409.745957506342, 420.22888000518776, 445.62122196133026, 966.5070813884969, 4777.880552986203, 5748.109043098327, 5997.610155339889, 5998.910016349758, 6032.547558933097, 545834.0, 559947.0, 595512.0, 602988.0, 615038.0, 112159.0, 117051.41474292574, 122566.0, 124307.0, 135072.0, 400.8617027125637, 434.2184068676433, 439.99560004399547, 453.055379533676, 455.214754548408, 11314.094872410024, 11402.942985285352, 11454.255473394203, 11508.021818145551, 11605.30368177912, 48106.75946620244, 53189.468105318454, 55315.0, 56974.43025569857, 57789.84420311486, 68480.0, 78519.42961140859, 78930.6053469752, 79461.60269198618, 81149.59425203073, 7916.6437510311025, 7988.960055199686, 8176.182381762014, 8243.0, 8438.409311348147, 9184.678536251198, 11673.591424300108, 11726.120540959291, 12745.10784245094, 12770.23378597287, 10930.672079837617, 10995.85580811766, 11085.889141108808, 11132.88867111351, 11401.543938242377, 8583.313334933066, 9621.941586425628, 9643.855342169732, 9721.979192184719, 10876.945615271872, 9763.316567840184, 10533.9473302633, 10890.673279801302, 11254.268472549258, 11378.715532111764, 7937.722179723682, 7965.920340796518, 8007.559584222924, 8073.919260807552, 8353.457025293337, 10684.358938463716, 10965.725856853323, 10971.561137554409, 11187.776244475228, 11247.212695111592], "value": 8925.139936917676, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.3815844711432, 1396.7150221795946, 1437.6837095838919, 1751.5883767314679, 1833.1384249402777, 7685.654145563449, 8017.118117007125, 8495.957520212398, 9048.63805447782, 9074.591643376047, 8647.264982476481, 8851.159139881716, 8883.51140687262, 8899.199072083511, 8901.599428025755, 2364.6334818103223, 2377.904883804654, 2384.3919800450863, 2390.0, 2403.3390817525146, 2350.1421980976993, 2378.881055947196, 2394.1381102802975, 2396.305071529263, 2401.0635852017726, 2368.976310236893, 2374.536965291769, 2380.940476488093, 2384.2132096408145, 2385.7733515316017, 2332.2187067332466, 2340.578695834749, 2350.4241460842204, 2355.528894221154, 2366.0890557135453, 2339.181286549711, 2347.507023525062, 2361.7520160383083, 2369.763023697634, 2369.763023697634, 8975.0, 9009.144131307516, 9028.09719028092, 9037.819243615157, 9051.23064539515, 5308.681479111266, 5406.783728650849, 5466.207399927028, 5473.124300112003, 5487.670739755587, 3568.8750893718857, 3675.4303083022173, 3703.2038111805823, 3704.759190652599, 3770.773753574767, 1113.0, 1115.9330440173615, 1122.2480937771713, 1130.6381957773515, 1133.6372360844532, 11702.414879256088, 11782.764344713058, 11876.287422754749, 11888.524459021628, 11950.581729639507, 4412.42638457005, 4531.932021019687, 4645.5354464553275, 4659.4175728034, 4687.718736875799, 8240.793980150544, 9255.86116208244, 9302.627894884265, 9322.533873306444, 9324.487153206503, 5305.0, 5327.174287985291, 5331.226972089025, 5337.306150200527, 5360.0351936650995, 3932.0, 4771.188897887368, 4873.70846725618, 4910.189818679949, 4941.950580494221, 3376.037829218661, 3742.1580144467275, 3814.8664796731982, 3873.0898238913833, 3903.434002069684, 1199.184554502929, 1210.7154818617619, 1217.6286232699113, 1221.9633410997685, 1223.4494477485168, 780.0366547314063, 874.4447275979799, 916.8853893263342, 923.5290002098978, 940.3229674634252, 5220.92168617471, 5523.602875245796, 5927.644341339534, 6116.0, 6226.59527130735, 913.6162811619135, 914.1955079530104, 941.7363138321281, 982.2436723722693, 1016.506994107857, 3972.6027397260623, 4027.939580906289, 4049.2913740095364, 4158.563350848118, 4198.454200953856, 8946.776330591787, 9538.809223815484, 10956.890431095746, 11011.559537618405, 11029.83455248172, 10834.187435942336, 10981.505832237408, 11011.229213954946, 11020.44897755125, 11075.0, 8250.54621995784, 8337.874931876027, 8353.874691879626, 8356.749297521084, 8366.539840308842, 4738.763061846825, 5235.921461178009, 5749.712514374348, 5951.256092988377, 5971.850703732268, 9961.35251208669, 10045.648402305884, 10215.642452514126, 10227.539760710935, 10275.794484110425, 9737.367071140354, 10208.693739187836, 10251.846222306522, 10335.276530642783, 10343.327683700536, 6976.337247961435, 7388.482806203514, 7577.0, 7618.0, 7778.416618753503, 8538.573071346533, 8609.956950215208, 8615.483071015758, 8628.956855215683, 8631.611577479154, 7385.7045718170675, 7433.479656423999, 7540.698372065056, 7599.924000759922, 7685.0, 6295.874082518232, 7344.742933997284, 7448.068991376078, 7551.395888329031, 7585.355244804033, 7062.505624606229, 7065.788026359218, 7144.9642751785905, 7158.391536719437, 7168.068151140318, 4822.758862056813, 4895.290182923527, 4905.117078925828, 4926.5073492650445, 4969.204927211629, 4454.4877339106415, 4897.706137631753, 4954.405471343462, 4974.825881094144, 5006.549410553068], "value": 4583.364986460333, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.3414488126123, 305.75845082384916, 313.78819296974564, 314.1690229343386, 315.37240890627646, 5347.652402593839, 5419.674819510822, 5600.719964001799, 5648.717564121798, 5718.2566266385365, 4641.953580464195, 5415.160650099241, 5457.072297709389, 5553.305836770403, 5563.304586926634, 3707.721920855933, 3717.962820371789, 4266.679999000087, 4266.829326826931, 4272.380504826799, 3304.5704058472365, 3490.389181893171, 3864.3237433449176, 4283.250431174532, 4285.421468101813, 3450.808736452346, 3522.1898963238473, 3783.9810800945957, 4128.0, 4159.916801663965, 4010.8796736097966, 4162.708610397289, 4194.4337514435465, 4216.219999300109, 4226.619604235603, 2962.0077274113196, 3155.7790954633183, 3611.512445819807, 3620.294042661682, 3627.8548858045647, 5200.529748369532, 5394.865128371783, 5412.377576578704, 5412.512873841334, 5513.972430137824, 4147.834086636531, 4776.211925032366, 4833.226683730586, 4854.980454104642, 4886.731229782361, 5042.3949126104735, 5922.230110085704, 5925.644461332291, 5949.6727679977585, 5957.914729844563, 3165.5884734984534, 3269.199046233688, 3341.916452088693, 3804.6385593368864, 3962.7820469874146, 5910.97044514779, 6128.111423843562, 6140.692965351759, 6155.230596175478, 6194.318624951252, 3904.7266691331333, 4006.4791577095375, 4021.7184797063924, 4030.5969403060044, 4071.8371265149062, 3504.684578387957, 3545.9290814183573, 3919.627635374635, 4022.135240923157, 4040.8585699500377, 4277.486701595766, 4429.800658970354, 4787.688800227974, 4798.712077275305, 4814.470408255089, 4991.750412479361, 5208.713520756319, 5237.711925844039, 5257.447967963385, 5955.034838503284, 1292.1859228685869, 1348.710027344106, 1361.0608680010762, 1370.7320728326258, 1378.3315092180285, 693.1681981622073, 833.3832963606887, 853.8728877881138, 899.5412339706796, 934.2105920497169, 4725.881852953635, 4924.212126059813, 5126.333576635014, 5147.279380886679, 5390.784368625289, 5133.512316329943, 5771.451712087345, 5844.0, 5994.880102397928, 6004.24734540912, 5206.943257413301, 5465.945340546623, 5492.395836457987, 5497.680556666452, 5594.888102238014, 2666.7466590673853, 2712.362594790223, 2850.0737260390456, 2933.6479622445445, 3198.3603279344225, 5391.29913111293, 5851.64890106595, 6371.808845734636, 6402.519811014193, 6433.260175079832, 5271.077561426735, 5695.063678349298, 5968.731407086691, 6278.46633036197, 6326.557141000086, 6286.465650419766, 6385.361463853577, 6388.2653494847755, 6389.166500099996, 6406.615603063831, 5363.329583802025, 5413.864653383697, 6010.827888561864, 6151.815445536641, 6175.289841668086, 5499.780008799603, 6012.849678758066, 6030.39696030411, 6058.212432383762, 6072.419221830793, 5222.712750798591, 5898.675572843535, 6140.662263575367, 6355.3644635536075, 6478.384553467413, 3929.19451512445, 3933.350997085449, 3948.5853985331128, 3988.660963818108, 3994.940075898806, 5187.948120518747, 5529.949309631157, 5694.943050569607, 6071.939280607137, 6093.6039157454625, 5154.458781827854, 5232.3982741985155, 5451.37309209446, 5831.0378787499585, 5849.298084229919, 4820.927686084781, 5144.250954675428, 5868.735906884286, 5905.11036468326, 5955.970220148872, 5297.867553311198, 5308.389535203501, 5463.399026107046, 5521.972390138024, 5647.830565083054, 4857.417109946829, 5566.610337276352, 5728.914066289092, 5777.959967205943, 5868.853278668067, 4974.9751251243515, 5282.9471705283995, 5720.74256658443, 5728.937582470391, 5771.538276937918], "value": 4192.465693214669, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.4630880530797, 722.8373615936415, 734.5299008634471, 764.6826566974702, 819.1439945257207, 11821.468033938472, 15094.471693490716, 15374.69250614987, 15605.531834044968, 15680.686386272268, 13740.10689305197, 14137.57587272381, 14197.71604567908, 14267.714645707105, 14278.000539962206, 839.2530647723515, 860.7417774667574, 862.4178679391417, 866.969656062038, 867.1588559097696, 686.4199751210219, 829.8008477965305, 851.4976164063202, 852.9658813647446, 863.1584205399748, 903.6656437118276, 904.5703290936785, 905.6377449020379, 908.9818203635923, 909.1181553892714, 883.7260449260685, 893.3032234856822, 901.7880798012462, 902.1159263921328, 902.8690839828221, 664.6278084272774, 665.1386454541381, 673.5386260411634, 675.2100042949761, 676.7326905872153, 15141.318640661086, 15199.01206421579, 15215.08709477435, 15215.61960950974, 15250.694986100327, 14658.853411465961, 14677.266136693122, 14710.0, 15017.549473515703, 15026.098434093989, 11950.521979120826, 12112.81830772539, 12321.322327271997, 12380.690482737913, 12607.936960315139, 3852.2680690668685, 3853.325668008087, 4058.0, 4081.7755023473696, 4090.0592863641527, 119212.0, 120168.79831201663, 121369.0, 121580.0, 122065.38967305195, 9950.701478955498, 11282.94358528202, 11399.601013964637, 11536.365499897585, 11891.643250702493, 23469.061237550308, 24107.27678169658, 24113.15603953853, 24141.0, 24378.512429751307, 8113.269805717514, 8153.347732181412, 8216.794580135425, 8230.753077407688, 8285.378596605278, 4424.6239069678795, 4533.5013148553635, 4549.909001819945, 4551.544845515422, 4594.2419500782, 3541.557305336833, 3584.731145164123, 3674.375356189454, 3674.761140525857, 3677.485152078711, 625.4902254662527, 629.7292164369366, 643.6620774093544, 657.283560918601, 660.3627499463041, 606.4299558415075, 606.5814587934311, 662.2615783401473, 676.090658064902, 686.1183379357502, 9108.956211534032, 9228.354015219005, 9447.291453140904, 9606.231501479864, 9645.758856028515, 624.1106423346713, 630.8864404407251, 639.4149353341734, 642.9903551446732, 693.9757108501178, 4396.780160992002, 4663.533646635309, 4672.43930728308, 4727.763611819395, 4744.572988431058, 112040.31939520914, 135948.0, 155318.44681553266, 156760.0, 157765.8446831057, 93977.530112349, 97095.0290497086, 99020.0, 127536.36231818782, 131508.0, 103968.48015759872, 105965.47017265018, 110686.44656776826, 110911.33632995511, 112541.0, 9631.83283761148, 9987.350822196535, 10000.099991000845, 10166.847497287694, 10226.0, 56667.433325666214, 58024.709876450346, 60140.69929650324, 60240.09639855493, 61422.385776141666, 63089.684551576946, 79454.205457947, 81489.0, 82292.17707822846, 82493.17506824854, 13351.198928064347, 13365.86634133685, 13416.865831341953, 13658.317084145554, 13855.307234638429, 12491.75016499683, 14701.33843977045, 15023.0, 15027.183906332084, 15323.46367877119, 13351.198928064347, 13465.0, 13567.932160339134, 13611.591652250449, 14010.78983815264, 13821.585352439442, 13864.376103075185, 13988.300584970508, 14028.438862445388, 14486.177045518112, 11622.70943226426, 13192.538261160813, 13436.664083397993, 13581.932090339486, 13885.444582217002, 10619.239774821961, 10786.406747628957, 11446.42767861587, 11472.369019703996, 11918.821217681569, 9866.506674666382, 10493.370397776158, 10636.627718030142, 11383.747787743507, 11643.708907277385], "value": 7847.88525175081, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1601.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 98.0, 152.0, 166.0, 163.0, 117.0, 119.0, 118.0, 126.0, 159.0], "value": 132.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 129.0, 152.0, 189.0, 137.0, 136.0, 129.0, 111.0, 162.0, 110.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 214.0, 205.0, 231.0, 201.0, 196.0, 197.0, 195.0, 207.0, 196.0], "value": 203.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 84.0, 77.0, 145.0, 58.0, 59.0, 59.0, 63.0, 135.0, 58.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 131.0, 71.0, 72.0, 76.0, 111.0, 70.0, 73.0, 115.0], "value": 86.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 91.0, 87.0, 92.0, 88.0, 91.0, 89.0, 91.0, 86.0], "value": 89.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 131.0, 117.0, 97.0, 96.0, 96.0, 118.0, 137.0, 124.0, 106.0], "value": 111.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 87.0, 90.0, 136.0, 140.0, 87.0, 137.0, 140.0, 119.0, 95.0], "value": 113.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 60.0, 56.0, 59.0, 58.0, 64.0, 65.0, 81.0, 84.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 67.0, 77.0, 72.0, 83.0, 71.0, 69.0, 68.0, 72.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 91.0, 91.0, 88.0, 87.0, 91.0, 81.0, 105.0, 90.0, 86.0], "value": 89.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 138.0, 141.0, 140.0, 140.0, 140.0, 139.0, 143.0, 152.0, 183.0], "value": 145.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 184.0, 232.0, 214.0, 177.0, 200.0, 173.0, 174.0, 170.0, 177.0], "value": 187.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 86.0, 87.0, 72.0, 63.0, 89.0, 85.0, 87.0, 91.0, 69.0], "value": 82.3, "unit": "score"}]}]} 17:54:55 INFO - Return code: 0 17:54:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:54:55 ERROR - # TBPL SUCCESS # 17:54:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:54:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:54:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:54:55 INFO - 2016-08-16 17:54:55.749 screenresolution[1671:11050] starting screenresolution argv=screenresolution get 17:54:55 INFO - 2016-08-16 17:54:55.751 screenresolution[1671:11050] Display 0: 1600x1200x32@60 17:54:55 INFO - 2016-08-16 17:54:55.757 screenresolution[1672:11053] starting screenresolution argv=screenresolution list 17:54:55 INFO - Available Modes on Display 0 17:54:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:54:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:54:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:54:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:54:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:54:55 INFO - Intel Iris: 17:54:55 INFO - Chipset Model: Intel Iris 17:54:55 INFO - Type: GPU 17:54:55 INFO - Bus: Built-In 17:54:55 INFO - VRAM (Dynamic, Max): 1536 MB 17:54:55 INFO - Vendor: Intel (0x8086) 17:54:55 INFO - Device ID: 0x0a2e 17:54:55 INFO - Revision ID: 0x0009 17:54:55 INFO - Displays: 17:54:55 INFO - Display: 17:54:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:54:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:54:55 INFO - Display Serial Number: 1600x1200 60 17:54:55 INFO - Main Display: Yes 17:54:55 INFO - Mirror: Off 17:54:55 INFO - Online: Yes 17:54:55 INFO - Rotation: Supported 17:54:55 INFO - Return code: 0 17:54:55 INFO - Running post-action listener: _resource_record_post_action 17:54:55 INFO - [mozharness: 2016-08-17 00:54:55.993849Z] Finished run-tests step (success) 17:54:55 INFO - Running post-run listener: _resource_record_post_run 17:54:56 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 32721920; Write bytes: 708161024; Read time: 308; Write time: 2078 17:54:56 INFO - TinderboxPrint: CPU usage
54.6% 17:54:56 INFO - TinderboxPrint: I/O read bytes / time
32,721,920 / 308 17:54:56 INFO - TinderboxPrint: I/O write bytes / time
708,161,024 / 2,078 17:54:56 INFO - TinderboxPrint: CPU idle
2,195.1 (45.4%) 17:54:56 INFO - TinderboxPrint: CPU system
979.2 (20.2%) 17:54:56 INFO - TinderboxPrint: CPU user
1,663.4 (34.4%) 17:54:56 INFO - TinderboxPrint: Swap in / out
433,479,680 / 0 17:54:56 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 394248704; Write bytes: 388233216; Read time: 29431; Write time: 713 17:54:56 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 30944256; Write bytes: 298303488; Read time: 289; Write time: 1310 17:54:56 INFO - Running post-run listener: _upload_blobber_files 17:54:56 INFO - Blob upload gear active. 17:54:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:54:56 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 17:54:56 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'] 17:54:56 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 17:54:56 INFO - (blobuploader) - INFO - Open directory for files ... 17:54:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:54:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:54:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:54:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:54:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:54:57 INFO - (blobuploader) - INFO - Done attempting. 17:54:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:54:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:54:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:54:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:54:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:54:58 INFO - (blobuploader) - INFO - Done attempting. 17:54:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:54:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:54:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:55:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:00 INFO - (blobuploader) - INFO - Done attempting. 17:55:00 INFO - (blobuploader) - INFO - Iteration through files over. 17:55:00 INFO - Return code: 0 17:55:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:55:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:55:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1740b1811b1c16f396f7edc868340a73b7b0d3fa492ee569fd26547e1733fc6e7e560794e68f595060964798fa61c2aaac6f1c6dd50f28f321652984a901cfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03a40ce5be84602fae6d35fe1779a1aa529514309228c43ab92725bc963cbd4687b7e01f892b82a3d721e70a9ae9b531b530fcbd964f91ff95ccea4a028c5418", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cda8214646f4654b499ea51772246bb2738f846f584b3f18d66213db6122d2a99b631ba4be88af480543a831483d831211a502ce5f4ef80cd8835f44b4e49ec"} 17:55:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:55:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:55:00 INFO - Contents: 17:55:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1740b1811b1c16f396f7edc868340a73b7b0d3fa492ee569fd26547e1733fc6e7e560794e68f595060964798fa61c2aaac6f1c6dd50f28f321652984a901cfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03a40ce5be84602fae6d35fe1779a1aa529514309228c43ab92725bc963cbd4687b7e01f892b82a3d721e70a9ae9b531b530fcbd964f91ff95ccea4a028c5418", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cda8214646f4654b499ea51772246bb2738f846f584b3f18d66213db6122d2a99b631ba4be88af480543a831483d831211a502ce5f4ef80cd8835f44b4e49ec"} 17:55:00 INFO - Running post-run listener: copy_logs_to_upload_dir 17:55:00 INFO - Copying logs to upload dir... 17:55:00 INFO - mkdir: /builds/slave/test/build/upload/logs 17:55:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.693015 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-16 17:55:00.886017) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 17:55:00.889421) ========= 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.A36P8Q0sMM/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.1VjepzQDh3/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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/b1740b1811b1c16f396f7edc868340a73b7b0d3fa492ee569fd26547e1733fc6e7e560794e68f595060964798fa61c2aaac6f1c6dd50f28f321652984a901cfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03a40ce5be84602fae6d35fe1779a1aa529514309228c43ab92725bc963cbd4687b7e01f892b82a3d721e70a9ae9b531b530fcbd964f91ff95ccea4a028c5418", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cda8214646f4654b499ea51772246bb2738f846f584b3f18d66213db6122d2a99b631ba4be88af480543a831483d831211a502ce5f4ef80cd8835f44b4e49ec"} build_url:https://queue.taskcluster.net/v1/task/f6oP3JAMQ9-n74BaQOwEWg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011101 build_url: 'https://queue.taskcluster.net/v1/task/f6oP3JAMQ9-n74BaQOwEWg/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/b1740b1811b1c16f396f7edc868340a73b7b0d3fa492ee569fd26547e1733fc6e7e560794e68f595060964798fa61c2aaac6f1c6dd50f28f321652984a901cfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03a40ce5be84602fae6d35fe1779a1aa529514309228c43ab92725bc963cbd4687b7e01f892b82a3d721e70a9ae9b531b530fcbd964f91ff95ccea4a028c5418", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cda8214646f4654b499ea51772246bb2738f846f584b3f18d66213db6122d2a99b631ba4be88af480543a831483d831211a502ce5f4ef80cd8835f44b4e49ec"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 17:55:00.922251) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:55:00.922574) ========= 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.A36P8Q0sMM/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.1VjepzQDh3/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.004882 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:55:00.970840) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 17:55:00.971165) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 17:55:00.971492) ========= ========= Total master_lag: 0.22 =========