builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-052 starttime: 1487955983.87 results: success (0) revision: 4851173666d03c2be1e2d72705650c69cfc35dfb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-24 09:06:23.871548) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-24 09:06:23.871966) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-24 09:06:23.872233) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-24 09:06:23.895171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 09:06:23.895509) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-24 09:06:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2017-02-24 09:06:24 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.075277 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 09:06:23.994044) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 09:06:23.994352) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017688 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 09:06:24.049451) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 09:06:24.049948) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4851173666d03c2be1e2d72705650c69cfc35dfb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4851173666d03c2be1e2d72705650c69cfc35dfb --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-24 09:06:24,764 truncating revision to first 12 chars 2017-02-24 09:06:24,764 Setting DEBUG logging. 2017-02-24 09:06:24,764 attempt 1/10 2017-02-24 09:06:24,764 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4851173666d0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-24 09:06:25,191 unpacking tar archive at: mozilla-aurora-4851173666d0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.734193 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 09:06:24.799970) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-24 09:06:24.800278) ========= script_repo_revision: 4851173666d03c2be1e2d72705650c69cfc35dfb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-24 09:06:24.800650) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-24 09:06:24.800910) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-24 09:06:24.811252) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-02-24 09:06:24.811597) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:06:25 INFO - MultiFileLogger online at 20170224 09:06:25 in /builds/slave/test 09:06:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 09:06:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:06:25 INFO - {'append_to_log': False, 09:06:25 INFO - 'base_work_dir': '/builds/slave/test', 09:06:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 09:06:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:06:25 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 09:06:25 INFO - 'buildbot_json_path': 'buildprops.json', 09:06:25 INFO - 'config_files': ('talos/linux_config.py',), 09:06:25 INFO - 'default_actions': ('clobber', 09:06:25 INFO - 'read-buildbot-config', 09:06:25 INFO - 'download-and-extract', 09:06:25 INFO - 'populate-webroot', 09:06:25 INFO - 'create-virtualenv', 09:06:25 INFO - 'install', 09:06:25 INFO - 'run-tests'), 09:06:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:06:25 INFO - 'download_minidump_stackwalk': True, 09:06:25 INFO - 'download_symbols': 'ondemand', 09:06:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:06:25 INFO - 'tooltool.py': '/tools/tooltool.py', 09:06:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:06:25 INFO - '/tools/misc-python/virtualenv.py')}, 09:06:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:06:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:06:25 INFO - 'installer_path': 'installer.exe', 09:06:25 INFO - 'log_level': 'info', 09:06:25 INFO - 'log_name': 'talos', 09:06:25 INFO - 'log_to_console': True, 09:06:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:06:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:06:25 INFO - 'opt_config_files': (), 09:06:25 INFO - 'pip_index': False, 09:06:25 INFO - 'sps_profile': False, 09:06:25 INFO - 'sps_profile_interval': 0, 09:06:25 INFO - 'suite': 'dromaeojs', 09:06:25 INFO - 'system_bits': '32', 09:06:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:06:25 INFO - 'title': 'talos-linux64-ix-052', 09:06:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:06:25 INFO - 'use_talos_json': True, 09:06:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:06:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:06:25 INFO - 'work_dir': 'build'} 09:06:25 INFO - [mozharness: 2017-02-24 17:06:25.623074Z] Running clobber step. 09:06:25 INFO - Running pre-action listener: _resource_record_pre_action 09:06:25 INFO - Running main action method: clobber 09:06:25 INFO - rmtree: /builds/slave/test/build 09:06:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:06:27 INFO - Running post-action listener: _resource_record_post_action 09:06:27 INFO - [mozharness: 2017-02-24 17:06:27.065795Z] Finished clobber step (success) 09:06:27 INFO - [mozharness: 2017-02-24 17:06:27.065895Z] Running read-buildbot-config step. 09:06:27 INFO - Running pre-action listener: _resource_record_pre_action 09:06:27 INFO - Running main action method: read_buildbot_config 09:06:27 INFO - Using buildbot properties: 09:06:27 INFO - { 09:06:27 INFO - "project": "", 09:06:27 INFO - "product": "firefox", 09:06:27 INFO - "who": "ffxbld@noreply.mozilla.org", 09:06:27 INFO - "installer_path": "public/build/target.tar.bz2", 09:06:27 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:06:27 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 09:06:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 09:06:27 INFO - "stage_platform": "linux64", 09:06:27 INFO - "basedir": "/builds/slave/test", 09:06:27 INFO - "buildnumber": 58, 09:06:27 INFO - "platform": "ubuntu64_hw", 09:06:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:06:27 INFO - "slavebuilddir": "test", 09:06:27 INFO - "taskId": "KNahyvIASIawBeLcN3Fl4w", 09:06:27 INFO - "branch": "mozilla-aurora", 09:06:27 INFO - "script_repo_revision": "production", 09:06:27 INFO - "revision": "4851173666d03c2be1e2d72705650c69cfc35dfb", 09:06:27 INFO - "slavename": "talos-linux64-ix-052", 09:06:27 INFO - "repo_path": "releases/mozilla-aurora" 09:06:27 INFO - } 09:06:27 INFO - Finding installer, test and symbols from parent task. 09:06:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KNahyvIASIawBeLcN3Fl4w'}, attempt #1 09:06:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KNahyvIASIawBeLcN3Fl4w'}, attempt #1 09:06:28 INFO - Task dependencies: dKoX6fZ_QqWxmVNql2WAOg 09:06:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg'}, attempt #1 09:06:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.tar.bz2 09:06:28 INFO - Set test_url: https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/test_packages.json 09:06:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.crashreporter-symbols.zip 09:06:28 INFO - Running post-action listener: _resource_record_post_action 09:06:28 INFO - [mozharness: 2017-02-24 17:06:28.804291Z] Finished read-buildbot-config step (success) 09:06:28 INFO - [mozharness: 2017-02-24 17:06:28.804512Z] Running download-and-extract step. 09:06:28 INFO - Running pre-action listener: _resource_record_pre_action 09:06:28 INFO - Running main action method: download_and_extract 09:06:28 INFO - mkdir: /builds/slave/test/build/tests 09:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:28 INFO - trying https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.test_packages.json 09:06:28 INFO - Downloading https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:06:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:06:30 INFO - Downloaded 896 bytes. 09:06:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:06:30 INFO - Using the following test package requirements: 09:06:30 INFO - {u'common': [u'target.common.tests.zip'], 09:06:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:06:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:06:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:06:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:06:30 INFO - u'mozbase': [u'target.common.tests.zip'], 09:06:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:06:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:06:30 INFO - u'web-platform': [u'target.common.tests.zip', 09:06:30 INFO - u'target.web-platform.tests.zip'], 09:06:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:06:30 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:06:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.common.tests.zip 09:06:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:06:30 INFO - Fetch https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.common.tests.zip into memory 09:06:34 INFO - Expected file size: 21861354 09:06:34 INFO - Obtained file size: 21861354 09:06:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:06:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.common.tests.zip 09:06:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:06:38 INFO - Fetch https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.common.tests.zip into memory 09:06:40 INFO - Expected file size: 21861354 09:06:40 INFO - Obtained file size: 21861354 09:06:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.talos.tests.zip 09:06:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:06:45 INFO - Fetch https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.talos.tests.zip into memory 09:06:49 INFO - Expected file size: 14403472 09:06:49 INFO - Obtained file size: 14403472 09:06: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')]} 09:06:49 INFO - trying https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.tar.bz2 09:06:49 INFO - Downloading https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:06:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:07:00 INFO - Downloaded 66097652 bytes. 09:07:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.tar.bz2 09:07:00 INFO - mkdir: /builds/slave/test/properties 09:07:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:07:00 INFO - Writing to file /builds/slave/test/properties/build_url 09:07:00 INFO - Contents: 09:07:00 INFO - build_url:https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.tar.bz2 09:07:00 INFO - Running post-action listener: _resource_record_post_action 09:07:00 INFO - Running post-action listener: set_extra_try_arguments 09:07:00 INFO - [mozharness: 2017-02-24 17:07:00.803620Z] Finished download-and-extract step (success) 09:07:00 INFO - [mozharness: 2017-02-24 17:07:00.803849Z] Running populate-webroot step. 09:07:00 INFO - Running pre-action listener: _resource_record_pre_action 09:07:00 INFO - Running main action method: populate_webroot 09:07:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:07:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:07:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:07:00 INFO - '--tppagecycles', 09:07:00 INFO - '7'], 09:07:00 INFO - 'tests': ['tsvgm']}}, 09:07:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:07:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:07:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:07:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:07:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:07:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:07:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:07:00 INFO - 'talos_options': ['--disable-e10s'], 09:07:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:07:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:07:00 INFO - 'talos_options': ['--disable-e10s'], 09:07:00 INFO - 'tests': ['damp', 'tps']}, 09:07:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:07:00 INFO - 'tests': ['damp', 'tps']}, 09:07:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:07:00 INFO - 'tests': ['dromaeo_dom']}, 09:07:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:07:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:07:00 INFO - 'tests': ['basic_compositor_video']}, 09:07:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:07:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:07:00 INFO - 'tests': ['a11yr', 09:07:00 INFO - 'ts_paint', 09:07:00 INFO - 'tpaint', 09:07:00 INFO - 'sessionrestore', 09:07:00 INFO - 'sessionrestore_no_auto_restore', 09:07:00 INFO - 'tabpaint']}, 09:07:00 INFO - 'other-e10s': {'tests': ['a11yr', 09:07:00 INFO - 'ts_paint', 09:07:00 INFO - 'tpaint', 09:07:00 INFO - 'sessionrestore', 09:07:00 INFO - 'sessionrestore_no_auto_restore', 09:07:00 INFO - 'tabpaint']}, 09:07:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:07:00 INFO - 'ts_paint', 09:07:00 INFO - 'tpaint', 09:07:00 INFO - 'sessionrestore', 09:07:00 INFO - 'sessionrestore_no_auto_restore', 09:07:00 INFO - 'tabpaint']}, 09:07:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:07:00 INFO - 'ts_paint', 09:07:00 INFO - 'tpaint', 09:07:00 INFO - 'sessionrestore', 09:07:00 INFO - 'sessionrestore_no_auto_restore', 09:07:00 INFO - 'tabpaint']}, 09:07:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:07:00 INFO - 'tests': ['a11yr', 09:07:00 INFO - 'ts_paint', 09:07:00 INFO - 'tpaint', 09:07:00 INFO - 'sessionrestore', 09:07:00 INFO - 'sessionrestore_no_auto_restore', 09:07:00 INFO - 'tabpaint']}, 09:07:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:07:00 INFO - 'tests': ['a11yr', 09:07:00 INFO - 'ts_paint', 09:07:00 INFO - 'tpaint', 09:07:00 INFO - 'sessionrestore', 09:07:00 INFO - 'sessionrestore_no_auto_restore', 09:07:00 INFO - 'tabpaint']}, 09:07:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:07:00 INFO - 'tests': ['tsvgx', 09:07:00 INFO - 'tsvgr_opacity', 09:07:00 INFO - 'tart', 09:07:00 INFO - 'tscrollx', 09:07:00 INFO - 'cart', 09:07:00 INFO - 'tsvg_static']}, 09:07:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:07:00 INFO - 'tsvgr_opacity', 09:07:00 INFO - 'tart', 09:07:00 INFO - 'tscrollx', 09:07:00 INFO - 'cart', 09:07:00 INFO - 'tsvg_static']}, 09:07:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:07:00 INFO - 'talos_options': ['--disable-e10s'], 09:07:00 INFO - 'tests': ['tp5o']}, 09:07:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:07:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:07:00 INFO - 'talos_options': ['--disable-e10s', 09:07:00 INFO - '--xperf_path', 09:07:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:00 INFO - 'tests': ['tp5n']}, 09:07:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:07:00 INFO - 'talos_options': ['--xperf_path', 09:07:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:00 INFO - 'tests': ['tp5n']}}, 09:07:00 INFO - 'talos.zip': {'path': '', 09:07:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:07:00 INFO - Running post-action listener: _resource_record_post_action 09:07:00 INFO - [mozharness: 2017-02-24 17:07:00.823946Z] Finished populate-webroot step (success) 09:07:00 INFO - [mozharness: 2017-02-24 17:07:00.824036Z] Running create-virtualenv step. 09:07:00 INFO - Running pre-action listener: _resource_record_pre_action 09:07:00 INFO - Running main action method: create_virtualenv 09:07:00 INFO - Creating virtualenv /builds/slave/test/build/venv 09:07:00 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 09:07:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:07:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:07:00 INFO - Using real prefix '/usr' 09:07:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:07:01 INFO - Installing distribute.............................................................................................................................................................................................done. 09:07:03 INFO - Installing pip.................done. 09:07:03 INFO - Return code: 0 09:07:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:07:03 INFO - Reading from file tmpfile_stdout 09:07:03 INFO - Output received: 09:07:03 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:07:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:07:03 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')]} 09:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:03 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')]} 09:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:03 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 0x14881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1655a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fa980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f7d00>, '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 0x17f8a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:07:03 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 09:07:03 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 09:07:03 INFO - Using env: {'DISPLAY': ':0', 09:07:03 INFO - 'HOME': '/home/cltbld', 09:07:03 INFO - 'LANG': 'en_US.UTF-8', 09:07:03 INFO - 'LANGUAGE': 'en_US:en', 09:07:03 INFO - 'LOGNAME': 'cltbld', 09:07:03 INFO - 'MAIL': '/var/mail/cltbld', 09:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:03 INFO - 'MOZ_NO_REMOTE': '1', 09:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:03 INFO - 'NO_EM_RESTART': '1', 09:07:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:03 INFO - 'PWD': '/builds/slave/test', 09:07:03 INFO - 'SHELL': '/bin/bash', 09:07:03 INFO - 'SHLVL': '1', 09:07:03 INFO - 'TERM': 'linux', 09:07:03 INFO - 'TMOUT': '86400', 09:07:03 INFO - 'USER': 'cltbld', 09:07:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 09:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:03 INFO - '_': '/tools/buildbot/bin/python'} 09:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:03 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 09:07:03 INFO - Cleaning up... 09:07:03 INFO - Return code: 0 09:07:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:07:03 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')]} 09:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:03 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')]} 09:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:03 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 0x14881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1655a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fa980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f7d00>, '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 0x17f8a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:07:03 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 09:07:03 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 09:07:03 INFO - Using env: {'DISPLAY': ':0', 09:07:03 INFO - 'HOME': '/home/cltbld', 09:07:03 INFO - 'LANG': 'en_US.UTF-8', 09:07:03 INFO - 'LANGUAGE': 'en_US:en', 09:07:03 INFO - 'LOGNAME': 'cltbld', 09:07:03 INFO - 'MAIL': '/var/mail/cltbld', 09:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:03 INFO - 'MOZ_NO_REMOTE': '1', 09:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:03 INFO - 'NO_EM_RESTART': '1', 09:07:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:03 INFO - 'PWD': '/builds/slave/test', 09:07:03 INFO - 'SHELL': '/bin/bash', 09:07:03 INFO - 'SHLVL': '1', 09:07:03 INFO - 'TERM': 'linux', 09:07:03 INFO - 'TMOUT': '86400', 09:07:03 INFO - 'USER': 'cltbld', 09:07:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 09:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:03 INFO - '_': '/tools/buildbot/bin/python'} 09:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:04 INFO - Downloading/unpacking psutil>=3.1.1 09:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:07:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:07:06 INFO - Installing collected packages: psutil 09:07:06 INFO - Running setup.py install for psutil 09:07:06 INFO - building 'psutil._psutil_linux' extension 09:07:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:07:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:07:06 INFO - building 'psutil._psutil_posix' extension 09:07:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:07:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:07:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:07:06 INFO - Successfully installed psutil 09:07:06 INFO - Cleaning up... 09:07:06 INFO - Return code: 0 09:07:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:07: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')]} 09:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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')]} 09:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:06 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 0x14881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1655a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fa980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f7d00>, '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 0x17f8a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:07:06 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 09:07:06 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 09:07:06 INFO - Using env: {'DISPLAY': ':0', 09:07:06 INFO - 'HOME': '/home/cltbld', 09:07:06 INFO - 'LANG': 'en_US.UTF-8', 09:07:06 INFO - 'LANGUAGE': 'en_US:en', 09:07:06 INFO - 'LOGNAME': 'cltbld', 09:07:06 INFO - 'MAIL': '/var/mail/cltbld', 09:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:06 INFO - 'MOZ_NO_REMOTE': '1', 09:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:06 INFO - 'NO_EM_RESTART': '1', 09:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:06 INFO - 'PWD': '/builds/slave/test', 09:07:06 INFO - 'SHELL': '/bin/bash', 09:07:06 INFO - 'SHLVL': '1', 09:07:06 INFO - 'TERM': 'linux', 09:07:06 INFO - 'TMOUT': '86400', 09:07:06 INFO - 'USER': 'cltbld', 09:07:06 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 09:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:06 INFO - '_': '/tools/buildbot/bin/python'} 09:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:07:06 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 09:07:06 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 09:07:06 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 09:07:06 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 09:07:06 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 09:07:06 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 09:07:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:07:09 INFO - Installing collected packages: mozsystemmonitor 09:07:09 INFO - Running setup.py install for mozsystemmonitor 09:07:09 INFO - Successfully installed mozsystemmonitor 09:07:09 INFO - Cleaning up... 09:07:09 INFO - Return code: 0 09:07:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:09 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 0x14881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1655a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fa980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f7d00>, '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 0x17f8a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:07:09 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 09:07:09 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 09:07:09 INFO - Using env: {'DISPLAY': ':0', 09:07:09 INFO - 'HOME': '/home/cltbld', 09:07:09 INFO - 'LANG': 'en_US.UTF-8', 09:07:09 INFO - 'LANGUAGE': 'en_US:en', 09:07:09 INFO - 'LOGNAME': 'cltbld', 09:07:09 INFO - 'MAIL': '/var/mail/cltbld', 09:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:09 INFO - 'MOZ_NO_REMOTE': '1', 09:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:09 INFO - 'NO_EM_RESTART': '1', 09:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:09 INFO - 'PWD': '/builds/slave/test', 09:07:09 INFO - 'SHELL': '/bin/bash', 09:07:09 INFO - 'SHLVL': '1', 09:07:09 INFO - 'TERM': 'linux', 09:07:09 INFO - 'TMOUT': '86400', 09:07:09 INFO - 'USER': 'cltbld', 09:07:09 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 09:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:09 INFO - '_': '/tools/buildbot/bin/python'} 09:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:09 INFO - Downloading/unpacking jsonschema==2.5.1 09:07:09 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 09:07:09 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 09:07:09 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 09:07:09 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 09:07:09 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 09:07:09 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 09:07:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:07:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:11 INFO - Downloading functools32-3.2.3-2.tar.gz 09:07:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:07:11 INFO - warning: no files found matching '*.txt' 09:07:11 INFO - no previously-included directories found matching 'build' 09:07:11 INFO - no previously-included directories found matching 'dist' 09:07:11 INFO - no previously-included directories found matching '.git*' 09:07:11 INFO - Installing collected packages: jsonschema, functools32 09:07:11 INFO - Running setup.py install for functools32 09:07:11 INFO - warning: no files found matching '*.txt' 09:07:11 INFO - no previously-included directories found matching 'build' 09:07:11 INFO - no previously-included directories found matching 'dist' 09:07:11 INFO - no previously-included directories found matching '.git*' 09:07:11 INFO - Successfully installed jsonschema functools32 09:07:11 INFO - Cleaning up... 09:07:11 INFO - Return code: 0 09:07:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1655a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fa980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f7d00>, '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 0x17f8a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:07:11 INFO - Using env: {'DISPLAY': ':0', 09:07:11 INFO - 'HOME': '/home/cltbld', 09:07:11 INFO - 'LANG': 'en_US.UTF-8', 09:07:11 INFO - 'LANGUAGE': 'en_US:en', 09:07:11 INFO - 'LOGNAME': 'cltbld', 09:07:11 INFO - 'MAIL': '/var/mail/cltbld', 09:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:11 INFO - 'MOZ_NO_REMOTE': '1', 09:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:11 INFO - 'NO_EM_RESTART': '1', 09:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:11 INFO - 'PWD': '/builds/slave/test', 09:07:11 INFO - 'SHELL': '/bin/bash', 09:07:11 INFO - 'SHLVL': '1', 09:07:11 INFO - 'TERM': 'linux', 09:07:11 INFO - 'TMOUT': '86400', 09:07:11 INFO - 'USER': 'cltbld', 09:07:11 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 09:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:11 INFO - '_': '/tools/buildbot/bin/python'} 09:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:07:12 INFO - Cleaning up... 09:07:12 INFO - Return code: 0 09:07:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:12 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 0x14881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1655a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fa980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f7d00>, '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 0x17f8a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:07:12 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 09:07:12 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 09:07:12 INFO - Using env: {'DISPLAY': ':0', 09:07:12 INFO - 'HOME': '/home/cltbld', 09:07:12 INFO - 'LANG': 'en_US.UTF-8', 09:07:12 INFO - 'LANGUAGE': 'en_US:en', 09:07:12 INFO - 'LOGNAME': 'cltbld', 09:07:12 INFO - 'MAIL': '/var/mail/cltbld', 09:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:12 INFO - 'MOZ_NO_REMOTE': '1', 09:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:12 INFO - 'NO_EM_RESTART': '1', 09:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:12 INFO - 'PWD': '/builds/slave/test', 09:07:12 INFO - 'SHELL': '/bin/bash', 09:07:12 INFO - 'SHLVL': '1', 09:07:12 INFO - 'TERM': 'linux', 09:07:12 INFO - 'TMOUT': '86400', 09:07:12 INFO - 'USER': 'cltbld', 09:07:12 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 09:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:12 INFO - '_': '/tools/buildbot/bin/python'} 09:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:12 INFO - Downloading/unpacking blobuploader==1.2.4 09:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:14 INFO - Downloading blobuploader-1.2.4.tar.gz 09:07:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:07:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:07:14 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 09:07:14 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 09:07:14 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 09:07:14 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 09:07:14 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 09:07:14 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 09:07:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:07:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:15 INFO - Downloading docopt-0.6.1.tar.gz 09:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:07:15 INFO - Installing collected packages: blobuploader, requests, docopt 09:07:15 INFO - Running setup.py install for blobuploader 09:07:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:07:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:07:15 INFO - Running setup.py install for requests 09:07:15 INFO - Running setup.py install for docopt 09:07:15 INFO - Successfully installed blobuploader requests docopt 09:07:15 INFO - Cleaning up... 09:07:16 INFO - Return code: 0 09:07:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:16 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')]} 09:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:16 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')]} 09:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:16 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 0x14881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1655a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fa980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f7d00>, '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 0x17f8a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:07:16 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 09:07:16 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 09:07:16 INFO - Using env: {'DISPLAY': ':0', 09:07:16 INFO - 'HOME': '/home/cltbld', 09:07:16 INFO - 'LANG': 'en_US.UTF-8', 09:07:16 INFO - 'LANGUAGE': 'en_US:en', 09:07:16 INFO - 'LOGNAME': 'cltbld', 09:07:16 INFO - 'MAIL': '/var/mail/cltbld', 09:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:16 INFO - 'MOZ_NO_REMOTE': '1', 09:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:16 INFO - 'NO_EM_RESTART': '1', 09:07:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:16 INFO - 'PWD': '/builds/slave/test', 09:07:16 INFO - 'SHELL': '/bin/bash', 09:07:16 INFO - 'SHLVL': '1', 09:07:16 INFO - 'TERM': 'linux', 09:07:16 INFO - 'TMOUT': '86400', 09:07:16 INFO - 'USER': 'cltbld', 09:07:16 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 09:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:16 INFO - '_': '/tools/buildbot/bin/python'} 09:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:07:16 INFO - Running setup.py (path:/tmp/pip-E7iBEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:07:16 INFO - Running setup.py (path:/tmp/pip-VdI3K9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:07:16 INFO - Running setup.py (path:/tmp/pip-viZ2Vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:07:16 INFO - Running setup.py (path:/tmp/pip-yKc4Yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:07:16 INFO - Running setup.py (path:/tmp/pip-bmMJOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:07:16 INFO - Running setup.py (path:/tmp/pip-c9cV5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:07:16 INFO - Running setup.py (path:/tmp/pip-QhkULI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:07:16 INFO - Running setup.py (path:/tmp/pip-E3S3Gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:07:16 INFO - Running setup.py (path:/tmp/pip-0HiQTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:07:16 INFO - Running setup.py (path:/tmp/pip-1k5gai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:07:16 INFO - Running setup.py (path:/tmp/pip-RslLCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:07:17 INFO - Running setup.py (path:/tmp/pip-0AkbzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:07:17 INFO - Running setup.py (path:/tmp/pip-IFg0px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:07:17 INFO - Running setup.py (path:/tmp/pip-5DUEPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:17 INFO - Running setup.py (path:/tmp/pip-w2WGOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:07:17 INFO - Running setup.py (path:/tmp/pip-pOm1bY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:07:17 INFO - Running setup.py (path:/tmp/pip-X7YKww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:07:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:07:17 INFO - Running setup.py install for manifestparser 09:07:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:07:17 INFO - Running setup.py install for mozcrash 09:07:17 INFO - Running setup.py install for mozdebug 09:07:17 INFO - Running setup.py install for mozdevice 09:07:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:07:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:07:17 INFO - Running setup.py install for mozfile 09:07:17 INFO - Running setup.py install for mozhttpd 09:07:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:07:18 INFO - Running setup.py install for mozinfo 09:07:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:07:18 INFO - Running setup.py install for mozInstall 09:07:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:07:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:07:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:07:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:07:18 INFO - Running setup.py install for mozleak 09:07:18 INFO - Running setup.py install for mozlog 09:07:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:07:18 INFO - Running setup.py install for moznetwork 09:07:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:07:18 INFO - Running setup.py install for mozprocess 09:07:18 INFO - Running setup.py install for mozprofile 09:07:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:07:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:07:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:07:18 INFO - Running setup.py install for mozrunner 09:07:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:07:18 INFO - Running setup.py install for mozscreenshot 09:07:19 INFO - Running setup.py install for moztest 09:07:19 INFO - Running setup.py install for mozversion 09:07:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:07:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:07:19 INFO - Cleaning up... 09:07:19 INFO - Return code: 0 09:07:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07: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')]} 09:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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')]} 09:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:19 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 0x14881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1655a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fa980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f7d00>, '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 0x17f8a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:07:19 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 09:07:19 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 09:07:19 INFO - Using env: {'DISPLAY': ':0', 09:07:19 INFO - 'HOME': '/home/cltbld', 09:07:19 INFO - 'LANG': 'en_US.UTF-8', 09:07:19 INFO - 'LANGUAGE': 'en_US:en', 09:07:19 INFO - 'LOGNAME': 'cltbld', 09:07:19 INFO - 'MAIL': '/var/mail/cltbld', 09:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:19 INFO - 'MOZ_NO_REMOTE': '1', 09:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:19 INFO - 'NO_EM_RESTART': '1', 09:07:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:19 INFO - 'PWD': '/builds/slave/test', 09:07:19 INFO - 'SHELL': '/bin/bash', 09:07:19 INFO - 'SHLVL': '1', 09:07:19 INFO - 'TERM': 'linux', 09:07:19 INFO - 'TMOUT': '86400', 09:07:19 INFO - 'USER': 'cltbld', 09:07:19 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 09:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:19 INFO - '_': '/tools/buildbot/bin/python'} 09:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:07:19 INFO - Running setup.py (path:/tmp/pip-oS3dAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:07:19 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)) 09:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:07:19 INFO - Running setup.py (path:/tmp/pip-RxISzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 09:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:07:19 INFO - Running setup.py (path:/tmp/pip-_AN0Tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:07:19 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)) 09:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:07:19 INFO - Running setup.py (path:/tmp/pip-GT3XQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 09:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:07:19 INFO - Running setup.py (path:/tmp/pip-ekpweZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:07:19 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)) 09:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:07:19 INFO - Running setup.py (path:/tmp/pip-M64MVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:07:19 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)) 09:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:07:19 INFO - Running setup.py (path:/tmp/pip-Ve7uv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:07:20 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)) 09:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:07:20 INFO - Running setup.py (path:/tmp/pip-fWLKrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:07:20 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)) 09:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:07:20 INFO - Running setup.py (path:/tmp/pip-JSkhgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:07:20 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)) 09:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:07:20 INFO - Running setup.py (path:/tmp/pip-80x53D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 09:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:07:20 INFO - Running setup.py (path:/tmp/pip-Hz9Yj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:07:20 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)) 09:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:07:20 INFO - Running setup.py (path:/tmp/pip-vKrWfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 09:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:07:20 INFO - Running setup.py (path:/tmp/pip-yTt43J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:07:20 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)) 09:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:07:20 INFO - Running setup.py (path:/tmp/pip-sbL0gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 09:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:20 INFO - Running setup.py (path:/tmp/pip-KVpycY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:20 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)) 09:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:07:20 INFO - Running setup.py (path:/tmp/pip-wTEQHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 09:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:07:20 INFO - Running setup.py (path:/tmp/pip-G9fK3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:07:20 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)) 09:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:07:20 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)) 09:07:20 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:07:20 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:07:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07:22 INFO - Downloading blessings-1.6.tar.gz 09:07:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:07:23 INFO - Installing collected packages: blessings 09:07:23 INFO - Running setup.py install for blessings 09:07:23 INFO - Successfully installed blessings 09:07:23 INFO - Cleaning up... 09:07:23 INFO - Return code: 0 09:07:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:07:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:07:23 INFO - Reading from file tmpfile_stdout 09:07:23 INFO - Current package versions: 09:07:23 INFO - argparse == 1.2.1 09:07:23 INFO - blessings == 1.6 09:07:23 INFO - blobuploader == 1.2.4 09:07:23 INFO - docopt == 0.6.1 09:07:23 INFO - functools32 == 3.2.3-2 09:07:23 INFO - jsonschema == 2.5.1 09:07:23 INFO - manifestparser == 1.1 09:07:23 INFO - mozInstall == 1.12 09:07:23 INFO - mozcrash == 1.0 09:07:23 INFO - mozdebug == 0.1 09:07:23 INFO - mozdevice == 0.49 09:07:23 INFO - mozfile == 1.2 09:07:23 INFO - mozhttpd == 0.7 09:07:23 INFO - mozinfo == 0.9 09:07:23 INFO - mozleak == 0.1 09:07:23 INFO - mozlog == 3.4 09:07:23 INFO - moznetwork == 0.27 09:07:23 INFO - mozprocess == 0.24 09:07:23 INFO - mozprofile == 0.28 09:07:23 INFO - mozrunner == 6.13 09:07:23 INFO - mozscreenshot == 0.1 09:07:23 INFO - mozsystemmonitor == 0.3 09:07:23 INFO - moztest == 0.8 09:07:23 INFO - mozversion == 1.4 09:07:23 INFO - psutil == 3.1.1 09:07:23 INFO - requests == 1.2.3 09:07:23 INFO - wsgiref == 0.1.2 09:07:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:23 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 0x14881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1655a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fa980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f7d00>, '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 0x17f8a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:07:23 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 09:07:23 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 09:07:23 INFO - Using env: {'DISPLAY': ':0', 09:07:23 INFO - 'HOME': '/home/cltbld', 09:07:23 INFO - 'LANG': 'en_US.UTF-8', 09:07:23 INFO - 'LANGUAGE': 'en_US:en', 09:07:23 INFO - 'LOGNAME': 'cltbld', 09:07:23 INFO - 'MAIL': '/var/mail/cltbld', 09:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:23 INFO - 'MOZ_NO_REMOTE': '1', 09:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:23 INFO - 'NO_EM_RESTART': '1', 09:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:23 INFO - 'PWD': '/builds/slave/test', 09:07:23 INFO - 'SHELL': '/bin/bash', 09:07:23 INFO - 'SHLVL': '1', 09:07:23 INFO - 'TERM': 'linux', 09:07:23 INFO - 'TMOUT': '86400', 09:07:23 INFO - 'USER': 'cltbld', 09:07:23 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 09:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:23 INFO - '_': '/tools/buildbot/bin/python'} 09:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:23 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)) 09:07:23 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)) 09:07:23 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)) 09:07:23 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)) 09:07:23 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)) 09:07:23 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)) 09:07:23 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)) 09:07:23 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)) 09:07:23 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)) 09:07:23 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)) 09:07:23 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)) 09:07:23 INFO - Cleaning up... 09:07:23 INFO - Return code: 0 09:07:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:23 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 0x14881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1655a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17fa980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f7d00>, '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 0x17f8a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:07:23 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 09:07:23 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 09:07:23 INFO - Using env: {'DISPLAY': ':0', 09:07:23 INFO - 'HOME': '/home/cltbld', 09:07:23 INFO - 'LANG': 'en_US.UTF-8', 09:07:23 INFO - 'LANGUAGE': 'en_US:en', 09:07:23 INFO - 'LOGNAME': 'cltbld', 09:07:23 INFO - 'MAIL': '/var/mail/cltbld', 09:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:23 INFO - 'MOZ_NO_REMOTE': '1', 09:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:23 INFO - 'NO_EM_RESTART': '1', 09:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:23 INFO - 'PWD': '/builds/slave/test', 09:07:23 INFO - 'SHELL': '/bin/bash', 09:07:23 INFO - 'SHLVL': '1', 09:07:23 INFO - 'TERM': 'linux', 09:07:23 INFO - 'TMOUT': '86400', 09:07:23 INFO - 'USER': 'cltbld', 09:07:23 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 09:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:23 INFO - '_': '/tools/buildbot/bin/python'} 09:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:07:23 INFO - Cleaning up... 09:07:23 INFO - Return code: 0 09:07:23 INFO - Running post-action listener: _resource_record_post_action 09:07:23 INFO - Running post-action listener: _start_resource_monitoring 09:07:23 INFO - Starting resource monitoring. 09:07:23 INFO - [mozharness: 2017-02-24 17:07:23.952761Z] Finished create-virtualenv step (success) 09:07:23 INFO - [mozharness: 2017-02-24 17:07:23.953213Z] Running install step. 09:07:23 INFO - Running pre-action listener: _resource_record_pre_action 09:07:23 INFO - Running main action method: install 09:07:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:07:24 INFO - Reading from file tmpfile_stdout 09:07:24 INFO - Detecting whether we're running mozinstall >=1.0... 09:07:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:07:24 INFO - Reading from file tmpfile_stdout 09:07:24 INFO - Output received: 09:07:24 INFO - Usage: mozinstall [options] installer 09:07:24 INFO - Options: 09:07:24 INFO - -h, --help show this help message and exit 09:07:24 INFO - -d DEST, --destination=DEST 09:07:24 INFO - Directory to install application into. [default: 09:07:24 INFO - "/builds/slave/test"] 09:07:24 INFO - --app=APP Application being installed. [default: firefox] 09:07:24 INFO - mkdir: /builds/slave/test/build/application 09:07:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:07:40 INFO - Reading from file tmpfile_stdout 09:07:40 INFO - Output received: 09:07:40 INFO - /builds/slave/test/build/application/firefox/firefox 09:07:40 INFO - Running post-action listener: _resource_record_post_action 09:07:40 INFO - [mozharness: 2017-02-24 17:07:40.725003Z] Finished install step (success) 09:07:40 INFO - [mozharness: 2017-02-24 17:07:40.725281Z] Running run-tests step. 09:07:40 INFO - Running pre-action listener: _resource_record_pre_action 09:07:40 INFO - Running main action method: run_tests 09:07:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:07:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:07:40 INFO - Python 2.7.3 09:07:40 INFO - Return code: 0 09:07:40 INFO - grabbing minidump binary from tooltool 09:07: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')]} 09:07:40 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/linux64/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 0x17f7d00>, '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 0x17f8a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:07:40 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:07:40 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/linux64/releng.manifest -o -c /builds/tooltool_cache 09:07:40 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:07:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:07:40 INFO - Return code: 0 09:07:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:07:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:07:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:07:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:07:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:07:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:07:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:07:40 INFO - Using env: {'DISPLAY': ':0', 09:07:40 INFO - 'HOME': '/home/cltbld', 09:07:40 INFO - 'LANG': 'en_US.UTF-8', 09:07:40 INFO - 'LANGUAGE': 'en_US:en', 09:07:40 INFO - 'LOGNAME': 'cltbld', 09:07:40 INFO - 'MAIL': '/var/mail/cltbld', 09:07:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:07:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:40 INFO - 'MOZ_NO_REMOTE': '1', 09:07:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:40 INFO - 'NO_EM_RESTART': '1', 09:07:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:40 INFO - 'PWD': '/builds/slave/test', 09:07:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:07:40 INFO - 'SHELL': '/bin/bash', 09:07:40 INFO - 'SHLVL': '1', 09:07:40 INFO - 'TERM': 'linux', 09:07:40 INFO - 'TMOUT': '86400', 09:07:40 INFO - 'USER': 'cltbld', 09:07:40 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502', 09:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:40 INFO - '_': '/tools/buildbot/bin/python'} 09:07:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:07:41 INFO - mozversion application_buildid: 20170224161212 09:07:41 INFO - mozversion application_changeset: 4851173666d03c2be1e2d72705650c69cfc35dfb 09:07:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:07:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:07:41 INFO - mozversion application_name: Firefox 09:07:41 INFO - mozversion application_remotingname: firefox-dev 09:07:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:07:41 INFO - mozversion application_vendor: Mozilla 09:07:41 INFO - mozversion application_version: 53.0a2 09:07:41 INFO - mozversion platform_buildid: 20170224161212 09:07:41 INFO - mozversion platform_changeset: 4851173666d03c2be1e2d72705650c69cfc35dfb 09:07:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:07:41 INFO - mozversion platform_version: 53.0a2 09:07:41 INFO - using testdate: 1487956061 09:07:41 INFO - actual date: 1487956061 09:07:41 INFO - starting webserver on 'localhost:42629' 09:07:41 INFO - SUITE-START | Running 2 tests 09:07:41 INFO - TEST-START | dromaeo_css 09:07:41 INFO - operating with platform_type : linux_ 09:07:41 INFO - Initialising browser for dromaeo_css test... 09:07:41 INFO - TEST-INFO | started process 11927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB7gqDC/profile http://localhost:42629/getInfo.html) 09:07:44 INFO - PROCESS | 11927 | __metrics Screen width/height:1600/1200 09:07:44 INFO - PROCESS | 11927 | colorDepth:24 09:07:44 INFO - PROCESS | 11927 | Browser inner width/height: 1024/697 09:07:44 INFO - PROCESS | 11927 | __metrics 09:07:45 INFO - PROCESS | 11927 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:07:45 INFO - PROCESS | 11927 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:07:46 INFO - TEST-INFO | 11927: exit 0 09:07:46 INFO - Browser initialized. 09:07:46 INFO - Running cycle 1/1 for dromaeo_css test... 09:07:46 INFO - TEST-INFO | started process 12021 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB7gqDC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:58 INFO - PROCESS | 12021 | RSS: Main: 137986048 09:07:58 INFO - PROCESS | 12021 | 09:10:59 INFO - PROCESS | 12021 | Cycle 1(1): loaded http://localhost:42629/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42629/tests/dromaeo/cssquery-ext.html) 09:11:00 INFO - PROCESS | 12021 | RSS: Main: 274886656 09:11:00 INFO - PROCESS | 12021 | 09:12:49 INFO - PROCESS | 12021 | ************************* 09:12:49 INFO - PROCESS | 12021 | A coding exception was thrown and uncaught in a Task. 09:12:49 INFO - PROCESS | 12021 | 09:12:49 ERROR - PROCESS | 12021 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:12:49 INFO - PROCESS | 12021 | Full stack: 09:12:49 INFO - PROCESS | 12021 | ************************* 09:14:02 INFO - PROCESS | 12021 | Cycle 1(1): loaded http://localhost:42629/tests/dromaeo/cssquery-ext.html (next: http://localhost:42629/tests/dromaeo/cssquery-jquery.html) 09:14:03 INFO - PROCESS | 12021 | RSS: Main: 224665600 09:14:03 INFO - PROCESS | 12021 | 09:17:05 INFO - PROCESS | 12021 | Cycle 1(1): loaded http://localhost:42629/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42629/tests/dromaeo/cssquery-mootools.html) 09:17:05 INFO - PROCESS | 12021 | RSS: Main: 170917888 09:17:05 INFO - PROCESS | 12021 | 09:20:07 INFO - PROCESS | 12021 | Cycle 1(1): loaded http://localhost:42629/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42629/tests/dromaeo/cssquery-prototype.html) 09:20:08 INFO - PROCESS | 12021 | RSS: Main: 173539328 09:20:08 INFO - PROCESS | 12021 | 09:23:10 INFO - PROCESS | 12021 | Cycle 1(1): loaded http://localhost:42629/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42629/tests/dromaeo/cssquery-yui.html) 09:23:11 INFO - PROCESS | 12021 | RSS: Main: 172531712 09:23:11 INFO - PROCESS | 12021 | 09:26:13 INFO - PROCESS | 12021 | Cycle 1(1): loaded http://localhost:42629/tests/dromaeo/cssquery-yui.html (next: http://localhost:42629/tests/dromaeo/cssquery-dojo.html) 09:26:14 INFO - PROCESS | 12021 | RSS: Main: 263028736 09:26:14 INFO - PROCESS | 12021 | 09:26:14 INFO - PROCESS | 12021 | __start_tp_report 09:26:14 INFO - PROCESS | 12021 | _x_x_mozilla_page_load 09:26:14 INFO - PROCESS | 12021 | _x_x_mozilla_page_load_details 09:26:14 INFO - PROCESS | 12021 | |i|pagename|runs| 09:26:14 INFO - PROCESS | 12021 | |0;dojo.html;3310.47032474804;3325.318309746502;3345.4647256438966;3367.1245476176186;3385.0521853880905;5392.272043274157;5460.290162278903;5464.12573988161;5480.6437581557275;5518.972405137979;5485.670859748408;5517.393086760453;5527.419620939803;5530.281063461744;5534.861628459291;5000.624953128521;5026.497350264981;5047.369078865142;5062.7468626568525;5131.2303154526935;4941;4958.181899986498;5081.872953176182;5128.4102328232175;5128.461511541291;4927.901441971158;4939.950600494003;4972.0801651694555;5023.522765337287;5023.799048038074;5044.066847633163;5046.44489106198;5054.241863720435;5054.671446355975;5076.517730815566;4853.0779151961015;4957.355543779286;4978.925316120261;5004.749762511896;5023.246513023039;5358.3569971603265;5440.4287549807095;5445.292112025411;5455.645383050089;5461.15352120422;5737.770489180428;5796;5812.767489300465;5821.53427725781;5846.239988801472;5910.113482977545;5931.199288096095;5932.0508718604815;5937.376575459601;5961.612495187799;5466.835994920159;5516.91724624131;5521.944780552183;5526.005319042611;5526.47498487643;5763.8559036024435;5840.970795145997;5841.970790146107;5904;5978.611390259619;5772.134179872969;5776.075827867521;5778.566607504454;5798.159266906275;5808.94191058084;5819.73811178498;5851.795187168429;5866.648001119861;5866.911996320058;5874.5887787854435;5619.466150715675;5683.119116536861;5854.121881717776;5860.8534786629825;5864.9413505864395;5724.542036637059;5771.249737534177;5784.59507834456;5830.533557315404;5889.617174883619;4544.409226800495;4548.6133678637025;4551.112533056023;4553.635709143261;4581.450225972904;3906.628870257321;4030.234255491447;4041.312976793952;4044.0900797320955;4072.0430698786354;5454.481824226692;5535.750891209825;5588.385277619459;5595.328560572757;5683.715814209273;5913.142594323799;5933.376995415506;5933.673647949404;5936.198613187251;5940.108983652401;5424.240606315119;5500.367457742331;5507.586930980193;5594.776208951678;5640.294963129609;4944.752762361867;5001.9499805002215;5002.199648056294;5036.874078148076;5059.038782631362;6162.322144564005;6165.198524191826;6167.660778657217;6171.228596425447;6184.103305020747;5904.822855314347;5910.379410161871;5916.556258280732;5916.73374698131;5923.733431995657;5971.313298970674;6002.039673652369;6023.909641355471;6042.667653278936;6049.243844519435;5748.367679555329;5791.8552036199435;5793.217915581511;5795.884082318245;5826.563007774519;5839.941600583939;5886.558508111994;5887.5289976802605;5891.410858914246;5894.616849904743;5552.861178470571;5580.776768929198;5609.186667933209;5636.126400407943;5739.483446489836;5710.029295019774;5718.085106382959;5718.742656580381;5732.3121225453215;5745.885082298414;5611.130274807411;5636.774529018793;5638.887222255614;5638.9436105638415;5686.09022556389;5619.325680918152;5622.578306626938;5678.716064196857;5697.57268204878;5711.628744131618;5555.944440555542;5585.273914391103;5626.971865140648;5661.264035675335;5665.546756259407 09:26:14 INFO - PROCESS | 12021 | |1;ext.html;544.1239943162803;583.6614763437207;591.1782622155205;591.4174538079993;614.6404353453228;31576;44736.77631611841;45986.31020534695;46042.53957460424;46075.76962115189;47256.52743472564;47705.52294477054;47762;47823.521764782345;47971;8634.870476942851;8934.419262747933;8951.015388307282;9182.219511341544;9188.494632795193;11033.448327583588;11345.149113816455;11354.489047992818;11744.588939387124;11747.236429632047;11507.654770356903;11559.133065020114;11573.768524629502;11581.18931674783;11586.710332241677;11398.658040258806;11447;11451.713707157387;11464.942675286653;11466;11287.717807054889;11351.829722554168;11357.886421135765;11363.659090227306;11368.14738894578;47026;47351.763241183915;47432.762836185946;47434.52565474335;47488.762556187;4165.375193720935;4232.809523571446;4251.638610718092;4354.521002689701;4392.407025051641;33706.32587348239;34330.48504272438;34402.48396274058;34491.482627760604;36022.279554409026;4468.061707041526;4470.664700147469;4494;4526.384093757271;4549.658775591844;239598;240537;241608;242001.78999105067;242374;56692.71653641705;57197;57639.711801440724;57822.421775782546;65600.34399656038;67879;68299;68377;68584;68634;16891.324347026228;17420.564485887953;17459.65080698379;17475.56311092233;17486.30054797794;12043.75912481763;12152.270863748026;12371.628851134481;12586.307753073668;13447;17510.737338939925;17615.471535853943;17632.294708211786;17676.204570794343;17688.380906668204;7104.92895071053;7114.217436082027;7125.0074968513345;7138.964305178441;7184.568925864465;990.6928852055886;1004;1008.4000019988096;1018.1803648063232;1023.5598692562121;31586;31984.84007579947;32058.19854503656;32190.83904580462;32207;1078.1428764132534;1158.1429741991035;1168.3515648814819;1186.027457484854;1194.988050119505;16009.43848984157;16458.506244812674;16543.83456165447;16608;17858;482982;484449;484658;484667;484776;56384.436155637915;56565.43434565602;56729.58176045632;56746;56753.432465674814;1481.7036592681507;1496.7829664698775;1527.9083255004514;1548.8606025457764;1552.8058992625922;28874;30092.849535752182;30179.81323266424;30667.2333191672;30703;45932;46377.304340434246;46377.30434043559;46432.535674644176;46547.53452465432;371175;372081;372121;372736;372877;24370.51258974846;24529.877350613133;26615.866920665274;27585;27838.16485505438;43528.78235608801;43873.34189987089;43879;44168.33747493855;44531.55468445274;37254.44118338173;37285.62714372821;37356.439653404675;37735.62264377431;38179;36655;36938.630613693516;36973.07567310839;37284.81357593195;37848.43227351537;36335.27329453449;36369;36440.635593643725;36749.44875826811;36772.44841327436;32074.67925320717;33221.667783322824;33270.33459330751;33815.66184338224;33827.492587610715;25256.494870102862;25446.109386171396;25858;25924.481510370064;26098.217053488424 09:26:14 INFO - PROCESS | 12021 | |2;jquery.html;440.5858493016564;443.22656963598524;443.5365043529511;444.48661795626043;457.6064584457366;19266.422007339785;19460.70808937865;21078.789212107873;21187.258445954394;21389.893050534745;21660.566788664255;22130.225442109528;22346.77653223467;22445.887770561167;22624.43438914028;6015.3383127855905;6205.472534834522;6219.471344935663;6225.657588832612;6233.625982441068;5111.667741596803;5179.741012949356;5182.144946083891;5190.506901844319;5322.547583455411;5148.639595228336;5157.329547158864;5160.329157209576;5160.432352441228;5184.196449550326;5166.689998600096;6047.092936059582;6082.239720034996;6095.05526643371;6097.57316987811;5373.570114390839;5525.944740552623;5527.2538207341895;5529.944700552983;5534.059209934321;24267.514649707082;24379.756202437926;24493.755062449505;24494.877525612435;24849.1302804401;3199.104250809777;3200.7919485233383;3203.535487354344;3218.291975765328;3258.6252580953255;15594.610134746723;15697.37210511578;15822.76265856013;15838.52484425469;16000;1907.5612609099846;1926.6820974539185;1969.4977780665981;1978.703194520819;2002.1991203518564;71089;84482;85455.14544854534;87849.56075219583;101969;11235.157363197794;11435.656930292105;11436.828447573293;11608.129390295762;11744.823827642593;16162.676746465006;16678.749818752727;16685.49943501697;16691.165441727866;16710.248038838283;8426.789330266669;8440.198181172778;8548.230659240573;8611.95694021526;8614.267787238156;8264.380171487162;8306.584670766437;8314.958425207957;8484.27883629886;8484.872726909101;7299.343059124704;7442.516236444614;7501.512401693873;7561.546307221584;7608.80977975544;2132.6161290967466;2219.1678120704737;2233.575620632075;2236.250855963238;2254.1096266974782;974.6355102855916;978.2711879649706;980.568549838069;983.9212862970945;992.3549692699803;20365.287214947406;20416.897915510326;20486.282980095624;20575.4856128595;20617.58764824695;975.8438649815995;981.6122631560494;984.7735020945223;992.8014397120605;994.2848586188911;11290.435478226056;11638.476268567934;11751.118666100077;11766.411679416165;11894.107941904393;652284;653205;655593;656354;672904;96037;98129;101774.4911275439;104174.47912760387;117260.41369793267;1157.6295585412588;1178.9742923656302;1197.1799317467562;1201.3752848518895;1205.2708111592535;18344.63310733751;18958.336458223897;19023.809761902758;19026.524336891136;19059.332923347618;46423;46867;47074;48274.03451931012;48563.75718121387;65263.40991390776;65764.34235657583;65801;67741;68006.31993679999;9011.954940225258;9232.492212928353;9296.302777291596;9386.953065234904;9493.525323733924;12459.12786104964;12730.745385092061;12820.23078615286;12875.420606072561;13340.266285354399;11534.192606517463;11570.59502917394;11731.648050558497;12049.939750301543;12119.697007574881;11603.245789023686;11662.825057624312;12043.939780301042;12046.939765301468;12282.447289871798;11676.357800321064;12372.257664540157;12465.626031219077;12489;12597.685057873627;9127.178553930178;9127.680531181377;9340.766480838034;9558.187554057706;9581.473018984023;11714.648560543197;12066.698332541757;12075.637730868088;12251.326177060348;12487.938525225458 09:26:14 INFO - PROCESS | 12021 | |3;mootools.html;1518.8025556677637;1519.3998370643603;1526.4504778279818;1538.4615384615386;1543.7298472767266;8405.957970210147;8965.193132618064;8970.506622135788;8982.595783189756;8992.41549299296;7758.573278469682;7967.760967170994;7981.92018079819;8187.26314631683;8737.737867863958;2379.9405014874637;2480.082369523279;2482.6648402465617;2487.751224877507;2494.6881639795024;2282.0529480265755;2319.1766922742436;2322.140807901079;2345.0502546468706;2345.0736958901307;2314.4561028158455;2333.7199536055614;2352.2120089769946;2359.7994170495444;2360.6813080234206;2383.52329534093;2392.043182726906;2395.5089206712582;2398.4243781492405;2400.4958958618713;2280.3159052284414;2281.885905704725;2282.1441959265276;2283.178055899875;2296.5292115116363;8408.411411201218;8422.78943026423;8472.06807251208;8478.321734261306;8480.321574274043;5309.787608495655;5466.863328416782;5470.64440811346;5484.040292948758;5508.283923089973;3199.1202419334636;3337.4159522083537;3422.5379573757473;3423.7945723256435;3429.0570093224565;1269.8793614606598;1312.770265203595;1314.231174762765;1345.3004437692346;1364.597443754095;12085.45615447307;12092.214006089576;12093.93953030238;12115.39423028845;12132.211406258653;4609.400777898919;4747.454042785055;4806.879828004258;4807.855764327076;4926.45808961014;10439;10474.581016759244;10482.947585262025;10506.317089389166;10509.054185123223;5502.614816962774;5529.115341545334;5535.806246781343;5537.307836520435;5554.50009499147;4875.366202393666;4898.828541001048;4958.404991400983;5050.444451110375;5078.873028174326;4121.345224492656;4144.088300573869;4169.533782099227;4203.243416185055;4208.726432781859;1314.1786383510307;1331.7469680760626;1333.5199328241824;1338.6854089289009;1346.8855147312393;976.4043933200742;1004.8090862736057;1005.6228914157191;1011.4083261292227;1015.6242190389603;5600.411956744565;5827.388124246893;6013.368596297413;6097.664628445389;6127.84680382994;1058.1164727452663;1072.1101485766794;1074.414444127952;1078.094400703413;1081.8160912644869;4137.275976704064;4192.308269135619;4215.388768628532;4254.723442976197;4325.134973005412;10176.440295783656;10596.841047384296;10606.946965265124;10608;10618.893811061791;10463.319884207654;10526.578936842594;10538.104261137889;10544.420056896945;10553;7702.807429814299;8102.108768035511;8116.715914942949;8271.21423464782;8349.707760228363;5982.4316689914385;6102.603330783662;6170.444659980623;6181.258249010148;6283.937160628335;9528.237740980567;9678.17735492491;9889.456079915673;9923.255755818487;9929;9391.342606017513;9424.434533927986;9576.808463830825;9630.566624502055;9965.800683986425;7507.512011719221;7632.5038872473115;7639.770806875803;7646.197149299466;7648.65581048843;7527.661255243418;7883.408744344312;7927.484713493604;8057.033156021315;8181;7414.406847452083;7450.031495905498;7486.475946683898;7535.6985720570565;7647.541147531166;7166.856662866818;7170.498065135599;7197.892031619425;7287;7344;6222.346653601488;6371.23545174582;6389.169407976933;6463.030545418225;6569.211694596679;5203.349581302337;5268.1834315681135;5273.709945953009;5356.946430535801;5398.028354896156;4971.130052240916;5047.116754567863;5106.948930510796;5242.868928276824;5285.709285989307 09:26:14 INFO - PROCESS | 12021 | |4;prototype.html;400.12772156698384;404.70860980094324;410.4192567516962;413.5669903783391;417.29060596985136;5313.946860531393;5343.625946183769;5388.946110538898;5403.567714582834;5406.216098665696;5210.583153347732;5234.895302093965;5303.575713942885;5319.6808191508535;5357.196420536921;4293.313069908815;4306.224879521685;4309.82760689572;4317;4327.761973091471;4314.97842510787;4328.458942632171;4332.566743325674;4345.435093437849;4353.564643535653;4009.398590211477;4145.233131870614;4191.308434108384;4313.266744653401;4330.805113769888;4172.408971977565;4175.62419382254;4182.100848317596;4185.22573323936;4190.497140343148;3711.758735682199;3741.3639681254253;3742.36379815432;3751.4185301278344;3774.4904437900805;5115.130427827278;5225.425203227642;5227.634065615409;5240.187770895517;5271.393789714193;4804.567588917014;4841.2496063110275;4846.733429661367;4848.230395905504;4852.296417019547;5583.832485025456;5584.636998595119;5593.972030139823;5600.159976003632;5609.943900560983;4034.374671925856;4104.240715467618;4131.442255295527;4135.648469880064;4154.376843473473;5437.8368648940595;5566.554675625981;5665.507176842177;5675.51758100562;5730.4269573042775;4056.5740597236863;4063.512378514597;4083.85706500277;4085.346344584852;4171.436856024458;4214.115035842446;4237.940514871282;4244.8089835956835;4246.027780553625;4258.7657678827345;4466.352378905106;4746.816464426333;4789.880252993703;4799.712017278905;4816.54242846929;5244.501772331622;5521.558275337963;5526.751296191681;5553.805616803393;5610.97194514033;1397.7204559088223;1399.167495340271;1404.985950140506;1405.943762249519;1407.429990853706;961.7355227312545;989.3774210295122;998.0418797953901;1001.5793366785967;1019.3832731197667;5229.921551176735;5238.528532432099;5239.685618862881;5249.238860365225;5266.7629956652045;5388.245645609618;5466.851961088137;5484.670919744828;5488.231647569343;5498.80754173602;5087;5247.711375874287;5257.76340064698;5295.867603309871;5298.81454149103;2871.267826704219;2879.337752316979;2929.3555417808047;2947.513660246035;2958.0238521287924;5678.20505129274;5686;5708.029634962067;5713.171590119409;5764.625299355528;5328.8401347959625;5538.9169162461785;5592.412796656374;5598.216249725042;5627.352854421794;5681.517071048925;5737.967165910176;5741.425857414225;5749.04532458966;5757.337906140848;5290.603204759582;5481.260029896072;5510.614257001971;5524.226608274925;5535.813353725336;5425.647332923348;5437.728113594384;5441.83674489766;5451.155070964007;5487.957288115245;5612.811003708639;5685.005124103182;5734.942650573441;5740.425957404226;5763;4316.503602085801;4413.977930110329;4443.4445694288215;4447.799849006868;4456.665750068693;5639.154126880837;5668.688222147822;5691.402402747652;5718.828435146952;5743.684097374685;5472.370677372153;5479;5548.528375088163;5572.498475137095;5599.776008959596;5588.748506317307;5592.804251851166;5605.831825045092;5612.354579223278;5620.122115740126;5499.835004949858;5531.944680553143;5552.916706249491;5589.860253493533;5603.7758489659955;5289.709066001406;5556.611037227355;5562.610617256753;5579.581531385244;5596.804111856066;5455.972720136374;5463.562914966873;5470.234167216513;5484.204790305464;5488.231647569423 09:26:14 INFO - PROCESS | 12021 | |5;yui.html;759.3962799574338;779.4271210660161;785.344237561636;821.7124006597692;834.5368320582074;15708;16197.035693282973;16200.75698864518;16365.75451368229;16605.584860378498;15453.30460129294;15588.298526566303;15625.453109141183;15930.761038584431;15942.282597283122;700.660179812793;824.9628766705498;831.8502669519484;833.5040650812787;833.8874251975997;713.9071920650308;805.959702014897;827.8758186272047;830.2610676497922;833.262562632072;854.9102344253857;855.7946092937681;855.9058503564603;855.9984817763201;856.5289090999956;723.7213672736035;855.4183155454289;856.7601071699903;856.8072183758667;857.0358346859751;557.2310211907542;612.9601575897597;626.8025571944822;628.2963081348872;635.6948664640998;14691.191984440851;14718.484853030093;14762.261886905611;14836.184009879453;14844.332005059798;14629.317628472756;14658.633534161625;14838.33227504754;14878.851211487854;14899.106053636817;12851.228926264454;12853.16454430459;12972.80540791889;13005.284709340982;13831.30843457823;3759.981200094009;3785.8107094645156;3788.1666033472866;3792.469054332396;3865.4588357629955;87494.12505874924;88579.55710221472;89079.55460222658;89340;90224;13020.348982551024;13522.797158042637;13571;13718.862811371759;13766.24285664298;23344.883275583514;23460.765392345857;23816.40458988539;23949.485304043174;24004.87997560001;7677.884831727529;7712.845743085107;7808.804779880435;7828.530288182727;7880.763577092696;4425.885600673728;4479.037007043501;4487.326900964881;4572.565606267399;4590.173768721662;3899.3760998240145;3973.562908080109;3984.322665146932;4009.639132478091;4061.3907913813164;662.0466528199378;665.5540787672271;672.4754691340762;673.939345458911;691.7060249393987;707.6178863413802;721.4913485992363;743.5835931878057;744.0587656614388;746.9551826890404;10319.84520232197;10595.364278143335;10635.512337474134;11357.94321028406;11401.429928503541;837.0750320895445;839.6557411461272;840.0465471689677;847.4745657692271;849.6983570832389;5270.051390749702;5287.559934091052;5395.244665746799;5398.514133727984;5426.9185962210595;76976;77838;80167;81021;83517;54351.45648543543;67475.66262168756;72304.2769572308;73197;75234.99999999891;63018;64050;64065.35934640687;64395.99999999906;65615;10076.294659374067;10194.490275486345;10213.234007449619;10246.282760206714;10304.278700491193;43654.12691746084;44308.33537496876;44361.556384435746;44607.776961114985;45714.31428528641;51140.74429627828;53830.73084634552;54562;56059.43940560542;56839.431605683414;12400.81398779037;12805.8079128815;12822.102452828212;13047.28239946812;13110.606681799562;12722.109452338247;13349.199048057148;13352.332383380986;15312.387504499695;15739.685206296039;14400.99193056476;14505.854941450873;14980.625484362978;15474.5357639271;15844.44544440939;14664.3401046951;15266.847331526542;15345.386184552493;16328.101954392623;16466;14073;14131.364088616243;14305;14587;15182.696346073237;11275.943620281847;11352.262102963281;11475.139364547525;11623.76752464963;11731.648050558497;11878;12031.217970831867;12093.274403535816;12137.150399472306;12143.696407589881 09:26:14 INFO - PROCESS | 12021 | __end_tp_report 09:26:14 INFO - PROCESS | 12021 | __start_cc_report 09:26:14 INFO - PROCESS | 12021 | _x_x_mozilla_cycle_collect,1283 09:26:14 INFO - PROCESS | 12021 | __end_cc_report 09:26:14 INFO - PROCESS | 12021 | __startTimestamp1487957174102__endTimestamp 09:26:14 INFO - PROCESS | 12021 | 09:26:14 INFO - PROCESS | 12021 | ------- Summary: start ------- 09:26:14 INFO - PROCESS | 12021 | Number of tests: 6 09:26:14 INFO - PROCESS | 12021 | 09:26:14 INFO - PROCESS | 12021 | [#0] dojo.html Cycles:165 Average:5450.37 Median:5626.97 stddev:588.14 (10.5%) stddev-sans-first:565.47 09:26:14 INFO - PROCESS | 12021 | Values: 3310.5 3325.3 3345.5 3367.1 3385.1 5392.3 5460.3 5464.1 5480.6 5519.0 5485.7 5517.4 5527.4 5530.3 5534.9 5000.6 5026.5 5047.4 5062.7 5131.2 4941.0 4958.2 5081.9 5128.4 5128.5 4927.9 4940.0 4972.1 5023.5 5023.8 5044.1 5046.4 5054.2 5054.7 5076.5 4853.1 4957.4 4978.9 5004.7 5023.2 5358.4 5440.4 5445.3 5455.6 5461.2 5737.8 5796.0 5812.8 5821.5 5846.2 5910.1 5931.2 5932.1 5937.4 5961.6 5466.8 5516.9 5521.9 5526.0 5526.5 5763.9 5841.0 5842.0 5904.0 5978.6 5772.1 5776.1 5778.6 5798.2 5808.9 5819.7 5851.8 5866.6 5866.9 5874.6 5619.5 5683.1 5854.1 5860.9 5864.9 5724.5 5771.2 5784.6 5830.5 5889.6 4544.4 4548.6 4551.1 4553.6 4581.5 3906.6 4030.2 4041.3 4044.1 4072.0 5454.5 5535.8 5588.4 5595.3 5683.7 5913.1 5933.4 5933.7 5936.2 5940.1 5424.2 5500.4 5507.6 5594.8 5640.3 4944.8 5001.9 5002.2 5036.9 5059.0 6162.3 6165.2 6167.7 6171.2 6184.1 5904.8 5910.4 5916.6 5916.7 5923.7 5971.3 6002.0 6023.9 6042.7 6049.2 5748.4 5791.9 5793.2 5795.9 5826.6 5839.9 5886.6 5887.5 5891.4 5894.6 5552.9 5580.8 5609.2 5636.1 5739.5 5710.0 5718.1 5718.7 5732.3 5745.9 5611.1 5636.8 5638.9 5638.9 5686.1 5619.3 5622.6 5678.7 5697.6 5711.6 5555.9 5585.3 5627.0 5661.3 5665.5 09:26:14 INFO - PROCESS | 12021 | 09:26:14 INFO - PROCESS | 12021 | [#1] ext.html Cycles:180 Average:53950.13 Median:36352.14 stddev:100249.76 (275.8%) stddev-sans-first:100450.79 09:26:14 INFO - PROCESS | 12021 | Values: 544.1 583.7 591.2 591.4 614.6 31576.0 44736.8 45986.3 46042.5 46075.8 47256.5 47705.5 47762.0 47823.5 47971.0 8634.9 8934.4 8951.0 9182.2 9188.5 11033.4 11345.1 11354.5 11744.6 11747.2 11507.7 11559.1 11573.8 11581.2 11586.7 11398.7 11447.0 11451.7 11464.9 11466.0 11287.7 11351.8 11357.9 11363.7 11368.1 47026.0 47351.8 47432.8 47434.5 47488.8 4165.4 4232.8 4251.6 4354.5 4392.4 33706.3 34330.5 34402.5 34491.5 36022.3 4468.1 4470.7 4494.0 4526.4 4549.7 239598.0 240537.0 241608.0 242001.8 242374.0 56692.7 57197.0 57639.7 57822.4 65600.3 67879.0 68299.0 68377.0 68584.0 68634.0 16891.3 17420.6 17459.7 17475.6 17486.3 12043.8 12152.3 12371.6 12586.3 13447.0 17510.7 17615.5 17632.3 17676.2 17688.4 7104.9 7114.2 7125.0 7139.0 7184.6 990.7 1004.0 1008.4 1018.2 1023.6 31586.0 31984.8 32058.2 32190.8 32207.0 1078.1 1158.1 1168.4 1186.0 1195.0 16009.4 16458.5 16543.8 16608.0 17858.0 482982.0 484449.0 484658.0 484667.0 484776.0 56384.4 56565.4 56729.6 56746.0 56753.4 1481.7 1496.8 1527.9 1548.9 1552.8 28874.0 30092.8 30179.8 30667.2 30703.0 45932.0 46377.3 46377.3 46432.5 46547.5 371175.0 372081.0 372121.0 372736.0 372877.0 24370.5 24529.9 26615.9 27585.0 27838.2 43528.8 43873.3 43879.0 44168.3 44531.6 37254.4 37285.6 37356.4 37735.6 38179.0 36655.0 36938.6 36973.1 37284.8 37848.4 36335.3 36369.0 36440.6 36749.4 36772.4 32074.7 33221.7 33270.3 33815.7 33827.5 25256.5 25446.1 25858.0 25924.5 26098.2 09:26:14 INFO - PROCESS | 12021 | 09:26:14 INFO - PROCESS | 12021 | [#2] jquery.html Cycles:180 Average:35187.40 Median:3202.16 stddev:108039.98 (3374.0%) stddev-sans-first:108311.56 09:26:14 INFO - PROCESS | 12021 | Values: 440.6 443.2 443.5 444.5 457.6 19266.4 19460.7 21078.8 21187.3 21389.9 21660.6 22130.2 22346.8 22445.9 22624.4 6015.3 6205.5 6219.5 6225.7 6233.6 5111.7 5179.7 5182.1 5190.5 5322.5 5148.6 5157.3 5160.3 5160.4 5184.2 5166.7 6047.1 6082.2 6095.1 6097.6 5373.6 5525.9 5527.3 5529.9 5534.1 24267.5 24379.8 24493.8 24494.9 24849.1 3199.1 3200.8 3203.5 3218.3 3258.6 15594.6 15697.4 15822.8 15838.5 16000.0 1907.6 1926.7 1969.5 1978.7 2002.2 71089.0 84482.0 85455.1 87849.6 101969.0 11235.2 11435.7 11436.8 11608.1 11744.8 16162.7 16678.7 16685.5 16691.2 16710.2 8426.8 8440.2 8548.2 8612.0 8614.3 8264.4 8306.6 8315.0 8484.3 8484.9 7299.3 7442.5 7501.5 7561.5 7608.8 2132.6 2219.2 2233.6 2236.3 2254.1 974.6 978.3 980.6 983.9 992.4 20365.3 20416.9 20486.3 20575.5 20617.6 975.8 981.6 984.8 992.8 994.3 11290.4 11638.5 11751.1 11766.4 11894.1 652284.0 653205.0 655593.0 656354.0 672904.0 96037.0 98129.0 101774.5 104174.5 117260.4 1157.6 1179.0 1197.2 1201.4 1205.3 18344.6 18958.3 19023.8 19026.5 19059.3 46423.0 46867.0 47074.0 48274.0 48563.8 65263.4 65764.3 65801.0 67741.0 68006.3 9012.0 9232.5 9296.3 9387.0 9493.5 12459.1 12730.7 12820.2 12875.4 13340.3 11534.2 11570.6 11731.6 12049.9 12119.7 11603.2 11662.8 12043.9 12046.9 12282.4 11676.4 12372.3 12465.6 12489.0 12597.7 9127.2 9127.7 9340.8 9558.2 9581.5 11714.6 12066.7 12075.6 12251.3 12487.9 09:26:14 INFO - PROCESS | 12021 | 09:26:14 INFO - PROCESS | 12021 | [#3] mootools.html Cycles:180 Average:5730.87 Median:4942.43 stddev:3143.53 (63.6%) stddev-sans-first:3136.41 09:26:14 INFO - PROCESS | 12021 | Values: 1518.8 1519.4 1526.5 1538.5 1543.7 8406.0 8965.2 8970.5 8982.6 8992.4 7758.6 7967.8 7981.9 8187.3 8737.7 2379.9 2480.1 2482.7 2487.8 2494.7 2282.1 2319.2 2322.1 2345.1 2345.1 2314.5 2333.7 2352.2 2359.8 2360.7 2383.5 2392.0 2395.5 2398.4 2400.5 2280.3 2281.9 2282.1 2283.2 2296.5 8408.4 8422.8 8472.1 8478.3 8480.3 5309.8 5466.9 5470.6 5484.0 5508.3 3199.1 3337.4 3422.5 3423.8 3429.1 1269.9 1312.8 1314.2 1345.3 1364.6 12085.5 12092.2 12093.9 12115.4 12132.2 4609.4 4747.5 4806.9 4807.9 4926.5 10439.0 10474.6 10482.9 10506.3 10509.1 5502.6 5529.1 5535.8 5537.3 5554.5 4875.4 4898.8 4958.4 5050.4 5078.9 4121.3 4144.1 4169.5 4203.2 4208.7 1314.2 1331.7 1333.5 1338.7 1346.9 976.4 1004.8 1005.6 1011.4 1015.6 5600.4 5827.4 6013.4 6097.7 6127.8 1058.1 1072.1 1074.4 1078.1 1081.8 4137.3 4192.3 4215.4 4254.7 4325.1 10176.4 10596.8 10606.9 10608.0 10618.9 10463.3 10526.6 10538.1 10544.4 10553.0 7702.8 8102.1 8116.7 8271.2 8349.7 5982.4 6102.6 6170.4 6181.3 6283.9 9528.2 9678.2 9889.5 9923.3 9929.0 9391.3 9424.4 9576.8 9630.6 9965.8 7507.5 7632.5 7639.8 7646.2 7648.7 7527.7 7883.4 7927.5 8057.0 8181.0 7414.4 7450.0 7486.5 7535.7 7647.5 7166.9 7170.5 7197.9 7287.0 7344.0 6222.3 6371.2 6389.2 6463.0 6569.2 5203.3 5268.2 5273.7 5356.9 5398.0 4971.1 5047.1 5106.9 5242.9 5285.7 09:26:14 INFO - PROCESS | 12021 | 09:26:14 INFO - PROCESS | 12021 | [#4] prototype.html Cycles:180 Average:4678.27 Median:5297.34 stddev:1326.49 (25.0%) stddev-sans-first:1290.76 09:26:14 INFO - PROCESS | 12021 | Values: 400.1 404.7 410.4 413.6 417.3 5313.9 5343.6 5388.9 5403.6 5406.2 5210.6 5234.9 5303.6 5319.7 5357.2 4293.3 4306.2 4309.8 4317.0 4327.8 4315.0 4328.5 4332.6 4345.4 4353.6 4009.4 4145.2 4191.3 4313.3 4330.8 4172.4 4175.6 4182.1 4185.2 4190.5 3711.8 3741.4 3742.4 3751.4 3774.5 5115.1 5225.4 5227.6 5240.2 5271.4 4804.6 4841.2 4846.7 4848.2 4852.3 5583.8 5584.6 5594.0 5600.2 5609.9 4034.4 4104.2 4131.4 4135.6 4154.4 5437.8 5566.6 5665.5 5675.5 5730.4 4056.6 4063.5 4083.9 4085.3 4171.4 4214.1 4237.9 4244.8 4246.0 4258.8 4466.4 4746.8 4789.9 4799.7 4816.5 5244.5 5521.6 5526.8 5553.8 5611.0 1397.7 1399.2 1405.0 1405.9 1407.4 961.7 989.4 998.0 1001.6 1019.4 5229.9 5238.5 5239.7 5249.2 5266.8 5388.2 5466.9 5484.7 5488.2 5498.8 5087.0 5247.7 5257.8 5295.9 5298.8 2871.3 2879.3 2929.4 2947.5 2958.0 5678.2 5686.0 5708.0 5713.2 5764.6 5328.8 5538.9 5592.4 5598.2 5627.4 5681.5 5738.0 5741.4 5749.0 5757.3 5290.6 5481.3 5510.6 5524.2 5535.8 5425.6 5437.7 5441.8 5451.2 5488.0 5612.8 5685.0 5734.9 5740.4 5763.0 4316.5 4414.0 4443.4 4447.8 4456.7 5639.2 5668.7 5691.4 5718.8 5743.7 5472.4 5479.0 5548.5 5572.5 5599.8 5588.7 5592.8 5605.8 5612.4 5620.1 5499.8 5531.9 5552.9 5589.9 5603.8 5289.7 5556.6 5562.6 5579.6 5596.8 5456.0 5463.6 5470.2 5484.2 5488.2 09:26:14 INFO - PROCESS | 12021 | 09:26:14 INFO - PROCESS | 12021 | [#5] yui.html Cycles:180 Average:18373.91 Median:24040.01 stddev:23359.33 (97.2%) stddev-sans-first:23387.41 09:26:14 INFO - PROCESS | 12021 | Values: 759.4 779.4 785.3 821.7 834.5 15708.0 16197.0 16200.8 16365.8 16605.6 15453.3 15588.3 15625.5 15930.8 15942.3 700.7 825.0 831.9 833.5 833.9 713.9 806.0 827.9 830.3 833.3 854.9 855.8 855.9 856.0 856.5 723.7 855.4 856.8 856.8 857.0 557.2 613.0 626.8 628.3 635.7 14691.2 14718.5 14762.3 14836.2 14844.3 14629.3 14658.6 14838.3 14878.9 14899.1 12851.2 12853.2 12972.8 13005.3 13831.3 3760.0 3785.8 3788.2 3792.5 3865.5 87494.1 88579.6 89079.6 89340.0 90224.0 13020.3 13522.8 13571.0 13718.9 13766.2 23344.9 23460.8 23816.4 23949.5 24004.9 7677.9 7712.8 7808.8 7828.5 7880.8 4425.9 4479.0 4487.3 4572.6 4590.2 3899.4 3973.6 3984.3 4009.6 4061.4 662.0 665.6 672.5 673.9 691.7 707.6 721.5 743.6 744.1 747.0 10319.8 10595.4 10635.5 11357.9 11401.4 837.1 839.7 840.0 847.5 849.7 5270.1 5287.6 5395.2 5398.5 5426.9 76976.0 77838.0 80167.0 81021.0 83517.0 54351.5 67475.7 72304.3 73197.0 75235.0 63018.0 64050.0 64065.4 64396.0 65615.0 10076.3 10194.5 10213.2 10246.3 10304.3 43654.1 44308.3 44361.6 44607.8 45714.3 51140.7 53830.7 54562.0 56059.4 56839.4 12400.8 12805.8 12822.1 13047.3 13110.6 12722.1 13349.2 13352.3 15312.4 15739.7 14401.0 14505.9 14980.6 15474.5 15844.4 14664.3 15266.8 15345.4 16328.1 16466.0 14073.0 14131.4 14305.0 14587.0 15182.7 11275.9 11352.3 11475.1 11623.8 11731.6 11878.0 12031.2 12093.3 12137.2 12143.7 09:26:14 INFO - PROCESS | 12021 | -------- Summary: end -------- 09:26:14 INFO - PROCESS | 12021 | 09:26:14 INFO - TEST-INFO | 12021: exit 0 09:26:14 INFO - TEST-OK | dromaeo_css | took 1113884ms 09:26:14 INFO - TEST-START | kraken 09:26:14 INFO - operating with platform_type : linux_ 09:26:14 INFO - Initialising browser for kraken test... 09:26:14 INFO - TEST-INFO | started process 12341 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXYOSiD/profile http://localhost:42629/getInfo.html) 09:26:18 INFO - PROCESS | 12341 | __metrics Screen width/height:1600/1200 09:26:18 INFO - PROCESS | 12341 | colorDepth:24 09:26:18 INFO - PROCESS | 12341 | Browser inner width/height: 1024/697 09:26:18 INFO - PROCESS | 12341 | __metrics 09:26:19 INFO - PROCESS | 12341 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:26:19 INFO - PROCESS | 12341 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:26:20 INFO - TEST-INFO | 12341: exit 0 09:26:20 INFO - Browser initialized. 09:26:20 INFO - Running cycle 1/1 for kraken test... 09:26:20 INFO - TEST-INFO | started process 12436 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXYOSiD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:26:32 INFO - PROCESS | 12436 | RSS: Main: 137973760 09:26:32 INFO - PROCESS | 12436 | 09:26:34 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:42629/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42629/tests/kraken/driver.html?testName=audio-beat-detection) 09:26:35 INFO - PROCESS | 12436 | RSS: Main: 180965376 09:26:35 INFO - PROCESS | 12436 | 09:26:38 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:42629/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42629/tests/kraken/driver.html?testName=audio-dft) 09:26:38 INFO - PROCESS | 12436 | RSS: Main: 172675072 09:26:38 INFO - PROCESS | 12436 | 09:26:41 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:42629/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42629/tests/kraken/driver.html?testName=audio-fft) 09:26:41 INFO - PROCESS | 12436 | RSS: Main: 263786496 09:26:41 INFO - PROCESS | 12436 | 09:26:44 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:42629/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42629/tests/kraken/driver.html?testName=audio-oscillator) 09:26:44 INFO - PROCESS | 12436 | RSS: Main: 169885696 09:26:44 INFO - PROCESS | 12436 | 09:26:46 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:42629/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42629/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:26:47 INFO - PROCESS | 12436 | RSS: Main: 172736512 09:26:47 INFO - PROCESS | 12436 | 09:26:50 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:42629/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42629/tests/kraken/driver.html?testName=imaging-darkroom) 09:26:50 INFO - PROCESS | 12436 | RSS: Main: 211193856 09:26:50 INFO - PROCESS | 12436 | 09:26:54 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:42629/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42629/tests/kraken/driver.html?testName=imaging-desaturate) 09:26:54 INFO - PROCESS | 12436 | RSS: Main: 210325504 09:26:54 INFO - PROCESS | 12436 | 09:26:57 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:42629/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42629/tests/kraken/driver.html?testName=json-parse-financial) 09:26:58 INFO - PROCESS | 12436 | RSS: Main: 208039936 09:26:58 INFO - PROCESS | 12436 | 09:26:59 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:42629/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42629/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:27:00 INFO - PROCESS | 12436 | RSS: Main: 171200512 09:27:00 INFO - PROCESS | 12436 | 09:27:01 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:42629/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42629/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:27:02 INFO - PROCESS | 12436 | RSS: Main: 178311168 09:27:02 INFO - PROCESS | 12436 | 09:27:04 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:42629/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42629/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:27:05 INFO - PROCESS | 12436 | RSS: Main: 186773504 09:27:05 INFO - PROCESS | 12436 | 09:27:07 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:42629/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42629/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:27:08 INFO - PROCESS | 12436 | RSS: Main: 197128192 09:27:08 INFO - PROCESS | 12436 | 09:27:11 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:42629/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42629/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:27:11 INFO - PROCESS | 12436 | RSS: Main: 192495616 09:27:11 INFO - PROCESS | 12436 | 09:27:13 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:42629/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42629/tests/kraken/driver.html?testName=ai-astar) 09:27:13 INFO - PROCESS | 12436 | RSS: Main: 244539392 09:27:13 INFO - PROCESS | 12436 | 09:27:13 INFO - PROCESS | 12436 | __start_tp_report 09:27:13 INFO - PROCESS | 12436 | _x_x_mozilla_page_load 09:27:13 INFO - PROCESS | 12436 | _x_x_mozilla_page_load_details 09:27:13 INFO - PROCESS | 12436 | |i|pagename|runs| 09:27:13 INFO - PROCESS | 12436 | |0;ai-astar;110;113;111;113;113;114;114;111;112;112 09:27:13 INFO - PROCESS | 12436 | |1;audio-beat-detection;155;117;119;163;117;121;122;118;145;121 09:27:13 INFO - PROCESS | 12436 | |2;audio-dft;160;160;161;159;159;161;163;161;160;160 09:27:13 INFO - PROCESS | 12436 | |3;audio-fft;73;84;76;104;77;76;77;76;104;76 09:27:13 INFO - PROCESS | 12436 | |4;audio-oscillator;82;82;97;82;82;84;95;82;81;113 09:27:13 INFO - PROCESS | 12436 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;118;116 09:27:13 INFO - PROCESS | 12436 | |6;imaging-darkroom;146;148;149;146;147;148;146;147;146;146 09:27:13 INFO - PROCESS | 12436 | |7;imaging-desaturate;95;95;95;96;95;96;96;96;96;95 09:27:13 INFO - PROCESS | 12436 | |8;json-parse-financial;48;50;48;49;49;51;49;49;50;50 09:27:13 INFO - PROCESS | 12436 | |9;json-stringify-tinderbox;64;64;64;63;63;65;64;63;64;63 09:27:13 INFO - PROCESS | 12436 | |10;stanford-crypto-aes;76;76;79;75;77;85;79;75;75;75 09:27:13 INFO - PROCESS | 12436 | |11;stanford-crypto-ccm;134;123;136;119;121;120;123;126;160;122 09:27:13 INFO - PROCESS | 12436 | |12;stanford-crypto-pbkdf2;164;161;158;159;162;160;159;159;158;160 09:27:13 INFO - PROCESS | 12436 | |13;stanford-crypto-sha256-iterative;60;64;60;61;68;60;67;59;59;63 09:27:13 INFO - PROCESS | 12436 | __end_tp_report 09:27:13 INFO - PROCESS | 12436 | __start_cc_report 09:27:13 INFO - PROCESS | 12436 | _x_x_mozilla_cycle_collect,1515 09:27:13 INFO - PROCESS | 12436 | __end_cc_report 09:27:13 INFO - PROCESS | 12436 | __startTimestamp1487957233576__endTimestamp 09:27:13 INFO - PROCESS | 12436 | 09:27:13 INFO - PROCESS | 12436 | ------- Summary: start ------- 09:27:13 INFO - PROCESS | 12436 | Number of tests: 14 09:27:13 INFO - PROCESS | 12436 | 09:27:13 INFO - PROCESS | 12436 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:1.34 (1.2%) stddev-sans-first:1.13 09:27:13 INFO - PROCESS | 12436 | Values: 110.0 113.0 111.0 113.0 113.0 114.0 114.0 111.0 112.0 112.0 09:27:13 INFO - PROCESS | 12436 | 09:27:13 INFO - PROCESS | 12436 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:121.50 stddev:17.54 (14.4%) stddev-sans-first:16.05 09:27:13 INFO - PROCESS | 12436 | Values: 155.0 117.0 119.0 163.0 117.0 121.0 122.0 118.0 145.0 121.0 09:27:13 INFO - PROCESS | 12436 | 09:27:13 INFO - PROCESS | 12436 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:1.17 (0.7%) stddev-sans-first:1.24 09:27:13 INFO - PROCESS | 12436 | Values: 160.0 160.0 161.0 159.0 159.0 161.0 163.0 161.0 160.0 160.0 09:27:13 INFO - PROCESS | 12436 | 09:27:13 INFO - PROCESS | 12436 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.00 stddev:11.77 (15.5%) stddev-sans-first:11.99 09:27:13 INFO - PROCESS | 12436 | Values: 73.0 84.0 76.0 104.0 77.0 76.0 77.0 76.0 104.0 76.0 09:27:13 INFO - PROCESS | 12436 | 09:27:13 INFO - PROCESS | 12436 | [#4] audio-oscillator Cycles:10 Average:88.00 Median:82.00 stddev:10.54 (12.9%) stddev-sans-first:10.95 09:27:13 INFO - PROCESS | 12436 | Values: 82.0 82.0 97.0 82.0 82.0 84.0 95.0 82.0 81.0 113.0 09:27:13 INFO - PROCESS | 12436 | 09:27:13 INFO - PROCESS | 12436 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 09:27:13 INFO - PROCESS | 12436 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 116.0 09:27:13 INFO - PROCESS | 12436 | 09:27:13 INFO - PROCESS | 12436 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 09:27:13 INFO - PROCESS | 12436 | Values: 146.0 148.0 149.0 146.0 147.0 148.0 146.0 147.0 146.0 146.0 09:27:13 INFO - PROCESS | 12436 | 09:27:13 INFO - PROCESS | 12436 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:27:13 INFO - PROCESS | 12436 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 09:27:13 INFO - PROCESS | 12436 | 09:27:13 INFO - PROCESS | 12436 | [#8] json-parse-financial Cycles:10 Average:49.30 Median:49.50 stddev:0.95 (1.9%) stddev-sans-first:0.88 09:27:13 INFO - PROCESS | 12436 | Values: 48.0 50.0 48.0 49.0 49.0 51.0 49.0 49.0 50.0 50.0 09:27:13 INFO - PROCESS | 12436 | 09:27:13 INFO - PROCESS | 12436 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 09:27:13 INFO - PROCESS | 12436 | Values: 64.0 64.0 64.0 63.0 63.0 65.0 64.0 63.0 64.0 63.0 09:27:13 INFO - PROCESS | 12436 | 09:27:13 INFO - PROCESS | 12436 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:76.50 stddev:3.16 (4.1%) stddev-sans-first:3.32 09:27:13 INFO - PROCESS | 12436 | Values: 76.0 76.0 79.0 75.0 77.0 85.0 79.0 75.0 75.0 75.0 09:27:13 INFO - PROCESS | 12436 | 09:27:13 INFO - PROCESS | 12436 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:124.50 stddev:12.50 (10.0%) stddev-sans-first:13.09 09:27:13 INFO - PROCESS | 12436 | Values: 134.0 123.0 136.0 119.0 121.0 120.0 123.0 126.0 160.0 122.0 09:27:13 INFO - PROCESS | 12436 | 09:27:13 INFO - PROCESS | 12436 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.00 Median:160.00 stddev:1.89 (1.2%) stddev-sans-first:1.33 09:27:13 INFO - PROCESS | 12436 | Values: 164.0 161.0 158.0 159.0 162.0 160.0 159.0 159.0 158.0 160.0 09:27:13 INFO - PROCESS | 12436 | 09:27:13 INFO - PROCESS | 12436 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:3.28 (5.3%) stddev-sans-first:3.39 09:27:13 INFO - PROCESS | 12436 | Values: 60.0 64.0 60.0 61.0 68.0 60.0 67.0 59.0 59.0 63.0 09:27:13 INFO - PROCESS | 12436 | -------- Summary: end -------- 09:27:13 INFO - PROCESS | 12436 | 09:27:14 INFO - TEST-INFO | 12436: exit 0 09:27:14 INFO - TEST-OK | kraken | took 59910ms 09:27:14 INFO - SUITE-END | took 1173s 09:27:15 INFO - Completed test suite (00:19:34) 09:27:15 INFO - javascript benchmark 09:27:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3310.47032474804, 3325.318309746502, 3345.4647256438966, 3367.1245476176186, 3385.0521853880905, 5392.272043274157, 5460.290162278903, 5464.12573988161, 5480.6437581557275, 5518.972405137979, 5485.670859748408, 5517.393086760453, 5527.419620939803, 5530.281063461744, 5534.861628459291, 5000.624953128521, 5026.497350264981, 5047.369078865142, 5062.7468626568525, 5131.2303154526935, 4941.0, 4958.181899986498, 5081.872953176182, 5128.4102328232175, 5128.461511541291, 4927.901441971158, 4939.950600494003, 4972.0801651694555, 5023.522765337287, 5023.799048038074, 5044.066847633163, 5046.44489106198, 5054.241863720435, 5054.671446355975, 5076.517730815566, 4853.0779151961015, 4957.355543779286, 4978.925316120261, 5004.749762511896, 5023.246513023039, 5358.3569971603265, 5440.4287549807095, 5445.292112025411, 5455.645383050089, 5461.15352120422, 5737.770489180428, 5796.0, 5812.767489300465, 5821.53427725781, 5846.239988801472, 5910.113482977545, 5931.199288096095, 5932.0508718604815, 5937.376575459601, 5961.612495187799, 5466.835994920159, 5516.91724624131, 5521.944780552183, 5526.005319042611, 5526.47498487643, 5763.8559036024435, 5840.970795145997, 5841.970790146107, 5904.0, 5978.611390259619, 5772.134179872969, 5776.075827867521, 5778.566607504454, 5798.159266906275, 5808.94191058084, 5819.73811178498, 5851.795187168429, 5866.648001119861, 5866.911996320058, 5874.5887787854435, 5619.466150715675, 5683.119116536861, 5854.121881717776, 5860.8534786629825, 5864.9413505864395, 5724.542036637059, 5771.249737534177, 5784.59507834456, 5830.533557315404, 5889.617174883619, 4544.409226800495, 4548.6133678637025, 4551.112533056023, 4553.635709143261, 4581.450225972904, 3906.628870257321, 4030.234255491447, 4041.312976793952, 4044.0900797320955, 4072.0430698786354, 5454.481824226692, 5535.750891209825, 5588.385277619459, 5595.328560572757, 5683.715814209273, 5913.142594323799, 5933.376995415506, 5933.673647949404, 5936.198613187251, 5940.108983652401, 5424.240606315119, 5500.367457742331, 5507.586930980193, 5594.776208951678, 5640.294963129609, 4944.752762361867, 5001.9499805002215, 5002.199648056294, 5036.874078148076, 5059.038782631362, 6162.322144564005, 6165.198524191826, 6167.660778657217, 6171.228596425447, 6184.103305020747, 5904.822855314347, 5910.379410161871, 5916.556258280732, 5916.73374698131, 5923.733431995657, 5971.313298970674, 6002.039673652369, 6023.909641355471, 6042.667653278936, 6049.243844519435, 5748.367679555329, 5791.8552036199435, 5793.217915581511, 5795.884082318245, 5826.563007774519, 5839.941600583939, 5886.558508111994, 5887.5289976802605, 5891.410858914246, 5894.616849904743, 5552.861178470571, 5580.776768929198, 5609.186667933209, 5636.126400407943, 5739.483446489836, 5710.029295019774, 5718.085106382959, 5718.742656580381, 5732.3121225453215, 5745.885082298414, 5611.130274807411, 5636.774529018793, 5638.887222255614, 5638.9436105638415, 5686.09022556389, 5619.325680918152, 5622.578306626938, 5678.716064196857, 5697.57268204878, 5711.628744131618, 5555.944440555542, 5585.273914391103, 5626.971865140648, 5661.264035675335, 5665.546756259407], "value": 5413.376173778425, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.1239943162803, 583.6614763437207, 591.1782622155205, 591.4174538079993, 614.6404353453228, 31576.0, 44736.77631611841, 45986.31020534695, 46042.53957460424, 46075.76962115189, 47256.52743472564, 47705.52294477054, 47762.0, 47823.521764782345, 47971.0, 8634.870476942851, 8934.419262747933, 8951.015388307282, 9182.219511341544, 9188.494632795193, 11033.448327583588, 11345.149113816455, 11354.489047992818, 11744.588939387124, 11747.236429632047, 11507.654770356903, 11559.133065020114, 11573.768524629502, 11581.18931674783, 11586.710332241677, 11398.658040258806, 11447.0, 11451.713707157387, 11464.942675286653, 11466.0, 11287.717807054889, 11351.829722554168, 11357.886421135765, 11363.659090227306, 11368.14738894578, 47026.0, 47351.763241183915, 47432.762836185946, 47434.52565474335, 47488.762556187, 4165.375193720935, 4232.809523571446, 4251.638610718092, 4354.521002689701, 4392.407025051641, 33706.32587348239, 34330.48504272438, 34402.48396274058, 34491.482627760604, 36022.279554409026, 4468.061707041526, 4470.664700147469, 4494.0, 4526.384093757271, 4549.658775591844, 239598.0, 240537.0, 241608.0, 242001.78999105067, 242374.0, 56692.71653641705, 57197.0, 57639.711801440724, 57822.421775782546, 65600.34399656038, 67879.0, 68299.0, 68377.0, 68584.0, 68634.0, 16891.324347026228, 17420.564485887953, 17459.65080698379, 17475.56311092233, 17486.30054797794, 12043.75912481763, 12152.270863748026, 12371.628851134481, 12586.307753073668, 13447.0, 17510.737338939925, 17615.471535853943, 17632.294708211786, 17676.204570794343, 17688.380906668204, 7104.92895071053, 7114.217436082027, 7125.0074968513345, 7138.964305178441, 7184.568925864465, 990.6928852055886, 1004.0, 1008.4000019988096, 1018.1803648063232, 1023.5598692562121, 31586.0, 31984.84007579947, 32058.19854503656, 32190.83904580462, 32207.0, 1078.1428764132534, 1158.1429741991035, 1168.3515648814819, 1186.027457484854, 1194.988050119505, 16009.43848984157, 16458.506244812674, 16543.83456165447, 16608.0, 17858.0, 482982.0, 484449.0, 484658.0, 484667.0, 484776.0, 56384.436155637915, 56565.43434565602, 56729.58176045632, 56746.0, 56753.432465674814, 1481.7036592681507, 1496.7829664698775, 1527.9083255004514, 1548.8606025457764, 1552.8058992625922, 28874.0, 30092.849535752182, 30179.81323266424, 30667.2333191672, 30703.0, 45932.0, 46377.304340434246, 46377.30434043559, 46432.535674644176, 46547.53452465432, 371175.0, 372081.0, 372121.0, 372736.0, 372877.0, 24370.51258974846, 24529.877350613133, 26615.866920665274, 27585.0, 27838.16485505438, 43528.78235608801, 43873.34189987089, 43879.0, 44168.33747493855, 44531.55468445274, 37254.44118338173, 37285.62714372821, 37356.439653404675, 37735.62264377431, 38179.0, 36655.0, 36938.630613693516, 36973.07567310839, 37284.81357593195, 37848.43227351537, 36335.27329453449, 36369.0, 36440.635593643725, 36749.44875826811, 36772.44841327436, 32074.67925320717, 33221.667783322824, 33270.33459330751, 33815.66184338224, 33827.492587610715, 25256.494870102862, 25446.109386171396, 25858.0, 25924.481510370064, 26098.217053488424], "value": 20239.17335176828, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.5858493016564, 443.22656963598524, 443.5365043529511, 444.48661795626043, 457.6064584457366, 19266.422007339785, 19460.70808937865, 21078.789212107873, 21187.258445954394, 21389.893050534745, 21660.566788664255, 22130.225442109528, 22346.77653223467, 22445.887770561167, 22624.43438914028, 6015.3383127855905, 6205.472534834522, 6219.471344935663, 6225.657588832612, 6233.625982441068, 5111.667741596803, 5179.741012949356, 5182.144946083891, 5190.506901844319, 5322.547583455411, 5148.639595228336, 5157.329547158864, 5160.329157209576, 5160.432352441228, 5184.196449550326, 5166.689998600096, 6047.092936059582, 6082.239720034996, 6095.05526643371, 6097.57316987811, 5373.570114390839, 5525.944740552623, 5527.2538207341895, 5529.944700552983, 5534.059209934321, 24267.514649707082, 24379.756202437926, 24493.755062449505, 24494.877525612435, 24849.1302804401, 3199.104250809777, 3200.7919485233383, 3203.535487354344, 3218.291975765328, 3258.6252580953255, 15594.610134746723, 15697.37210511578, 15822.76265856013, 15838.52484425469, 16000.0, 1907.5612609099846, 1926.6820974539185, 1969.4977780665981, 1978.703194520819, 2002.1991203518564, 71089.0, 84482.0, 85455.14544854534, 87849.56075219583, 101969.0, 11235.157363197794, 11435.656930292105, 11436.828447573293, 11608.129390295762, 11744.823827642593, 16162.676746465006, 16678.749818752727, 16685.49943501697, 16691.165441727866, 16710.248038838283, 8426.789330266669, 8440.198181172778, 8548.230659240573, 8611.95694021526, 8614.267787238156, 8264.380171487162, 8306.584670766437, 8314.958425207957, 8484.27883629886, 8484.872726909101, 7299.343059124704, 7442.516236444614, 7501.512401693873, 7561.546307221584, 7608.80977975544, 2132.6161290967466, 2219.1678120704737, 2233.575620632075, 2236.250855963238, 2254.1096266974782, 974.6355102855916, 978.2711879649706, 980.568549838069, 983.9212862970945, 992.3549692699803, 20365.287214947406, 20416.897915510326, 20486.282980095624, 20575.4856128595, 20617.58764824695, 975.8438649815995, 981.6122631560494, 984.7735020945223, 992.8014397120605, 994.2848586188911, 11290.435478226056, 11638.476268567934, 11751.118666100077, 11766.411679416165, 11894.107941904393, 652284.0, 653205.0, 655593.0, 656354.0, 672904.0, 96037.0, 98129.0, 101774.4911275439, 104174.47912760387, 117260.41369793267, 1157.6295585412588, 1178.9742923656302, 1197.1799317467562, 1201.3752848518895, 1205.2708111592535, 18344.63310733751, 18958.336458223897, 19023.809761902758, 19026.524336891136, 19059.332923347618, 46423.0, 46867.0, 47074.0, 48274.03451931012, 48563.75718121387, 65263.40991390776, 65764.34235657583, 65801.0, 67741.0, 68006.31993679999, 9011.954940225258, 9232.492212928353, 9296.302777291596, 9386.953065234904, 9493.525323733924, 12459.12786104964, 12730.745385092061, 12820.23078615286, 12875.420606072561, 13340.266285354399, 11534.192606517463, 11570.59502917394, 11731.648050558497, 12049.939750301543, 12119.697007574881, 11603.245789023686, 11662.825057624312, 12043.939780301042, 12046.939765301468, 12282.447289871798, 11676.357800321064, 12372.257664540157, 12465.626031219077, 12489.0, 12597.685057873627, 9127.178553930178, 9127.680531181377, 9340.766480838034, 9558.187554057706, 9581.473018984023, 11714.648560543197, 12066.698332541757, 12075.637730868088, 12251.326177060348, 12487.938525225458], "value": 10085.285897002936, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.8025556677637, 1519.3998370643603, 1526.4504778279818, 1538.4615384615386, 1543.7298472767266, 8405.957970210147, 8965.193132618064, 8970.506622135788, 8982.595783189756, 8992.41549299296, 7758.573278469682, 7967.760967170994, 7981.92018079819, 8187.26314631683, 8737.737867863958, 2379.9405014874637, 2480.082369523279, 2482.6648402465617, 2487.751224877507, 2494.6881639795024, 2282.0529480265755, 2319.1766922742436, 2322.140807901079, 2345.0502546468706, 2345.0736958901307, 2314.4561028158455, 2333.7199536055614, 2352.2120089769946, 2359.7994170495444, 2360.6813080234206, 2383.52329534093, 2392.043182726906, 2395.5089206712582, 2398.4243781492405, 2400.4958958618713, 2280.3159052284414, 2281.885905704725, 2282.1441959265276, 2283.178055899875, 2296.5292115116363, 8408.411411201218, 8422.78943026423, 8472.06807251208, 8478.321734261306, 8480.321574274043, 5309.787608495655, 5466.863328416782, 5470.64440811346, 5484.040292948758, 5508.283923089973, 3199.1202419334636, 3337.4159522083537, 3422.5379573757473, 3423.7945723256435, 3429.0570093224565, 1269.8793614606598, 1312.770265203595, 1314.231174762765, 1345.3004437692346, 1364.597443754095, 12085.45615447307, 12092.214006089576, 12093.93953030238, 12115.39423028845, 12132.211406258653, 4609.400777898919, 4747.454042785055, 4806.879828004258, 4807.855764327076, 4926.45808961014, 10439.0, 10474.581016759244, 10482.947585262025, 10506.317089389166, 10509.054185123223, 5502.614816962774, 5529.115341545334, 5535.806246781343, 5537.307836520435, 5554.50009499147, 4875.366202393666, 4898.828541001048, 4958.404991400983, 5050.444451110375, 5078.873028174326, 4121.345224492656, 4144.088300573869, 4169.533782099227, 4203.243416185055, 4208.726432781859, 1314.1786383510307, 1331.7469680760626, 1333.5199328241824, 1338.6854089289009, 1346.8855147312393, 976.4043933200742, 1004.8090862736057, 1005.6228914157191, 1011.4083261292227, 1015.6242190389603, 5600.411956744565, 5827.388124246893, 6013.368596297413, 6097.664628445389, 6127.84680382994, 1058.1164727452663, 1072.1101485766794, 1074.414444127952, 1078.094400703413, 1081.8160912644869, 4137.275976704064, 4192.308269135619, 4215.388768628532, 4254.723442976197, 4325.134973005412, 10176.440295783656, 10596.841047384296, 10606.946965265124, 10608.0, 10618.893811061791, 10463.319884207654, 10526.578936842594, 10538.104261137889, 10544.420056896945, 10553.0, 7702.807429814299, 8102.108768035511, 8116.715914942949, 8271.21423464782, 8349.707760228363, 5982.4316689914385, 6102.603330783662, 6170.444659980623, 6181.258249010148, 6283.937160628335, 9528.237740980567, 9678.17735492491, 9889.456079915673, 9923.255755818487, 9929.0, 9391.342606017513, 9424.434533927986, 9576.808463830825, 9630.566624502055, 9965.800683986425, 7507.512011719221, 7632.5038872473115, 7639.770806875803, 7646.197149299466, 7648.65581048843, 7527.661255243418, 7883.408744344312, 7927.484713493604, 8057.033156021315, 8181.0, 7414.406847452083, 7450.031495905498, 7486.475946683898, 7535.6985720570565, 7647.541147531166, 7166.856662866818, 7170.498065135599, 7197.892031619425, 7287.0, 7344.0, 6222.346653601488, 6371.23545174582, 6389.169407976933, 6463.030545418225, 6569.211694596679, 5203.349581302337, 5268.1834315681135, 5273.709945953009, 5356.946430535801, 5398.028354896156, 4971.130052240916, 5047.116754567863, 5106.948930510796, 5242.868928276824, 5285.709285989307], "value": 4667.83923182508, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.12772156698384, 404.70860980094324, 410.4192567516962, 413.5669903783391, 417.29060596985136, 5313.946860531393, 5343.625946183769, 5388.946110538898, 5403.567714582834, 5406.216098665696, 5210.583153347732, 5234.895302093965, 5303.575713942885, 5319.6808191508535, 5357.196420536921, 4293.313069908815, 4306.224879521685, 4309.82760689572, 4317.0, 4327.761973091471, 4314.97842510787, 4328.458942632171, 4332.566743325674, 4345.435093437849, 4353.564643535653, 4009.398590211477, 4145.233131870614, 4191.308434108384, 4313.266744653401, 4330.805113769888, 4172.408971977565, 4175.62419382254, 4182.100848317596, 4185.22573323936, 4190.497140343148, 3711.758735682199, 3741.3639681254253, 3742.36379815432, 3751.4185301278344, 3774.4904437900805, 5115.130427827278, 5225.425203227642, 5227.634065615409, 5240.187770895517, 5271.393789714193, 4804.567588917014, 4841.2496063110275, 4846.733429661367, 4848.230395905504, 4852.296417019547, 5583.832485025456, 5584.636998595119, 5593.972030139823, 5600.159976003632, 5609.943900560983, 4034.374671925856, 4104.240715467618, 4131.442255295527, 4135.648469880064, 4154.376843473473, 5437.8368648940595, 5566.554675625981, 5665.507176842177, 5675.51758100562, 5730.4269573042775, 4056.5740597236863, 4063.512378514597, 4083.85706500277, 4085.346344584852, 4171.436856024458, 4214.115035842446, 4237.940514871282, 4244.8089835956835, 4246.027780553625, 4258.7657678827345, 4466.352378905106, 4746.816464426333, 4789.880252993703, 4799.712017278905, 4816.54242846929, 5244.501772331622, 5521.558275337963, 5526.751296191681, 5553.805616803393, 5610.97194514033, 1397.7204559088223, 1399.167495340271, 1404.985950140506, 1405.943762249519, 1407.429990853706, 961.7355227312545, 989.3774210295122, 998.0418797953901, 1001.5793366785967, 1019.3832731197667, 5229.921551176735, 5238.528532432099, 5239.685618862881, 5249.238860365225, 5266.7629956652045, 5388.245645609618, 5466.851961088137, 5484.670919744828, 5488.231647569343, 5498.80754173602, 5087.0, 5247.711375874287, 5257.76340064698, 5295.867603309871, 5298.81454149103, 2871.267826704219, 2879.337752316979, 2929.3555417808047, 2947.513660246035, 2958.0238521287924, 5678.20505129274, 5686.0, 5708.029634962067, 5713.171590119409, 5764.625299355528, 5328.8401347959625, 5538.9169162461785, 5592.412796656374, 5598.216249725042, 5627.352854421794, 5681.517071048925, 5737.967165910176, 5741.425857414225, 5749.04532458966, 5757.337906140848, 5290.603204759582, 5481.260029896072, 5510.614257001971, 5524.226608274925, 5535.813353725336, 5425.647332923348, 5437.728113594384, 5441.83674489766, 5451.155070964007, 5487.957288115245, 5612.811003708639, 5685.005124103182, 5734.942650573441, 5740.425957404226, 5763.0, 4316.503602085801, 4413.977930110329, 4443.4445694288215, 4447.799849006868, 4456.665750068693, 5639.154126880837, 5668.688222147822, 5691.402402747652, 5718.828435146952, 5743.684097374685, 5472.370677372153, 5479.0, 5548.528375088163, 5572.498475137095, 5599.776008959596, 5588.748506317307, 5592.804251851166, 5605.831825045092, 5612.354579223278, 5620.122115740126, 5499.835004949858, 5531.944680553143, 5552.916706249491, 5589.860253493533, 5603.7758489659955, 5289.709066001406, 5556.611037227355, 5562.610617256753, 5579.581531385244, 5596.804111856066, 5455.972720136374, 5463.562914966873, 5470.234167216513, 5484.204790305464, 5488.231647569423], "value": 4274.895497083384, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.3962799574338, 779.4271210660161, 785.344237561636, 821.7124006597692, 834.5368320582074, 15708.0, 16197.035693282973, 16200.75698864518, 16365.75451368229, 16605.584860378498, 15453.30460129294, 15588.298526566303, 15625.453109141183, 15930.761038584431, 15942.282597283122, 700.660179812793, 824.9628766705498, 831.8502669519484, 833.5040650812787, 833.8874251975997, 713.9071920650308, 805.959702014897, 827.8758186272047, 830.2610676497922, 833.262562632072, 854.9102344253857, 855.7946092937681, 855.9058503564603, 855.9984817763201, 856.5289090999956, 723.7213672736035, 855.4183155454289, 856.7601071699903, 856.8072183758667, 857.0358346859751, 557.2310211907542, 612.9601575897597, 626.8025571944822, 628.2963081348872, 635.6948664640998, 14691.191984440851, 14718.484853030093, 14762.261886905611, 14836.184009879453, 14844.332005059798, 14629.317628472756, 14658.633534161625, 14838.33227504754, 14878.851211487854, 14899.106053636817, 12851.228926264454, 12853.16454430459, 12972.80540791889, 13005.284709340982, 13831.30843457823, 3759.981200094009, 3785.8107094645156, 3788.1666033472866, 3792.469054332396, 3865.4588357629955, 87494.12505874924, 88579.55710221472, 89079.55460222658, 89340.0, 90224.0, 13020.348982551024, 13522.797158042637, 13571.0, 13718.862811371759, 13766.24285664298, 23344.883275583514, 23460.765392345857, 23816.40458988539, 23949.485304043174, 24004.87997560001, 7677.884831727529, 7712.845743085107, 7808.804779880435, 7828.530288182727, 7880.763577092696, 4425.885600673728, 4479.037007043501, 4487.326900964881, 4572.565606267399, 4590.173768721662, 3899.3760998240145, 3973.562908080109, 3984.322665146932, 4009.639132478091, 4061.3907913813164, 662.0466528199378, 665.5540787672271, 672.4754691340762, 673.939345458911, 691.7060249393987, 707.6178863413802, 721.4913485992363, 743.5835931878057, 744.0587656614388, 746.9551826890404, 10319.84520232197, 10595.364278143335, 10635.512337474134, 11357.94321028406, 11401.429928503541, 837.0750320895445, 839.6557411461272, 840.0465471689677, 847.4745657692271, 849.6983570832389, 5270.051390749702, 5287.559934091052, 5395.244665746799, 5398.514133727984, 5426.9185962210595, 76976.0, 77838.0, 80167.0, 81021.0, 83517.0, 54351.45648543543, 67475.66262168756, 72304.2769572308, 73197.0, 75234.99999999891, 63018.0, 64050.0, 64065.35934640687, 64395.99999999906, 65615.0, 10076.294659374067, 10194.490275486345, 10213.234007449619, 10246.282760206714, 10304.278700491193, 43654.12691746084, 44308.33537496876, 44361.556384435746, 44607.776961114985, 45714.31428528641, 51140.74429627828, 53830.73084634552, 54562.0, 56059.43940560542, 56839.431605683414, 12400.81398779037, 12805.8079128815, 12822.102452828212, 13047.28239946812, 13110.606681799562, 12722.109452338247, 13349.199048057148, 13352.332383380986, 15312.387504499695, 15739.685206296039, 14400.99193056476, 14505.854941450873, 14980.625484362978, 15474.5357639271, 15844.44544440939, 14664.3401046951, 15266.847331526542, 15345.386184552493, 16328.101954392623, 16466.0, 14073.0, 14131.364088616243, 14305.0, 14587.0, 15182.696346073237, 11275.943620281847, 11352.262102963281, 11475.139364547525, 11623.76752464963, 11731.648050558497, 11878.0, 12031.217970831867, 12093.274403535816, 12137.150399472306, 12143.696407589881], "value": 7571.188013768739, "unit": "score"}], "name": "dromaeo_css", "value": 7420.503326369565, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 111.0, 113.0, 113.0, 114.0, 114.0, 111.0, 112.0, 112.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 117.0, 119.0, 163.0, 117.0, 121.0, 122.0, 118.0, 145.0, 121.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 159.0, 159.0, 161.0, 163.0, 161.0, 160.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 84.0, 76.0, 104.0, 77.0, 76.0, 77.0, 76.0, 104.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 97.0, 82.0, 82.0, 84.0, 95.0, 82.0, 81.0, 113.0], "value": 88.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 149.0, 146.0, 147.0, 148.0, 146.0, 147.0, 146.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 50.0, 48.0, 49.0, 49.0, 51.0, 49.0, 49.0, 50.0, 50.0], "value": 49.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 63.0, 65.0, 64.0, 63.0, 64.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 79.0, 75.0, 77.0, 85.0, 79.0, 75.0, 75.0, 75.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 123.0, 136.0, 119.0, 121.0, 120.0, 123.0, 126.0, 160.0, 122.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 158.0, 159.0, 162.0, 160.0, 159.0, 159.0, 158.0, 160.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 64.0, 60.0, 61.0, 68.0, 60.0, 67.0, 59.0, 59.0, 63.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1472.8999999999999, "alertThreshold": 2.0}]} 09:27:15 INFO - Return code: 0 09:27:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:27:15 ERROR - # TBPL SUCCESS # 09:27:15 INFO - Running post-action listener: _resource_record_post_action 09:27:15 INFO - [mozharness: 2017-02-24 17:27:15.413376Z] Finished run-tests step (success) 09:27:15 INFO - Running post-run listener: _resource_record_post_run 09:27:15 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 266240; Write bytes: 336977920; Read time: 40; Write time: 216332 09:27:15 INFO - TinderboxPrint: CPU usage
13.0% 09:27:15 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 40 09:27:15 INFO - TinderboxPrint: I/O write bytes / time
336,977,920 / 216,332 09:27:15 INFO - TinderboxPrint: CPU idle
8,269.0 (87.0%) 09:27:15 INFO - TinderboxPrint: CPU user
1,191.3 (12.5%) 09:27:15 INFO - TinderboxPrint: Swap in / out
0 / 0 09:27:15 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 52662272; Read time: 0; Write time: 50716 09:27:15 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 254955520; Read time: 40; Write time: 154988 09:27:16 INFO - Running post-run listener: _upload_blobber_files 09:27:16 INFO - Blob upload gear active. 09:27:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:27:16 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 09:27:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:27:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:27:16 INFO - (blobuploader) - INFO - Open directory for files ... 09:27:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:27:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:27:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:17 INFO - (blobuploader) - INFO - Done attempting. 09:27:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:27:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:27:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:18 INFO - (blobuploader) - INFO - Done attempting. 09:27:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:27:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:27:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:21 INFO - (blobuploader) - INFO - Done attempting. 09:27:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:27:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:27:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:22 INFO - (blobuploader) - INFO - Done attempting. 09:27:22 INFO - (blobuploader) - INFO - Iteration through files over. 09:27:22 INFO - Return code: 0 09:27:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:27:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:27:22 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/74e94fa4b91499413dd1cea9dc2c483bf4f56acdffdfdea9597bdaeea0b8843aa8265baabea4de0448244cf35a3f88e4ce259618af99cbcd6cf22cab57adb2f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/88bbe4569bf9bf1b67ab6b663307cca1ba2c025d75b60ef00d86ca0139d3524c8c7e3f0621616708803ba75dd544c368b5db73049b815ea5b3e8b3637fd28252", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/aace7a38dee75ea4f27647af7cd18e985344b46b98f8604de1786247bc71fff2f88125885ba880a25d61bebb7fc67d7a67e44e96d3e1b6111dd7aaf2b2b7edbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/424ac254f7e94b512dc97ce7543f8c1fbe80c4b1d73c4a1dc4be09a685ee1d70b6d833e16e5c6791962195b27aceee9eab85585a23094e3ff8af5a38bfd713b6"} 09:27:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:27:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:27:22 INFO - Contents: 09:27:22 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/74e94fa4b91499413dd1cea9dc2c483bf4f56acdffdfdea9597bdaeea0b8843aa8265baabea4de0448244cf35a3f88e4ce259618af99cbcd6cf22cab57adb2f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/88bbe4569bf9bf1b67ab6b663307cca1ba2c025d75b60ef00d86ca0139d3524c8c7e3f0621616708803ba75dd544c368b5db73049b815ea5b3e8b3637fd28252", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/aace7a38dee75ea4f27647af7cd18e985344b46b98f8604de1786247bc71fff2f88125885ba880a25d61bebb7fc67d7a67e44e96d3e1b6111dd7aaf2b2b7edbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/424ac254f7e94b512dc97ce7543f8c1fbe80c4b1d73c4a1dc4be09a685ee1d70b6d833e16e5c6791962195b27aceee9eab85585a23094e3ff8af5a38bfd713b6"} 09:27:22 INFO - Running post-run listener: copy_logs_to_upload_dir 09:27:22 INFO - Copying logs to upload dir... 09:27:22 INFO - mkdir: /builds/slave/test/build/upload/logs 09:27:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.674686 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-02-24 09:27:21.488892) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-24 09:27:21.491958) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/74e94fa4b91499413dd1cea9dc2c483bf4f56acdffdfdea9597bdaeea0b8843aa8265baabea4de0448244cf35a3f88e4ce259618af99cbcd6cf22cab57adb2f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/88bbe4569bf9bf1b67ab6b663307cca1ba2c025d75b60ef00d86ca0139d3524c8c7e3f0621616708803ba75dd544c368b5db73049b815ea5b3e8b3637fd28252", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/aace7a38dee75ea4f27647af7cd18e985344b46b98f8604de1786247bc71fff2f88125885ba880a25d61bebb7fc67d7a67e44e96d3e1b6111dd7aaf2b2b7edbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/424ac254f7e94b512dc97ce7543f8c1fbe80c4b1d73c4a1dc4be09a685ee1d70b6d833e16e5c6791962195b27aceee9eab85585a23094e3ff8af5a38bfd713b6"} build_url:https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011405 build_url: 'https://queue.taskcluster.net/v1/task/dKoX6fZ_QqWxmVNql2WAOg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/74e94fa4b91499413dd1cea9dc2c483bf4f56acdffdfdea9597bdaeea0b8843aa8265baabea4de0448244cf35a3f88e4ce259618af99cbcd6cf22cab57adb2f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/88bbe4569bf9bf1b67ab6b663307cca1ba2c025d75b60ef00d86ca0139d3524c8c7e3f0621616708803ba75dd544c368b5db73049b815ea5b3e8b3637fd28252", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/aace7a38dee75ea4f27647af7cd18e985344b46b98f8604de1786247bc71fff2f88125885ba880a25d61bebb7fc67d7a67e44e96d3e1b6111dd7aaf2b2b7edbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/424ac254f7e94b512dc97ce7543f8c1fbe80c4b1d73c4a1dc4be09a685ee1d70b6d833e16e5c6791962195b27aceee9eab85585a23094e3ff8af5a38bfd713b6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-24 09:27:21.518441) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 09:27:21.518931) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1487955094.849708-2142329502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 09:27:21.600314) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-24 09:27:21.600655) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-24 09:27:21.600942) ========= ========= Total master_lag: 0.17 =========