builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1490112721.74 results: success (0) revision: afaf4387ec15fceba1381b01fa34fc997be0f96e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 09:12:01.744885) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 09:12:01.745324) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 09:12:01.745600) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 09:12:01.760200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 09:12:01.760531) ========= 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-1490112721.405171-1823671951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-21 09:12:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 207M=0s 2017-03-21 09:12:02 (207 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135838 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 09:12:01.910044) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 09:12:01.910745) ========= 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-1490112721.405171-1823671951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018268 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 09:12:01.959823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 09:12:01.960562) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev afaf4387ec15fceba1381b01fa34fc997be0f96e --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 afaf4387ec15fceba1381b01fa34fc997be0f96e --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-1490112721.405171-1823671951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-21 09:12:02,428 truncating revision to first 12 chars 2017-03-21 09:12:02,428 Setting DEBUG logging. 2017-03-21 09:12:02,428 attempt 1/10 2017-03-21 09:12:02,428 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/afaf4387ec15?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 09:12:03,220 unpacking tar archive at: mozilla-aurora-afaf4387ec15/testing/mozharness/ program finished with exit code 0 elapsedTime=1.182178 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 09:12:03.156058) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 09:12:03.156532) ========= script_repo_revision: afaf4387ec15fceba1381b01fa34fc997be0f96e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 09:12:03.156910) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 09:12:03.157251) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 09:12:03.166439) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-03-21 09:12:03.166716) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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-1490112721.405171-1823671951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:12:03 INFO - MultiFileLogger online at 20170321 09:12:03 in /builds/slave/test 09:12:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:12:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:12:03 INFO - {'append_to_log': False, 09:12:03 INFO - 'base_work_dir': '/builds/slave/test', 09:12:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:12:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:12:03 INFO - 'branch': 'Mozilla-Aurora', 09:12:03 INFO - 'buildbot_json_path': 'buildprops.json', 09:12:03 INFO - 'config_files': ('talos/linux_config.py',), 09:12:03 INFO - 'default_actions': ('clobber', 09:12:03 INFO - 'read-buildbot-config', 09:12:03 INFO - 'download-and-extract', 09:12:03 INFO - 'populate-webroot', 09:12:03 INFO - 'create-virtualenv', 09:12:03 INFO - 'install', 09:12:03 INFO - 'run-tests'), 09:12:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:12:03 INFO - 'download_minidump_stackwalk': True, 09:12:03 INFO - 'download_symbols': 'ondemand', 09:12:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:12:03 INFO - 'tooltool.py': '/tools/tooltool.py', 09:12:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:12:03 INFO - '/tools/misc-python/virtualenv.py')}, 09:12:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:12:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:12:03 INFO - 'gecko_profile': False, 09:12:03 INFO - 'gecko_profile_interval': 0, 09:12:03 INFO - 'installer_path': 'installer.exe', 09:12:03 INFO - 'log_level': 'info', 09:12:03 INFO - 'log_name': 'talos', 09:12:03 INFO - 'log_to_console': True, 09:12:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:12:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:12:03 INFO - 'opt_config_files': (), 09:12:03 INFO - 'pip_index': False, 09:12:03 INFO - 'suite': 'dromaeojs', 09:12:03 INFO - 'system_bits': '32', 09:12:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:12:03 INFO - 'title': 'talos-linux64-ix-052', 09:12:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:12:03 INFO - 'use_talos_json': True, 09:12:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:12:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:12:03 INFO - 'work_dir': 'build'} 09:12:03 INFO - [mozharness: 2017-03-21 16:12:03.731130Z] Running clobber step. 09:12:03 INFO - Running pre-action listener: _resource_record_pre_action 09:12:03 INFO - Running main action method: clobber 09:12:03 INFO - rmtree: /builds/slave/test/build 09:12:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:12:05 INFO - Running post-action listener: _resource_record_post_action 09:12:05 INFO - [mozharness: 2017-03-21 16:12:05.176692Z] Finished clobber step (success) 09:12:05 INFO - [mozharness: 2017-03-21 16:12:05.176792Z] Running read-buildbot-config step. 09:12:05 INFO - Running pre-action listener: _resource_record_pre_action 09:12:05 INFO - Running main action method: read_buildbot_config 09:12:05 INFO - Using buildbot properties: 09:12:05 INFO - { 09:12:05 INFO - "project": "", 09:12:05 INFO - "product": "firefox", 09:12:05 INFO - "who": "ffxbld@noreply.mozilla.org", 09:12:05 INFO - "installer_path": "public/build/target.tar.bz2", 09:12:05 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:12:05 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 09:12:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:12:05 INFO - "stage_platform": "linux64-pgo", 09:12:05 INFO - "basedir": "/builds/slave/test", 09:12:05 INFO - "buildnumber": 842, 09:12:05 INFO - "platform": "ubuntu64_hw", 09:12:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:12:05 INFO - "slavebuilddir": "test", 09:12:05 INFO - "taskId": "Tz3HUi0GRNGskOQvYsMAbg", 09:12:05 INFO - "branch": "mozilla-aurora", 09:12:05 INFO - "script_repo_revision": "production", 09:12:05 INFO - "revision": "afaf4387ec15fceba1381b01fa34fc997be0f96e", 09:12:05 INFO - "slavename": "talos-linux64-ix-052", 09:12:05 INFO - "repo_path": "releases/mozilla-aurora" 09:12:05 INFO - } 09:12:05 INFO - Finding installer, test and symbols from parent task. 09:12:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tz3HUi0GRNGskOQvYsMAbg'}, attempt #1 09:12:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tz3HUi0GRNGskOQvYsMAbg'}, attempt #1 09:12:06 INFO - Task dependencies: JQfrjHwnQk2UEeGe_YYBwQ 09:12:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ'}, attempt #1 09:12:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.tar.bz2 09:12:06 INFO - Set test_url: https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/test_packages.json 09:12:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.crashreporter-symbols.zip 09:12:06 INFO - Running post-action listener: _resource_record_post_action 09:12:06 INFO - [mozharness: 2017-03-21 16:12:06.577510Z] Finished read-buildbot-config step (success) 09:12:06 INFO - [mozharness: 2017-03-21 16:12:06.577732Z] Running download-and-extract step. 09:12:06 INFO - Running pre-action listener: _resource_record_pre_action 09:12:06 INFO - Running main action method: download_and_extract 09:12:06 INFO - mkdir: /builds/slave/test/build/tests 09:12: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:12:06 INFO - trying https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.test_packages.json 09:12:06 INFO - Downloading https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:12:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:12:07 INFO - Downloaded 896 bytes. 09:12:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:12:07 INFO - Using the following test package requirements: 09:12:07 INFO - {u'common': [u'target.common.tests.zip'], 09:12:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:12:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:12:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:12:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:12:07 INFO - u'mozbase': [u'target.common.tests.zip'], 09:12:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:12:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:12:07 INFO - u'web-platform': [u'target.common.tests.zip', 09:12:07 INFO - u'target.web-platform.tests.zip'], 09:12:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:12:07 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:12:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.common.tests.zip 09:12:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:12:07 INFO - Fetch https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.common.tests.zip into memory 09:12:08 INFO - Expected file size: 59533977 09:12:08 INFO - Obtained file size: 59533977 09:12:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:12:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.common.tests.zip 09:12:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:12:17 INFO - Fetch https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.common.tests.zip into memory 09:12:19 INFO - Expected file size: 59533977 09:12:19 INFO - Obtained file size: 59533977 09:12:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.talos.tests.zip 09:12:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:12:29 INFO - Fetch https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.talos.tests.zip into memory 09:12:30 INFO - Expected file size: 14404438 09:12:30 INFO - Obtained file size: 14404438 09:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:30 INFO - trying https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.tar.bz2 09:12:30 INFO - Downloading https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:12:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:12:31 INFO - Downloaded 66697423 bytes. 09:12:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.tar.bz2 09:12:31 INFO - mkdir: /builds/slave/test/properties 09:12:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:12:31 INFO - Writing to file /builds/slave/test/properties/build_url 09:12:31 INFO - Contents: 09:12:31 INFO - build_url:https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.tar.bz2 09:12:31 INFO - Running post-action listener: _resource_record_post_action 09:12:31 INFO - Running post-action listener: set_extra_try_arguments 09:12:31 INFO - [mozharness: 2017-03-21 16:12:31.803434Z] Finished download-and-extract step (success) 09:12:31 INFO - [mozharness: 2017-03-21 16:12:31.803532Z] Running populate-webroot step. 09:12:31 INFO - Running pre-action listener: _resource_record_pre_action 09:12:31 INFO - Running main action method: populate_webroot 09:12:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:12:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:12:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:12:31 INFO - '--tppagecycles', 09:12:31 INFO - '7'], 09:12:31 INFO - 'tests': ['tsvgm']}}, 09:12:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:12:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:12:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:12:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:12:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:12:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:12:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:12:31 INFO - 'talos_options': ['--disable-e10s'], 09:12:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:12:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:12:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:12:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:12:31 INFO - 'talos_options': ['--disable-e10s'], 09:12:31 INFO - 'tests': ['damp', 'tps']}, 09:12:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:12:31 INFO - 'tests': ['damp', 'tps']}, 09:12:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:12:31 INFO - 'tests': ['dromaeo_dom']}, 09:12:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:12:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:12:31 INFO - 'tests': ['basic_compositor_video']}, 09:12:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:12:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:12:31 INFO - 'tests': ['a11yr', 09:12:31 INFO - 'ts_paint', 09:12:31 INFO - 'tpaint', 09:12:31 INFO - 'sessionrestore', 09:12:31 INFO - 'sessionrestore_no_auto_restore', 09:12:31 INFO - 'tabpaint']}, 09:12:31 INFO - 'other-e10s': {'tests': ['a11yr', 09:12:31 INFO - 'ts_paint', 09:12:31 INFO - 'tpaint', 09:12:31 INFO - 'sessionrestore', 09:12:31 INFO - 'sessionrestore_no_auto_restore', 09:12:31 INFO - 'tabpaint']}, 09:12:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:12:31 INFO - 'ts_paint', 09:12:31 INFO - 'tpaint', 09:12:31 INFO - 'sessionrestore', 09:12:31 INFO - 'sessionrestore_no_auto_restore', 09:12:31 INFO - 'tabpaint']}, 09:12:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:12:31 INFO - 'ts_paint', 09:12:31 INFO - 'tpaint', 09:12:31 INFO - 'sessionrestore', 09:12:31 INFO - 'sessionrestore_no_auto_restore', 09:12:31 INFO - 'tabpaint']}, 09:12:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:12:31 INFO - 'tests': ['a11yr', 09:12:31 INFO - 'ts_paint', 09:12:31 INFO - 'tpaint', 09:12:31 INFO - 'sessionrestore', 09:12:31 INFO - 'sessionrestore_no_auto_restore', 09:12:31 INFO - 'tabpaint']}, 09:12:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:12:31 INFO - 'tests': ['a11yr', 09:12:31 INFO - 'ts_paint', 09:12:31 INFO - 'tpaint', 09:12:31 INFO - 'sessionrestore', 09:12:31 INFO - 'sessionrestore_no_auto_restore', 09:12:31 INFO - 'tabpaint']}, 09:12:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:12:31 INFO - 'tests': ['tsvgx', 09:12:31 INFO - 'tsvgr_opacity', 09:12:31 INFO - 'tart', 09:12:31 INFO - 'tscrollx', 09:12:31 INFO - 'cart', 09:12:31 INFO - 'tsvg_static']}, 09:12:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:12:31 INFO - 'tsvgr_opacity', 09:12:31 INFO - 'tart', 09:12:31 INFO - 'tscrollx', 09:12:31 INFO - 'cart', 09:12:31 INFO - 'tsvg_static']}, 09:12:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:12:31 INFO - 'talos_options': ['--disable-e10s'], 09:12:31 INFO - 'tests': ['tp5o']}, 09:12:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:12:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:12:31 INFO - 'talos_options': ['--disable-e10s', 09:12:31 INFO - '--xperf_path', 09:12:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:12:31 INFO - 'tests': ['tp5n']}, 09:12:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:12:31 INFO - 'talos_options': ['--xperf_path', 09:12:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:12:31 INFO - 'tests': ['tp5n']}}, 09:12:31 INFO - 'talos.zip': {'path': '', 09:12:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:12:31 INFO - Running post-action listener: _resource_record_post_action 09:12:31 INFO - [mozharness: 2017-03-21 16:12:31.816850Z] Finished populate-webroot step (success) 09:12:31 INFO - [mozharness: 2017-03-21 16:12:31.816941Z] Running create-virtualenv step. 09:12:31 INFO - Running pre-action listener: _resource_record_pre_action 09:12:31 INFO - Running main action method: create_virtualenv 09:12:31 INFO - Creating virtualenv /builds/slave/test/build/venv 09:12:31 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:12:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:12:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:12:31 INFO - Using real prefix '/usr' 09:12:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:12:32 INFO - Installing distribute.............................................................................................................................................................................................done. 09:12:34 INFO - Installing pip.................done. 09:12:34 INFO - Return code: 0 09:12:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:12:34 INFO - Reading from file tmpfile_stdout 09:12:34 INFO - Output received: 09:12:34 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:12:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfeab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe8290>, '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 0xfe8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe9040>, '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-1490112721.405171-1823671951', '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:12:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:12:34 INFO - Using env: {'DISPLAY': ':0', 09:12:34 INFO - 'HOME': '/home/cltbld', 09:12:34 INFO - 'LANG': 'en_US.UTF-8', 09:12:34 INFO - 'LANGUAGE': 'en_US:en', 09:12:34 INFO - 'LOGNAME': 'cltbld', 09:12:34 INFO - 'MAIL': '/var/mail/cltbld', 09:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:34 INFO - 'MOZ_NO_REMOTE': '1', 09:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:34 INFO - 'NO_EM_RESTART': '1', 09:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:34 INFO - 'PWD': '/builds/slave/test', 09:12:34 INFO - 'SHELL': '/bin/bash', 09:12:34 INFO - 'SHLVL': '1', 09:12:34 INFO - 'TERM': 'linux', 09:12:34 INFO - 'TMOUT': '86400', 09:12:34 INFO - 'USER': 'cltbld', 09:12:34 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490112721.405171-1823671951', 09:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:34 INFO - '_': '/tools/buildbot/bin/python'} 09:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:34 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:12:34 INFO - Cleaning up... 09:12:34 INFO - Return code: 0 09:12:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfeab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe8290>, '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 0xfe8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe9040>, '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-1490112721.405171-1823671951', '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:12:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:12:34 INFO - Using env: {'DISPLAY': ':0', 09:12:34 INFO - 'HOME': '/home/cltbld', 09:12:34 INFO - 'LANG': 'en_US.UTF-8', 09:12:34 INFO - 'LANGUAGE': 'en_US:en', 09:12:34 INFO - 'LOGNAME': 'cltbld', 09:12:34 INFO - 'MAIL': '/var/mail/cltbld', 09:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:34 INFO - 'MOZ_NO_REMOTE': '1', 09:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:34 INFO - 'NO_EM_RESTART': '1', 09:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:34 INFO - 'PWD': '/builds/slave/test', 09:12:34 INFO - 'SHELL': '/bin/bash', 09:12:34 INFO - 'SHLVL': '1', 09:12:34 INFO - 'TERM': 'linux', 09:12:34 INFO - 'TMOUT': '86400', 09:12:34 INFO - 'USER': 'cltbld', 09:12:34 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490112721.405171-1823671951', 09:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:34 INFO - '_': '/tools/buildbot/bin/python'} 09:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:35 INFO - Downloading/unpacking psutil>=3.1.1 09:12:35 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:12:35 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:12:35 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:12:35 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:12:35 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:12:35 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:12:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:12:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:12:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:12:37 INFO - Installing collected packages: psutil 09:12:37 INFO - Running setup.py install for psutil 09:12:37 INFO - building 'psutil._psutil_linux' extension 09:12:37 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:12:37 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:12:37 INFO - building 'psutil._psutil_posix' extension 09:12:37 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:12:37 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:12:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:12:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:12:37 INFO - Successfully installed psutil 09:12:37 INFO - Cleaning up... 09:12:37 INFO - Return code: 0 09:12:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfeab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe8290>, '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 0xfe8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe9040>, '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-1490112721.405171-1823671951', '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:12:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:12:37 INFO - Using env: {'DISPLAY': ':0', 09:12:37 INFO - 'HOME': '/home/cltbld', 09:12:37 INFO - 'LANG': 'en_US.UTF-8', 09:12:37 INFO - 'LANGUAGE': 'en_US:en', 09:12:37 INFO - 'LOGNAME': 'cltbld', 09:12:37 INFO - 'MAIL': '/var/mail/cltbld', 09:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:37 INFO - 'MOZ_NO_REMOTE': '1', 09:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:37 INFO - 'NO_EM_RESTART': '1', 09:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:37 INFO - 'PWD': '/builds/slave/test', 09:12:37 INFO - 'SHELL': '/bin/bash', 09:12:37 INFO - 'SHLVL': '1', 09:12:37 INFO - 'TERM': 'linux', 09:12:37 INFO - 'TMOUT': '86400', 09:12:37 INFO - 'USER': 'cltbld', 09:12:37 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490112721.405171-1823671951', 09:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:37 INFO - '_': '/tools/buildbot/bin/python'} 09:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:12:38 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:12:38 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:12:38 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:12:38 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:12:38 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:12:38 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:12:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:12:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:12:40 INFO - Installing collected packages: mozsystemmonitor 09:12:40 INFO - Running setup.py install for mozsystemmonitor 09:12:40 INFO - Successfully installed mozsystemmonitor 09:12:40 INFO - Cleaning up... 09:12:40 INFO - Return code: 0 09:12:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:12: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:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:40 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 0xd4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfeab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe8290>, '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 0xfe8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe9040>, '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-1490112721.405171-1823671951', '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:12:40 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:12:40 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:12:40 INFO - Using env: {'DISPLAY': ':0', 09:12:40 INFO - 'HOME': '/home/cltbld', 09:12:40 INFO - 'LANG': 'en_US.UTF-8', 09:12:40 INFO - 'LANGUAGE': 'en_US:en', 09:12:40 INFO - 'LOGNAME': 'cltbld', 09:12:40 INFO - 'MAIL': '/var/mail/cltbld', 09:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:40 INFO - 'MOZ_NO_REMOTE': '1', 09:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:40 INFO - 'NO_EM_RESTART': '1', 09:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:40 INFO - 'PWD': '/builds/slave/test', 09:12:40 INFO - 'SHELL': '/bin/bash', 09:12:40 INFO - 'SHLVL': '1', 09:12:40 INFO - 'TERM': 'linux', 09:12:40 INFO - 'TMOUT': '86400', 09:12:40 INFO - 'USER': 'cltbld', 09:12:40 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490112721.405171-1823671951', 09:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:40 INFO - '_': '/tools/buildbot/bin/python'} 09:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:40 INFO - Downloading/unpacking jsonschema==2.5.1 09:12:40 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:12:40 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:12:40 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:12:40 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:12:40 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:12:40 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:12:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:12:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:42 INFO - Downloading functools32-3.2.3-2.tar.gz 09:12:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:12:42 INFO - warning: no files found matching '*.txt' 09:12:42 INFO - no previously-included directories found matching 'build' 09:12:42 INFO - no previously-included directories found matching 'dist' 09:12:42 INFO - no previously-included directories found matching '.git*' 09:12:42 INFO - Installing collected packages: jsonschema, functools32 09:12:42 INFO - Running setup.py install for functools32 09:12:42 INFO - warning: no files found matching '*.txt' 09:12:42 INFO - no previously-included directories found matching 'build' 09:12:42 INFO - no previously-included directories found matching 'dist' 09:12:42 INFO - no previously-included directories found matching '.git*' 09:12:42 INFO - Successfully installed jsonschema functools32 09:12:42 INFO - Cleaning up... 09:12:43 INFO - Return code: 0 09:12:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:12:43 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:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:43 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:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:43 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 0xd4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfeab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe8290>, '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 0xfe8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe9040>, '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-1490112721.405171-1823671951', '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:12:43 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:12:43 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:12:43 INFO - Using env: {'DISPLAY': ':0', 09:12:43 INFO - 'HOME': '/home/cltbld', 09:12:43 INFO - 'LANG': 'en_US.UTF-8', 09:12:43 INFO - 'LANGUAGE': 'en_US:en', 09:12:43 INFO - 'LOGNAME': 'cltbld', 09:12:43 INFO - 'MAIL': '/var/mail/cltbld', 09:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:43 INFO - 'MOZ_NO_REMOTE': '1', 09:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:43 INFO - 'NO_EM_RESTART': '1', 09:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:43 INFO - 'PWD': '/builds/slave/test', 09:12:43 INFO - 'SHELL': '/bin/bash', 09:12:43 INFO - 'SHLVL': '1', 09:12:43 INFO - 'TERM': 'linux', 09:12:43 INFO - 'TMOUT': '86400', 09:12:43 INFO - 'USER': 'cltbld', 09:12:43 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490112721.405171-1823671951', 09:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:43 INFO - '_': '/tools/buildbot/bin/python'} 09:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:12:43 INFO - Cleaning up... 09:12:43 INFO - Return code: 0 09:12:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:12:43 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:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:43 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:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:43 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 0xd4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfeab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe8290>, '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 0xfe8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe9040>, '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-1490112721.405171-1823671951', '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:12:43 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:12:43 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:12:43 INFO - Using env: {'DISPLAY': ':0', 09:12:43 INFO - 'HOME': '/home/cltbld', 09:12:43 INFO - 'LANG': 'en_US.UTF-8', 09:12:43 INFO - 'LANGUAGE': 'en_US:en', 09:12:43 INFO - 'LOGNAME': 'cltbld', 09:12:43 INFO - 'MAIL': '/var/mail/cltbld', 09:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:43 INFO - 'MOZ_NO_REMOTE': '1', 09:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:43 INFO - 'NO_EM_RESTART': '1', 09:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:43 INFO - 'PWD': '/builds/slave/test', 09:12:43 INFO - 'SHELL': '/bin/bash', 09:12:43 INFO - 'SHLVL': '1', 09:12:43 INFO - 'TERM': 'linux', 09:12:43 INFO - 'TMOUT': '86400', 09:12:43 INFO - 'USER': 'cltbld', 09:12:43 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490112721.405171-1823671951', 09:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:43 INFO - '_': '/tools/buildbot/bin/python'} 09:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:43 INFO - Downloading/unpacking blobuploader==1.2.4 09:12:43 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:12:43 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:12:43 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:12:43 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:12:43 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:12:43 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:12:45 INFO - Downloading blobuploader-1.2.4.tar.gz 09:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:12:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:12:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:46 INFO - Downloading docopt-0.6.1.tar.gz 09:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:12:46 INFO - Installing collected packages: blobuploader, requests, docopt 09:12:46 INFO - Running setup.py install for blobuploader 09:12:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:12:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:12:46 INFO - Running setup.py install for requests 09:12:46 INFO - Running setup.py install for docopt 09:12:46 INFO - Successfully installed blobuploader requests docopt 09:12:46 INFO - Cleaning up... 09:12:46 INFO - Return code: 0 09:12:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:46 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 0xd4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfeab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe8290>, '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 0xfe8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe9040>, '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-1490112721.405171-1823671951', '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:12:46 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:12:46 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:12:46 INFO - Using env: {'DISPLAY': ':0', 09:12:46 INFO - 'HOME': '/home/cltbld', 09:12:46 INFO - 'LANG': 'en_US.UTF-8', 09:12:46 INFO - 'LANGUAGE': 'en_US:en', 09:12:46 INFO - 'LOGNAME': 'cltbld', 09:12:46 INFO - 'MAIL': '/var/mail/cltbld', 09:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:46 INFO - 'MOZ_NO_REMOTE': '1', 09:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:46 INFO - 'NO_EM_RESTART': '1', 09:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:46 INFO - 'PWD': '/builds/slave/test', 09:12:46 INFO - 'SHELL': '/bin/bash', 09:12:46 INFO - 'SHLVL': '1', 09:12:46 INFO - 'TERM': 'linux', 09:12:46 INFO - 'TMOUT': '86400', 09:12:46 INFO - 'USER': 'cltbld', 09:12:46 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490112721.405171-1823671951', 09:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:46 INFO - '_': '/tools/buildbot/bin/python'} 09:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:12:47 INFO - Running setup.py (path:/tmp/pip-KyQ0rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:12:47 INFO - Running setup.py (path:/tmp/pip-tvBKxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:12:47 INFO - Running setup.py (path:/tmp/pip-YUh4iH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:12:47 INFO - Running setup.py (path:/tmp/pip-XBPJqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:12:47 INFO - Running setup.py (path:/tmp/pip-pdM6PB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:12:47 INFO - Running setup.py (path:/tmp/pip-gSHcYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:12:47 INFO - Running setup.py (path:/tmp/pip-5IQnEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:12:47 INFO - Running setup.py (path:/tmp/pip-FZf84F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:12:47 INFO - Running setup.py (path:/tmp/pip-OZ_qRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:12:47 INFO - Running setup.py (path:/tmp/pip-ChhIbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:12:47 INFO - Running setup.py (path:/tmp/pip-HJyVPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:12:47 INFO - Running setup.py (path:/tmp/pip-zkTDaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:12:48 INFO - Running setup.py (path:/tmp/pip-Xkv4uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:12:48 INFO - Running setup.py (path:/tmp/pip-K03q1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:48 INFO - Running setup.py (path:/tmp/pip-WzD_nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:12:48 INFO - Running setup.py (path:/tmp/pip-1t0yYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:12:48 INFO - Running setup.py (path:/tmp/pip-h_yfw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:12:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:12:48 INFO - Running setup.py install for manifestparser 09:12:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:12:48 INFO - Running setup.py install for mozcrash 09:12:48 INFO - Running setup.py install for mozdebug 09:12:48 INFO - Running setup.py install for mozdevice 09:12:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:12:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:12:48 INFO - Running setup.py install for mozfile 09:12:48 INFO - Running setup.py install for mozhttpd 09:12:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:12:48 INFO - Running setup.py install for mozinfo 09:12:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:12:49 INFO - Running setup.py install for mozInstall 09:12:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:12:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:12:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:12:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:12:49 INFO - Running setup.py install for mozleak 09:12:49 INFO - Running setup.py install for mozlog 09:12:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:12:49 INFO - Running setup.py install for moznetwork 09:12:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:12:49 INFO - Running setup.py install for mozprocess 09:12:49 INFO - Running setup.py install for mozprofile 09:12:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:12:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:12:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:12:49 INFO - Running setup.py install for mozrunner 09:12:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:12:49 INFO - Running setup.py install for mozscreenshot 09:12:49 INFO - Running setup.py install for moztest 09:12:50 INFO - Running setup.py install for mozversion 09:12:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:12:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:12:50 INFO - Cleaning up... 09:12:50 INFO - Return code: 0 09:12:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:50 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 0xd4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfeab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe8290>, '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 0xfe8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe9040>, '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-1490112721.405171-1823671951', '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:12:50 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:12:50 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:12:50 INFO - Using env: {'DISPLAY': ':0', 09:12:50 INFO - 'HOME': '/home/cltbld', 09:12:50 INFO - 'LANG': 'en_US.UTF-8', 09:12:50 INFO - 'LANGUAGE': 'en_US:en', 09:12:50 INFO - 'LOGNAME': 'cltbld', 09:12:50 INFO - 'MAIL': '/var/mail/cltbld', 09:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:50 INFO - 'MOZ_NO_REMOTE': '1', 09:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:50 INFO - 'NO_EM_RESTART': '1', 09:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:50 INFO - 'PWD': '/builds/slave/test', 09:12:50 INFO - 'SHELL': '/bin/bash', 09:12:50 INFO - 'SHLVL': '1', 09:12:50 INFO - 'TERM': 'linux', 09:12:50 INFO - 'TMOUT': '86400', 09:12:50 INFO - 'USER': 'cltbld', 09:12:50 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490112721.405171-1823671951', 09:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:50 INFO - '_': '/tools/buildbot/bin/python'} 09:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:12:50 INFO - Running setup.py (path:/tmp/pip-ULUHLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:12:50 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:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:12:50 INFO - Running setup.py (path:/tmp/pip-7yiUId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:12:50 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:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:12:50 INFO - Running setup.py (path:/tmp/pip-8Rq35O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:12:50 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:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:12:50 INFO - Running setup.py (path:/tmp/pip-RMfFiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:12:50 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:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:12:50 INFO - Running setup.py (path:/tmp/pip-5KNqgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:12:50 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:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:12:50 INFO - Running setup.py (path:/tmp/pip-73DTjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:12:50 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:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:12:50 INFO - Running setup.py (path:/tmp/pip-aowkEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:12:50 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:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:12:50 INFO - Running setup.py (path:/tmp/pip-IHTvxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:12:50 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:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:12:50 INFO - Running setup.py (path:/tmp/pip-Xwq_Kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:12:51 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:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:12:51 INFO - Running setup.py (path:/tmp/pip-jkrLbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:12:51 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:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:12:51 INFO - Running setup.py (path:/tmp/pip-J_a0xK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:12:51 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:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:12:51 INFO - Running setup.py (path:/tmp/pip-dqemEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:12:51 INFO - Running setup.py (path:/tmp/pip-O3Ou5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:12:51 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:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:12:51 INFO - Running setup.py (path:/tmp/pip-CMj2ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:12:51 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:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:51 INFO - Running setup.py (path:/tmp/pip-izkjAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:51 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:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:12:51 INFO - Running setup.py (path:/tmp/pip-fE3yts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:12:51 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:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:12:51 INFO - Running setup.py (path:/tmp/pip-31VJsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:12:51 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:12:51 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:12:51 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:12:51 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:12:51 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:12:51 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:12:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:12:51 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:12:51 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:12:51 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:12:51 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:12:51 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:12:51 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:12:53 INFO - Downloading blessings-1.6.tar.gz 09:12:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:12:53 INFO - Installing collected packages: blessings 09:12:53 INFO - Running setup.py install for blessings 09:12:53 INFO - Successfully installed blessings 09:12:53 INFO - Cleaning up... 09:12:53 INFO - Return code: 0 09:12:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:12:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:12:54 INFO - Reading from file tmpfile_stdout 09:12:54 INFO - Current package versions: 09:12:54 INFO - argparse == 1.2.1 09:12:54 INFO - blessings == 1.6 09:12:54 INFO - blobuploader == 1.2.4 09:12:54 INFO - docopt == 0.6.1 09:12:54 INFO - functools32 == 3.2.3-2 09:12:54 INFO - jsonschema == 2.5.1 09:12:54 INFO - manifestparser == 1.1 09:12:54 INFO - mozInstall == 1.12 09:12:54 INFO - mozcrash == 1.0 09:12:54 INFO - mozdebug == 0.1 09:12:54 INFO - mozdevice == 0.49 09:12:54 INFO - mozfile == 1.2 09:12:54 INFO - mozhttpd == 0.7 09:12:54 INFO - mozinfo == 0.9 09:12:54 INFO - mozleak == 0.1 09:12:54 INFO - mozlog == 3.4 09:12:54 INFO - moznetwork == 0.27 09:12:54 INFO - mozprocess == 0.25 09:12:54 INFO - mozprofile == 0.28 09:12:54 INFO - mozrunner == 6.13 09:12:54 INFO - mozscreenshot == 0.1 09:12:54 INFO - mozsystemmonitor == 0.3 09:12:54 INFO - moztest == 0.8 09:12:54 INFO - mozversion == 1.4 09:12:54 INFO - psutil == 3.1.1 09:12:54 INFO - requests == 1.2.3 09:12:54 INFO - wsgiref == 0.1.2 09:12:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:54 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 0xd4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfeab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe8290>, '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 0xfe8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe9040>, '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-1490112721.405171-1823671951', '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:12:54 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:12:54 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:12:54 INFO - Using env: {'DISPLAY': ':0', 09:12:54 INFO - 'HOME': '/home/cltbld', 09:12:54 INFO - 'LANG': 'en_US.UTF-8', 09:12:54 INFO - 'LANGUAGE': 'en_US:en', 09:12:54 INFO - 'LOGNAME': 'cltbld', 09:12:54 INFO - 'MAIL': '/var/mail/cltbld', 09:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:54 INFO - 'MOZ_NO_REMOTE': '1', 09:12:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:54 INFO - 'NO_EM_RESTART': '1', 09:12:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:54 INFO - 'PWD': '/builds/slave/test', 09:12:54 INFO - 'SHELL': '/bin/bash', 09:12:54 INFO - 'SHLVL': '1', 09:12:54 INFO - 'TERM': 'linux', 09:12:54 INFO - 'TMOUT': '86400', 09:12:54 INFO - 'USER': 'cltbld', 09:12:54 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490112721.405171-1823671951', 09:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:54 INFO - '_': '/tools/buildbot/bin/python'} 09:12:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:54 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:12:54 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:12:54 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:12:54 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:12:54 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:12:54 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:12:54 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:12:54 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:12:54 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:12:54 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:12:54 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:12:54 INFO - Cleaning up... 09:12:54 INFO - Return code: 0 09:12:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:54 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 0xd4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfeab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe8290>, '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 0xfe8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe9040>, '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-1490112721.405171-1823671951', '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:12:54 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:12:54 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:12:54 INFO - Using env: {'DISPLAY': ':0', 09:12:54 INFO - 'HOME': '/home/cltbld', 09:12:54 INFO - 'LANG': 'en_US.UTF-8', 09:12:54 INFO - 'LANGUAGE': 'en_US:en', 09:12:54 INFO - 'LOGNAME': 'cltbld', 09:12:54 INFO - 'MAIL': '/var/mail/cltbld', 09:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:54 INFO - 'MOZ_NO_REMOTE': '1', 09:12:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:54 INFO - 'NO_EM_RESTART': '1', 09:12:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:54 INFO - 'PWD': '/builds/slave/test', 09:12:54 INFO - 'SHELL': '/bin/bash', 09:12:54 INFO - 'SHLVL': '1', 09:12:54 INFO - 'TERM': 'linux', 09:12:54 INFO - 'TMOUT': '86400', 09:12:54 INFO - 'USER': 'cltbld', 09:12:54 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490112721.405171-1823671951', 09:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:54 INFO - '_': '/tools/buildbot/bin/python'} 09:12:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:12:54 INFO - Cleaning up... 09:12:54 INFO - Return code: 0 09:12:54 INFO - Running post-action listener: _resource_record_post_action 09:12:54 INFO - Running post-action listener: _start_resource_monitoring 09:12:54 INFO - Starting resource monitoring. 09:12:54 INFO - [mozharness: 2017-03-21 16:12:54.644798Z] Finished create-virtualenv step (success) 09:12:54 INFO - [mozharness: 2017-03-21 16:12:54.645318Z] Running install step. 09:12:54 INFO - Running pre-action listener: _resource_record_pre_action 09:12:54 INFO - Running main action method: install 09:12:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:12:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:12:54 INFO - Reading from file tmpfile_stdout 09:12:54 INFO - Detecting whether we're running mozinstall >=1.0... 09:12:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:12:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:12:54 INFO - Reading from file tmpfile_stdout 09:12:54 INFO - Output received: 09:12:54 INFO - Usage: mozinstall [options] installer 09:12:54 INFO - Options: 09:12:54 INFO - -h, --help show this help message and exit 09:12:54 INFO - -d DEST, --destination=DEST 09:12:54 INFO - Directory to install application into. [default: 09:12:54 INFO - "/builds/slave/test"] 09:12:54 INFO - --app=APP Application being installed. [default: firefox] 09:12:54 INFO - mkdir: /builds/slave/test/build/application 09:12:54 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:12:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:13:11 INFO - Reading from file tmpfile_stdout 09:13:11 INFO - Output received: 09:13:11 INFO - /builds/slave/test/build/application/firefox/firefox 09:13:11 INFO - Running post-action listener: _resource_record_post_action 09:13:11 INFO - [mozharness: 2017-03-21 16:13:11.489734Z] Finished install step (success) 09:13:11 INFO - [mozharness: 2017-03-21 16:13:11.490011Z] Running run-tests step. 09:13:11 INFO - Running pre-action listener: _resource_record_pre_action 09:13:11 INFO - Running main action method: run_tests 09:13:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:13:11 INFO - Python 2.7.3 09:13:11 INFO - Return code: 0 09:13:11 INFO - grabbing minidump binary from tooltool 09:13: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:13:11 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 0xfe8290>, '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 0xfe8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe9040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:13:11 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:13:11 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:13:11 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:13:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:13:11 INFO - Return code: 0 09:13:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:13:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:13:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:13:11 INFO - ENV: RUST_BACKTRACE is now 1 09:13:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:13:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:13:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/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:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/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:13:11 INFO - Using env: {'DISPLAY': ':0', 09:13:11 INFO - 'HOME': '/home/cltbld', 09:13:11 INFO - 'LANG': 'en_US.UTF-8', 09:13:11 INFO - 'LANGUAGE': 'en_US:en', 09:13:11 INFO - 'LOGNAME': 'cltbld', 09:13:11 INFO - 'MAIL': '/var/mail/cltbld', 09:13:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:13:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:11 INFO - 'MOZ_NO_REMOTE': '1', 09:13:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:13:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:11 INFO - 'NO_EM_RESTART': '1', 09:13:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:11 INFO - 'PWD': '/builds/slave/test', 09:13:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:13:11 INFO - 'RUST_BACKTRACE': '1', 09:13:11 INFO - 'SHELL': '/bin/bash', 09:13:11 INFO - 'SHLVL': '1', 09:13:11 INFO - 'TERM': 'linux', 09:13:11 INFO - 'TMOUT': '86400', 09:13:11 INFO - 'USER': 'cltbld', 09:13:11 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490112721.405171-1823671951', 09:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:11 INFO - '_': '/tools/buildbot/bin/python'} 09:13:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/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:13:11 INFO - mozversion application_buildid: 20170321151357 09:13:11 INFO - mozversion application_changeset: afaf4387ec15fceba1381b01fa34fc997be0f96e 09:13:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:13:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:13:11 INFO - mozversion application_name: Firefox 09:13:11 INFO - mozversion application_remotingname: firefox-dev 09:13:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:13:11 INFO - mozversion application_vendor: Mozilla 09:13:11 INFO - mozversion application_version: 54.0a2 09:13:11 INFO - mozversion platform_buildid: 20170321151357 09:13:11 INFO - mozversion platform_changeset: afaf4387ec15fceba1381b01fa34fc997be0f96e 09:13:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:13:11 INFO - mozversion platform_version: 54.0a2 09:13:11 INFO - using testdate: 1490112791 09:13:11 INFO - actual date: 1490112791 09:13:11 INFO - starting webserver on 'localhost:58295' 09:13:11 INFO - SUITE-START | Running 2 tests 09:13:11 INFO - TEST-START | dromaeo_css 09:13:11 INFO - operating with platform_type : linux_ 09:13:11 INFO - Initialising browser for dromaeo_css test... 09:13:11 INFO - TEST-INFO | started process 31475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHbIDCF/profile http://localhost:58295/getInfo.html) 09:13:15 INFO - PROCESS | 31475 | __metrics Screen width/height:1600/1200 09:13:15 INFO - PROCESS | 31475 | colorDepth:24 09:13:15 INFO - PROCESS | 31475 | Browser inner width/height: 1024/697 09:13:15 INFO - PROCESS | 31475 | __metrics 09:13:16 INFO - PROCESS | 31475 | 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:13:16 INFO - PROCESS | 31475 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:13:17 INFO - TEST-INFO | 31475: exit 0 09:13:17 INFO - Browser initialized. 09:13:17 INFO - Running cycle 1/1 for dromaeo_css test... 09:13:17 INFO - TEST-INFO | started process 31564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHbIDCF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:29 INFO - PROCESS | 31564 | RSS: Main: 139845632 09:13:29 INFO - PROCESS | 31564 | 09:16:30 INFO - PROCESS | 31564 | Cycle 1(1): loaded http://localhost:58295/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58295/tests/dromaeo/cssquery-ext.html) 09:16:31 INFO - PROCESS | 31564 | RSS: Main: 282886144 09:16:31 INFO - PROCESS | 31564 | 09:18:18 INFO - PROCESS | 31564 | ************************* 09:18:18 INFO - PROCESS | 31564 | A coding exception was thrown and uncaught in a Task. 09:18:18 INFO - PROCESS | 31564 | 09:18:18 ERROR - PROCESS | 31564 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:18:18 INFO - PROCESS | 31564 | Full stack: 09:18:18 INFO - PROCESS | 31564 | ************************* 09:19:33 INFO - PROCESS | 31564 | Cycle 1(1): loaded http://localhost:58295/tests/dromaeo/cssquery-ext.html (next: http://localhost:58295/tests/dromaeo/cssquery-jquery.html) 09:19:34 INFO - PROCESS | 31564 | RSS: Main: 220315648 09:19:34 INFO - PROCESS | 31564 | 09:22:36 INFO - PROCESS | 31564 | Cycle 1(1): loaded http://localhost:58295/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58295/tests/dromaeo/cssquery-mootools.html) 09:22:37 INFO - PROCESS | 31564 | RSS: Main: 169865216 09:22:37 INFO - PROCESS | 31564 | 09:25:38 INFO - PROCESS | 31564 | Cycle 1(1): loaded http://localhost:58295/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58295/tests/dromaeo/cssquery-prototype.html) 09:25:39 INFO - PROCESS | 31564 | RSS: Main: 213921792 09:25:39 INFO - PROCESS | 31564 | 09:28:42 INFO - PROCESS | 31564 | Cycle 1(1): loaded http://localhost:58295/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58295/tests/dromaeo/cssquery-yui.html) 09:28:42 INFO - PROCESS | 31564 | RSS: Main: 177377280 09:28:42 INFO - PROCESS | 31564 | 09:31:45 INFO - PROCESS | 31564 | Cycle 1(1): loaded http://localhost:58295/tests/dromaeo/cssquery-yui.html (next: http://localhost:58295/tests/dromaeo/cssquery-dojo.html) 09:31:45 INFO - PROCESS | 31564 | RSS: Main: 258580480 09:31:45 INFO - PROCESS | 31564 | 09:31:45 INFO - PROCESS | 31564 | __start_tp_report 09:31:45 INFO - PROCESS | 31564 | _x_x_mozilla_page_load 09:31:45 INFO - PROCESS | 31564 | _x_x_mozilla_page_load_details 09:31:45 INFO - PROCESS | 31564 | |i|pagename|runs| 09:31:45 INFO - PROCESS | 31564 | |0;dojo.html;3392.6946574808267;3421.1789170599063;3425.811580363081;3434.1414646338417;3464.6362131976143;5712.428757124286;5791.652500849952;5798.3331916829575;5828;5831.037878750012;5809.941900580993;5863.179154918314;5863.325717542484;5872.119182122684;5887.4995625371785;5211.947880521194;5218.139007063849;5239.345081864767;5286.418493965661;5311.840644780663;5126.487351264881;5316.9202461963105;5327.280817089682;5331.786728530854;5333.733313334337;5159.277701121846;5169.767360468788;5203.427622961472;5285.709285989269;5289.947100528984;5277.102892508283;5302.893942121174;5306.09796334624;5306.7611957462;5308.097623404031;5037.042961837239;5174.793008279665;5221.477852214786;5249.658772179796;5298.788048478056;5686.317641882959;5748.597598168088;5829.387914268983;5835.766569337221;5839.795607153729;6219.129321894939;6287.685615719196;6296.6536840473755;6306;6306.621602703853;6342.429181373698;6344.619322840645;6344.809655710336;6345.270293916213;6354.7458101675875;5592.720363981825;5616.9157462638095;5734.455226753494;5766.769329226784;5781.797637082682;6324.841878952971;6324.968375158095;6336.04959256106;6336.429721325103;6342.175517182736;6004.849878752979;6091.482224011009;6096.3903609639565;6098.298695649968;6108.694565271808;6067.666278354733;6100.847478813065;6152.138700581922;6196.256449226122;6199.938000619936;6234;6251.9687401562705;6262.185915830913;6264.467520260829;6266.342034086355;5943.197668314809;5973.731182096816;5978.910316345258;6257.124002639634;6264.968675156686;4646.140464014168;4664.766761661904;4712.387389639325;4730.929036064462;4735.431748190171;4134.111166099303;4155.812988415529;4283.400323954649;4294.89262768427;4306.590873866978;5958.404159584007;5960.254968128984;6025.969870150621;6052.334243233241;6058.575899687068;6259.499240060784;6289.465395441347;6325.65208913505;6326.46225070865;6326.49388048955;5741;6011.0382338825575;6013.759449621966;6014.699265036731;6028.306744724413;5202.76587553561;5288.81489147878;5315.04329220744;5387.81142660005;5396.595255355864;6551.0500977358015;6573.80278591643;6579.24338701046;6581.572197807127;6594.307597702172;6261.342559031236;6287.182666253358;6335.841603959938;6337.683115844282;6341.207349081365;6248.656323902229;6293.181886354928;6310.305866354605;6315.179026726496;6426.903596446151;6092.299385570716;6093.9085913712215;6095.695215239309;6105.17580126695;6137.631742095488;6183.783353800065;6205.441510263918;6209.96895015522;6215.906761398493;6217.036359364306;5897.439743224387;5980.760769569169;5984.670843103497;6016;6050.2437195350585;5973.402659733992;6050.848728781815;6053.818385448443;6067.12026756109;6088.634681919099;6023.608465449732;6030.8793824122395;6033.577649564489;6036.547258955508;6038.9396106038375;5937.524998000236;5962.4633782959745;5995.2206213192;6113.877722445615;6119.959572021022;6034.336223015377;6060.818175454743;6064.969675151596;6094.421030002142;6101.60339577926 09:31:45 INFO - PROCESS | 31564 | |1;ext.html;745.9254074592542;809.2433574607741;824.8226631274275;882.7793051737066;897.2418306530978;31136;43483.78258108709;43945.56054439459;44000;44055.559444405546;45676;45903.31145032827;45903.54096459034;45916;45932.77033614836;7721.575313357763;7882.408819338572;9117.49853758043;9237.676681316156;9251.306152038624;10597.57609695615;10854.72863178419;11084.168687348441;11093.667189984313;11103.611373601925;10875.238733288674;10885.401302928336;10898.073663738593;10926.836097458505;10926.836097458505;10697.572097116145;10814.891851081546;10820.72948176294;10826.24216304859;10838.67483975482;10449.582016719398;10551.683449496528;10569.365838049742;10574;10574.312669676447;42174.367384489255;42396;42447.57552424467;42480.57519424828;42497.362539561625;4153.823938016294;4199.853005144805;4244.299690551055;4324.978375108104;4328.415663885398;29243.56134657982;29744.8512757437;29750.70249297501;29756.70243297561;31303;4340.826366945318;4441.244988351988;4446.799894004777;4453.287474004176;4540.318952157169;230165.84917075475;231123;231433;231742;231886;53188.202176967374;53430.46569534333;53517;53613.195802063;53652;55495;55791.44208557944;56017.719911400185;56021.43978560244;56063.159052614246;14419.78370324446;14620.634484137981;14632.195229262492;14638.707225855636;14645.633859153393;12545;12565.685857853627;12570.87429125697;13050.282234477196;13200.801987970188;12667.746645067047;12763.234205947487;13074.477020919057;13146.802797958038;13184.670383240496;5189.455107213688;5301.946980530222;5315.813946511854;5354.143337066051;5360.91958620621;983.896690847465;984.3601658921615;997.5211898288717;1001.5142655812072;1027.1474676018886;27684.861575691993;27824.721752782618;28253.71746282552;28269.434611307657;28462.576871156773;1056.9894301057045;1073.414988831089;1086.6359769477156;1104.4422566603814;1105.5964572930823;13567.38946747379;16626.25181866819;17510.562235943948;17688.204030818386;17693.646127077645;323860;323940;324175;324972;325206;56837;56916;56954.145687814715;57093.42906570964;57163;1466.113001633996;1506.3974410235994;1515.3559737111684;1520.7186670465999;1524.5273965070642;31011.534826978066;32448;32504.187395315308;32567.348653026333;32943.50584741279;46927;46962;47055;47055.294170586785;47283.52716472929;289604;290535;290559;290704;291277;30960.69039309668;32141.839290803397;34098.829505852314;34235.82882085673;34240.828795855865;38876.80561597174;38933.22133557256;39089.022774430865;39221.2155756889;39272.214555709295;33645;34242.82878585591;34411.31177376388;36825.89522314335;37188.44217336796;30199.547006794477;30356.69643303627;30750.84624576863;31059.447027648977;31248.375032499676;31087.22281942879;31099.37801243917;31315.21711957128;31595.84202078975;32177.87377441778;29440.705592943796;30914;30992.88370047608;31083;31181.53227701632;22546.436339091655;22742;22839.20062797794;23049.308520744406;23055.769442306035 09:31:45 INFO - PROCESS | 31564 | |2;jquery.html;411.8414410451975;466.82260740918446;469.66653675890126;484.716440882084;488.20179007323026;19588.608227835433;20765.273215437464;22121.77878221217;22172;22366.440838978993;22063.44841378966;22127;22453;22687;22915;6519.1199188109595;6536.411722944934;6754.864902701943;6761;6828.829279268033;4229;4413.337999300099;6610.966945165267;6709.396154346108;6709.630970296632;7284.6721897514735;7515.7745267641785;7535.962320188419;7546.245375462438;7644.5031072980355;7490.550566966;7589.544627322323;7595.582242976634;7611.847763044708;7629.237076292382;7265.782026539212;7412.629368531552;7452.329290363893;7458.291462311072;7466.887996680054;25500.872495637588;25715.099971501095;25769.098081567055;25963.610545841828;25996.480070398487;3207.615086189649;3682.576503702055;3697.9630203698157;3754.6433088856515;3777.527809023872;16311.755323670155;16722.581935451588;16786.91606541972;16925.91537042307;17601.7359739604;2236.463248820288;2279.09975559653;2282.2696737044153;2317.524907393997;2325.1164557468223;94058.52970735103;94816.52591736997;95931;98146;99220.50389748077;14408.031285113573;16794.58013549671;18918.43244702661;18997.24011039543;19660;27209.183724488295;28485.145445636663;35551.11122221914;35566.82216588952;35747.64252357495;10114.190864730805;10222.182225421948;10273.383596984206;10384.169266458664;10500.527476263587;8672.696455624024;8731.825363492695;8763.649454021768;8935.508547029845;8977.955110224408;8923.330750193762;8925.152110549487;9118.270538356915;9119.680811171576;9195.95402022999;3578.4453409721536;3788.583255841855;3901.8068535825546;3909.3940439231965;3989.261986532501;959.5154447004218;972.9708108756748;974.7758015656296;978.8287049766262;987.9950600247097;20687.58624827495;21419.357419277447;21555.892220538797;21829.126834926425;21974.230901918356;986.4032260482448;988.2390559269322;991.4695637833869;995.3032876986139;999.7200783780553;11647.184697071292;11698.766024679458;11776.587819426279;11798.823017654571;11976.461059252355;662867;663530;671783;674980;675197;108738.45630771795;128868;130302;131604.3419782914;131913;1289.8387701537308;1300.5838131797734;1360.8026836108709;1380.7169530246276;1434.634168287101;13873.861261387257;18175.636487270443;18229.908850455664;19462.61074778525;19667.311644092388;50415.49584504255;50814.49185508245;51364;51778.48221517736;51821.22268166056;61953.38046619476;63403.682981584796;63793.68103159455;64054.03918941313;65691.34308657043;10856.45717714127;11052.226344156154;11128.499217535393;11469.483873225558;11790.587329443428;12561.811572826598;12756.553520626734;12819.359032048547;12874.098813083368;12918.806217906927;10961.616343427942;11385.886141138813;11468.197226194086;11609;11701;10447.634332798316;10617.787644246917;10624.415657138932;10715.839262410915;11072.723181920517;11582.942085289857;11596;11603.767924641628;11749.236299640495;11780.882191178322;11618.419079046183;11652.242604230698;11819.349935753617;11928.701782455508;12240.510379584717;11072.612458564234;11361.715957101138;11369.431528423711;11546.307221566733;11747.353895535485 09:31:45 INFO - PROCESS | 31564 | |3;mootools.html;1551.50351887396;1573.3470609696974;1577.164103025397;1584.8573628373445;1598.8481094296042;10938.179636527262;11639.243449175798;11652.766944661102;11655.184137110406;11673.357965311916;11419.942900285487;11424.657260282205;11687.357195354252;11687.532498700062;11689.707757306072;2476.1457297232514;2511.108556462457;2511.7864981476596;2512.8617926014063;2516.257703977331;2460.458699086198;2501.012100220412;2503.912363067293;2508.034406753404;2511.485145545159;2473.5794914864427;2487.3905893056226;2492.4018235623503;2496.2012156110054;2498.6252062190724;2420.0077968033197;2434.513097380522;2442.1696623148127;2442.206282958046;2444.6577479152756;2372.810175185981;2407.3981504623844;2429.53838770633;2457.668214791016;2459.594166962449;11408.657740267805;11486.253393529394;11500.884991150066;11510.712232194179;11517.827232591433;5855.590108692393;5970.910436343458;5985.431384018511;5985.4912332451795;5985.730642121115;3477.7391695622678;3559.522798038811;3591.2458383739445;3598.4062629666073;3656.360136976045;1354.052163485564;1372.0875617714207;1375.587323802865;1450.8766754825851;1459.8248210214842;16004;16056.27746751399;16100.919495402564;16124.75812862808;16292.837071629368;4806.44725856524;4885.658003939761;4895.510448955076;4956;4978.726170060609;12952.352382380843;12953.158044727063;12968;12968.09223354356;12973.740525189443;5948.375420580864;5978.5814992950945;5982.162497250389;5991.340952495222;5993.011153159767;5305.283786688825;5334.733263336818;5347.41178470368;5392.865178370572;5394.703291319015;4079.9188215123017;4135.379693046068;4165.500139983222;4171.687123465752;4200.705950583491;1035.5081336365167;1054.5781687325132;1057.931234469757;1067.5196161727254;1072.3780207479642;893.7542175901679;894.199691276317;895.2122132523468;898.793277546168;916.5463095767504;7042.718291268292;7060.752873649398;7063.57618542889;7130.786076417716;7150.463715221379;1026.7741096958657;1031.8555402243692;1054.4200689620677;1057.8730552333768;1061.2147011211648;4105.035316700573;4148.958510414917;4154.397612346193;4185.916281674349;4207.894802629898;14156.150630961969;14325.283735813167;14479.203643799692;14505.12969221829;14528.63678408027;12258.325792081521;14096.332081943461;14393.064450810663;14402.207878566569;14472.565823025327;9083.68207112761;10068;10298.588056477807;10343.534540945526;10378.532966016548;6715.127033485811;6790.694418751069;6829.146356705412;6862.416694581017;6905.067815844997;12592.622221333375;12656.493740250287;12761.338571307813;13089.08376413642;13121.475140994635;12897.677558061123;12903.161294515827;13052.412641430969;13184.143030702973;13267.46930122823;8875.156860098281;8877.547963127494;8879.822403551763;8894.555272236492;8967.551622418723;10104.646337378157;10269.281150319406;10284.691459256233;10287.279890407599;10501.527431265458;9617;9709.46597937092;9883.30816842814;10127;10284.177265818567;9696.321257511907;9734.902650973683;9744.220462362851;9775.120239178508;9862.605495780088;8057.274845263954;8182.672693092448;8182.7954301142945;8184.631691574013;8186.345092392713;6397.424231819158;6428.357164283534;6463.256725476443;6507.642079685474;6556;6328.936710632835;6373.171487706569;6392.744290228339;6493.902591461037;6527.379898909596 09:31:45 INFO - PROCESS | 31564 | |4;prototype.html;400.21358031468156;410.99589004109947;421.6753100112915;428.2291874625674;432.9740215587065;4965.8510244692625;5120.3343565336545;5215.191645294981;5236.26692263083;5256.921146182805;4945.826896058638;4972.676776009557;5021.59827213823;5078.923816142752;5119;4382.386465894761;4383.211022016036;4383.824647014116;4399.51427443495;4403.207422663919;4093.856715014975;4138.606832350937;4374.58441448062;4402.955970440303;4408.889777755566;4375.299952007679;4377.912441751163;4380.97809510952;4400.7996001999;4411.514733379326;4348.91302173958;4369.038811461473;4372.191144638252;4401.735895846259;4413.977930110361;3858.305505009097;4295.91408171838;4322.740635561876;4328.63206627437;4330.921157844221;4946.826861059882;4972.328735620681;5026.2711906773675;5046.873828154289;5051.267566202917;5006.424261209934;5008.549230569266;5028.245763135523;5035.388675623802;5051.570616497565;5213.426523082458;5351.598630102758;5415.593830462731;5418.428655689884;5455.509004189602;4472.172648060119;4534.863954081383;4546.931796023062;4547.499775024745;4558.088382323515;5617.4382561743905;5621.606487545873;5652.858678532987;5658.6516595612775;5705.971470142665;4417.757023363682;4608.493065762764;4625.190591646448;4651.5813576778255;4655.4878963314;4756.381670382828;4770;4780.832670856573;4791.544803243686;4797.040591881638;4998.850034498971;5036.420811606712;5072.467390923974;5109.20807274873;5128.948710512922;5105.157648987875;5375.543078838265;5410.675359478444;5461.563074953994;5476.2333273341765;1545.860872521456;1569.7723830044579;1606.8634166096012;1636.378176293001;1642.228152768197;1238.3005048993282;1258.3016425883723;1258.7230809221955;1264.367816091954;1272.4592048379402;5308.681479111266;5309.787608495617;5331.360236771612;5343.599230057684;5362.892742145135;5489.862753431116;5530.668159910338;5558.805441809517;5560.776629141583;5568.49883510486;5055.244891534123;5275.60432967529;5283.471652834686;5291;5302.628815982845;2920.488914440007;2929.9745089219027;2933.5159698649486;2937.2363185571476;2942.4997750382486;5563.984827310825;5727.255456790591;5731.340895796953;5761.423857614289;5779.422057794187;5559.444055594408;5602.047651899187;5624.903143886984;5641.238432811518;5663.716814159276;5711.800086997018;5719.163891787199;5722.828315150552;5723;5745.511631511201;5376.59675524345;5471.562275018068;5518.006758783457;5529;5536.944630553643;5449.727513624223;5477.493689235492;5479.287692599936;5480.205370221216;5490.6980116094;5667.809759950456;5669.177969194526;5673.865226954708;5693.178182981406;5719.828405147852;4438.511763706054;4613.953860461486;4625.444946606429;4670.159371313196;4689.412599361559;5354.223637572608;5420.83737487876;5575.693336866511;5600.215969764155;5601.767611125546;5238.5023422774775;5256.921146182887;5279.363397346835;5311.49540793624;5330.601229446687;5367.677939323653;5433.375161856279;5439.884823611071;5458.235846981346;5459.454054594509;5245.842624721265;5340.305760251143;5356.732163391893;5395.568354531707;5468.425815289337;5396.325459317585;5413.404525502113;5417.539509141767;5429.375621803543;5462.930117062813;5199.63602547818;5348.759305831325;5350.618974556285;5357.437469065848;5376.327959005124 09:31:45 INFO - PROCESS | 31564 | |5;yui.html;720.7873677265206;808.1837344282274;809.951402915825;815.1807433529306;846.9703560375384;15940.36238550458;17218.39735609254;17913.10434478274;17939.64120717585;18298.085095745228;16087.597810054725;16431.260593273302;16493.505194844143;16666.83333166671;16680.83319166808;887.0375642427957;905.4069584422214;905.6151135767306;907.8955920069177;908.509404921345;870.5647176411794;903.9593218305159;907.3557773980482;907.691384929124;908.4776253654143;951.0251991708485;951.8477043673014;953.6709835106911;954.2509130332691;954.3605784124653;948.7201275623707;951.4481600671594;951.857221416793;952.4618590496382;952.6856137474617;699.7445932234749;704.7216349541953;704.9577025378494;705.0446644796278;705.509670778809;16343.34626614934;16425.09661968591;16434.01395916237;16666;16720.41478548245;15843.524694259191;16189.919050404673;16376.590585235344;16522.2564984576;16627.251773670214;13870.930645346809;13913;14112.364943577564;14141.787873181911;14274.286285685674;3918.666913312372;3987.4816273884207;4121;4133.111381053088;4159.188958153161;81303;81576.59211703904;82620;83718;84751.99999999939;12286.877131228573;12477.188982716094;12549.372531373578;12689.682757931125;12748.61754147377;21986.560268794856;22277.777222227895;22392.10431582751;22434.102635894382;22718.772812271665;8604.78488037804;8726.69456569017;8802.427842190365;8846.248068914214;8877.156670116328;4957.479464656231;4982.800687972441;5011.022850544182;5097.974510127426;5194.818181363634;3760.6803421708914;3795.203007368428;3818.4845045919;3880.5149356330458;3885.3589157789215;622.2470810319564;626.5770604841714;626.8495561065312;629.288903538998;641.8619996700731;751.3988808952815;761.1741260732057;774.6088225446114;781.0705260739702;800.8518424091561;10845.57182947758;11052;11550;11752.823707644393;11876.821847672292;762.1045271805606;763.4426868386109;766.5898744171841;782.1240210963757;786.1116937860296;5273.156294992783;5335.866603334947;5389.541888939406;5394.541463975527;5413.106837371868;80739.59630201929;81989.18010819935;83135;84997.57501212577;87636;69752.65123674349;73958;75319;77091.61454192693;78430.6078469604;66219.66890165518;66446.33553664498;67778;68141.65929170322;69088.6545567279;10132.696019119438;10531.062471816427;10627.149828013586;10698.732531686459;10712;47224;47759.761201193774;47936.5206347932;48176;48645.27032094592;54917;55136.72431637816;55888.720556398584;55999.16001259903;57156.42843571511;11961.401929903644;12089.697757556132;12099.637010889688;12217.93891030539;12473.877351038087;14393;14533.27333633293;14607.85392146065;14647.267636617913;14724.55826325212;13796.448142074205;13844.723105538034;14003.579892603238;15550.533483995498;15748.370065197263;14469.204193769443;14616.926915365355;15922.840771592137;16568.088755118584;17145.228464718868;14657.120572765669;15522.301496432914;15831.841681583037;16802.663946720753;16815.831841681917;13230.338483076;13310.534131305745;13519.256440895846;13979.93010034984;14121.364538595582;12210.816837747263;12390.62828115158;13579.660508487366;13584.86415135836;13735.107218030797 09:31:45 INFO - PROCESS | 31564 | __end_tp_report 09:31:45 INFO - PROCESS | 31564 | __start_cc_report 09:31:45 INFO - PROCESS | 31564 | _x_x_mozilla_cycle_collect,1355 09:31:45 INFO - PROCESS | 31564 | __end_cc_report 09:31:45 INFO - PROCESS | 31564 | __startTimestamp1490113905648__endTimestamp 09:31:45 INFO - PROCESS | 31564 | 09:31:45 INFO - PROCESS | 31564 | ------- Summary: start ------- 09:31:45 INFO - PROCESS | 31564 | Number of tests: 6 09:31:45 INFO - PROCESS | 31564 | 09:31:45 INFO - PROCESS | 31564 | [#0] dojo.html Cycles:165 Average:5774.56 Median:6016.00 stddev:663.08 (11.0%) stddev-sans-first:638.24 09:31:45 INFO - PROCESS | 31564 | Values: 3392.7 3421.2 3425.8 3434.1 3464.6 5712.4 5791.7 5798.3 5828.0 5831.0 5809.9 5863.2 5863.3 5872.1 5887.5 5211.9 5218.1 5239.3 5286.4 5311.8 5126.5 5316.9 5327.3 5331.8 5333.7 5159.3 5169.8 5203.4 5285.7 5289.9 5277.1 5302.9 5306.1 5306.8 5308.1 5037.0 5174.8 5221.5 5249.7 5298.8 5686.3 5748.6 5829.4 5835.8 5839.8 6219.1 6287.7 6296.7 6306.0 6306.6 6342.4 6344.6 6344.8 6345.3 6354.7 5592.7 5616.9 5734.5 5766.8 5781.8 6324.8 6325.0 6336.0 6336.4 6342.2 6004.8 6091.5 6096.4 6098.3 6108.7 6067.7 6100.8 6152.1 6196.3 6199.9 6234.0 6252.0 6262.2 6264.5 6266.3 5943.2 5973.7 5978.9 6257.1 6265.0 4646.1 4664.8 4712.4 4730.9 4735.4 4134.1 4155.8 4283.4 4294.9 4306.6 5958.4 5960.3 6026.0 6052.3 6058.6 6259.5 6289.5 6325.7 6326.5 6326.5 5741.0 6011.0 6013.8 6014.7 6028.3 5202.8 5288.8 5315.0 5387.8 5396.6 6551.1 6573.8 6579.2 6581.6 6594.3 6261.3 6287.2 6335.8 6337.7 6341.2 6248.7 6293.2 6310.3 6315.2 6426.9 6092.3 6093.9 6095.7 6105.2 6137.6 6183.8 6205.4 6210.0 6215.9 6217.0 5897.4 5980.8 5984.7 6016.0 6050.2 5973.4 6050.8 6053.8 6067.1 6088.6 6023.6 6030.9 6033.6 6036.5 6038.9 5937.5 5962.5 5995.2 6113.9 6120.0 6034.3 6060.8 6065.0 6094.4 6101.6 09:31:45 INFO - PROCESS | 31564 | 09:31:45 INFO - PROCESS | 31564 | [#1] ext.html Cycles:180 Average:45278.62 Median:31275.69 stddev:74343.94 (237.7%) stddev-sans-first:74477.30 09:31:45 INFO - PROCESS | 31564 | Values: 745.9 809.2 824.8 882.8 897.2 31136.0 43483.8 43945.6 44000.0 44055.6 45676.0 45903.3 45903.5 45916.0 45932.8 7721.6 7882.4 9117.5 9237.7 9251.3 10597.6 10854.7 11084.2 11093.7 11103.6 10875.2 10885.4 10898.1 10926.8 10926.8 10697.6 10814.9 10820.7 10826.2 10838.7 10449.6 10551.7 10569.4 10574.0 10574.3 42174.4 42396.0 42447.6 42480.6 42497.4 4153.8 4199.9 4244.3 4325.0 4328.4 29243.6 29744.9 29750.7 29756.7 31303.0 4340.8 4441.2 4446.8 4453.3 4540.3 230165.8 231123.0 231433.0 231742.0 231886.0 53188.2 53430.5 53517.0 53613.2 53652.0 55495.0 55791.4 56017.7 56021.4 56063.2 14419.8 14620.6 14632.2 14638.7 14645.6 12545.0 12565.7 12570.9 13050.3 13200.8 12667.7 12763.2 13074.5 13146.8 13184.7 5189.5 5301.9 5315.8 5354.1 5360.9 983.9 984.4 997.5 1001.5 1027.1 27684.9 27824.7 28253.7 28269.4 28462.6 1057.0 1073.4 1086.6 1104.4 1105.6 13567.4 16626.3 17510.6 17688.2 17693.6 323860.0 323940.0 324175.0 324972.0 325206.0 56837.0 56916.0 56954.1 57093.4 57163.0 1466.1 1506.4 1515.4 1520.7 1524.5 31011.5 32448.0 32504.2 32567.3 32943.5 46927.0 46962.0 47055.0 47055.3 47283.5 289604.0 290535.0 290559.0 290704.0 291277.0 30960.7 32141.8 34098.8 34235.8 34240.8 38876.8 38933.2 39089.0 39221.2 39272.2 33645.0 34242.8 34411.3 36825.9 37188.4 30199.5 30356.7 30750.8 31059.4 31248.4 31087.2 31099.4 31315.2 31595.8 32177.9 29440.7 30914.0 30992.9 31083.0 31181.5 22546.4 22742.0 22839.2 23049.3 23055.8 09:31:45 INFO - PROCESS | 31564 | 09:31:45 INFO - PROCESS | 31564 | [#2] jquery.html Cycles:180 Average:37584.97 Median:25607.99 stddev:110279.10 (430.6%) stddev-sans-first:110553.14 09:31:45 INFO - PROCESS | 31564 | Values: 411.8 466.8 469.7 484.7 488.2 19588.6 20765.3 22121.8 22172.0 22366.4 22063.4 22127.0 22453.0 22687.0 22915.0 6519.1 6536.4 6754.9 6761.0 6828.8 4229.0 4413.3 6611.0 6709.4 6709.6 7284.7 7515.8 7536.0 7546.2 7644.5 7490.6 7589.5 7595.6 7611.8 7629.2 7265.8 7412.6 7452.3 7458.3 7466.9 25500.9 25715.1 25769.1 25963.6 25996.5 3207.6 3682.6 3698.0 3754.6 3777.5 16311.8 16722.6 16786.9 16925.9 17601.7 2236.5 2279.1 2282.3 2317.5 2325.1 94058.5 94816.5 95931.0 98146.0 99220.5 14408.0 16794.6 18918.4 18997.2 19660.0 27209.2 28485.1 35551.1 35566.8 35747.6 10114.2 10222.2 10273.4 10384.2 10500.5 8672.7 8731.8 8763.6 8935.5 8978.0 8923.3 8925.2 9118.3 9119.7 9196.0 3578.4 3788.6 3901.8 3909.4 3989.3 959.5 973.0 974.8 978.8 988.0 20687.6 21419.4 21555.9 21829.1 21974.2 986.4 988.2 991.5 995.3 999.7 11647.2 11698.8 11776.6 11798.8 11976.5 662867.0 663530.0 671783.0 674980.0 675197.0 108738.5 128868.0 130302.0 131604.3 131913.0 1289.8 1300.6 1360.8 1380.7 1434.6 13873.9 18175.6 18229.9 19462.6 19667.3 50415.5 50814.5 51364.0 51778.5 51821.2 61953.4 63403.7 63793.7 64054.0 65691.3 10856.5 11052.2 11128.5 11469.5 11790.6 12561.8 12756.6 12819.4 12874.1 12918.8 10961.6 11385.9 11468.2 11609.0 11701.0 10447.6 10617.8 10624.4 10715.8 11072.7 11582.9 11596.0 11603.8 11749.2 11780.9 11618.4 11652.2 11819.3 11928.7 12240.5 11072.6 11361.7 11369.4 11546.3 11747.4 09:31:45 INFO - PROCESS | 31564 | 09:31:45 INFO - PROCESS | 31564 | [#3] mootools.html Cycles:180 Average:7060.51 Median:2494.30 stddev:4437.84 (177.9%) stddev-sans-first:4430.99 09:31:45 INFO - PROCESS | 31564 | Values: 1551.5 1573.3 1577.2 1584.9 1598.8 10938.2 11639.2 11652.8 11655.2 11673.4 11419.9 11424.7 11687.4 11687.5 11689.7 2476.1 2511.1 2511.8 2512.9 2516.3 2460.5 2501.0 2503.9 2508.0 2511.5 2473.6 2487.4 2492.4 2496.2 2498.6 2420.0 2434.5 2442.2 2442.2 2444.7 2372.8 2407.4 2429.5 2457.7 2459.6 11408.7 11486.3 11500.9 11510.7 11517.8 5855.6 5970.9 5985.4 5985.5 5985.7 3477.7 3559.5 3591.2 3598.4 3656.4 1354.1 1372.1 1375.6 1450.9 1459.8 16004.0 16056.3 16100.9 16124.8 16292.8 4806.4 4885.7 4895.5 4956.0 4978.7 12952.4 12953.2 12968.0 12968.1 12973.7 5948.4 5978.6 5982.2 5991.3 5993.0 5305.3 5334.7 5347.4 5392.9 5394.7 4079.9 4135.4 4165.5 4171.7 4200.7 1035.5 1054.6 1057.9 1067.5 1072.4 893.8 894.2 895.2 898.8 916.5 7042.7 7060.8 7063.6 7130.8 7150.5 1026.8 1031.9 1054.4 1057.9 1061.2 4105.0 4149.0 4154.4 4185.9 4207.9 14156.2 14325.3 14479.2 14505.1 14528.6 12258.3 14096.3 14393.1 14402.2 14472.6 9083.7 10068.0 10298.6 10343.5 10378.5 6715.1 6790.7 6829.1 6862.4 6905.1 12592.6 12656.5 12761.3 13089.1 13121.5 12897.7 12903.2 13052.4 13184.1 13267.5 8875.2 8877.5 8879.8 8894.6 8967.6 10104.6 10269.3 10284.7 10287.3 10501.5 9617.0 9709.5 9883.3 10127.0 10284.2 9696.3 9734.9 9744.2 9775.1 9862.6 8057.3 8182.7 8182.8 8184.6 8186.3 6397.4 6428.4 6463.3 6507.6 6556.0 6328.9 6373.2 6392.7 6493.9 6527.4 09:31:45 INFO - PROCESS | 31564 | 09:31:45 INFO - PROCESS | 31564 | [#4] prototype.html Cycles:180 Average:4728.48 Median:5214.31 stddev:1246.60 (23.9%) stddev-sans-first:1207.03 09:31:45 INFO - PROCESS | 31564 | Values: 400.2 411.0 421.7 428.2 433.0 4965.9 5120.3 5215.2 5236.3 5256.9 4945.8 4972.7 5021.6 5078.9 5119.0 4382.4 4383.2 4383.8 4399.5 4403.2 4093.9 4138.6 4374.6 4403.0 4408.9 4375.3 4377.9 4381.0 4400.8 4411.5 4348.9 4369.0 4372.2 4401.7 4414.0 3858.3 4295.9 4322.7 4328.6 4330.9 4946.8 4972.3 5026.3 5046.9 5051.3 5006.4 5008.5 5028.2 5035.4 5051.6 5213.4 5351.6 5415.6 5418.4 5455.5 4472.2 4534.9 4546.9 4547.5 4558.1 5617.4 5621.6 5652.9 5658.7 5706.0 4417.8 4608.5 4625.2 4651.6 4655.5 4756.4 4770.0 4780.8 4791.5 4797.0 4998.9 5036.4 5072.5 5109.2 5128.9 5105.2 5375.5 5410.7 5461.6 5476.2 1545.9 1569.8 1606.9 1636.4 1642.2 1238.3 1258.3 1258.7 1264.4 1272.5 5308.7 5309.8 5331.4 5343.6 5362.9 5489.9 5530.7 5558.8 5560.8 5568.5 5055.2 5275.6 5283.5 5291.0 5302.6 2920.5 2930.0 2933.5 2937.2 2942.5 5564.0 5727.3 5731.3 5761.4 5779.4 5559.4 5602.0 5624.9 5641.2 5663.7 5711.8 5719.2 5722.8 5723.0 5745.5 5376.6 5471.6 5518.0 5529.0 5536.9 5449.7 5477.5 5479.3 5480.2 5490.7 5667.8 5669.2 5673.9 5693.2 5719.8 4438.5 4614.0 4625.4 4670.2 4689.4 5354.2 5420.8 5575.7 5600.2 5601.8 5238.5 5256.9 5279.4 5311.5 5330.6 5367.7 5433.4 5439.9 5458.2 5459.5 5245.8 5340.3 5356.7 5395.6 5468.4 5396.3 5413.4 5417.5 5429.4 5462.9 5199.6 5348.8 5350.6 5357.4 5376.3 09:31:45 INFO - PROCESS | 31564 | 09:31:45 INFO - PROCESS | 31564 | [#5] yui.html Cycles:180 Average:19016.72 Median:47491.88 stddev:23791.84 (50.1%) stddev-sans-first:23818.91 09:31:45 INFO - PROCESS | 31564 | Values: 720.8 808.2 810.0 815.2 847.0 15940.4 17218.4 17913.1 17939.6 18298.1 16087.6 16431.3 16493.5 16666.8 16680.8 887.0 905.4 905.6 907.9 908.5 870.6 904.0 907.4 907.7 908.5 951.0 951.8 953.7 954.3 954.4 948.7 951.4 951.9 952.5 952.7 699.7 704.7 705.0 705.0 705.5 16343.3 16425.1 16434.0 16666.0 16720.4 15843.5 16189.9 16376.6 16522.3 16627.3 13870.9 13913.0 14112.4 14141.8 14274.3 3918.7 3987.5 4121.0 4133.1 4159.2 81303.0 81576.6 82620.0 83718.0 84752.0 12286.9 12477.2 12549.4 12689.7 12748.6 21986.6 22277.8 22392.1 22434.1 22718.8 8604.8 8726.7 8802.4 8846.2 8877.2 4957.5 4982.8 5011.0 5098.0 5194.8 3760.7 3795.2 3818.5 3880.5 3885.4 622.2 626.6 626.8 629.3 641.9 751.4 761.2 774.6 781.1 800.9 10845.6 11052.0 11550.0 11752.8 11876.8 762.1 763.4 766.6 782.1 786.1 5273.2 5335.9 5389.5 5394.5 5413.1 80739.6 81989.2 83135.0 84997.6 87636.0 69752.7 73958.0 75319.0 77091.6 78430.6 66219.7 66446.3 67778.0 68141.7 69088.7 10132.7 10531.1 10627.1 10698.7 10712.0 47224.0 47759.8 47936.5 48176.0 48645.3 54917.0 55136.7 55888.7 55999.2 57156.4 11961.4 12089.7 12099.6 12217.9 12473.9 14393.0 14533.3 14607.9 14647.3 14724.6 13796.4 13844.7 14003.6 15550.5 15748.4 14469.2 14616.9 15922.8 16568.1 17145.2 14657.1 15522.3 15831.8 16802.7 16815.8 13230.3 13310.5 13519.3 13979.9 14121.4 12210.8 12390.6 13579.7 13584.9 13735.1 09:31:45 INFO - PROCESS | 31564 | -------- Summary: end -------- 09:31:45 INFO - PROCESS | 31564 | 09:31:46 INFO - TEST-INFO | 31564: exit 0 09:31:46 INFO - TEST-OK | dromaeo_css | took 1114707ms 09:31:46 INFO - TEST-START | kraken 09:31:46 INFO - operating with platform_type : linux_ 09:31:46 INFO - Initialising browser for kraken test... 09:31:46 INFO - TEST-INFO | started process 31890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUDD93e/profile http://localhost:58295/getInfo.html) 09:31:50 INFO - PROCESS | 31890 | __metrics Screen width/height:1600/1200 09:31:50 INFO - PROCESS | 31890 | colorDepth:24 09:31:50 INFO - PROCESS | 31890 | Browser inner width/height: 1024/697 09:31:50 INFO - PROCESS | 31890 | __metrics 09:31:51 INFO - PROCESS | 31890 | 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:31:51 INFO - PROCESS | 31890 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:31:51 INFO - TEST-INFO | 31890: exit 0 09:31:51 INFO - Browser initialized. 09:31:51 INFO - Running cycle 1/1 for kraken test... 09:31:52 INFO - TEST-INFO | started process 31980 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUDD93e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:32:03 INFO - PROCESS | 31980 | RSS: Main: 140013568 09:32:03 INFO - PROCESS | 31980 | 09:32:06 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58295/tests/kraken/driver.html?testName=audio-beat-detection) 09:32:07 INFO - PROCESS | 31980 | RSS: Main: 183042048 09:32:07 INFO - PROCESS | 31980 | 09:32:09 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58295/tests/kraken/driver.html?testName=audio-dft) 09:32:10 INFO - PROCESS | 31980 | RSS: Main: 174981120 09:32:10 INFO - PROCESS | 31980 | 09:32:13 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58295/tests/kraken/driver.html?testName=audio-fft) 09:32:13 INFO - PROCESS | 31980 | RSS: Main: 265904128 09:32:13 INFO - PROCESS | 31980 | 09:32:15 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58295/tests/kraken/driver.html?testName=audio-oscillator) 09:32:16 INFO - PROCESS | 31980 | RSS: Main: 171790336 09:32:16 INFO - PROCESS | 31980 | 09:32:18 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58295/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:32:18 INFO - PROCESS | 31980 | RSS: Main: 174788608 09:32:18 INFO - PROCESS | 31980 | 09:32:21 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58295/tests/kraken/driver.html?testName=imaging-darkroom) 09:32:22 INFO - PROCESS | 31980 | RSS: Main: 211664896 09:32:22 INFO - PROCESS | 31980 | 09:32:25 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58295/tests/kraken/driver.html?testName=imaging-desaturate) 09:32:26 INFO - PROCESS | 31980 | RSS: Main: 212058112 09:32:26 INFO - PROCESS | 31980 | 09:32:29 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58295/tests/kraken/driver.html?testName=json-parse-financial) 09:32:29 INFO - PROCESS | 31980 | RSS: Main: 210501632 09:32:29 INFO - PROCESS | 31980 | 09:32:31 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58295/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:32:31 INFO - PROCESS | 31980 | RSS: Main: 173150208 09:32:31 INFO - PROCESS | 31980 | 09:32:33 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58295/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:32:34 INFO - PROCESS | 31980 | RSS: Main: 180117504 09:32:34 INFO - PROCESS | 31980 | 09:32:36 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58295/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:32:36 INFO - PROCESS | 31980 | RSS: Main: 188424192 09:32:36 INFO - PROCESS | 31980 | 09:32:39 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:32:40 INFO - PROCESS | 31980 | RSS: Main: 198336512 09:32:40 INFO - PROCESS | 31980 | 09:32:42 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:32:43 INFO - PROCESS | 31980 | RSS: Main: 194916352 09:32:43 INFO - PROCESS | 31980 | 09:32:44 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58295/tests/kraken/driver.html?testName=ai-astar) 09:32:45 INFO - PROCESS | 31980 | RSS: Main: 246235136 09:32:45 INFO - PROCESS | 31980 | 09:32:45 INFO - PROCESS | 31980 | __start_tp_report 09:32:45 INFO - PROCESS | 31980 | _x_x_mozilla_page_load 09:32:45 INFO - PROCESS | 31980 | _x_x_mozilla_page_load_details 09:32:45 INFO - PROCESS | 31980 | |i|pagename|runs| 09:32:45 INFO - PROCESS | 31980 | |0;ai-astar;103;110;112;111;111;112;112;111;113;111 09:32:45 INFO - PROCESS | 31980 | |1;audio-beat-detection;140;116;119;161;115;120;115;116;130;116 09:32:45 INFO - PROCESS | 31980 | |2;audio-dft;160;162;161;162;161;161;160;162;161;162 09:32:45 INFO - PROCESS | 31980 | |3;audio-fft;74;75;77;107;77;76;75;75;89;74 09:32:45 INFO - PROCESS | 31980 | |4;audio-oscillator;81;82;105;81;81;81;100;81;81;98 09:32:45 INFO - PROCESS | 31980 | |5;imaging-gaussian-blur;113;113;113;113;113;113;112;113;113;112 09:32:45 INFO - PROCESS | 31980 | |6;imaging-darkroom;147;147;147;146;147;146;147;147;146;147 09:32:45 INFO - PROCESS | 31980 | |7;imaging-desaturate;94;94;94;94;94;94;94;93;95;93 09:32:45 INFO - PROCESS | 31980 | |8;json-parse-financial;56;56;56;58;54;55;54;54;54;55 09:32:45 INFO - PROCESS | 31980 | |9;json-stringify-tinderbox;54;54;53;53;54;54;54;53;53;53 09:32:45 INFO - PROCESS | 31980 | |10;stanford-crypto-aes;76;84;75;80;79;75;76;75;81;75 09:32:45 INFO - PROCESS | 31980 | |11;stanford-crypto-ccm;122;121;122;121;130;132;127;127;159;133 09:32:45 INFO - PROCESS | 31980 | |12;stanford-crypto-pbkdf2;158;158;158;157;155;157;166;163;156;158 09:32:45 INFO - PROCESS | 31980 | |13;stanford-crypto-sha256-iterative;60;60;59;63;59;59;64;60;60;59 09:32:45 INFO - PROCESS | 31980 | __end_tp_report 09:32:45 INFO - PROCESS | 31980 | __start_cc_report 09:32:45 INFO - PROCESS | 31980 | _x_x_mozilla_cycle_collect,1672 09:32:45 INFO - PROCESS | 31980 | __end_cc_report 09:32:45 INFO - PROCESS | 31980 | __startTimestamp1490113965180__endTimestamp 09:32:45 INFO - PROCESS | 31980 | 09:32:45 INFO - PROCESS | 31980 | ------- Summary: start ------- 09:32:45 INFO - PROCESS | 31980 | Number of tests: 14 09:32:45 INFO - PROCESS | 31980 | 09:32:45 INFO - PROCESS | 31980 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:2.80 (2.5%) stddev-sans-first:0.88 09:32:45 INFO - PROCESS | 31980 | Values: 103.0 110.0 112.0 111.0 111.0 112.0 112.0 111.0 113.0 111.0 09:32:45 INFO - PROCESS | 31980 | 09:32:45 INFO - PROCESS | 31980 | [#1] audio-beat-detection Cycles:10 Average:124.80 Median:119.50 stddev:15.09 (12.6%) stddev-sans-first:14.97 09:32:45 INFO - PROCESS | 31980 | Values: 140.0 116.0 119.0 161.0 115.0 120.0 115.0 116.0 130.0 116.0 09:32:45 INFO - PROCESS | 31980 | 09:32:45 INFO - PROCESS | 31980 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.71 09:32:45 INFO - PROCESS | 31980 | Values: 160.0 162.0 161.0 162.0 161.0 161.0 160.0 162.0 161.0 162.0 09:32:45 INFO - PROCESS | 31980 | 09:32:45 INFO - PROCESS | 31980 | [#3] audio-fft Cycles:10 Average:79.90 Median:75.50 stddev:10.49 (13.9%) stddev-sans-first:10.91 09:32:45 INFO - PROCESS | 31980 | Values: 74.0 75.0 77.0 107.0 77.0 76.0 75.0 75.0 89.0 74.0 09:32:45 INFO - PROCESS | 31980 | 09:32:45 INFO - PROCESS | 31980 | [#4] audio-oscillator Cycles:10 Average:87.10 Median:81.00 stddev:9.75 (12.0%) stddev-sans-first:10.08 09:32:45 INFO - PROCESS | 31980 | Values: 81.0 82.0 105.0 81.0 81.0 81.0 100.0 81.0 81.0 98.0 09:32:45 INFO - PROCESS | 31980 | 09:32:45 INFO - PROCESS | 31980 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:32:45 INFO - PROCESS | 31980 | Values: 113.0 113.0 113.0 113.0 113.0 113.0 112.0 113.0 113.0 112.0 09:32:45 INFO - PROCESS | 31980 | 09:32:45 INFO - PROCESS | 31980 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:32:45 INFO - PROCESS | 31980 | Values: 147.0 147.0 147.0 146.0 147.0 146.0 147.0 147.0 146.0 147.0 09:32:45 INFO - PROCESS | 31980 | 09:32:45 INFO - PROCESS | 31980 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 09:32:45 INFO - PROCESS | 31980 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 95.0 93.0 09:32:45 INFO - PROCESS | 31980 | 09:32:45 INFO - PROCESS | 31980 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:1.32 (2.4%) stddev-sans-first:1.36 09:32:45 INFO - PROCESS | 31980 | Values: 56.0 56.0 56.0 58.0 54.0 55.0 54.0 54.0 54.0 55.0 09:32:45 INFO - PROCESS | 31980 | 09:32:45 INFO - PROCESS | 31980 | [#9] json-stringify-tinderbox Cycles:10 Average:53.50 Median:54.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 09:32:45 INFO - PROCESS | 31980 | Values: 54.0 54.0 53.0 53.0 54.0 54.0 54.0 53.0 53.0 53.0 09:32:45 INFO - PROCESS | 31980 | 09:32:45 INFO - PROCESS | 31980 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:77.50 stddev:3.20 (4.1%) stddev-sans-first:3.35 09:32:45 INFO - PROCESS | 31980 | Values: 76.0 84.0 75.0 80.0 79.0 75.0 76.0 75.0 81.0 75.0 09:32:45 INFO - PROCESS | 31980 | 09:32:45 INFO - PROCESS | 31980 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:128.50 stddev:11.35 (8.8%) stddev-sans-first:11.71 09:32:45 INFO - PROCESS | 31980 | Values: 122.0 121.0 122.0 121.0 130.0 132.0 127.0 127.0 159.0 133.0 09:32:45 INFO - PROCESS | 31980 | 09:32:45 INFO - PROCESS | 31980 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.60 Median:158.00 stddev:3.34 (2.1%) stddev-sans-first:3.54 09:32:45 INFO - PROCESS | 31980 | Values: 158.0 158.0 158.0 157.0 155.0 157.0 166.0 163.0 156.0 158.0 09:32:45 INFO - PROCESS | 31980 | 09:32:45 INFO - PROCESS | 31980 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.30 Median:60.00 stddev:1.77 (2.9%) stddev-sans-first:1.87 09:32:45 INFO - PROCESS | 31980 | Values: 60.0 60.0 59.0 63.0 59.0 59.0 64.0 60.0 60.0 59.0 09:32:45 INFO - PROCESS | 31980 | -------- Summary: end -------- 09:32:45 INFO - PROCESS | 31980 | 09:32:46 INFO - TEST-INFO | 31980: exit 0 09:32:46 INFO - TEST-OK | kraken | took 59878ms 09:32:46 INFO - SUITE-END | took 1174s 09:32:46 INFO - Completed test suite (00:19:35) 09:32:46 INFO - javascript benchmark 09:32:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7815.2210248100855, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3392.6946574808267, 3421.1789170599063, 3425.811580363081, 3434.1414646338417, 3464.6362131976143, 5712.428757124286, 5791.652500849952, 5798.3331916829575, 5828.0, 5831.037878750012, 5809.941900580993, 5863.179154918314, 5863.325717542484, 5872.119182122684, 5887.4995625371785, 5211.947880521194, 5218.139007063849, 5239.345081864767, 5286.418493965661, 5311.840644780663, 5126.487351264881, 5316.9202461963105, 5327.280817089682, 5331.786728530854, 5333.733313334337, 5159.277701121846, 5169.767360468788, 5203.427622961472, 5285.709285989269, 5289.947100528984, 5277.102892508283, 5302.893942121174, 5306.09796334624, 5306.7611957462, 5308.097623404031, 5037.042961837239, 5174.793008279665, 5221.477852214786, 5249.658772179796, 5298.788048478056, 5686.317641882959, 5748.597598168088, 5829.387914268983, 5835.766569337221, 5839.795607153729, 6219.129321894939, 6287.685615719196, 6296.6536840473755, 6306.0, 6306.621602703853, 6342.429181373698, 6344.619322840645, 6344.809655710336, 6345.270293916213, 6354.7458101675875, 5592.720363981825, 5616.9157462638095, 5734.455226753494, 5766.769329226784, 5781.797637082682, 6324.841878952971, 6324.968375158095, 6336.04959256106, 6336.429721325103, 6342.175517182736, 6004.849878752979, 6091.482224011009, 6096.3903609639565, 6098.298695649968, 6108.694565271808, 6067.666278354733, 6100.847478813065, 6152.138700581922, 6196.256449226122, 6199.938000619936, 6234.0, 6251.9687401562705, 6262.185915830913, 6264.467520260829, 6266.342034086355, 5943.197668314809, 5973.731182096816, 5978.910316345258, 6257.124002639634, 6264.968675156686, 4646.140464014168, 4664.766761661904, 4712.387389639325, 4730.929036064462, 4735.431748190171, 4134.111166099303, 4155.812988415529, 4283.400323954649, 4294.89262768427, 4306.590873866978, 5958.404159584007, 5960.254968128984, 6025.969870150621, 6052.334243233241, 6058.575899687068, 6259.499240060784, 6289.465395441347, 6325.65208913505, 6326.46225070865, 6326.49388048955, 5741.0, 6011.0382338825575, 6013.759449621966, 6014.699265036731, 6028.306744724413, 5202.76587553561, 5288.81489147878, 5315.04329220744, 5387.81142660005, 5396.595255355864, 6551.0500977358015, 6573.80278591643, 6579.24338701046, 6581.572197807127, 6594.307597702172, 6261.342559031236, 6287.182666253358, 6335.841603959938, 6337.683115844282, 6341.207349081365, 6248.656323902229, 6293.181886354928, 6310.305866354605, 6315.179026726496, 6426.903596446151, 6092.299385570716, 6093.9085913712215, 6095.695215239309, 6105.17580126695, 6137.631742095488, 6183.783353800065, 6205.441510263918, 6209.96895015522, 6215.906761398493, 6217.036359364306, 5897.439743224387, 5980.760769569169, 5984.670843103497, 6016.0, 6050.2437195350585, 5973.402659733992, 6050.848728781815, 6053.818385448443, 6067.12026756109, 6088.634681919099, 6023.608465449732, 6030.8793824122395, 6033.577649564489, 6036.547258955508, 6038.9396106038375, 5937.524998000236, 5962.4633782959745, 5995.2206213192, 6113.877722445615, 6119.959572021022, 6034.336223015377, 6060.818175454743, 6064.969675151596, 6094.421030002142, 6101.60339577926], "value": 5729.917554335986, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.9254074592542, 809.2433574607741, 824.8226631274275, 882.7793051737066, 897.2418306530978, 31136.0, 43483.78258108709, 43945.56054439459, 44000.0, 44055.559444405546, 45676.0, 45903.31145032827, 45903.54096459034, 45916.0, 45932.77033614836, 7721.575313357763, 7882.408819338572, 9117.49853758043, 9237.676681316156, 9251.306152038624, 10597.57609695615, 10854.72863178419, 11084.168687348441, 11093.667189984313, 11103.611373601925, 10875.238733288674, 10885.401302928336, 10898.073663738593, 10926.836097458505, 10926.836097458505, 10697.572097116145, 10814.891851081546, 10820.72948176294, 10826.24216304859, 10838.67483975482, 10449.582016719398, 10551.683449496528, 10569.365838049742, 10574.0, 10574.312669676447, 42174.367384489255, 42396.0, 42447.57552424467, 42480.57519424828, 42497.362539561625, 4153.823938016294, 4199.853005144805, 4244.299690551055, 4324.978375108104, 4328.415663885398, 29243.56134657982, 29744.8512757437, 29750.70249297501, 29756.70243297561, 31303.0, 4340.826366945318, 4441.244988351988, 4446.799894004777, 4453.287474004176, 4540.318952157169, 230165.84917075475, 231123.0, 231433.0, 231742.0, 231886.0, 53188.202176967374, 53430.46569534333, 53517.0, 53613.195802063, 53652.0, 55495.0, 55791.44208557944, 56017.719911400185, 56021.43978560244, 56063.159052614246, 14419.78370324446, 14620.634484137981, 14632.195229262492, 14638.707225855636, 14645.633859153393, 12545.0, 12565.685857853627, 12570.87429125697, 13050.282234477196, 13200.801987970188, 12667.746645067047, 12763.234205947487, 13074.477020919057, 13146.802797958038, 13184.670383240496, 5189.455107213688, 5301.946980530222, 5315.813946511854, 5354.143337066051, 5360.91958620621, 983.896690847465, 984.3601658921615, 997.5211898288717, 1001.5142655812072, 1027.1474676018886, 27684.861575691993, 27824.721752782618, 28253.71746282552, 28269.434611307657, 28462.576871156773, 1056.9894301057045, 1073.414988831089, 1086.6359769477156, 1104.4422566603814, 1105.5964572930823, 13567.38946747379, 16626.25181866819, 17510.562235943948, 17688.204030818386, 17693.646127077645, 323860.0, 323940.0, 324175.0, 324972.0, 325206.0, 56837.0, 56916.0, 56954.145687814715, 57093.42906570964, 57163.0, 1466.113001633996, 1506.3974410235994, 1515.3559737111684, 1520.7186670465999, 1524.5273965070642, 31011.534826978066, 32448.0, 32504.187395315308, 32567.348653026333, 32943.50584741279, 46927.0, 46962.0, 47055.0, 47055.294170586785, 47283.52716472929, 289604.0, 290535.0, 290559.0, 290704.0, 291277.0, 30960.69039309668, 32141.839290803397, 34098.829505852314, 34235.82882085673, 34240.828795855865, 38876.80561597174, 38933.22133557256, 39089.022774430865, 39221.2155756889, 39272.214555709295, 33645.0, 34242.82878585591, 34411.31177376388, 36825.89522314335, 37188.44217336796, 30199.547006794477, 30356.69643303627, 30750.84624576863, 31059.447027648977, 31248.375032499676, 31087.22281942879, 31099.37801243917, 31315.21711957128, 31595.84202078975, 32177.87377441778, 29440.705592943796, 30914.0, 30992.88370047608, 31083.0, 31181.53227701632, 22546.436339091655, 22742.0, 22839.20062797794, 23049.308520744406, 23055.769442306035], "value": 18815.49801731148, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.8414410451975, 466.82260740918446, 469.66653675890126, 484.716440882084, 488.20179007323026, 19588.608227835433, 20765.273215437464, 22121.77878221217, 22172.0, 22366.440838978993, 22063.44841378966, 22127.0, 22453.0, 22687.0, 22915.0, 6519.1199188109595, 6536.411722944934, 6754.864902701943, 6761.0, 6828.829279268033, 4229.0, 4413.337999300099, 6610.966945165267, 6709.396154346108, 6709.630970296632, 7284.6721897514735, 7515.7745267641785, 7535.962320188419, 7546.245375462438, 7644.5031072980355, 7490.550566966, 7589.544627322323, 7595.582242976634, 7611.847763044708, 7629.237076292382, 7265.782026539212, 7412.629368531552, 7452.329290363893, 7458.291462311072, 7466.887996680054, 25500.872495637588, 25715.099971501095, 25769.098081567055, 25963.610545841828, 25996.480070398487, 3207.615086189649, 3682.576503702055, 3697.9630203698157, 3754.6433088856515, 3777.527809023872, 16311.755323670155, 16722.581935451588, 16786.91606541972, 16925.91537042307, 17601.7359739604, 2236.463248820288, 2279.09975559653, 2282.2696737044153, 2317.524907393997, 2325.1164557468223, 94058.52970735103, 94816.52591736997, 95931.0, 98146.0, 99220.50389748077, 14408.031285113573, 16794.58013549671, 18918.43244702661, 18997.24011039543, 19660.0, 27209.183724488295, 28485.145445636663, 35551.11122221914, 35566.82216588952, 35747.64252357495, 10114.190864730805, 10222.182225421948, 10273.383596984206, 10384.169266458664, 10500.527476263587, 8672.696455624024, 8731.825363492695, 8763.649454021768, 8935.508547029845, 8977.955110224408, 8923.330750193762, 8925.152110549487, 9118.270538356915, 9119.680811171576, 9195.95402022999, 3578.4453409721536, 3788.583255841855, 3901.8068535825546, 3909.3940439231965, 3989.261986532501, 959.5154447004218, 972.9708108756748, 974.7758015656296, 978.8287049766262, 987.9950600247097, 20687.58624827495, 21419.357419277447, 21555.892220538797, 21829.126834926425, 21974.230901918356, 986.4032260482448, 988.2390559269322, 991.4695637833869, 995.3032876986139, 999.7200783780553, 11647.184697071292, 11698.766024679458, 11776.587819426279, 11798.823017654571, 11976.461059252355, 662867.0, 663530.0, 671783.0, 674980.0, 675197.0, 108738.45630771795, 128868.0, 130302.0, 131604.3419782914, 131913.0, 1289.8387701537308, 1300.5838131797734, 1360.8026836108709, 1380.7169530246276, 1434.634168287101, 13873.861261387257, 18175.636487270443, 18229.908850455664, 19462.61074778525, 19667.311644092388, 50415.49584504255, 50814.49185508245, 51364.0, 51778.48221517736, 51821.22268166056, 61953.38046619476, 63403.682981584796, 63793.68103159455, 64054.03918941313, 65691.34308657043, 10856.45717714127, 11052.226344156154, 11128.499217535393, 11469.483873225558, 11790.587329443428, 12561.811572826598, 12756.553520626734, 12819.359032048547, 12874.098813083368, 12918.806217906927, 10961.616343427942, 11385.886141138813, 11468.197226194086, 11609.0, 11701.0, 10447.634332798316, 10617.787644246917, 10624.415657138932, 10715.839262410915, 11072.723181920517, 11582.942085289857, 11596.0, 11603.767924641628, 11749.236299640495, 11780.882191178322, 11618.419079046183, 11652.242604230698, 11819.349935753617, 11928.701782455508, 12240.510379584717, 11072.612458564234, 11361.715957101138, 11369.431528423711, 11546.307221566733, 11747.353895535485], "value": 11377.894695081552, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1551.50351887396, 1573.3470609696974, 1577.164103025397, 1584.8573628373445, 1598.8481094296042, 10938.179636527262, 11639.243449175798, 11652.766944661102, 11655.184137110406, 11673.357965311916, 11419.942900285487, 11424.657260282205, 11687.357195354252, 11687.532498700062, 11689.707757306072, 2476.1457297232514, 2511.108556462457, 2511.7864981476596, 2512.8617926014063, 2516.257703977331, 2460.458699086198, 2501.012100220412, 2503.912363067293, 2508.034406753404, 2511.485145545159, 2473.5794914864427, 2487.3905893056226, 2492.4018235623503, 2496.2012156110054, 2498.6252062190724, 2420.0077968033197, 2434.513097380522, 2442.1696623148127, 2442.206282958046, 2444.6577479152756, 2372.810175185981, 2407.3981504623844, 2429.53838770633, 2457.668214791016, 2459.594166962449, 11408.657740267805, 11486.253393529394, 11500.884991150066, 11510.712232194179, 11517.827232591433, 5855.590108692393, 5970.910436343458, 5985.431384018511, 5985.4912332451795, 5985.730642121115, 3477.7391695622678, 3559.522798038811, 3591.2458383739445, 3598.4062629666073, 3656.360136976045, 1354.052163485564, 1372.0875617714207, 1375.587323802865, 1450.8766754825851, 1459.8248210214842, 16004.0, 16056.27746751399, 16100.919495402564, 16124.75812862808, 16292.837071629368, 4806.44725856524, 4885.658003939761, 4895.510448955076, 4956.0, 4978.726170060609, 12952.352382380843, 12953.158044727063, 12968.0, 12968.09223354356, 12973.740525189443, 5948.375420580864, 5978.5814992950945, 5982.162497250389, 5991.340952495222, 5993.011153159767, 5305.283786688825, 5334.733263336818, 5347.41178470368, 5392.865178370572, 5394.703291319015, 4079.9188215123017, 4135.379693046068, 4165.500139983222, 4171.687123465752, 4200.705950583491, 1035.5081336365167, 1054.5781687325132, 1057.931234469757, 1067.5196161727254, 1072.3780207479642, 893.7542175901679, 894.199691276317, 895.2122132523468, 898.793277546168, 916.5463095767504, 7042.718291268292, 7060.752873649398, 7063.57618542889, 7130.786076417716, 7150.463715221379, 1026.7741096958657, 1031.8555402243692, 1054.4200689620677, 1057.8730552333768, 1061.2147011211648, 4105.035316700573, 4148.958510414917, 4154.397612346193, 4185.916281674349, 4207.894802629898, 14156.150630961969, 14325.283735813167, 14479.203643799692, 14505.12969221829, 14528.63678408027, 12258.325792081521, 14096.332081943461, 14393.064450810663, 14402.207878566569, 14472.565823025327, 9083.68207112761, 10068.0, 10298.588056477807, 10343.534540945526, 10378.532966016548, 6715.127033485811, 6790.694418751069, 6829.146356705412, 6862.416694581017, 6905.067815844997, 12592.622221333375, 12656.493740250287, 12761.338571307813, 13089.08376413642, 13121.475140994635, 12897.677558061123, 12903.161294515827, 13052.412641430969, 13184.143030702973, 13267.46930122823, 8875.156860098281, 8877.547963127494, 8879.822403551763, 8894.555272236492, 8967.551622418723, 10104.646337378157, 10269.281150319406, 10284.691459256233, 10287.279890407599, 10501.527431265458, 9617.0, 9709.46597937092, 9883.30816842814, 10127.0, 10284.177265818567, 9696.321257511907, 9734.902650973683, 9744.220462362851, 9775.120239178508, 9862.605495780088, 8057.274845263954, 8182.672693092448, 8182.7954301142945, 8184.631691574013, 8186.345092392713, 6397.424231819158, 6428.357164283534, 6463.256725476443, 6507.642079685474, 6556.0, 6328.936710632835, 6373.171487706569, 6392.744290228339, 6493.902591461037, 6527.379898909596], "value": 5365.517582621997, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.21358031468156, 410.99589004109947, 421.6753100112915, 428.2291874625674, 432.9740215587065, 4965.8510244692625, 5120.3343565336545, 5215.191645294981, 5236.26692263083, 5256.921146182805, 4945.826896058638, 4972.676776009557, 5021.59827213823, 5078.923816142752, 5119.0, 4382.386465894761, 4383.211022016036, 4383.824647014116, 4399.51427443495, 4403.207422663919, 4093.856715014975, 4138.606832350937, 4374.58441448062, 4402.955970440303, 4408.889777755566, 4375.299952007679, 4377.912441751163, 4380.97809510952, 4400.7996001999, 4411.514733379326, 4348.91302173958, 4369.038811461473, 4372.191144638252, 4401.735895846259, 4413.977930110361, 3858.305505009097, 4295.91408171838, 4322.740635561876, 4328.63206627437, 4330.921157844221, 4946.826861059882, 4972.328735620681, 5026.2711906773675, 5046.873828154289, 5051.267566202917, 5006.424261209934, 5008.549230569266, 5028.245763135523, 5035.388675623802, 5051.570616497565, 5213.426523082458, 5351.598630102758, 5415.593830462731, 5418.428655689884, 5455.509004189602, 4472.172648060119, 4534.863954081383, 4546.931796023062, 4547.499775024745, 4558.088382323515, 5617.4382561743905, 5621.606487545873, 5652.858678532987, 5658.6516595612775, 5705.971470142665, 4417.757023363682, 4608.493065762764, 4625.190591646448, 4651.5813576778255, 4655.4878963314, 4756.381670382828, 4770.0, 4780.832670856573, 4791.544803243686, 4797.040591881638, 4998.850034498971, 5036.420811606712, 5072.467390923974, 5109.20807274873, 5128.948710512922, 5105.157648987875, 5375.543078838265, 5410.675359478444, 5461.563074953994, 5476.2333273341765, 1545.860872521456, 1569.7723830044579, 1606.8634166096012, 1636.378176293001, 1642.228152768197, 1238.3005048993282, 1258.3016425883723, 1258.7230809221955, 1264.367816091954, 1272.4592048379402, 5308.681479111266, 5309.787608495617, 5331.360236771612, 5343.599230057684, 5362.892742145135, 5489.862753431116, 5530.668159910338, 5558.805441809517, 5560.776629141583, 5568.49883510486, 5055.244891534123, 5275.60432967529, 5283.471652834686, 5291.0, 5302.628815982845, 2920.488914440007, 2929.9745089219027, 2933.5159698649486, 2937.2363185571476, 2942.4997750382486, 5563.984827310825, 5727.255456790591, 5731.340895796953, 5761.423857614289, 5779.422057794187, 5559.444055594408, 5602.047651899187, 5624.903143886984, 5641.238432811518, 5663.716814159276, 5711.800086997018, 5719.163891787199, 5722.828315150552, 5723.0, 5745.511631511201, 5376.59675524345, 5471.562275018068, 5518.006758783457, 5529.0, 5536.944630553643, 5449.727513624223, 5477.493689235492, 5479.287692599936, 5480.205370221216, 5490.6980116094, 5667.809759950456, 5669.177969194526, 5673.865226954708, 5693.178182981406, 5719.828405147852, 4438.511763706054, 4613.953860461486, 4625.444946606429, 4670.159371313196, 4689.412599361559, 5354.223637572608, 5420.83737487876, 5575.693336866511, 5600.215969764155, 5601.767611125546, 5238.5023422774775, 5256.921146182887, 5279.363397346835, 5311.49540793624, 5330.601229446687, 5367.677939323653, 5433.375161856279, 5439.884823611071, 5458.235846981346, 5459.454054594509, 5245.842624721265, 5340.305760251143, 5356.732163391893, 5395.568354531707, 5468.425815289337, 5396.325459317585, 5413.404525502113, 5417.539509141767, 5429.375621803543, 5462.930117062813, 5199.63602547818, 5348.759305831325, 5350.618974556285, 5357.437469065848, 5376.327959005124], "value": 4367.10766576087, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.7873677265206, 808.1837344282274, 809.951402915825, 815.1807433529306, 846.9703560375384, 15940.36238550458, 17218.39735609254, 17913.10434478274, 17939.64120717585, 18298.085095745228, 16087.597810054725, 16431.260593273302, 16493.505194844143, 16666.83333166671, 16680.83319166808, 887.0375642427957, 905.4069584422214, 905.6151135767306, 907.8955920069177, 908.509404921345, 870.5647176411794, 903.9593218305159, 907.3557773980482, 907.691384929124, 908.4776253654143, 951.0251991708485, 951.8477043673014, 953.6709835106911, 954.2509130332691, 954.3605784124653, 948.7201275623707, 951.4481600671594, 951.857221416793, 952.4618590496382, 952.6856137474617, 699.7445932234749, 704.7216349541953, 704.9577025378494, 705.0446644796278, 705.509670778809, 16343.34626614934, 16425.09661968591, 16434.01395916237, 16666.0, 16720.41478548245, 15843.524694259191, 16189.919050404673, 16376.590585235344, 16522.2564984576, 16627.251773670214, 13870.930645346809, 13913.0, 14112.364943577564, 14141.787873181911, 14274.286285685674, 3918.666913312372, 3987.4816273884207, 4121.0, 4133.111381053088, 4159.188958153161, 81303.0, 81576.59211703904, 82620.0, 83718.0, 84751.99999999939, 12286.877131228573, 12477.188982716094, 12549.372531373578, 12689.682757931125, 12748.61754147377, 21986.560268794856, 22277.777222227895, 22392.10431582751, 22434.102635894382, 22718.772812271665, 8604.78488037804, 8726.69456569017, 8802.427842190365, 8846.248068914214, 8877.156670116328, 4957.479464656231, 4982.800687972441, 5011.022850544182, 5097.974510127426, 5194.818181363634, 3760.6803421708914, 3795.203007368428, 3818.4845045919, 3880.5149356330458, 3885.3589157789215, 622.2470810319564, 626.5770604841714, 626.8495561065312, 629.288903538998, 641.8619996700731, 751.3988808952815, 761.1741260732057, 774.6088225446114, 781.0705260739702, 800.8518424091561, 10845.57182947758, 11052.0, 11550.0, 11752.823707644393, 11876.821847672292, 762.1045271805606, 763.4426868386109, 766.5898744171841, 782.1240210963757, 786.1116937860296, 5273.156294992783, 5335.866603334947, 5389.541888939406, 5394.541463975527, 5413.106837371868, 80739.59630201929, 81989.18010819935, 83135.0, 84997.57501212577, 87636.0, 69752.65123674349, 73958.0, 75319.0, 77091.61454192693, 78430.6078469604, 66219.66890165518, 66446.33553664498, 67778.0, 68141.65929170322, 69088.6545567279, 10132.696019119438, 10531.062471816427, 10627.149828013586, 10698.732531686459, 10712.0, 47224.0, 47759.761201193774, 47936.5206347932, 48176.0, 48645.27032094592, 54917.0, 55136.72431637816, 55888.720556398584, 55999.16001259903, 57156.42843571511, 11961.401929903644, 12089.697757556132, 12099.637010889688, 12217.93891030539, 12473.877351038087, 14393.0, 14533.27333633293, 14607.85392146065, 14647.267636617913, 14724.55826325212, 13796.448142074205, 13844.723105538034, 14003.579892603238, 15550.533483995498, 15748.370065197263, 14469.204193769443, 14616.926915365355, 15922.840771592137, 16568.088755118584, 17145.228464718868, 14657.120572765669, 15522.301496432914, 15831.841681583037, 16802.663946720753, 16815.831841681917, 13230.338483076, 13310.534131305745, 13519.256440895846, 13979.93010034984, 14121.364538595582, 12210.816837747263, 12390.62828115158, 13579.660508487366, 13584.86415135836, 13735.107218030797], "value": 7926.423529905523, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1451.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 112.0, 111.0, 111.0, 112.0, 112.0, 111.0, 113.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 116.0, 119.0, 161.0, 115.0, 120.0, 115.0, 116.0, 130.0, 116.0], "value": 124.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 162.0, 161.0, 161.0, 160.0, 162.0, 161.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 107.0, 77.0, 76.0, 75.0, 75.0, 89.0, 74.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 105.0, 81.0, 81.0, 81.0, 100.0, 81.0, 81.0, 98.0], "value": 87.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 95.0, 93.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 58.0, 54.0, 55.0, 54.0, 54.0, 54.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 53.0, 54.0, 54.0, 54.0, 53.0, 53.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 84.0, 75.0, 80.0, 79.0, 75.0, 76.0, 75.0, 81.0, 75.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 121.0, 122.0, 121.0, 130.0, 132.0, 127.0, 127.0, 159.0, 133.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 158.0, 158.0, 157.0, 155.0, 157.0, 166.0, 163.0, 156.0, 158.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 63.0, 59.0, 59.0, 64.0, 60.0, 60.0, 59.0], "value": 60.3, "unit": "score"}]}]} 09:32:46 INFO - Return code: 0 09:32:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:32:47 ERROR - # TBPL SUCCESS # 09:32:47 INFO - Running post-action listener: _resource_record_post_action 09:32:47 INFO - [mozharness: 2017-03-21 16:32:47.032233Z] Finished run-tests step (success) 09:32:47 INFO - Running post-run listener: _resource_record_post_run 09:32:47 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 368082944; Read time: 12; Write time: 233584 09:32:47 INFO - TinderboxPrint: CPU usage
13.1% 09:32:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:32:47 INFO - TinderboxPrint: I/O write bytes / time
368,082,944 / 233,584 09:32:47 INFO - TinderboxPrint: CPU idle
8,265.3 (86.9%) 09:32:47 INFO - TinderboxPrint: CPU user
1,201.9 (12.6%) 09:32:47 INFO - TinderboxPrint: Swap in / out
0 / 0 09:32:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110735360; Read time: 0; Write time: 111320 09:32:47 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 257347584; Read time: 12; Write time: 122264 09:32:47 INFO - Running post-run listener: _upload_blobber_files 09:32:47 INFO - Blob upload gear active. 09:32:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:32:47 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:32:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:32:48 INFO - (blobuploader) - INFO - Open directory for files ... 09:32:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:32:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:32:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:32:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:32:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:32:49 INFO - (blobuploader) - INFO - Done attempting. 09:32:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:32:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:32:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:32:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:32:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:32:49 INFO - (blobuploader) - INFO - Done attempting. 09:32:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:32:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:32:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:32:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:32:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:32:52 INFO - (blobuploader) - INFO - Done attempting. 09:32:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:32:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:32:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:32:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:32:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:32:53 INFO - (blobuploader) - INFO - Done attempting. 09:32:53 INFO - (blobuploader) - INFO - Iteration through files over. 09:32:53 INFO - Return code: 0 09:32:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:32:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:32:53 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de89bfa575553a1704039b09da3a1100a645f9b09f11ce64153e9ab26af24ba0ded4ce7b80e410315e5e555cb4dad72a1beeb91fb325a03f9b90dc79d8b44498", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de650eeeba2b2e997834f7987620bfdfb4f27ebde2e9243fa6b6ef609e9830a47fb1352a82742a997fe9fb266a7bdfa88fe7649442a229cb48c974c5c1d072d3", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bcac6420b6d65f4423e7ba5d6614700c9a7934a36986900dd595e250d65563b45fde02a3008394c2b2b1d368d8375539060bebdba859fd256c0edea21ba2a32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/970e1ccc461c25ca8fd71a51feef25034049da1adb1fa2fb30be1888087853683d7c3eea0c57a0db7e8913957255ed2901789ed181297e05683a533e2a9f83f5"} 09:32:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:32:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:32:53 INFO - Contents: 09:32:53 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de89bfa575553a1704039b09da3a1100a645f9b09f11ce64153e9ab26af24ba0ded4ce7b80e410315e5e555cb4dad72a1beeb91fb325a03f9b90dc79d8b44498", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de650eeeba2b2e997834f7987620bfdfb4f27ebde2e9243fa6b6ef609e9830a47fb1352a82742a997fe9fb266a7bdfa88fe7649442a229cb48c974c5c1d072d3", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bcac6420b6d65f4423e7ba5d6614700c9a7934a36986900dd595e250d65563b45fde02a3008394c2b2b1d368d8375539060bebdba859fd256c0edea21ba2a32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/970e1ccc461c25ca8fd71a51feef25034049da1adb1fa2fb30be1888087853683d7c3eea0c57a0db7e8913957255ed2901789ed181297e05683a533e2a9f83f5"} 09:32:53 INFO - Running post-run listener: copy_logs_to_upload_dir 09:32:53 INFO - Copying logs to upload dir... 09:32:53 INFO - mkdir: /builds/slave/test/build/upload/logs 09:32:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.048766 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-03-21 09:32:53.231840) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 09:32:53.235574) ========= 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-1490112721.405171-1823671951 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/sha512/de89bfa575553a1704039b09da3a1100a645f9b09f11ce64153e9ab26af24ba0ded4ce7b80e410315e5e555cb4dad72a1beeb91fb325a03f9b90dc79d8b44498", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de650eeeba2b2e997834f7987620bfdfb4f27ebde2e9243fa6b6ef609e9830a47fb1352a82742a997fe9fb266a7bdfa88fe7649442a229cb48c974c5c1d072d3", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bcac6420b6d65f4423e7ba5d6614700c9a7934a36986900dd595e250d65563b45fde02a3008394c2b2b1d368d8375539060bebdba859fd256c0edea21ba2a32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/970e1ccc461c25ca8fd71a51feef25034049da1adb1fa2fb30be1888087853683d7c3eea0c57a0db7e8913957255ed2901789ed181297e05683a533e2a9f83f5"} build_url:https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/JQfrjHwnQk2UEeGe_YYBwQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de89bfa575553a1704039b09da3a1100a645f9b09f11ce64153e9ab26af24ba0ded4ce7b80e410315e5e555cb4dad72a1beeb91fb325a03f9b90dc79d8b44498", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de650eeeba2b2e997834f7987620bfdfb4f27ebde2e9243fa6b6ef609e9830a47fb1352a82742a997fe9fb266a7bdfa88fe7649442a229cb48c974c5c1d072d3", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bcac6420b6d65f4423e7ba5d6614700c9a7934a36986900dd595e250d65563b45fde02a3008394c2b2b1d368d8375539060bebdba859fd256c0edea21ba2a32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/970e1ccc461c25ca8fd71a51feef25034049da1adb1fa2fb30be1888087853683d7c3eea0c57a0db7e8913957255ed2901789ed181297e05683a533e2a9f83f5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 09:32:53.260185) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 09:32:53.260498) ========= 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-1490112721.405171-1823671951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 09:32:53.312320) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 09:32:53.312635) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 09:32:53.312897) ========= ========= Total master_lag: 0.13 =========