builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-079 starttime: 1491491653.11 results: success (0) revision: e03c56f3a839d1575e87dbd782638ad4894429e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-06 08:14:13.106064) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-06 08:14:13.106516) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-06 08:14:13.106807) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-06 08:14:13.125369) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 08:14:13.125786) ========= 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=1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-06 08:14:13-- 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% 220M=0s 2017-04-06 08:14:13 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.180868 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 08:14:13.322420) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 08:14:13.322784) ========= 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=1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016709 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 08:14:13.372580) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-06 08:14:13.376010) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e03c56f3a839d1575e87dbd782638ad4894429e8 --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 e03c56f3a839d1575e87dbd782638ad4894429e8 --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=1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-06 08:14:13,866 truncating revision to first 12 chars 2017-04-06 08:14:13,866 Setting DEBUG logging. 2017-04-06 08:14:13,866 attempt 1/10 2017-04-06 08:14:13,866 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e03c56f3a839?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-06 08:14:15,073 unpacking tar archive at: mozilla-aurora-e03c56f3a839/testing/mozharness/ program finished with exit code 0 elapsedTime=1.561692 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-06 08:14:14.951780) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-06 08:14:14.952131) ========= script_repo_revision: e03c56f3a839d1575e87dbd782638ad4894429e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-06 08:14:14.952573) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-06 08:14:14.952898) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-06 08:14:14.963256) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-04-06 08:14:14.963972) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:14:15 INFO - MultiFileLogger online at 20170406 08:14:15 in /builds/slave/test 08:14:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 08:14:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:14:15 INFO - {'append_to_log': False, 08:14:15 INFO - 'base_work_dir': '/builds/slave/test', 08:14:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 08:14:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:14:15 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 08:14:15 INFO - 'buildbot_json_path': 'buildprops.json', 08:14:15 INFO - 'config_files': ('talos/linux_config.py',), 08:14:15 INFO - 'default_actions': ('clobber', 08:14:15 INFO - 'read-buildbot-config', 08:14:15 INFO - 'download-and-extract', 08:14:15 INFO - 'populate-webroot', 08:14:15 INFO - 'create-virtualenv', 08:14:15 INFO - 'install', 08:14:15 INFO - 'run-tests'), 08:14:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:14:15 INFO - 'download_minidump_stackwalk': True, 08:14:15 INFO - 'download_symbols': 'ondemand', 08:14:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:14:15 INFO - 'tooltool.py': '/tools/tooltool.py', 08:14:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:14:15 INFO - '/tools/misc-python/virtualenv.py')}, 08:14:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:14:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:14:15 INFO - 'gecko_profile': False, 08:14:15 INFO - 'gecko_profile_interval': 0, 08:14:15 INFO - 'installer_path': 'installer.exe', 08:14:15 INFO - 'log_level': 'info', 08:14:15 INFO - 'log_name': 'talos', 08:14:15 INFO - 'log_to_console': True, 08:14:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:14:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:14:15 INFO - 'opt_config_files': (), 08:14:15 INFO - 'pip_index': False, 08:14:15 INFO - 'suite': 'dromaeojs', 08:14:15 INFO - 'system_bits': '32', 08:14:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:14:15 INFO - 'title': 'talos-linux64-ix-079', 08:14:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:14:15 INFO - 'use_talos_json': True, 08:14:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:14:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:14:15 INFO - 'work_dir': 'build'} 08:14:15 INFO - [mozharness: 2017-04-06 15:14:15.552365Z] Running clobber step. 08:14:15 INFO - Running pre-action listener: _resource_record_pre_action 08:14:15 INFO - Running main action method: clobber 08:14:15 INFO - rmtree: /builds/slave/test/build 08:14:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:14:16 INFO - Running post-action listener: _resource_record_post_action 08:14:16 INFO - [mozharness: 2017-04-06 15:14:16.480261Z] Finished clobber step (success) 08:14:16 INFO - [mozharness: 2017-04-06 15:14:16.480360Z] Running read-buildbot-config step. 08:14:16 INFO - Running pre-action listener: _resource_record_pre_action 08:14:16 INFO - Running main action method: read_buildbot_config 08:14:16 INFO - Using buildbot properties: 08:14:16 INFO - { 08:14:16 INFO - "project": "", 08:14:16 INFO - "product": "firefox", 08:14:16 INFO - "who": "bhearsum@mozilla.com", 08:14:16 INFO - "installer_path": "public/build/target.tar.bz2", 08:14:16 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:14:16 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 08:14:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 08:14:16 INFO - "stage_platform": "linux64", 08:14:16 INFO - "basedir": "/builds/slave/test", 08:14:16 INFO - "buildnumber": 120, 08:14:16 INFO - "platform": "ubuntu64_hw", 08:14:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:14:16 INFO - "slavebuilddir": "test", 08:14:16 INFO - "taskId": "QxoLjdtOSrutJ2wz7rqZ5Q", 08:14:16 INFO - "branch": "mozilla-aurora", 08:14:16 INFO - "script_repo_revision": "production", 08:14:16 INFO - "revision": "e03c56f3a839d1575e87dbd782638ad4894429e8", 08:14:16 INFO - "slavename": "talos-linux64-ix-079", 08:14:16 INFO - "repo_path": "releases/mozilla-aurora" 08:14:16 INFO - } 08:14:16 INFO - Finding installer, test and symbols from parent task. 08:14:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QxoLjdtOSrutJ2wz7rqZ5Q'}, attempt #1 08:14:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QxoLjdtOSrutJ2wz7rqZ5Q'}, attempt #1 08:14:17 INFO - Task dependencies: CWp0vHGKR6uOc00E_96wMA 08:14:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA'}, attempt #1 08:14:17 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.tar.bz2 08:14:17 INFO - Set test_url: https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/test_packages.json 08:14:17 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.crashreporter-symbols.zip 08:14:17 INFO - Running post-action listener: _resource_record_post_action 08:14:17 INFO - [mozharness: 2017-04-06 15:14:17.966273Z] Finished read-buildbot-config step (success) 08:14:17 INFO - [mozharness: 2017-04-06 15:14:17.966491Z] Running download-and-extract step. 08:14:17 INFO - Running pre-action listener: _resource_record_pre_action 08:14:17 INFO - Running main action method: download_and_extract 08:14:17 INFO - mkdir: /builds/slave/test/build/tests 08:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:17 INFO - trying https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.test_packages.json 08:14:17 INFO - Downloading https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:14:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:14:18 INFO - Downloaded 896 bytes. 08:14:18 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:14:18 INFO - Using the following test package requirements: 08:14:18 INFO - {u'common': [u'target.common.tests.zip'], 08:14:18 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:14:18 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:14:18 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:14:18 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:14:18 INFO - u'mozbase': [u'target.common.tests.zip'], 08:14:18 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:14:18 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:14:18 INFO - u'web-platform': [u'target.common.tests.zip', 08:14:18 INFO - u'target.web-platform.tests.zip'], 08:14:18 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:14:18 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:14:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.common.tests.zip 08:14:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:14:18 INFO - Fetch https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.common.tests.zip into memory 08:14:19 INFO - Expected file size: 59539299 08:14:19 INFO - Obtained file size: 59539299 08:14:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:14:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.common.tests.zip 08:14:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:14:29 INFO - Fetch https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.common.tests.zip into memory 08:14:30 INFO - Expected file size: 59539299 08:14:30 INFO - Obtained file size: 59539299 08:14:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.talos.tests.zip 08:14:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:14:41 INFO - Fetch https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.talos.tests.zip into memory 08:14:41 INFO - Expected file size: 14404438 08:14:41 INFO - Obtained file size: 14404438 08:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:42 INFO - trying https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.tar.bz2 08:14:42 INFO - Downloading https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:14:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:14:43 INFO - Downloaded 66801962 bytes. 08:14:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.tar.bz2 08:14:43 INFO - mkdir: /builds/slave/test/properties 08:14:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:43 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:43 INFO - Contents: 08:14:43 INFO - build_url:https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.tar.bz2 08:14:43 INFO - Running post-action listener: _resource_record_post_action 08:14:43 INFO - Running post-action listener: set_extra_try_arguments 08:14:43 INFO - [mozharness: 2017-04-06 15:14:43.340405Z] Finished download-and-extract step (success) 08:14:43 INFO - [mozharness: 2017-04-06 15:14:43.340501Z] Running populate-webroot step. 08:14:43 INFO - Running pre-action listener: _resource_record_pre_action 08:14:43 INFO - Running main action method: populate_webroot 08:14:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:43 INFO - '--tppagecycles', 08:14:43 INFO - '7'], 08:14:43 INFO - 'tests': ['tsvgm']}}, 08:14:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:14:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:14:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:14:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:14:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:14:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:14:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:14:43 INFO - 'talos_options': ['--disable-e10s'], 08:14:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:14:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:14:43 INFO - 'talos_options': ['--disable-e10s'], 08:14:43 INFO - 'tests': ['damp', 'tps']}, 08:14:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:14:43 INFO - 'tests': ['damp', 'tps']}, 08:14:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:14:43 INFO - 'tests': ['dromaeo_dom']}, 08:14:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:14:43 INFO - 'tests': ['basic_compositor_video']}, 08:14:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:14:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:14:43 INFO - 'tests': ['a11yr', 08:14:43 INFO - 'ts_paint', 08:14:43 INFO - 'tpaint', 08:14:43 INFO - 'sessionrestore', 08:14:43 INFO - 'sessionrestore_no_auto_restore', 08:14:43 INFO - 'tabpaint']}, 08:14:43 INFO - 'other-e10s': {'tests': ['a11yr', 08:14:43 INFO - 'ts_paint', 08:14:43 INFO - 'tpaint', 08:14:43 INFO - 'sessionrestore', 08:14:43 INFO - 'sessionrestore_no_auto_restore', 08:14:43 INFO - 'tabpaint']}, 08:14:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:14:43 INFO - 'ts_paint', 08:14:43 INFO - 'tpaint', 08:14:43 INFO - 'sessionrestore', 08:14:43 INFO - 'sessionrestore_no_auto_restore', 08:14:43 INFO - 'tabpaint']}, 08:14:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:14:43 INFO - 'ts_paint', 08:14:43 INFO - 'tpaint', 08:14:43 INFO - 'sessionrestore', 08:14:43 INFO - 'sessionrestore_no_auto_restore', 08:14:43 INFO - 'tabpaint']}, 08:14:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:14:43 INFO - 'tests': ['a11yr', 08:14:43 INFO - 'ts_paint', 08:14:43 INFO - 'tpaint', 08:14:43 INFO - 'sessionrestore', 08:14:43 INFO - 'sessionrestore_no_auto_restore', 08:14:43 INFO - 'tabpaint']}, 08:14:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:14:43 INFO - 'tests': ['a11yr', 08:14:43 INFO - 'ts_paint', 08:14:43 INFO - 'tpaint', 08:14:43 INFO - 'sessionrestore', 08:14:43 INFO - 'sessionrestore_no_auto_restore', 08:14:43 INFO - 'tabpaint']}, 08:14:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:14:43 INFO - 'tests': ['tsvgx', 08:14:43 INFO - 'tsvgr_opacity', 08:14:43 INFO - 'tart', 08:14:43 INFO - 'tscrollx', 08:14:43 INFO - 'cart', 08:14:43 INFO - 'tsvg_static']}, 08:14:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:14:43 INFO - 'tsvgr_opacity', 08:14:43 INFO - 'tart', 08:14:43 INFO - 'tscrollx', 08:14:43 INFO - 'cart', 08:14:43 INFO - 'tsvg_static']}, 08:14:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:14:43 INFO - 'talos_options': ['--disable-e10s'], 08:14:43 INFO - 'tests': ['tp5o']}, 08:14:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:14:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:14:43 INFO - 'talos_options': ['--disable-e10s', 08:14:43 INFO - '--xperf_path', 08:14:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:43 INFO - 'tests': ['tp5n']}, 08:14:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:14:43 INFO - 'talos_options': ['--xperf_path', 08:14:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:43 INFO - 'tests': ['tp5n']}}, 08:14:43 INFO - 'talos.zip': {'path': '', 08:14:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:43 INFO - Running post-action listener: _resource_record_post_action 08:14:43 INFO - [mozharness: 2017-04-06 15:14:43.353669Z] Finished populate-webroot step (success) 08:14:43 INFO - [mozharness: 2017-04-06 15:14:43.353758Z] Running create-virtualenv step. 08:14:43 INFO - Running pre-action listener: _resource_record_pre_action 08:14:43 INFO - Running main action method: create_virtualenv 08:14:43 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:43 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 08:14:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:43 INFO - Using real prefix '/usr' 08:14:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:43 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:45 INFO - Installing pip.................done. 08:14:45 INFO - Return code: 0 08:14:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:14:46 INFO - Reading from file tmpfile_stdout 08:14:46 INFO - Output received: 08:14:46 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) 08:14:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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')]} 08:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:46 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 0x1acb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b09a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d66400>, '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 0x1d673b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67840>, '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': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', '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 08:14:46 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 08:14:46 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 08:14:46 INFO - Using env: {'DISPLAY': ':0', 08:14:46 INFO - 'HOME': '/home/cltbld', 08:14:46 INFO - 'LANG': 'en_US.UTF-8', 08:14:46 INFO - 'LANGUAGE': 'en_US:en', 08:14:46 INFO - 'LOGNAME': 'cltbld', 08:14:46 INFO - 'MAIL': '/var/mail/cltbld', 08:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:46 INFO - 'MOZ_NO_REMOTE': '1', 08:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:46 INFO - 'NO_EM_RESTART': '1', 08:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:46 INFO - 'PWD': '/builds/slave/test', 08:14:46 INFO - 'SHELL': '/bin/bash', 08:14:46 INFO - 'SHLVL': '1', 08:14:46 INFO - 'TERM': 'linux', 08:14:46 INFO - 'TMOUT': '86400', 08:14:46 INFO - 'USER': 'cltbld', 08:14:46 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', 08:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:46 INFO - '_': '/tools/buildbot/bin/python'} 08:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:46 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 08:14:46 INFO - Cleaning up... 08:14:46 INFO - Return code: 0 08:14:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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')]} 08:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:46 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 0x1acb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b09a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d66400>, '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 0x1d673b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67840>, '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': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', '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 08:14:46 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 08:14:46 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 08:14:46 INFO - Using env: {'DISPLAY': ':0', 08:14:46 INFO - 'HOME': '/home/cltbld', 08:14:46 INFO - 'LANG': 'en_US.UTF-8', 08:14:46 INFO - 'LANGUAGE': 'en_US:en', 08:14:46 INFO - 'LOGNAME': 'cltbld', 08:14:46 INFO - 'MAIL': '/var/mail/cltbld', 08:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:46 INFO - 'MOZ_NO_REMOTE': '1', 08:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:46 INFO - 'NO_EM_RESTART': '1', 08:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:46 INFO - 'PWD': '/builds/slave/test', 08:14:46 INFO - 'SHELL': '/bin/bash', 08:14:46 INFO - 'SHLVL': '1', 08:14:46 INFO - 'TERM': 'linux', 08:14:46 INFO - 'TMOUT': '86400', 08:14:46 INFO - 'USER': 'cltbld', 08:14:46 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', 08:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:46 INFO - '_': '/tools/buildbot/bin/python'} 08:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:46 INFO - Downloading/unpacking psutil>=3.1.1 08:14:46 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 08:14:46 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 08:14:46 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 08:14:46 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 08:14:46 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 08:14:46 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 08:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:49 INFO - Installing collected packages: psutil 08:14:49 INFO - Running setup.py install for psutil 08:14:49 INFO - building 'psutil._psutil_linux' extension 08:14:49 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 08:14:49 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 08:14:49 INFO - building 'psutil._psutil_posix' extension 08:14:49 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 08:14:49 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 08:14:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:49 INFO - Successfully installed psutil 08:14:49 INFO - Cleaning up... 08:14:49 INFO - Return code: 0 08:14:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:49 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 0x1acb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b09a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d66400>, '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 0x1d673b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67840>, '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': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', '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 08:14:49 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 08:14:49 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 08:14:49 INFO - Using env: {'DISPLAY': ':0', 08:14:49 INFO - 'HOME': '/home/cltbld', 08:14:49 INFO - 'LANG': 'en_US.UTF-8', 08:14:49 INFO - 'LANGUAGE': 'en_US:en', 08:14:49 INFO - 'LOGNAME': 'cltbld', 08:14:49 INFO - 'MAIL': '/var/mail/cltbld', 08:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:49 INFO - 'MOZ_NO_REMOTE': '1', 08:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:49 INFO - 'NO_EM_RESTART': '1', 08:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:49 INFO - 'PWD': '/builds/slave/test', 08:14:49 INFO - 'SHELL': '/bin/bash', 08:14:49 INFO - 'SHLVL': '1', 08:14:49 INFO - 'TERM': 'linux', 08:14:49 INFO - 'TMOUT': '86400', 08:14:49 INFO - 'USER': 'cltbld', 08:14:49 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', 08:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:49 INFO - '_': '/tools/buildbot/bin/python'} 08:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:14:49 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 08:14:49 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 08:14:49 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 08:14:49 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 08:14:49 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 08:14:49 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 08:14:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:14:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:14:51 INFO - Installing collected packages: mozsystemmonitor 08:14:51 INFO - Running setup.py install for mozsystemmonitor 08:14:52 INFO - Successfully installed mozsystemmonitor 08:14:52 INFO - Cleaning up... 08:14:52 INFO - Return code: 0 08:14:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:14:52 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')]} 08:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:52 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')]} 08:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:52 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 0x1acb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b09a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d66400>, '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 0x1d673b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67840>, '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': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', '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 08:14:52 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 08:14:52 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 08:14:52 INFO - Using env: {'DISPLAY': ':0', 08:14:52 INFO - 'HOME': '/home/cltbld', 08:14:52 INFO - 'LANG': 'en_US.UTF-8', 08:14:52 INFO - 'LANGUAGE': 'en_US:en', 08:14:52 INFO - 'LOGNAME': 'cltbld', 08:14:52 INFO - 'MAIL': '/var/mail/cltbld', 08:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:52 INFO - 'MOZ_NO_REMOTE': '1', 08:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:52 INFO - 'NO_EM_RESTART': '1', 08:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:52 INFO - 'PWD': '/builds/slave/test', 08:14:52 INFO - 'SHELL': '/bin/bash', 08:14:52 INFO - 'SHLVL': '1', 08:14:52 INFO - 'TERM': 'linux', 08:14:52 INFO - 'TMOUT': '86400', 08:14:52 INFO - 'USER': 'cltbld', 08:14:52 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', 08:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:52 INFO - '_': '/tools/buildbot/bin/python'} 08:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:52 INFO - Downloading/unpacking jsonschema==2.5.1 08:14:52 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 08:14:52 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 08:14:52 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 08:14:52 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 08:14:52 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 08:14:52 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 08:14:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:14:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:14:55 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 08:14:55 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 08:14:55 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 08:14:55 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 08:14:55 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 08:14:55 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 08:14:55 INFO - Downloading functools32-3.2.3-2.tar.gz 08:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:14:56 INFO - warning: no files found matching '*.txt' 08:14:56 INFO - no previously-included directories found matching 'build' 08:14:56 INFO - no previously-included directories found matching 'dist' 08:14:56 INFO - no previously-included directories found matching '.git*' 08:14:56 INFO - Installing collected packages: jsonschema, functools32 08:14:56 INFO - Running setup.py install for functools32 08:14:56 INFO - warning: no files found matching '*.txt' 08:14:56 INFO - no previously-included directories found matching 'build' 08:14:56 INFO - no previously-included directories found matching 'dist' 08:14:56 INFO - no previously-included directories found matching '.git*' 08:14:56 INFO - Successfully installed jsonschema functools32 08:14:56 INFO - Cleaning up... 08:14:56 INFO - Return code: 0 08:14:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1acb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b09a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d66400>, '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 0x1d673b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67840>, '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': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', '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 08:14:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:14:56 INFO - Using env: {'DISPLAY': ':0', 08:14:56 INFO - 'HOME': '/home/cltbld', 08:14:56 INFO - 'LANG': 'en_US.UTF-8', 08:14:56 INFO - 'LANGUAGE': 'en_US:en', 08:14:56 INFO - 'LOGNAME': 'cltbld', 08:14:56 INFO - 'MAIL': '/var/mail/cltbld', 08:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:56 INFO - 'MOZ_NO_REMOTE': '1', 08:14:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:56 INFO - 'NO_EM_RESTART': '1', 08:14:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:56 INFO - 'PWD': '/builds/slave/test', 08:14:56 INFO - 'SHELL': '/bin/bash', 08:14:56 INFO - 'SHLVL': '1', 08:14:56 INFO - 'TERM': 'linux', 08:14:56 INFO - 'TMOUT': '86400', 08:14:56 INFO - 'USER': 'cltbld', 08:14:56 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', 08:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:56 INFO - '_': '/tools/buildbot/bin/python'} 08:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:14:57 INFO - Cleaning up... 08:14:57 INFO - Return code: 0 08:14:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:57 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 0x1acb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b09a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d66400>, '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 0x1d673b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67840>, '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': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', '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 08:14:57 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 08:14:57 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 08:14:57 INFO - Using env: {'DISPLAY': ':0', 08:14:57 INFO - 'HOME': '/home/cltbld', 08:14:57 INFO - 'LANG': 'en_US.UTF-8', 08:14:57 INFO - 'LANGUAGE': 'en_US:en', 08:14:57 INFO - 'LOGNAME': 'cltbld', 08:14:57 INFO - 'MAIL': '/var/mail/cltbld', 08:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:57 INFO - 'MOZ_NO_REMOTE': '1', 08:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:57 INFO - 'NO_EM_RESTART': '1', 08:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:57 INFO - 'PWD': '/builds/slave/test', 08:14:57 INFO - 'SHELL': '/bin/bash', 08:14:57 INFO - 'SHLVL': '1', 08:14:57 INFO - 'TERM': 'linux', 08:14:57 INFO - 'TMOUT': '86400', 08:14:57 INFO - 'USER': 'cltbld', 08:14:57 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', 08:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:57 INFO - '_': '/tools/buildbot/bin/python'} 08:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:57 INFO - Downloading/unpacking blobuploader==1.2.4 08:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:59 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:15:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:15:00 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 08:15:00 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 08:15:00 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 08:15:00 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 08:15:00 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 08:15:00 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 08:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:15:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:15:00 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 08:15:00 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 08:15:00 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 08:15:00 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 08:15:00 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 08:15:00 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 08:15:00 INFO - Downloading docopt-0.6.1.tar.gz 08:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:15:00 INFO - Installing collected packages: blobuploader, requests, docopt 08:15:00 INFO - Running setup.py install for blobuploader 08:15:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:15:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:15:00 INFO - Running setup.py install for requests 08:15:01 INFO - Running setup.py install for docopt 08:15:01 INFO - Successfully installed blobuploader requests docopt 08:15:01 INFO - Cleaning up... 08:15:01 INFO - Return code: 0 08:15:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:01 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 0x1acb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b09a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d66400>, '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 0x1d673b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67840>, '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': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', '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 08:15:01 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 08:15:01 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 08:15:01 INFO - Using env: {'DISPLAY': ':0', 08:15:01 INFO - 'HOME': '/home/cltbld', 08:15:01 INFO - 'LANG': 'en_US.UTF-8', 08:15:01 INFO - 'LANGUAGE': 'en_US:en', 08:15:01 INFO - 'LOGNAME': 'cltbld', 08:15:01 INFO - 'MAIL': '/var/mail/cltbld', 08:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:01 INFO - 'MOZ_NO_REMOTE': '1', 08:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:01 INFO - 'NO_EM_RESTART': '1', 08:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:01 INFO - 'PWD': '/builds/slave/test', 08:15:01 INFO - 'SHELL': '/bin/bash', 08:15:01 INFO - 'SHLVL': '1', 08:15:01 INFO - 'TERM': 'linux', 08:15:01 INFO - 'TMOUT': '86400', 08:15:01 INFO - 'USER': 'cltbld', 08:15:01 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', 08:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:01 INFO - '_': '/tools/buildbot/bin/python'} 08:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:15:01 INFO - Running setup.py (path:/tmp/pip-gQKp_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:15:01 INFO - Running setup.py (path:/tmp/pip-23l5D2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:15:01 INFO - Running setup.py (path:/tmp/pip-9HBBZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:15:01 INFO - Running setup.py (path:/tmp/pip-MmFKkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:15:01 INFO - Running setup.py (path:/tmp/pip-w8Qz9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:15:01 INFO - Running setup.py (path:/tmp/pip-qPVV5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:15:02 INFO - Running setup.py (path:/tmp/pip-zLL_Ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:15:02 INFO - Running setup.py (path:/tmp/pip-yuTwuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:15:02 INFO - Running setup.py (path:/tmp/pip-XhAWdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:15:02 INFO - Running setup.py (path:/tmp/pip-CaBgcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:15:02 INFO - Running setup.py (path:/tmp/pip-8Khg6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:15:02 INFO - Running setup.py (path:/tmp/pip-BJd265-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:15:02 INFO - Running setup.py (path:/tmp/pip-B4rOFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:15:02 INFO - Running setup.py (path:/tmp/pip-hTUUA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:02 INFO - Running setup.py (path:/tmp/pip-mry7Pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:15:02 INFO - Running setup.py (path:/tmp/pip-pDL406-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:15:02 INFO - Running setup.py (path:/tmp/pip-oMTsBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:15:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:15:02 INFO - Running setup.py install for manifestparser 08:15:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:15:02 INFO - Running setup.py install for mozcrash 08:15:03 INFO - Running setup.py install for mozdebug 08:15:03 INFO - Running setup.py install for mozdevice 08:15:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:15:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:15:03 INFO - Running setup.py install for mozfile 08:15:03 INFO - Running setup.py install for mozhttpd 08:15:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:15:03 INFO - Running setup.py install for mozinfo 08:15:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:15:03 INFO - Running setup.py install for mozInstall 08:15:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:15:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:15:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:15:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:15:03 INFO - Running setup.py install for mozleak 08:15:03 INFO - Running setup.py install for mozlog 08:15:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:15:03 INFO - Running setup.py install for moznetwork 08:15:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:15:03 INFO - Running setup.py install for mozprocess 08:15:04 INFO - Running setup.py install for mozprofile 08:15:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:15:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:15:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:15:04 INFO - Running setup.py install for mozrunner 08:15:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:15:04 INFO - Running setup.py install for mozscreenshot 08:15:04 INFO - Running setup.py install for moztest 08:15:04 INFO - Running setup.py install for mozversion 08:15:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:15:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:15:04 INFO - Cleaning up... 08:15:04 INFO - Return code: 0 08:15:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:04 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 0x1acb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b09a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d66400>, '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 0x1d673b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67840>, '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': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', '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 08:15:04 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 08:15:04 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 08:15:04 INFO - Using env: {'DISPLAY': ':0', 08:15:04 INFO - 'HOME': '/home/cltbld', 08:15:04 INFO - 'LANG': 'en_US.UTF-8', 08:15:04 INFO - 'LANGUAGE': 'en_US:en', 08:15:04 INFO - 'LOGNAME': 'cltbld', 08:15:04 INFO - 'MAIL': '/var/mail/cltbld', 08:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:04 INFO - 'MOZ_NO_REMOTE': '1', 08:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:04 INFO - 'NO_EM_RESTART': '1', 08:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:04 INFO - 'PWD': '/builds/slave/test', 08:15:04 INFO - 'SHELL': '/bin/bash', 08:15:04 INFO - 'SHLVL': '1', 08:15:04 INFO - 'TERM': 'linux', 08:15:04 INFO - 'TMOUT': '86400', 08:15:04 INFO - 'USER': 'cltbld', 08:15:04 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', 08:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:04 INFO - '_': '/tools/buildbot/bin/python'} 08:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:15:04 INFO - Running setup.py (path:/tmp/pip-EzYVth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:15:04 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)) 08:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:15:04 INFO - Running setup.py (path:/tmp/pip-gKR1WW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:15:05 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)) 08:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:15:05 INFO - Running setup.py (path:/tmp/pip-5zktFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:15:05 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)) 08:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:15:05 INFO - Running setup.py (path:/tmp/pip-dynVIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:15:05 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)) 08:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:15:05 INFO - Running setup.py (path:/tmp/pip-e7oRfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:15:05 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)) 08:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:15:05 INFO - Running setup.py (path:/tmp/pip-1VZvz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:15:05 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)) 08:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:15:05 INFO - Running setup.py (path:/tmp/pip-kDU0El-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:15:05 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)) 08:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:15:05 INFO - Running setup.py (path:/tmp/pip-HMOGj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:15:05 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)) 08:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:15:05 INFO - Running setup.py (path:/tmp/pip-2FBPUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:15:05 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)) 08:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:15:05 INFO - Running setup.py (path:/tmp/pip-UJwpFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:15:05 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)) 08:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:15:05 INFO - Running setup.py (path:/tmp/pip-A90jYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:15:05 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)) 08:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:15:05 INFO - Running setup.py (path:/tmp/pip-yDPOD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:15:05 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)) 08:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:15:05 INFO - Running setup.py (path:/tmp/pip-CQzqGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:15:05 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)) 08:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:15:05 INFO - Running setup.py (path:/tmp/pip-mmwpks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:15:05 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)) 08:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:05 INFO - Running setup.py (path:/tmp/pip-gi82LD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:05 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)) 08:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:15:05 INFO - Running setup.py (path:/tmp/pip-S6I_P7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:15:06 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)) 08:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:15:06 INFO - Running setup.py (path:/tmp/pip-nXEm1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:15:06 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)) 08:15:06 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)) 08:15:06 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)) 08:15:06 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)) 08:15:06 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)) 08:15:06 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)) 08:15:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:08 INFO - Downloading blessings-1.6.tar.gz 08:15:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:15:08 INFO - Installing collected packages: blessings 08:15:08 INFO - Running setup.py install for blessings 08:15:08 INFO - Successfully installed blessings 08:15:08 INFO - Cleaning up... 08:15:08 INFO - Return code: 0 08:15:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:15:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:08 INFO - Reading from file tmpfile_stdout 08:15:08 INFO - Current package versions: 08:15:08 INFO - argparse == 1.2.1 08:15:08 INFO - blessings == 1.6 08:15:08 INFO - blobuploader == 1.2.4 08:15:08 INFO - docopt == 0.6.1 08:15:08 INFO - functools32 == 3.2.3-2 08:15:08 INFO - jsonschema == 2.5.1 08:15:08 INFO - manifestparser == 1.1 08:15:08 INFO - mozInstall == 1.12 08:15:08 INFO - mozcrash == 1.0 08:15:08 INFO - mozdebug == 0.1 08:15:08 INFO - mozdevice == 0.49 08:15:08 INFO - mozfile == 1.2 08:15:08 INFO - mozhttpd == 0.7 08:15:08 INFO - mozinfo == 0.9 08:15:08 INFO - mozleak == 0.1 08:15:08 INFO - mozlog == 3.4 08:15:08 INFO - moznetwork == 0.27 08:15:08 INFO - mozprocess == 0.25 08:15:08 INFO - mozprofile == 0.28 08:15:08 INFO - mozrunner == 6.13 08:15:08 INFO - mozscreenshot == 0.1 08:15:08 INFO - mozsystemmonitor == 0.3 08:15:08 INFO - moztest == 0.8 08:15:08 INFO - mozversion == 1.4 08:15:08 INFO - psutil == 3.1.1 08:15:08 INFO - requests == 1.2.3 08:15:08 INFO - wsgiref == 0.1.2 08:15:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:08 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 0x1acb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b09a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d66400>, '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 0x1d673b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67840>, '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': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', '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 08:15:08 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 08:15:08 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 08:15:08 INFO - Using env: {'DISPLAY': ':0', 08:15:08 INFO - 'HOME': '/home/cltbld', 08:15:08 INFO - 'LANG': 'en_US.UTF-8', 08:15:08 INFO - 'LANGUAGE': 'en_US:en', 08:15:08 INFO - 'LOGNAME': 'cltbld', 08:15:08 INFO - 'MAIL': '/var/mail/cltbld', 08:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:08 INFO - 'MOZ_NO_REMOTE': '1', 08:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:08 INFO - 'NO_EM_RESTART': '1', 08:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:08 INFO - 'PWD': '/builds/slave/test', 08:15:08 INFO - 'SHELL': '/bin/bash', 08:15:08 INFO - 'SHLVL': '1', 08:15:08 INFO - 'TERM': 'linux', 08:15:08 INFO - 'TMOUT': '86400', 08:15:08 INFO - 'USER': 'cltbld', 08:15:08 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', 08:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:08 INFO - '_': '/tools/buildbot/bin/python'} 08:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:08 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)) 08:15:08 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)) 08:15:08 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)) 08:15:08 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)) 08:15:08 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)) 08:15:08 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)) 08:15:08 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)) 08:15:08 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)) 08:15:08 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)) 08:15:08 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)) 08:15:08 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)) 08:15:08 INFO - Cleaning up... 08:15:08 INFO - Return code: 0 08:15:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1acb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b09a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d66400>, '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 0x1d673b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67840>, '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': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', '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 08:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:15:08 INFO - Using env: {'DISPLAY': ':0', 08:15:08 INFO - 'HOME': '/home/cltbld', 08:15:08 INFO - 'LANG': 'en_US.UTF-8', 08:15:08 INFO - 'LANGUAGE': 'en_US:en', 08:15:08 INFO - 'LOGNAME': 'cltbld', 08:15:08 INFO - 'MAIL': '/var/mail/cltbld', 08:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:08 INFO - 'MOZ_NO_REMOTE': '1', 08:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:08 INFO - 'NO_EM_RESTART': '1', 08:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:08 INFO - 'PWD': '/builds/slave/test', 08:15:08 INFO - 'SHELL': '/bin/bash', 08:15:08 INFO - 'SHLVL': '1', 08:15:08 INFO - 'TERM': 'linux', 08:15:08 INFO - 'TMOUT': '86400', 08:15:08 INFO - 'USER': 'cltbld', 08:15:08 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', 08:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:08 INFO - '_': '/tools/buildbot/bin/python'} 08:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:15:09 INFO - Cleaning up... 08:15:09 INFO - Return code: 0 08:15:09 INFO - Running post-action listener: _resource_record_post_action 08:15:09 INFO - Running post-action listener: _start_resource_monitoring 08:15:09 INFO - Starting resource monitoring. 08:15:09 INFO - [mozharness: 2017-04-06 15:15:09.050197Z] Finished create-virtualenv step (success) 08:15:09 INFO - [mozharness: 2017-04-06 15:15:09.050660Z] Running install step. 08:15:09 INFO - Running pre-action listener: _resource_record_pre_action 08:15:09 INFO - Running main action method: install 08:15:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:09 INFO - Reading from file tmpfile_stdout 08:15:09 INFO - Detecting whether we're running mozinstall >=1.0... 08:15:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:15:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:15:09 INFO - Reading from file tmpfile_stdout 08:15:09 INFO - Output received: 08:15:09 INFO - Usage: mozinstall [options] installer 08:15:09 INFO - Options: 08:15:09 INFO - -h, --help show this help message and exit 08:15:09 INFO - -d DEST, --destination=DEST 08:15:09 INFO - Directory to install application into. [default: 08:15:09 INFO - "/builds/slave/test"] 08:15:09 INFO - --app=APP Application being installed. [default: firefox] 08:15:09 INFO - mkdir: /builds/slave/test/build/application 08:15:09 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'] 08:15:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:15:26 INFO - Reading from file tmpfile_stdout 08:15:26 INFO - Output received: 08:15:26 INFO - /builds/slave/test/build/application/firefox/firefox 08:15:26 INFO - Running post-action listener: _resource_record_post_action 08:15:26 INFO - [mozharness: 2017-04-06 15:15:26.042318Z] Finished install step (success) 08:15:26 INFO - [mozharness: 2017-04-06 15:15:26.042590Z] Running run-tests step. 08:15:26 INFO - Running pre-action listener: _resource_record_pre_action 08:15:26 INFO - Running main action method: run_tests 08:15:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:15:26 INFO - Python 2.7.3 08:15:26 INFO - Return code: 0 08:15:26 INFO - grabbing minidump binary from tooltool 08:15:26 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')]} 08:15:26 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 0x1d66400>, '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 0x1d673b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d67840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:15:26 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 08:15:26 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 08:15:26 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 08:15:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:15:26 INFO - Return code: 0 08:15:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:15:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:15:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:15:26 INFO - ENV: RUST_BACKTRACE is now 1 08:15:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:15:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:15:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 08:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-079 --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 08:15:26 INFO - Using env: {'DISPLAY': ':0', 08:15:26 INFO - 'HOME': '/home/cltbld', 08:15:26 INFO - 'LANG': 'en_US.UTF-8', 08:15:26 INFO - 'LANGUAGE': 'en_US:en', 08:15:26 INFO - 'LOGNAME': 'cltbld', 08:15:26 INFO - 'MAIL': '/var/mail/cltbld', 08:15:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:15:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:26 INFO - 'MOZ_NO_REMOTE': '1', 08:15:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:15:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:26 INFO - 'NO_EM_RESTART': '1', 08:15:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:26 INFO - 'PWD': '/builds/slave/test', 08:15:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:15:26 INFO - 'RUST_BACKTRACE': '1', 08:15:26 INFO - 'SHELL': '/bin/bash', 08:15:26 INFO - 'SHLVL': '1', 08:15:26 INFO - 'TERM': 'linux', 08:15:26 INFO - 'TMOUT': '86400', 08:15:26 INFO - 'USER': 'cltbld', 08:15:26 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845', 08:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:26 INFO - '_': '/tools/buildbot/bin/python'} 08:15:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 08:15:26 INFO - mozversion application_buildid: 20170406141857 08:15:26 INFO - mozversion application_changeset: e03c56f3a839d1575e87dbd782638ad4894429e8 08:15:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:15:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:15:26 INFO - mozversion application_name: Firefox 08:15:26 INFO - mozversion application_remotingname: firefox-dev 08:15:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:15:26 INFO - mozversion application_vendor: Mozilla 08:15:26 INFO - mozversion application_version: 54.0a2 08:15:26 INFO - mozversion platform_buildid: 20170406141857 08:15:26 INFO - mozversion platform_changeset: e03c56f3a839d1575e87dbd782638ad4894429e8 08:15:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:15:26 INFO - mozversion platform_version: 54.0a2 08:15:26 INFO - using testdate: 1491491726 08:15:26 INFO - actual date: 1491491726 08:15:26 INFO - starting webserver on 'localhost:53258' 08:15:26 INFO - SUITE-START | Running 2 tests 08:15:26 INFO - TEST-START | dromaeo_css 08:15:26 INFO - operating with platform_type : linux_ 08:15:26 INFO - Initialising browser for dromaeo_css test... 08:15:26 INFO - TEST-INFO | started process 1907 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplNInze/profile http://localhost:53258/getInfo.html) 08:15:30 INFO - PROCESS | 1907 | __metrics Screen width/height:1600/1200 08:15:30 INFO - PROCESS | 1907 | colorDepth:24 08:15:30 INFO - PROCESS | 1907 | Browser inner width/height: 1024/697 08:15:30 INFO - PROCESS | 1907 | __metrics 08:15:31 INFO - PROCESS | 1907 | 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" 08:15:31 INFO - PROCESS | 1907 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:15:32 INFO - PROCESS | 1907 | console.error: PushService: 08:15:32 INFO - PROCESS | 1907 | stateChangeProcessEnqueue: Error transitioning state 08:15:32 INFO - PROCESS | 1907 | UnknownError 08:15:32 INFO - TEST-INFO | 1907: exit 0 08:15:32 INFO - Browser initialized. 08:15:32 INFO - Running cycle 1/1 for dromaeo_css test... 08:15:32 INFO - TEST-INFO | started process 1998 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplNInze/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:44 INFO - PROCESS | 1998 | RSS: Main: 140066816 08:15:44 INFO - PROCESS | 1998 | 08:18:46 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:53258/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53258/tests/dromaeo/cssquery-ext.html) 08:18:48 INFO - PROCESS | 1998 | RSS: Main: 280113152 08:18:48 INFO - PROCESS | 1998 | 08:20:34 INFO - PROCESS | 1998 | ************************* 08:20:34 INFO - PROCESS | 1998 | A coding exception was thrown and uncaught in a Task. 08:20:34 INFO - PROCESS | 1998 | 08:20:34 ERROR - PROCESS | 1998 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:20:34 INFO - PROCESS | 1998 | Full stack: 08:20:34 INFO - PROCESS | 1998 | ************************* 08:20:34 INFO - PROCESS | 1998 | ************************* 08:20:34 INFO - PROCESS | 1998 | A coding exception was thrown and uncaught in a Task. 08:20:34 INFO - PROCESS | 1998 | 08:20:34 ERROR - PROCESS | 1998 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:20:34 INFO - PROCESS | 1998 | Full stack: 08:20:34 INFO - PROCESS | 1998 | ************************* 08:20:34 INFO - PROCESS | 1998 | ************************* 08:20:34 INFO - PROCESS | 1998 | A coding exception was thrown and uncaught in a Task. 08:20:34 INFO - PROCESS | 1998 | 08:20:34 ERROR - PROCESS | 1998 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:20:34 INFO - PROCESS | 1998 | Full stack: 08:20:34 INFO - PROCESS | 1998 | ************************* 08:20:34 INFO - PROCESS | 1998 | ************************* 08:20:34 INFO - PROCESS | 1998 | A coding exception was thrown and uncaught in a Task. 08:20:34 INFO - PROCESS | 1998 | 08:20:34 ERROR - PROCESS | 1998 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:20:34 INFO - PROCESS | 1998 | Full stack: 08:20:34 INFO - PROCESS | 1998 | ************************* 08:21:50 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:53258/tests/dromaeo/cssquery-ext.html (next: http://localhost:53258/tests/dromaeo/cssquery-jquery.html) 08:21:50 INFO - PROCESS | 1998 | RSS: Main: 214618112 08:21:50 INFO - PROCESS | 1998 | 08:24:53 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:53258/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53258/tests/dromaeo/cssquery-mootools.html) 08:24:53 INFO - PROCESS | 1998 | RSS: Main: 208302080 08:24:53 INFO - PROCESS | 1998 | 08:27:55 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:53258/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53258/tests/dromaeo/cssquery-prototype.html) 08:27:56 INFO - PROCESS | 1998 | RSS: Main: 172064768 08:27:56 INFO - PROCESS | 1998 | 08:30:58 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:53258/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53258/tests/dromaeo/cssquery-yui.html) 08:30:59 INFO - PROCESS | 1998 | RSS: Main: 176537600 08:30:59 INFO - PROCESS | 1998 | 08:34:01 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:53258/tests/dromaeo/cssquery-yui.html (next: http://localhost:53258/tests/dromaeo/cssquery-dojo.html) 08:34:02 INFO - PROCESS | 1998 | RSS: Main: 263004160 08:34:02 INFO - PROCESS | 1998 | 08:34:02 INFO - PROCESS | 1998 | __start_tp_report 08:34:02 INFO - PROCESS | 1998 | _x_x_mozilla_page_load 08:34:02 INFO - PROCESS | 1998 | _x_x_mozilla_page_load_details 08:34:02 INFO - PROCESS | 1998 | |i|pagename|runs| 08:34:02 INFO - PROCESS | 1998 | |0;dojo.html;3439.1917899293667;3481.9651803481966;3482.094655389598;3507.631698671638;3537.221811201536;5798.56510761693;5894.29268487781;5899.115132730092;5900.763969441223;5918.496927761134;5906.970465147679;5936.851578710523;5941.138534912435;5942.940570594293;5951.6726580038085;5202.921956170651;5218;5239.947600523984;5274.525292723654;5292.682439053669;5055.115354812893;5076.086304465195;5292.126799078147;5293.550048245904;5299.5230429261355;5156.716380599066;5188.273641690166;5257.921131183016;5272;5276.419593844674;5270.262163297141;5277.393099793535;5284.656497327662;5292.44429334922;5292.550133238679;4989.625778066623;5160.974195129038;5210.895782084375;5266.34170728659;5275.525202731773;5689.317281926154;5756.107803290497;5810.883782324372;5821.883562328772;5828.621139625953;6281.24625044993;6345.206849143857;6349.682515874188;6356.237251529846;6365.458935990447;6375.266844312917;6376.458001069915;6402.967985160091;6403.295637479873;6407.647579383132;5588.916166257469;5618.325800903876;5807.216025836543;5843.18195452637;5939.198208241918;6448.774292899726;6451.967740161269;6454.709538070798;6454.935450645527;6464.191976003;6139.723712432951;6155;6172.753089876444;6189.195404597373;6205.906911396332;6050.6672133032225;6099.115628233882;6214.906776398358;6292.244930608356;6302.243730752339;6325.082862984934;6332.430081292706;6337.841553961096;6348.04779283102;6350.428461438492;6020.397960203944;6062.514998800086;6065.120557519135;6113.658745237643;6142.345304543789;4725.362076119749;4743.83396581118;4744.596709279681;4750.216214324598;4769.950610865604;4124.072083781125;4211.1998720243055;4231.153769246163;4233.386159006926;4278.187144442546;5878.2358293421585;6005.789797357072;6049.667268300285;6110.3765049759795;6112.419320164578;6343;6354.872902542016;6358.682065896779;6380.968095159495;6381.298057213703;6120.571559990758;6131.478824299896;6132.294786099566;6139.47814435769;6139.693015349215;5193.091209038404;5237.240600112962;5313.946860531345;5363.597730170253;5421.484958928895;6642.43539299165;6652.268250492442;6653.135092437952;6655.767048153291;6657.966710166418;6272.937270627235;6372.107904893412;6373.426391624776;6383;6386.680665966776;6275.3724627536885;6309.684515774101;6461.160049193575;6493.480521558358;6638.468922486093;6239.625622462667;6243.562950593597;6245.6252624842655;6248.250209974832;6254.124422580933;6356.5232607555545;6367.490600751836;6371.776987805404;6372.6495042773095;6381.457576106083;5925.881482370414;5999.1901093351835;6103.450689437972;6149.877002460015;6192.81421557354;6167.784127555514;6171.938280617136;6211.9068213977735;6220.160278362363;6221.3156552780065;6183.319834818077;6204.472619827185;6206.534509911684;6211.378862113753;6213.285472170758;5900.262467191601;5919.733611987557;5960.910586341295;5966.940330596812;6091.725872335667;6038.849028774316;6049.183360246487;6065.969670151621;6076.665783381956;6087.9391206087375 08:34:02 INFO - PROCESS | 1998 | |1;ext.html;763.8739607964686;825.7027470110759;845.7631863078338;890.6882591093118;902.2871931174373;31895.362092758132;43573.564264357345;43697.34453983193;43773.562264377346;43823;45669.314960275624;45757.31364029542;45853;45910.31134532985;45972.540274597246;7509.173990861001;7800.453968222227;8995.730128096151;9132.908670913306;9138.771530711752;10531.05220530156;10683.626073087444;10689.465526723672;10690.305130166515;11018;10720.571177152944;10783.352998820095;10796.460176991159;10812.621558245462;10819.78360432791;10721.30311529748;10764.300320479144;10766.300190487593;10770.838437423445;10774.084202842767;10540.314879532882;10569.577216911315;10581.470926453647;10583.470826458723;10586.41774702391;42616.360754588706;42781.57218427807;42823.143537129086;42922.141557168994;42982;4199.475065616798;4250.3199488081755;4271.67962402821;4356.128774245164;4368.650507959387;29967.850160749276;30411.239719006982;30777.384452311053;30961.071167864775;32266.516002259985;4289.463817022872;4388.824447022115;4405.163019026407;4407.096545208225;4426.822927082945;239606;239910;240294.798526008;240576;240872;55627.44372556303;55747;55916.72041639766;55996.44003559994;56055.439445605836;57848.71075644595;57958.4204157953;58142.7092864533;58148.70925645345;58157.4184258152;15993.760093598605;16062.196890155445;16126.032438053755;16173.514794556182;16247.756283655755;12525.185862918881;12701.428435720414;14015.369308381147;14037.71924561503;14186.077904936146;13705.588832335046;13719.314034298246;13768.793468097987;13816.861831381759;13832.239226842621;5590.413006634326;5592.105263157875;5627.690477023803;5638.323401191883;5641.182028605829;1020.4642562654666;1026.7022563456662;1027.3733022856052;1037.7561273100816;1042.3120740311358;27969.580456293173;28362.43275134527;28435.431291374058;28616.85691571529;28766.42467150645;1091.9890801092047;1097.2100087936674;1109.8501702270091;1126.9492872820742;1132.2866594045863;15670.373185072698;16871.578210544834;17370.21834017472;17429.47711568655;17852.107394630217;359722;360235;362249;362424;364105;62747.37252627507;62864.37135628676;62970.0554491683;63225.36774632287;63231.683841580496;1486.5317425011087;1514.2807166595778;1519.4302136698739;1535.2860919672405;1554.9541737063303;30247.69752302449;30916.690833091383;31504.684953151092;31874.20314492156;31920.840395797873;44195.558044419144;44253.336199956386;44385;44478.332825007004;44524;322136;322564;323182;323751;323962;27167.59248611312;27777.027804026762;30760;32251.193720157185;32430;41253.79373103115;41878;46341.304880427495;46559.76720116513;46598;32156.356872861943;32170.839145804122;32375.35249294954;32406;32552.34895302128;31545.526817097303;31617.5257371135;32082.19794505156;32316.83841580777;32588.83705581457;36875;36998.26003479969;37075.443868341456;37607.62392376151;37769.244615106996;30794;30802;30996.845015774776;31237.219069523442;31248.843755781076;24080;25317.113901013377;25325.746742532338;25393;25403.618945715458 08:34:02 INFO - PROCESS | 1998 | |2;jquery.html;443.1204059941019;467.3457159976035;469.1110345894531;474.7578734845228;487.68787975695557;19704.90147549262;21396.25113121041;21828.45428864279;21906.342809715694;21991.34025979221;21648.8917555412;21850.672239916414;22021.779782202175;22094.33716988493;22324.330270091923;6356.427921487065;6458.418742313191;6588.901166482495;6766.763163289286;6808.931910680904;6722.764703235388;6846.691898864563;6852.6231057291825;6856.142982127234;6856.211535673411;6626.469882409419;6776.186857577073;6809.625470599115;6815.659217039153;6820.590764554143;6737.831554211135;6781.525293229452;6792.864142717142;7224.096987876515;7499.47503674743;7234.7885150354205;7423.777286681354;7467.887981680279;7483.13943896448;7484.850302993964;25119.497610047878;25714.871425642938;25752;25891.48217035649;26054.088106916355;3034.7117023882697;3035.104644129965;3161.2413020875056;3223.774335796495;3225.7580681448985;15682.68634627301;15790.684186316324;15808.288627011698;16056.277467513873;16443.260053297632;2210.546837898243;2234.0728597631964;2257.1761307122947;2265.648824432216;2280.133549251274;86590;89593.55203223941;91959;103748.48125759399;122943;17207;18359.898221870273;18800.52998675044;18907.810921890607;19010.61978760417;32705.509417358284;32958;33016.35869130512;33118.834405827816;33152.50271245933;10457.738556536147;10657.14742820588;10762.946185269024;10994.890051099546;11018.11855051594;8963.372563920462;9063.184313411693;9107.863382049274;9138.360314778034;9282.860757088649;9154.633814647339;9343.626254949726;9467.147956683932;9488.146066854017;9521.857172142423;3264.4450443424676;3432.5754811752845;3679.5768486623847;3811.8284677189595;3845;978.7895602445508;979.4368238263028;980.926430517714;987.3779518903045;1001.5993602559034;21495.57008859814;21586.676199857015;21596.28143498478;21734.45663858416;21908.342749717533;994.786120983992;994.8060128275062;1004.081265641944;1016.1718199667396;1027.3733022856052;11168.609098681669;11264.66206013821;11810.232334898204;11936;12143.392830358447;734258;748782;759096;769448;781158;86239;87952.56023719968;111231.08213196103;116547.41726291315;123555;1164.361370716511;1288.1305119044607;1345.3878485288974;1387.3202130955758;1405.3956798576505;18908.52728681739;19808.504787380432;19812.70280945816;19821.60356792885;19877.906715130808;47688;49971;51294;52154.91876040921;52677.47322526879;68874.65562672155;69163;69679.65160174167;71109.28890711234;71269.64365178141;8046.0747014091785;11063.778724425627;11178.776424471627;12098.879011209776;12422.627321180378;13677.24775137377;13865.646903768084;14324.14055156694;14393.136411815325;14650.34073466718;12386.938065309616;12407.31759753186;12462.31457269859;12602.621921342374;12692.746145077232;11406.087512999105;11585.594504192313;11815.40922953866;11829.290242585472;11952.880471195525;12514.74970500603;12604.49582016709;12841.871581284442;12966.935165324114;13098.541551045668;14592.124472531257;14827.703445931236;14842.554723358317;14958.775618365515;15004.924975375054;12775.169613975062;12861.742765144832;12987.220766754024;13843.377048032662;14011.43954241819 08:34:02 INFO - PROCESS | 1998 | |3;mootools.html;1539.9769003464944;1564.045931981491;1579.913104779237;1585.064811761061;1587.484067678005;10632.46837658117;11265.042471389921;11274.32354058756;11280.32318060917;11294;10738.140948724084;11066.557337706503;11072.944635276832;11107.333559986406;11129.554817807299;2419.7701218384227;2461.5569197544437;2462.66753988212;2463.4210960424284;2466.5930121529927;2352.188494969233;2395.317334559651;2399.8920048597856;2423.769741874528;2442.218490083174;2291.2897001929373;2329.8252631052655;2337.100216416675;2364.9527009459803;2381.214199314231;2227.649829429951;2283.178055899883;2293.346396277053;2298.9310320690324;2337.053493335202;2316.455632926261;2320.501092265154;2322.4077860145726;2329.0683726509365;2330.102910379499;11375.374354410504;11585.18903676743;11588.13089018327;11599.594014209462;11613.361265130414;5675.971620141914;5823.883522329572;5828.242328497268;5834.183214349994;5837.241158649391;3396.609389920166;3410;3442.208292092808;3464.133966508373;3520.1551627609447;1286.4468278640181;1288.9742205155844;1315.6645055510878;1329.4084132561013;1370.6230786533683;13617.523386681418;13920.095193812369;16037.117958512394;16543.91728041364;16770;4455.1757924784015;4606.815727370935;4746.169420351424;4773.451053128865;4783.617310615212;10563.524641391155;10797.946010270056;12864.421101050475;12865.678358041125;12884.80672789909;4848.321235027099;5534.889302213933;5715.457031581993;5767.8558036049435;5793.478586927196;5080.77136528857;5109.054824857339;5148.433672296044;5184.351956005499;5184.507471790174;3835.616438356142;3857.267119247334;3883.2233553289457;3920.3335432976464;3921.490206273166;1003.7741508160751;1006.2050979725934;1006.954687039085;1016.8118898003893;1020.806046851096;1063.9680809575725;1065.2170654568886;1070.0797314309686;1073.4042606353548;1084.3114622214794;6732.124823772878;6859.519833611599;6860.211075726255;6972.755953541602;6985.615791131537;1048.4757621189406;1069.8074346617527;1073.8550295709979;1078.5146683992077;1115.2472081345059;4790.952090479121;4792.856214313576;4899.099750784025;4900.240462728283;4912.508749125131;12978.740425191443;13458.528951486847;14544.418223271163;15286.617834554003;15297.388104475918;13762.65593360174;13763.931180344034;13779.517716879862;13801;13805.654858628615;10518.73703157412;10544.947275263728;10705.090067344207;10760.94619526913;10824.621138260123;7461.141968673455;7516.135644400745;7650.158482567024;7661.88507172404;7784.2215778421705;13117.147385419918;13204.075714699879;13223.140495867738;13495.730085398041;13574;13346;13350.065495415227;13354.065215434826;13418;13419.932900335436;9854.55654495535;10032.498375081072;10092.091711745978;10093.444860532742;10097.394156350643;10409.635662751767;10440.112590429899;10442.582296708351;10537.262391632512;10565.683029509128;8942.68700595476;8950.955245223733;9047.411918225294;9050.728478145666;9123.589438475152;9167.174954253882;9215.907840921773;9225.031371705874;9236.26109911192;9369.953150234205;8584.141585841366;8754;8761.824763504566;8763.25512331459;8768.824623507366;6233.127362169391;6257.155284036597;6337.588056776295;6343.429091381798;6357.110004599267;6204.193454850841;6270.153529273673;6375.936240637534;6497.220333560003;6579.407853293226 08:34:02 INFO - PROCESS | 1998 | |4;prototype.html;395.7724308522597;422.6618705035971;423.73303821573506;430.0710465394747;434.5046646822623;5154.768035438405;5220.425753167154;5265.289185959889;5283.920741188886;5295.31160949077;4956.4547899731;5144.845654630358;5168.793248270074;5181.637285390015;5189.299444574981;4267.914641707164;4349.978250108753;4356.847510337139;4365.34117035526;4366.301391777316;4331.155424692186;4346.9565304347025;4351.695381323293;4355.150745604608;4393.143337049277;4356.629686476654;4360.389545463638;4361.912761744763;4372.584604462587;4384.188925048876;4167.229062623409;4271.615554600101;4305.63402110821;4307.440032795748;4347.152305300468;4051.7974101295113;4063.756174629532;4091.488563929509;4095.89760255996;4100.220958017997;5055.9241611375855;5075.807185311449;5094.592432605383;5105.795768169269;5112.744362781883;4975.502449755032;4994.528493544635;5038.5465308122075;5083.440821509631;5103.106956282636;5417.726834193962;5467.726613669301;5482.643628164156;5487.2317875497065;5513.889722205574;4571.519990401027;4585.335126406686;4586.128635559233;4603.976980115078;4634.814607415699;5446.782128714846;5669.744861481243;5670.837478316935;5701.57238207132;5722.597963498928;4668.5798278155125;4757.500462451462;4758.287016673995;4791.47293797682;4802.423709154924;4848.878778030577;4869.318295438641;4870.659053866196;4871.29366241893;4882.536159064884;4934.5312195341385;5080.501252130631;5085.618578606545;5107.719075450886;5119.948800511947;5445.891082178414;5452.40023597404;5452.863678407992;5461.508464238158;5513.531349835229;1535.9862490756047;1645.0423995445622;1646.752987051928;1662.4846297647769;1669.5659128626644;1247.6444213399138;1257.8616352201434;1282.2050328796206;1282.7819270723999;1307.6469353274754;5346.732663366816;5364.7317634118135;5393.2449457076045;5393.973030134903;5426.864328391743;5526.447355264441;5578.330600327906;5584.86037849057;5609.326880774252;5636.661800291996;5200.6619569727845;5251.291075704808;5352.812651557177;5354.705491197944;5362.8659283517445;2912.85435728217;2915.6938521455368;2930.4432157889933;2948.88204471823;2969.9109026729234;5762.250907382014;5794.594378393556;5820.9730939911005;5838.766449342063;5840.94159058404;5432.320959880015;5523.9837459327055;5535.640183388067;5616.943830561724;5645.334626285256;5655.462731040545;5773;5792.783515461801;5804.361520232856;5811.476967072984;5520.503154716095;5572.665640061609;5582.190582365453;5660.801871934463;5715.8571035724435;5323.920141197807;5466.72666366688;5522.337319521683;5576.972115139561;5578.832635020955;5758.654480731169;5772.297172334088;5794;5805.245318108618;5859.062549991981;4521.59305662492;4676.158291507561;4683.437987441393;4683.812647494198;4701.952980470288;5634.971825141012;5645.181448689835;5655.349634791887;5656.886862262814;5664;5485.341758988947;5499.945000549943;5543;5558.583106267127;5591.18927755465;5277.20841873722;5461.617686761889;5503.174523821459;5533.529649979636;5544.1960915667805;5525.806596769094;5536.7231638417115;5572.442755724395;5576.10782274834;5580.748866300945;5601.271834661468;5621.30177514787;5631.380548139619;5667.206591077335;5680.318361796611;5269.683818970874;5380.25141828915;5415.702136382537;5469.453054694499;5502.80740174092 08:34:02 INFO - PROCESS | 1998 | |5;yui.html;866.5060915278286;871.7820544863785;927.0868194828096;927.2906226736545;933.0389698610429;15674.686506269882;16998.40505582305;17083.743743843854;17911.193996270165;18175.182116804743;15245.085294882314;15729.05625662461;15791.447299344525;17029.57426064349;17317.13414329285;869.0440515433005;889.417431582313;912.2018234045211;915.7390143809016;916.1251005289965;897.9461232326081;909.277124685873;909.6043221198767;911.7128104647015;911.7629416351763;948.7770373962113;950.9144177024067;951.1534734086669;951.2675240065146;951.2722767083187;942.9198518126002;943.5895385507326;945.6973768394116;946.3044662173297;946.9621215151386;697.400235797214;697.6337422852991;697.9057827193315;698.0157977252051;698.7414656577048;16635.251413686412;16674.49976500707;16739.916300418543;17691.646167076586;17954.19206135727;15296.235188240544;15634;15703.528894133195;15888.841111588852;16084.758728618963;13266.933665331708;13753.243571603558;13758.31208439574;13819.654508637364;13866.722665546733;4049.9392509112386;4070;4094.6928980326593;4115.403266526337;4247.065645557972;50025.343629803836;50030.499695002945;54288;70510.99999999949;87469.56265218633;11853.170278080452;12108.576199832964;12133.272003679807;12234.75530489403;12348.691282718004;23253;23341.416464588183;23341.41646458852;23398;23514.294571162893;9397.248220142372;9446.244300456085;9516.809663806685;9528.714138575853;9532.90467095334;4656.348111264426;4663.137319595886;4689.249720044776;4724.622030237572;4789.616830653539;3784.2053168834304;3960.7227494075137;3963.8810835674976;3965.048388386824;3965.1673148638533;643.2441880790053;648.6432462145801;665.2449469851753;668.1114118222752;670.8926571748497;826.2109685250572;831.8294749576322;864.2308345572445;872.0973792125246;885.2784980241083;11422.428878556038;11913.404329783476;11936.403179840972;12058.13098969661;12338.321392323329;831.6548632317641;831.9683592345448;832.704389941562;855.7261676263661;864.822711344173;5693.658380497183;5771.88456230873;5776.797812076641;5911.645301281937;6038.758449662052;71327;84088;84208.57895710482;84333.57833210795;84424.57787711146;72396;73262.63368683122;73546.6322668394;74562;74788;66371.66814165899;66819;67680.6615966917;68925.31074689189;69310.65344673244;11619.76760464769;12164.2701437914;12218.327991960528;12490.75018499643;12549.121561490609;38458.42312365373;41755.7912210437;42972.78513607412;43041.569584305005;43887.70842186785;50946.74526627343;50963.49036509587;51344.48655513397;51570;51975.48024519706;14360.210188439736;14467;14528.927355363156;14700.485483008044;15046.247687615356;16570.83429165693;16623.335066597683;16776.32894684199;18251.269949201884;18263.45209643713;15487.345500264964;16380.180990950643;16528.917355413145;16660.66678666396;17244;15548.766768498708;16288.511344659679;16401.179941002665;16486.17569121515;16762.413315533897;16174.919125404298;16213.189340533163;16224.756628650344;16327.346906123623;16527.173641317644;11543.8268425972;12075.57735479254;12111.152219344915;12172.817407739069;12675.746485070431;12821.679458013625;13114.60656180316;13127.474901003852;13198.495528931331;13426.462941482621 08:34:02 INFO - PROCESS | 1998 | __end_tp_report 08:34:02 INFO - PROCESS | 1998 | __start_cc_report 08:34:02 INFO - PROCESS | 1998 | _x_x_mozilla_cycle_collect,1451 08:34:02 INFO - PROCESS | 1998 | __end_cc_report 08:34:02 INFO - PROCESS | 1998 | __startTimestamp1491492842239__endTimestamp 08:34:02 INFO - PROCESS | 1998 | 08:34:02 INFO - PROCESS | 1998 | ------- Summary: start ------- 08:34:02 INFO - PROCESS | 1998 | Number of tests: 6 08:34:02 INFO - PROCESS | 1998 | 08:34:02 INFO - PROCESS | 1998 | [#0] dojo.html Cycles:165 Average:5828.17 Median:6087.94 stddev:690.38 (11.3%) stddev-sans-first:666.58 08:34:02 INFO - PROCESS | 1998 | Values: 3439.2 3482.0 3482.1 3507.6 3537.2 5798.6 5894.3 5899.1 5900.8 5918.5 5907.0 5936.9 5941.1 5942.9 5951.7 5202.9 5218.0 5239.9 5274.5 5292.7 5055.1 5076.1 5292.1 5293.6 5299.5 5156.7 5188.3 5257.9 5272.0 5276.4 5270.3 5277.4 5284.7 5292.4 5292.6 4989.6 5161.0 5210.9 5266.3 5275.5 5689.3 5756.1 5810.9 5821.9 5828.6 6281.2 6345.2 6349.7 6356.2 6365.5 6375.3 6376.5 6403.0 6403.3 6407.6 5588.9 5618.3 5807.2 5843.2 5939.2 6448.8 6452.0 6454.7 6454.9 6464.2 6139.7 6155.0 6172.8 6189.2 6205.9 6050.7 6099.1 6214.9 6292.2 6302.2 6325.1 6332.4 6337.8 6348.0 6350.4 6020.4 6062.5 6065.1 6113.7 6142.3 4725.4 4743.8 4744.6 4750.2 4770.0 4124.1 4211.2 4231.2 4233.4 4278.2 5878.2 6005.8 6049.7 6110.4 6112.4 6343.0 6354.9 6358.7 6381.0 6381.3 6120.6 6131.5 6132.3 6139.5 6139.7 5193.1 5237.2 5313.9 5363.6 5421.5 6642.4 6652.3 6653.1 6655.8 6658.0 6272.9 6372.1 6373.4 6383.0 6386.7 6275.4 6309.7 6461.2 6493.5 6638.5 6239.6 6243.6 6245.6 6248.3 6254.1 6356.5 6367.5 6371.8 6372.6 6381.5 5925.9 5999.2 6103.5 6149.9 6192.8 6167.8 6171.9 6211.9 6220.2 6221.3 6183.3 6204.5 6206.5 6211.4 6213.3 5900.3 5919.7 5960.9 5966.9 6091.7 6038.8 6049.2 6066.0 6076.7 6087.9 08:34:02 INFO - PROCESS | 1998 | 08:34:02 INFO - PROCESS | 1998 | [#1] ext.html Cycles:180 Average:48054.20 Median:32119.28 stddev:81907.84 (255.0%) stddev-sans-first:82060.65 08:34:02 INFO - PROCESS | 1998 | Values: 763.9 825.7 845.8 890.7 902.3 31895.4 43573.6 43697.3 43773.6 43823.0 45669.3 45757.3 45853.0 45910.3 45972.5 7509.2 7800.5 8995.7 9132.9 9138.8 10531.1 10683.6 10689.5 10690.3 11018.0 10720.6 10783.4 10796.5 10812.6 10819.8 10721.3 10764.3 10766.3 10770.8 10774.1 10540.3 10569.6 10581.5 10583.5 10586.4 42616.4 42781.6 42823.1 42922.1 42982.0 4199.5 4250.3 4271.7 4356.1 4368.7 29967.9 30411.2 30777.4 30961.1 32266.5 4289.5 4388.8 4405.2 4407.1 4426.8 239606.0 239910.0 240294.8 240576.0 240872.0 55627.4 55747.0 55916.7 55996.4 56055.4 57848.7 57958.4 58142.7 58148.7 58157.4 15993.8 16062.2 16126.0 16173.5 16247.8 12525.2 12701.4 14015.4 14037.7 14186.1 13705.6 13719.3 13768.8 13816.9 13832.2 5590.4 5592.1 5627.7 5638.3 5641.2 1020.5 1026.7 1027.4 1037.8 1042.3 27969.6 28362.4 28435.4 28616.9 28766.4 1092.0 1097.2 1109.9 1126.9 1132.3 15670.4 16871.6 17370.2 17429.5 17852.1 359722.0 360235.0 362249.0 362424.0 364105.0 62747.4 62864.4 62970.1 63225.4 63231.7 1486.5 1514.3 1519.4 1535.3 1555.0 30247.7 30916.7 31504.7 31874.2 31920.8 44195.6 44253.3 44385.0 44478.3 44524.0 322136.0 322564.0 323182.0 323751.0 323962.0 27167.6 27777.0 30760.0 32251.2 32430.0 41253.8 41878.0 46341.3 46559.8 46598.0 32156.4 32170.8 32375.4 32406.0 32552.3 31545.5 31617.5 32082.2 32316.8 32588.8 36875.0 36998.3 37075.4 37607.6 37769.2 30794.0 30802.0 30996.8 31237.2 31248.8 24080.0 25317.1 25325.7 25393.0 25403.6 08:34:02 INFO - PROCESS | 1998 | 08:34:02 INFO - PROCESS | 1998 | [#2] jquery.html Cycles:180 Average:39995.23 Median:2261.41 stddev:124265.76 (5495.1%) stddev-sans-first:124578.87 08:34:02 INFO - PROCESS | 1998 | Values: 443.1 467.3 469.1 474.8 487.7 19704.9 21396.3 21828.5 21906.3 21991.3 21648.9 21850.7 22021.8 22094.3 22324.3 6356.4 6458.4 6588.9 6766.8 6808.9 6722.8 6846.7 6852.6 6856.1 6856.2 6626.5 6776.2 6809.6 6815.7 6820.6 6737.8 6781.5 6792.9 7224.1 7499.5 7234.8 7423.8 7467.9 7483.1 7484.9 25119.5 25714.9 25752.0 25891.5 26054.1 3034.7 3035.1 3161.2 3223.8 3225.8 15682.7 15790.7 15808.3 16056.3 16443.3 2210.5 2234.1 2257.2 2265.6 2280.1 86590.0 89593.6 91959.0 103748.5 122943.0 17207.0 18359.9 18800.5 18907.8 19010.6 32705.5 32958.0 33016.4 33118.8 33152.5 10457.7 10657.1 10762.9 10994.9 11018.1 8963.4 9063.2 9107.9 9138.4 9282.9 9154.6 9343.6 9467.1 9488.1 9521.9 3264.4 3432.6 3679.6 3811.8 3845.0 978.8 979.4 980.9 987.4 1001.6 21495.6 21586.7 21596.3 21734.5 21908.3 994.8 994.8 1004.1 1016.2 1027.4 11168.6 11264.7 11810.2 11936.0 12143.4 734258.0 748782.0 759096.0 769448.0 781158.0 86239.0 87952.6 111231.1 116547.4 123555.0 1164.4 1288.1 1345.4 1387.3 1405.4 18908.5 19808.5 19812.7 19821.6 19877.9 47688.0 49971.0 51294.0 52154.9 52677.5 68874.7 69163.0 69679.7 71109.3 71269.6 8046.1 11063.8 11178.8 12098.9 12422.6 13677.2 13865.6 14324.1 14393.1 14650.3 12386.9 12407.3 12462.3 12602.6 12692.7 11406.1 11585.6 11815.4 11829.3 11952.9 12514.7 12604.5 12841.9 12966.9 13098.5 14592.1 14827.7 14842.6 14958.8 15004.9 12775.2 12861.7 12987.2 13843.4 14011.4 08:34:02 INFO - PROCESS | 1998 | 08:34:02 INFO - PROCESS | 1998 | [#3] mootools.html Cycles:180 Average:7012.57 Median:2321.45 stddev:4411.00 (190.0%) stddev-sans-first:4404.21 08:34:02 INFO - PROCESS | 1998 | Values: 1540.0 1564.0 1579.9 1585.1 1587.5 10632.5 11265.0 11274.3 11280.3 11294.0 10738.1 11066.6 11072.9 11107.3 11129.6 2419.8 2461.6 2462.7 2463.4 2466.6 2352.2 2395.3 2399.9 2423.8 2442.2 2291.3 2329.8 2337.1 2365.0 2381.2 2227.6 2283.2 2293.3 2298.9 2337.1 2316.5 2320.5 2322.4 2329.1 2330.1 11375.4 11585.2 11588.1 11599.6 11613.4 5676.0 5823.9 5828.2 5834.2 5837.2 3396.6 3410.0 3442.2 3464.1 3520.2 1286.4 1289.0 1315.7 1329.4 1370.6 13617.5 13920.1 16037.1 16543.9 16770.0 4455.2 4606.8 4746.2 4773.5 4783.6 10563.5 10797.9 12864.4 12865.7 12884.8 4848.3 5534.9 5715.5 5767.9 5793.5 5080.8 5109.1 5148.4 5184.4 5184.5 3835.6 3857.3 3883.2 3920.3 3921.5 1003.8 1006.2 1007.0 1016.8 1020.8 1064.0 1065.2 1070.1 1073.4 1084.3 6732.1 6859.5 6860.2 6972.8 6985.6 1048.5 1069.8 1073.9 1078.5 1115.2 4791.0 4792.9 4899.1 4900.2 4912.5 12978.7 13458.5 14544.4 15286.6 15297.4 13762.7 13763.9 13779.5 13801.0 13805.7 10518.7 10544.9 10705.1 10760.9 10824.6 7461.1 7516.1 7650.2 7661.9 7784.2 13117.1 13204.1 13223.1 13495.7 13574.0 13346.0 13350.1 13354.1 13418.0 13419.9 9854.6 10032.5 10092.1 10093.4 10097.4 10409.6 10440.1 10442.6 10537.3 10565.7 8942.7 8951.0 9047.4 9050.7 9123.6 9167.2 9215.9 9225.0 9236.3 9370.0 8584.1 8754.0 8761.8 8763.3 8768.8 6233.1 6257.2 6337.6 6343.4 6357.1 6204.2 6270.2 6375.9 6497.2 6579.4 08:34:02 INFO - PROCESS | 1998 | 08:34:02 INFO - PROCESS | 1998 | [#4] prototype.html Cycles:180 Average:4785.44 Median:5273.45 stddev:1272.84 (24.1%) stddev-sans-first:1233.03 08:34:02 INFO - PROCESS | 1998 | Values: 395.8 422.7 423.7 430.1 434.5 5154.8 5220.4 5265.3 5283.9 5295.3 4956.5 5144.8 5168.8 5181.6 5189.3 4267.9 4350.0 4356.8 4365.3 4366.3 4331.2 4347.0 4351.7 4355.2 4393.1 4356.6 4360.4 4361.9 4372.6 4384.2 4167.2 4271.6 4305.6 4307.4 4347.2 4051.8 4063.8 4091.5 4095.9 4100.2 5055.9 5075.8 5094.6 5105.8 5112.7 4975.5 4994.5 5038.5 5083.4 5103.1 5417.7 5467.7 5482.6 5487.2 5513.9 4571.5 4585.3 4586.1 4604.0 4634.8 5446.8 5669.7 5670.8 5701.6 5722.6 4668.6 4757.5 4758.3 4791.5 4802.4 4848.9 4869.3 4870.7 4871.3 4882.5 4934.5 5080.5 5085.6 5107.7 5119.9 5445.9 5452.4 5452.9 5461.5 5513.5 1536.0 1645.0 1646.8 1662.5 1669.6 1247.6 1257.9 1282.2 1282.8 1307.6 5346.7 5364.7 5393.2 5394.0 5426.9 5526.4 5578.3 5584.9 5609.3 5636.7 5200.7 5251.3 5352.8 5354.7 5362.9 2912.9 2915.7 2930.4 2948.9 2969.9 5762.3 5794.6 5821.0 5838.8 5840.9 5432.3 5524.0 5535.6 5616.9 5645.3 5655.5 5773.0 5792.8 5804.4 5811.5 5520.5 5572.7 5582.2 5660.8 5715.9 5323.9 5466.7 5522.3 5577.0 5578.8 5758.7 5772.3 5794.0 5805.2 5859.1 4521.6 4676.2 4683.4 4683.8 4702.0 5635.0 5645.2 5655.3 5656.9 5664.0 5485.3 5499.9 5543.0 5558.6 5591.2 5277.2 5461.6 5503.2 5533.5 5544.2 5525.8 5536.7 5572.4 5576.1 5580.7 5601.3 5621.3 5631.4 5667.2 5680.3 5269.7 5380.3 5415.7 5469.5 5502.8 08:34:02 INFO - PROCESS | 1998 | 08:34:02 INFO - PROCESS | 1998 | [#5] yui.html Cycles:180 Average:18350.23 Median:23001.43 stddev:21936.65 (95.4%) stddev-sans-first:21958.89 08:34:02 INFO - PROCESS | 1998 | Values: 866.5 871.8 927.1 927.3 933.0 15674.7 16998.4 17083.7 17911.2 18175.2 15245.1 15729.1 15791.4 17029.6 17317.1 869.0 889.4 912.2 915.7 916.1 897.9 909.3 909.6 911.7 911.8 948.8 950.9 951.2 951.3 951.3 942.9 943.6 945.7 946.3 947.0 697.4 697.6 697.9 698.0 698.7 16635.3 16674.5 16739.9 17691.6 17954.2 15296.2 15634.0 15703.5 15888.8 16084.8 13266.9 13753.2 13758.3 13819.7 13866.7 4049.9 4070.0 4094.7 4115.4 4247.1 50025.3 50030.5 54288.0 70511.0 87469.6 11853.2 12108.6 12133.3 12234.8 12348.7 23253.0 23341.4 23341.4 23398.0 23514.3 9397.2 9446.2 9516.8 9528.7 9532.9 4656.3 4663.1 4689.2 4724.6 4789.6 3784.2 3960.7 3963.9 3965.0 3965.2 643.2 648.6 665.2 668.1 670.9 826.2 831.8 864.2 872.1 885.3 11422.4 11913.4 11936.4 12058.1 12338.3 831.7 832.0 832.7 855.7 864.8 5693.7 5771.9 5776.8 5911.6 6038.8 71327.0 84088.0 84208.6 84333.6 84424.6 72396.0 73262.6 73546.6 74562.0 74788.0 66371.7 66819.0 67680.7 68925.3 69310.7 11619.8 12164.3 12218.3 12490.8 12549.1 38458.4 41755.8 42972.8 43041.6 43887.7 50946.7 50963.5 51344.5 51570.0 51975.5 14360.2 14467.0 14528.9 14700.5 15046.2 16570.8 16623.3 16776.3 18251.3 18263.5 15487.3 16380.2 16528.9 16660.7 17244.0 15548.8 16288.5 16401.2 16486.2 16762.4 16174.9 16213.2 16224.8 16327.3 16527.2 11543.8 12075.6 12111.2 12172.8 12675.7 12821.7 13114.6 13127.5 13198.5 13426.5 08:34:02 INFO - PROCESS | 1998 | -------- Summary: end -------- 08:34:02 INFO - PROCESS | 1998 | 08:34:03 INFO - TEST-INFO | 1998: exit 0 08:34:03 INFO - TEST-OK | dromaeo_css | took 1116711ms 08:34:03 INFO - TEST-START | kraken 08:34:03 INFO - operating with platform_type : linux_ 08:34:03 INFO - Initialising browser for kraken test... 08:34:03 INFO - TEST-INFO | started process 2322 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm6mhvx/profile http://localhost:53258/getInfo.html) 08:34:07 INFO - PROCESS | 2322 | __metrics Screen width/height:1600/1200 08:34:07 INFO - PROCESS | 2322 | colorDepth:24 08:34:07 INFO - PROCESS | 2322 | Browser inner width/height: 1024/697 08:34:07 INFO - PROCESS | 2322 | __metrics 08:34:08 INFO - PROCESS | 2322 | 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" 08:34:08 INFO - PROCESS | 2322 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:34:09 INFO - TEST-INFO | 2322: exit 0 08:34:09 INFO - Browser initialized. 08:34:09 INFO - Running cycle 1/1 for kraken test... 08:34:09 INFO - TEST-INFO | started process 2484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm6mhvx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:34:21 INFO - PROCESS | 2484 | RSS: Main: 139358208 08:34:21 INFO - PROCESS | 2484 | 08:34:23 INFO - PROCESS | 2484 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53258/tests/kraken/driver.html?testName=audio-beat-detection) 08:34:24 INFO - PROCESS | 2484 | RSS: Main: 184258560 08:34:24 INFO - PROCESS | 2484 | 08:34:26 INFO - PROCESS | 2484 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53258/tests/kraken/driver.html?testName=audio-dft) 08:34:27 INFO - PROCESS | 2484 | RSS: Main: 174002176 08:34:27 INFO - PROCESS | 2484 | 08:34:30 INFO - PROCESS | 2484 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53258/tests/kraken/driver.html?testName=audio-fft) 08:34:30 INFO - PROCESS | 2484 | RSS: Main: 265289728 08:34:30 INFO - PROCESS | 2484 | 08:34:33 INFO - PROCESS | 2484 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53258/tests/kraken/driver.html?testName=audio-oscillator) 08:34:33 INFO - PROCESS | 2484 | RSS: Main: 171839488 08:34:33 INFO - PROCESS | 2484 | 08:34:35 INFO - PROCESS | 2484 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53258/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:34:36 INFO - PROCESS | 2484 | RSS: Main: 174133248 08:34:36 INFO - PROCESS | 2484 | 08:34:39 INFO - PROCESS | 2484 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53258/tests/kraken/driver.html?testName=imaging-darkroom) 08:34:39 INFO - PROCESS | 2484 | RSS: Main: 213725184 08:34:39 INFO - PROCESS | 2484 | 08:34:43 INFO - PROCESS | 2484 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53258/tests/kraken/driver.html?testName=imaging-desaturate) 08:34:43 INFO - PROCESS | 2484 | RSS: Main: 211763200 08:34:43 INFO - PROCESS | 2484 | 08:34:46 INFO - PROCESS | 2484 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53258/tests/kraken/driver.html?testName=json-parse-financial) 08:34:47 INFO - PROCESS | 2484 | RSS: Main: 211001344 08:34:47 INFO - PROCESS | 2484 | 08:34:48 INFO - PROCESS | 2484 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53258/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:34:49 INFO - PROCESS | 2484 | RSS: Main: 173133824 08:34:49 INFO - PROCESS | 2484 | 08:34:50 INFO - PROCESS | 2484 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53258/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:34:51 INFO - PROCESS | 2484 | RSS: Main: 180084736 08:34:51 INFO - PROCESS | 2484 | 08:34:53 INFO - PROCESS | 2484 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53258/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:34:54 INFO - PROCESS | 2484 | RSS: Main: 184459264 08:34:54 INFO - PROCESS | 2484 | 08:34:56 INFO - PROCESS | 2484 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:57 INFO - PROCESS | 2484 | RSS: Main: 182960128 08:34:57 INFO - PROCESS | 2484 | 08:35:00 INFO - PROCESS | 2484 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:35:00 INFO - PROCESS | 2484 | RSS: Main: 185929728 08:35:00 INFO - PROCESS | 2484 | 08:35:02 INFO - PROCESS | 2484 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53258/tests/kraken/driver.html?testName=ai-astar) 08:35:02 INFO - PROCESS | 2484 | RSS: Main: 238878720 08:35:02 INFO - PROCESS | 2484 | 08:35:02 INFO - PROCESS | 2484 | __start_tp_report 08:35:02 INFO - PROCESS | 2484 | _x_x_mozilla_page_load 08:35:02 INFO - PROCESS | 2484 | _x_x_mozilla_page_load_details 08:35:02 INFO - PROCESS | 2484 | |i|pagename|runs| 08:35:02 INFO - PROCESS | 2484 | |0;ai-astar;101;111;111;110;111;110;111;113;110;111 08:35:02 INFO - PROCESS | 2484 | |1;audio-beat-detection;145;115;115;155;114;115;115;114;140;115 08:35:02 INFO - PROCESS | 2484 | |2;audio-dft;160;160;161;161;160;161;161;161;161;161 08:35:02 INFO - PROCESS | 2484 | |3;audio-fft;75;76;77;116;75;75;77;75;91;75 08:35:02 INFO - PROCESS | 2484 | |4;audio-oscillator;92;81;104;82;81;81;96;82;82;111 08:35:02 INFO - PROCESS | 2484 | |5;imaging-gaussian-blur;114;113;113;113;113;113;113;112;112;112 08:35:02 INFO - PROCESS | 2484 | |6;imaging-darkroom;146;146;147;146;147;146;146;146;145;146 08:35:02 INFO - PROCESS | 2484 | |7;imaging-desaturate;94;94;94;93;93;94;94;94;94;93 08:35:02 INFO - PROCESS | 2484 | |8;json-parse-financial;56;54;67;54;53;56;55;54;53;54 08:35:02 INFO - PROCESS | 2484 | |9;json-stringify-tinderbox;52;53;51;52;53;53;52;55;53;53 08:35:02 INFO - PROCESS | 2484 | |10;stanford-crypto-aes;81;78;75;80;81;84;80;80;94;80 08:35:02 INFO - PROCESS | 2484 | |11;stanford-crypto-ccm;124;128;120;119;123;119;141;117;127;120 08:35:02 INFO - PROCESS | 2484 | |12;stanford-crypto-pbkdf2;164;164;166;161;157;158;167;160;163;161 08:35:02 INFO - PROCESS | 2484 | |13;stanford-crypto-sha256-iterative;59;60;68;60;61;59;60;59;59;58 08:35:02 INFO - PROCESS | 2484 | __end_tp_report 08:35:02 INFO - PROCESS | 2484 | __start_cc_report 08:35:02 INFO - PROCESS | 2484 | _x_x_mozilla_cycle_collect,1639 08:35:02 INFO - PROCESS | 2484 | __end_cc_report 08:35:02 INFO - PROCESS | 2484 | __startTimestamp1491492902557__endTimestamp 08:35:02 INFO - PROCESS | 2484 | 08:35:02 INFO - PROCESS | 2484 | ------- Summary: start ------- 08:35:02 INFO - PROCESS | 2484 | Number of tests: 14 08:35:02 INFO - PROCESS | 2484 | 08:35:02 INFO - PROCESS | 2484 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.25 (2.9%) stddev-sans-first:0.93 08:35:02 INFO - PROCESS | 2484 | Values: 101.0 111.0 111.0 110.0 111.0 110.0 111.0 113.0 110.0 111.0 08:35:02 INFO - PROCESS | 2484 | 08:35:02 INFO - PROCESS | 2484 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:115.00 stddev:15.85 (13.8%) stddev-sans-first:14.94 08:35:02 INFO - PROCESS | 2484 | Values: 145.0 115.0 115.0 155.0 114.0 115.0 115.0 114.0 140.0 115.0 08:35:02 INFO - PROCESS | 2484 | 08:35:02 INFO - PROCESS | 2484 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 08:35:02 INFO - PROCESS | 2484 | Values: 160.0 160.0 161.0 161.0 160.0 161.0 161.0 161.0 161.0 161.0 08:35:02 INFO - PROCESS | 2484 | 08:35:02 INFO - PROCESS | 2484 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.50 stddev:13.17 (17.4%) stddev-sans-first:13.78 08:35:02 INFO - PROCESS | 2484 | Values: 75.0 76.0 77.0 116.0 75.0 75.0 77.0 75.0 91.0 75.0 08:35:02 INFO - PROCESS | 2484 | 08:35:02 INFO - PROCESS | 2484 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:82.00 stddev:11.08 (13.5%) stddev-sans-first:11.71 08:35:02 INFO - PROCESS | 2484 | Values: 92.0 81.0 104.0 82.0 81.0 81.0 96.0 82.0 82.0 111.0 08:35:02 INFO - PROCESS | 2484 | 08:35:02 INFO - PROCESS | 2484 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:113.00 stddev:0.63 (0.6%) stddev-sans-first:0.50 08:35:02 INFO - PROCESS | 2484 | Values: 114.0 113.0 113.0 113.0 113.0 113.0 113.0 112.0 112.0 112.0 08:35:02 INFO - PROCESS | 2484 | 08:35:02 INFO - PROCESS | 2484 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 08:35:02 INFO - PROCESS | 2484 | Values: 146.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 145.0 146.0 08:35:02 INFO - PROCESS | 2484 | 08:35:02 INFO - PROCESS | 2484 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:35:02 INFO - PROCESS | 2484 | Values: 94.0 94.0 94.0 93.0 93.0 94.0 94.0 94.0 94.0 93.0 08:35:02 INFO - PROCESS | 2484 | 08:35:02 INFO - PROCESS | 2484 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:54.50 stddev:4.14 (7.6%) stddev-sans-first:4.39 08:35:02 INFO - PROCESS | 2484 | Values: 56.0 54.0 67.0 54.0 53.0 56.0 55.0 54.0 53.0 54.0 08:35:02 INFO - PROCESS | 2484 | 08:35:02 INFO - PROCESS | 2484 | [#9] json-stringify-tinderbox Cycles:10 Average:52.70 Median:53.00 stddev:1.06 (2.0%) stddev-sans-first:1.09 08:35:02 INFO - PROCESS | 2484 | Values: 52.0 53.0 51.0 52.0 53.0 53.0 52.0 55.0 53.0 53.0 08:35:02 INFO - PROCESS | 2484 | 08:35:02 INFO - PROCESS | 2484 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:80.50 stddev:5.01 (6.2%) stddev-sans-first:5.32 08:35:02 INFO - PROCESS | 2484 | Values: 81.0 78.0 75.0 80.0 81.0 84.0 80.0 80.0 94.0 80.0 08:35:02 INFO - PROCESS | 2484 | 08:35:02 INFO - PROCESS | 2484 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:123.50 stddev:7.04 (5.7%) stddev-sans-first:7.46 08:35:02 INFO - PROCESS | 2484 | Values: 124.0 128.0 120.0 119.0 123.0 119.0 141.0 117.0 127.0 120.0 08:35:02 INFO - PROCESS | 2484 | 08:35:02 INFO - PROCESS | 2484 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:163.50 stddev:3.28 (2.0%) stddev-sans-first:3.41 08:35:02 INFO - PROCESS | 2484 | Values: 164.0 164.0 166.0 161.0 157.0 158.0 167.0 160.0 163.0 161.0 08:35:02 INFO - PROCESS | 2484 | 08:35:02 INFO - PROCESS | 2484 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.30 Median:60.00 stddev:2.83 (4.7%) stddev-sans-first:2.96 08:35:02 INFO - PROCESS | 2484 | Values: 59.0 60.0 68.0 60.0 61.0 59.0 60.0 59.0 59.0 58.0 08:35:02 INFO - PROCESS | 2484 | -------- Summary: end -------- 08:35:02 INFO - PROCESS | 2484 | 08:35:03 INFO - TEST-INFO | 2484: exit 0 08:35:03 INFO - TEST-OK | kraken | took 60585ms 08:35:03 INFO - SUITE-END | took 1177s 08:35:03 INFO - Completed test suite (00:19:37) 08:35:03 INFO - javascript benchmark 08:35:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7912.595502899917, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3439.1917899293667, 3481.9651803481966, 3482.094655389598, 3507.631698671638, 3537.221811201536, 5798.56510761693, 5894.29268487781, 5899.115132730092, 5900.763969441223, 5918.496927761134, 5906.970465147679, 5936.851578710523, 5941.138534912435, 5942.940570594293, 5951.6726580038085, 5202.921956170651, 5218.0, 5239.947600523984, 5274.525292723654, 5292.682439053669, 5055.115354812893, 5076.086304465195, 5292.126799078147, 5293.550048245904, 5299.5230429261355, 5156.716380599066, 5188.273641690166, 5257.921131183016, 5272.0, 5276.419593844674, 5270.262163297141, 5277.393099793535, 5284.656497327662, 5292.44429334922, 5292.550133238679, 4989.625778066623, 5160.974195129038, 5210.895782084375, 5266.34170728659, 5275.525202731773, 5689.317281926154, 5756.107803290497, 5810.883782324372, 5821.883562328772, 5828.621139625953, 6281.24625044993, 6345.206849143857, 6349.682515874188, 6356.237251529846, 6365.458935990447, 6375.266844312917, 6376.458001069915, 6402.967985160091, 6403.295637479873, 6407.647579383132, 5588.916166257469, 5618.325800903876, 5807.216025836543, 5843.18195452637, 5939.198208241918, 6448.774292899726, 6451.967740161269, 6454.709538070798, 6454.935450645527, 6464.191976003, 6139.723712432951, 6155.0, 6172.753089876444, 6189.195404597373, 6205.906911396332, 6050.6672133032225, 6099.115628233882, 6214.906776398358, 6292.244930608356, 6302.243730752339, 6325.082862984934, 6332.430081292706, 6337.841553961096, 6348.04779283102, 6350.428461438492, 6020.397960203944, 6062.514998800086, 6065.120557519135, 6113.658745237643, 6142.345304543789, 4725.362076119749, 4743.83396581118, 4744.596709279681, 4750.216214324598, 4769.950610865604, 4124.072083781125, 4211.1998720243055, 4231.153769246163, 4233.386159006926, 4278.187144442546, 5878.2358293421585, 6005.789797357072, 6049.667268300285, 6110.3765049759795, 6112.419320164578, 6343.0, 6354.872902542016, 6358.682065896779, 6380.968095159495, 6381.298057213703, 6120.571559990758, 6131.478824299896, 6132.294786099566, 6139.47814435769, 6139.693015349215, 5193.091209038404, 5237.240600112962, 5313.946860531345, 5363.597730170253, 5421.484958928895, 6642.43539299165, 6652.268250492442, 6653.135092437952, 6655.767048153291, 6657.966710166418, 6272.937270627235, 6372.107904893412, 6373.426391624776, 6383.0, 6386.680665966776, 6275.3724627536885, 6309.684515774101, 6461.160049193575, 6493.480521558358, 6638.468922486093, 6239.625622462667, 6243.562950593597, 6245.6252624842655, 6248.250209974832, 6254.124422580933, 6356.5232607555545, 6367.490600751836, 6371.776987805404, 6372.6495042773095, 6381.457576106083, 5925.881482370414, 5999.1901093351835, 6103.450689437972, 6149.877002460015, 6192.81421557354, 6167.784127555514, 6171.938280617136, 6211.9068213977735, 6220.160278362363, 6221.3156552780065, 6183.319834818077, 6204.472619827185, 6206.534509911684, 6211.378862113753, 6213.285472170758, 5900.262467191601, 5919.733611987557, 5960.910586341295, 5966.940330596812, 6091.725872335667, 6038.849028774316, 6049.183360246487, 6065.969670151621, 6076.665783381956, 6087.9391206087375], "value": 5780.745719613607, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.8739607964686, 825.7027470110759, 845.7631863078338, 890.6882591093118, 902.2871931174373, 31895.362092758132, 43573.564264357345, 43697.34453983193, 43773.562264377346, 43823.0, 45669.314960275624, 45757.31364029542, 45853.0, 45910.31134532985, 45972.540274597246, 7509.173990861001, 7800.453968222227, 8995.730128096151, 9132.908670913306, 9138.771530711752, 10531.05220530156, 10683.626073087444, 10689.465526723672, 10690.305130166515, 11018.0, 10720.571177152944, 10783.352998820095, 10796.460176991159, 10812.621558245462, 10819.78360432791, 10721.30311529748, 10764.300320479144, 10766.300190487593, 10770.838437423445, 10774.084202842767, 10540.314879532882, 10569.577216911315, 10581.470926453647, 10583.470826458723, 10586.41774702391, 42616.360754588706, 42781.57218427807, 42823.143537129086, 42922.141557168994, 42982.0, 4199.475065616798, 4250.3199488081755, 4271.67962402821, 4356.128774245164, 4368.650507959387, 29967.850160749276, 30411.239719006982, 30777.384452311053, 30961.071167864775, 32266.516002259985, 4289.463817022872, 4388.824447022115, 4405.163019026407, 4407.096545208225, 4426.822927082945, 239606.0, 239910.0, 240294.798526008, 240576.0, 240872.0, 55627.44372556303, 55747.0, 55916.72041639766, 55996.44003559994, 56055.439445605836, 57848.71075644595, 57958.4204157953, 58142.7092864533, 58148.70925645345, 58157.4184258152, 15993.760093598605, 16062.196890155445, 16126.032438053755, 16173.514794556182, 16247.756283655755, 12525.185862918881, 12701.428435720414, 14015.369308381147, 14037.71924561503, 14186.077904936146, 13705.588832335046, 13719.314034298246, 13768.793468097987, 13816.861831381759, 13832.239226842621, 5590.413006634326, 5592.105263157875, 5627.690477023803, 5638.323401191883, 5641.182028605829, 1020.4642562654666, 1026.7022563456662, 1027.3733022856052, 1037.7561273100816, 1042.3120740311358, 27969.580456293173, 28362.43275134527, 28435.431291374058, 28616.85691571529, 28766.42467150645, 1091.9890801092047, 1097.2100087936674, 1109.8501702270091, 1126.9492872820742, 1132.2866594045863, 15670.373185072698, 16871.578210544834, 17370.21834017472, 17429.47711568655, 17852.107394630217, 359722.0, 360235.0, 362249.0, 362424.0, 364105.0, 62747.37252627507, 62864.37135628676, 62970.0554491683, 63225.36774632287, 63231.683841580496, 1486.5317425011087, 1514.2807166595778, 1519.4302136698739, 1535.2860919672405, 1554.9541737063303, 30247.69752302449, 30916.690833091383, 31504.684953151092, 31874.20314492156, 31920.840395797873, 44195.558044419144, 44253.336199956386, 44385.0, 44478.332825007004, 44524.0, 322136.0, 322564.0, 323182.0, 323751.0, 323962.0, 27167.59248611312, 27777.027804026762, 30760.0, 32251.193720157185, 32430.0, 41253.79373103115, 41878.0, 46341.304880427495, 46559.76720116513, 46598.0, 32156.356872861943, 32170.839145804122, 32375.35249294954, 32406.0, 32552.34895302128, 31545.526817097303, 31617.5257371135, 32082.19794505156, 32316.83841580777, 32588.83705581457, 36875.0, 36998.26003479969, 37075.443868341456, 37607.62392376151, 37769.244615106996, 30794.0, 30802.0, 30996.845015774776, 31237.219069523442, 31248.843755781076, 24080.0, 25317.113901013377, 25325.746742532338, 25393.0, 25403.618945715458], "value": 19337.18691833649, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.1204059941019, 467.3457159976035, 469.1110345894531, 474.7578734845228, 487.68787975695557, 19704.90147549262, 21396.25113121041, 21828.45428864279, 21906.342809715694, 21991.34025979221, 21648.8917555412, 21850.672239916414, 22021.779782202175, 22094.33716988493, 22324.330270091923, 6356.427921487065, 6458.418742313191, 6588.901166482495, 6766.763163289286, 6808.931910680904, 6722.764703235388, 6846.691898864563, 6852.6231057291825, 6856.142982127234, 6856.211535673411, 6626.469882409419, 6776.186857577073, 6809.625470599115, 6815.659217039153, 6820.590764554143, 6737.831554211135, 6781.525293229452, 6792.864142717142, 7224.096987876515, 7499.47503674743, 7234.7885150354205, 7423.777286681354, 7467.887981680279, 7483.13943896448, 7484.850302993964, 25119.497610047878, 25714.871425642938, 25752.0, 25891.48217035649, 26054.088106916355, 3034.7117023882697, 3035.104644129965, 3161.2413020875056, 3223.774335796495, 3225.7580681448985, 15682.68634627301, 15790.684186316324, 15808.288627011698, 16056.277467513873, 16443.260053297632, 2210.546837898243, 2234.0728597631964, 2257.1761307122947, 2265.648824432216, 2280.133549251274, 86590.0, 89593.55203223941, 91959.0, 103748.48125759399, 122943.0, 17207.0, 18359.898221870273, 18800.52998675044, 18907.810921890607, 19010.61978760417, 32705.509417358284, 32958.0, 33016.35869130512, 33118.834405827816, 33152.50271245933, 10457.738556536147, 10657.14742820588, 10762.946185269024, 10994.890051099546, 11018.11855051594, 8963.372563920462, 9063.184313411693, 9107.863382049274, 9138.360314778034, 9282.860757088649, 9154.633814647339, 9343.626254949726, 9467.147956683932, 9488.146066854017, 9521.857172142423, 3264.4450443424676, 3432.5754811752845, 3679.5768486623847, 3811.8284677189595, 3845.0, 978.7895602445508, 979.4368238263028, 980.926430517714, 987.3779518903045, 1001.5993602559034, 21495.57008859814, 21586.676199857015, 21596.28143498478, 21734.45663858416, 21908.342749717533, 994.786120983992, 994.8060128275062, 1004.081265641944, 1016.1718199667396, 1027.3733022856052, 11168.609098681669, 11264.66206013821, 11810.232334898204, 11936.0, 12143.392830358447, 734258.0, 748782.0, 759096.0, 769448.0, 781158.0, 86239.0, 87952.56023719968, 111231.08213196103, 116547.41726291315, 123555.0, 1164.361370716511, 1288.1305119044607, 1345.3878485288974, 1387.3202130955758, 1405.3956798576505, 18908.52728681739, 19808.504787380432, 19812.70280945816, 19821.60356792885, 19877.906715130808, 47688.0, 49971.0, 51294.0, 52154.91876040921, 52677.47322526879, 68874.65562672155, 69163.0, 69679.65160174167, 71109.28890711234, 71269.64365178141, 8046.0747014091785, 11063.778724425627, 11178.776424471627, 12098.879011209776, 12422.627321180378, 13677.24775137377, 13865.646903768084, 14324.14055156694, 14393.136411815325, 14650.34073466718, 12386.938065309616, 12407.31759753186, 12462.31457269859, 12602.621921342374, 12692.746145077232, 11406.087512999105, 11585.594504192313, 11815.40922953866, 11829.290242585472, 11952.880471195525, 12514.74970500603, 12604.49582016709, 12841.871581284442, 12966.935165324114, 13098.541551045668, 14592.124472531257, 14827.703445931236, 14842.554723358317, 14958.775618365515, 15004.924975375054, 12775.169613975062, 12861.742765144832, 12987.220766754024, 13843.377048032662, 14011.43954241819], "value": 11609.852185150387, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1539.9769003464944, 1564.045931981491, 1579.913104779237, 1585.064811761061, 1587.484067678005, 10632.46837658117, 11265.042471389921, 11274.32354058756, 11280.32318060917, 11294.0, 10738.140948724084, 11066.557337706503, 11072.944635276832, 11107.333559986406, 11129.554817807299, 2419.7701218384227, 2461.5569197544437, 2462.66753988212, 2463.4210960424284, 2466.5930121529927, 2352.188494969233, 2395.317334559651, 2399.8920048597856, 2423.769741874528, 2442.218490083174, 2291.2897001929373, 2329.8252631052655, 2337.100216416675, 2364.9527009459803, 2381.214199314231, 2227.649829429951, 2283.178055899883, 2293.346396277053, 2298.9310320690324, 2337.053493335202, 2316.455632926261, 2320.501092265154, 2322.4077860145726, 2329.0683726509365, 2330.102910379499, 11375.374354410504, 11585.18903676743, 11588.13089018327, 11599.594014209462, 11613.361265130414, 5675.971620141914, 5823.883522329572, 5828.242328497268, 5834.183214349994, 5837.241158649391, 3396.609389920166, 3410.0, 3442.208292092808, 3464.133966508373, 3520.1551627609447, 1286.4468278640181, 1288.9742205155844, 1315.6645055510878, 1329.4084132561013, 1370.6230786533683, 13617.523386681418, 13920.095193812369, 16037.117958512394, 16543.91728041364, 16770.0, 4455.1757924784015, 4606.815727370935, 4746.169420351424, 4773.451053128865, 4783.617310615212, 10563.524641391155, 10797.946010270056, 12864.421101050475, 12865.678358041125, 12884.80672789909, 4848.321235027099, 5534.889302213933, 5715.457031581993, 5767.8558036049435, 5793.478586927196, 5080.77136528857, 5109.054824857339, 5148.433672296044, 5184.351956005499, 5184.507471790174, 3835.616438356142, 3857.267119247334, 3883.2233553289457, 3920.3335432976464, 3921.490206273166, 1003.7741508160751, 1006.2050979725934, 1006.954687039085, 1016.8118898003893, 1020.806046851096, 1063.9680809575725, 1065.2170654568886, 1070.0797314309686, 1073.4042606353548, 1084.3114622214794, 6732.124823772878, 6859.519833611599, 6860.211075726255, 6972.755953541602, 6985.615791131537, 1048.4757621189406, 1069.8074346617527, 1073.8550295709979, 1078.5146683992077, 1115.2472081345059, 4790.952090479121, 4792.856214313576, 4899.099750784025, 4900.240462728283, 4912.508749125131, 12978.740425191443, 13458.528951486847, 14544.418223271163, 15286.617834554003, 15297.388104475918, 13762.65593360174, 13763.931180344034, 13779.517716879862, 13801.0, 13805.654858628615, 10518.73703157412, 10544.947275263728, 10705.090067344207, 10760.94619526913, 10824.621138260123, 7461.141968673455, 7516.135644400745, 7650.158482567024, 7661.88507172404, 7784.2215778421705, 13117.147385419918, 13204.075714699879, 13223.140495867738, 13495.730085398041, 13574.0, 13346.0, 13350.065495415227, 13354.065215434826, 13418.0, 13419.932900335436, 9854.55654495535, 10032.498375081072, 10092.091711745978, 10093.444860532742, 10097.394156350643, 10409.635662751767, 10440.112590429899, 10442.582296708351, 10537.262391632512, 10565.683029509128, 8942.68700595476, 8950.955245223733, 9047.411918225294, 9050.728478145666, 9123.589438475152, 9167.174954253882, 9215.907840921773, 9225.031371705874, 9236.26109911192, 9369.953150234205, 8584.141585841366, 8754.0, 8761.824763504566, 8763.25512331459, 8768.824623507366, 6233.127362169391, 6257.155284036597, 6337.588056776295, 6343.429091381798, 6357.110004599267, 6204.193454850841, 6270.153529273673, 6375.936240637534, 6497.220333560003, 6579.407853293226], "value": 5326.142029730271, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.7724308522597, 422.6618705035971, 423.73303821573506, 430.0710465394747, 434.5046646822623, 5154.768035438405, 5220.425753167154, 5265.289185959889, 5283.920741188886, 5295.31160949077, 4956.4547899731, 5144.845654630358, 5168.793248270074, 5181.637285390015, 5189.299444574981, 4267.914641707164, 4349.978250108753, 4356.847510337139, 4365.34117035526, 4366.301391777316, 4331.155424692186, 4346.9565304347025, 4351.695381323293, 4355.150745604608, 4393.143337049277, 4356.629686476654, 4360.389545463638, 4361.912761744763, 4372.584604462587, 4384.188925048876, 4167.229062623409, 4271.615554600101, 4305.63402110821, 4307.440032795748, 4347.152305300468, 4051.7974101295113, 4063.756174629532, 4091.488563929509, 4095.89760255996, 4100.220958017997, 5055.9241611375855, 5075.807185311449, 5094.592432605383, 5105.795768169269, 5112.744362781883, 4975.502449755032, 4994.528493544635, 5038.5465308122075, 5083.440821509631, 5103.106956282636, 5417.726834193962, 5467.726613669301, 5482.643628164156, 5487.2317875497065, 5513.889722205574, 4571.519990401027, 4585.335126406686, 4586.128635559233, 4603.976980115078, 4634.814607415699, 5446.782128714846, 5669.744861481243, 5670.837478316935, 5701.57238207132, 5722.597963498928, 4668.5798278155125, 4757.500462451462, 4758.287016673995, 4791.47293797682, 4802.423709154924, 4848.878778030577, 4869.318295438641, 4870.659053866196, 4871.29366241893, 4882.536159064884, 4934.5312195341385, 5080.501252130631, 5085.618578606545, 5107.719075450886, 5119.948800511947, 5445.891082178414, 5452.40023597404, 5452.863678407992, 5461.508464238158, 5513.531349835229, 1535.9862490756047, 1645.0423995445622, 1646.752987051928, 1662.4846297647769, 1669.5659128626644, 1247.6444213399138, 1257.8616352201434, 1282.2050328796206, 1282.7819270723999, 1307.6469353274754, 5346.732663366816, 5364.7317634118135, 5393.2449457076045, 5393.973030134903, 5426.864328391743, 5526.447355264441, 5578.330600327906, 5584.86037849057, 5609.326880774252, 5636.661800291996, 5200.6619569727845, 5251.291075704808, 5352.812651557177, 5354.705491197944, 5362.8659283517445, 2912.85435728217, 2915.6938521455368, 2930.4432157889933, 2948.88204471823, 2969.9109026729234, 5762.250907382014, 5794.594378393556, 5820.9730939911005, 5838.766449342063, 5840.94159058404, 5432.320959880015, 5523.9837459327055, 5535.640183388067, 5616.943830561724, 5645.334626285256, 5655.462731040545, 5773.0, 5792.783515461801, 5804.361520232856, 5811.476967072984, 5520.503154716095, 5572.665640061609, 5582.190582365453, 5660.801871934463, 5715.8571035724435, 5323.920141197807, 5466.72666366688, 5522.337319521683, 5576.972115139561, 5578.832635020955, 5758.654480731169, 5772.297172334088, 5794.0, 5805.245318108618, 5859.062549991981, 4521.59305662492, 4676.158291507561, 4683.437987441393, 4683.812647494198, 4701.952980470288, 5634.971825141012, 5645.181448689835, 5655.349634791887, 5656.886862262814, 5664.0, 5485.341758988947, 5499.945000549943, 5543.0, 5558.583106267127, 5591.18927755465, 5277.20841873722, 5461.617686761889, 5503.174523821459, 5533.529649979636, 5544.1960915667805, 5525.806596769094, 5536.7231638417115, 5572.442755724395, 5576.10782274834, 5580.748866300945, 5601.271834661468, 5621.30177514787, 5631.380548139619, 5667.206591077335, 5680.318361796611, 5269.683818970874, 5380.25141828915, 5415.702136382537, 5469.453054694499, 5502.80740174092], "value": 4416.5450505985, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [866.5060915278286, 871.7820544863785, 927.0868194828096, 927.2906226736545, 933.0389698610429, 15674.686506269882, 16998.40505582305, 17083.743743843854, 17911.193996270165, 18175.182116804743, 15245.085294882314, 15729.05625662461, 15791.447299344525, 17029.57426064349, 17317.13414329285, 869.0440515433005, 889.417431582313, 912.2018234045211, 915.7390143809016, 916.1251005289965, 897.9461232326081, 909.277124685873, 909.6043221198767, 911.7128104647015, 911.7629416351763, 948.7770373962113, 950.9144177024067, 951.1534734086669, 951.2675240065146, 951.2722767083187, 942.9198518126002, 943.5895385507326, 945.6973768394116, 946.3044662173297, 946.9621215151386, 697.400235797214, 697.6337422852991, 697.9057827193315, 698.0157977252051, 698.7414656577048, 16635.251413686412, 16674.49976500707, 16739.916300418543, 17691.646167076586, 17954.19206135727, 15296.235188240544, 15634.0, 15703.528894133195, 15888.841111588852, 16084.758728618963, 13266.933665331708, 13753.243571603558, 13758.31208439574, 13819.654508637364, 13866.722665546733, 4049.9392509112386, 4070.0, 4094.6928980326593, 4115.403266526337, 4247.065645557972, 50025.343629803836, 50030.499695002945, 54288.0, 70510.99999999949, 87469.56265218633, 11853.170278080452, 12108.576199832964, 12133.272003679807, 12234.75530489403, 12348.691282718004, 23253.0, 23341.416464588183, 23341.41646458852, 23398.0, 23514.294571162893, 9397.248220142372, 9446.244300456085, 9516.809663806685, 9528.714138575853, 9532.90467095334, 4656.348111264426, 4663.137319595886, 4689.249720044776, 4724.622030237572, 4789.616830653539, 3784.2053168834304, 3960.7227494075137, 3963.8810835674976, 3965.048388386824, 3965.1673148638533, 643.2441880790053, 648.6432462145801, 665.2449469851753, 668.1114118222752, 670.8926571748497, 826.2109685250572, 831.8294749576322, 864.2308345572445, 872.0973792125246, 885.2784980241083, 11422.428878556038, 11913.404329783476, 11936.403179840972, 12058.13098969661, 12338.321392323329, 831.6548632317641, 831.9683592345448, 832.704389941562, 855.7261676263661, 864.822711344173, 5693.658380497183, 5771.88456230873, 5776.797812076641, 5911.645301281937, 6038.758449662052, 71327.0, 84088.0, 84208.57895710482, 84333.57833210795, 84424.57787711146, 72396.0, 73262.63368683122, 73546.6322668394, 74562.0, 74788.0, 66371.66814165899, 66819.0, 67680.6615966917, 68925.31074689189, 69310.65344673244, 11619.76760464769, 12164.2701437914, 12218.327991960528, 12490.75018499643, 12549.121561490609, 38458.42312365373, 41755.7912210437, 42972.78513607412, 43041.569584305005, 43887.70842186785, 50946.74526627343, 50963.49036509587, 51344.48655513397, 51570.0, 51975.48024519706, 14360.210188439736, 14467.0, 14528.927355363156, 14700.485483008044, 15046.247687615356, 16570.83429165693, 16623.335066597683, 16776.32894684199, 18251.269949201884, 18263.45209643713, 15487.345500264964, 16380.180990950643, 16528.917355413145, 16660.66678666396, 17244.0, 15548.766768498708, 16288.511344659679, 16401.179941002665, 16486.17569121515, 16762.413315533897, 16174.919125404298, 16213.189340533163, 16224.756628650344, 16327.346906123623, 16527.173641317644, 11543.8268425972, 12075.57735479254, 12111.152219344915, 12172.817407739069, 12675.746485070431, 12821.679458013625, 13114.60656180316, 13127.474901003852, 13198.495528931331, 13426.462941482621], "value": 8038.499023081336, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1453.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 111.0, 110.0, 111.0, 110.0, 111.0, 113.0, 110.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 115.0, 115.0, 155.0, 114.0, 115.0, 115.0, 114.0, 140.0, 115.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 116.0, 75.0, 75.0, 77.0, 75.0, 91.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 81.0, 104.0, 82.0, 81.0, 81.0, 96.0, 82.0, 82.0, 111.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 112.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 67.0, 54.0, 53.0, 56.0, 55.0, 54.0, 53.0, 54.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 51.0, 52.0, 53.0, 53.0, 52.0, 55.0, 53.0, 53.0], "value": 52.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 75.0, 80.0, 81.0, 84.0, 80.0, 80.0, 94.0, 80.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 128.0, 120.0, 119.0, 123.0, 119.0, 141.0, 117.0, 127.0, 120.0], "value": 123.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 166.0, 161.0, 157.0, 158.0, 167.0, 160.0, 163.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 68.0, 60.0, 61.0, 59.0, 60.0, 59.0, 59.0, 58.0], "value": 60.3, "unit": "score"}]}]} 08:35:03 INFO - Return code: 0 08:35:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:35:03 ERROR - # TBPL SUCCESS # 08:35:03 INFO - Running post-action listener: _resource_record_post_action 08:35:03 INFO - [mozharness: 2017-04-06 15:35:03.883199Z] Finished run-tests step (success) 08:35:03 INFO - Running post-run listener: _resource_record_post_run 08:35:03 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 266240; Write bytes: 364531712; Read time: 32; Write time: 247800 08:35:03 INFO - TinderboxPrint: CPU usage
13.2% 08:35:03 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 08:35:03 INFO - TinderboxPrint: I/O write bytes / time
364,531,712 / 247,800 08:35:03 INFO - TinderboxPrint: CPU idle
8,275.4 (86.8%) 08:35:03 INFO - TinderboxPrint: CPU user
1,204.6 (12.6%) 08:35:03 INFO - TinderboxPrint: Swap in / out
0 / 0 08:35:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110878720; Read time: 0; Write time: 105008 08:35:03 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 266240; Write bytes: 253353984; Read time: 32; Write time: 142776 08:35:04 INFO - Running post-run listener: _upload_blobber_files 08:35:04 INFO - Blob upload gear active. 08:35:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:35:04 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 08:35:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:35:04 INFO - (blobuploader) - INFO - Open directory for files ... 08:35:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:35:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:35:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:05 INFO - (blobuploader) - INFO - Done attempting. 08:35:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:35:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:35:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:07 INFO - (blobuploader) - INFO - Done attempting. 08:35:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:35:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:35:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:10 INFO - (blobuploader) - INFO - Done attempting. 08:35:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:35:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:35:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:11 INFO - (blobuploader) - INFO - Done attempting. 08:35:11 INFO - (blobuploader) - INFO - Iteration through files over. 08:35:11 INFO - Return code: 0 08:35:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:35:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:35:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/345718ff3e714e50d51108686bc2f64a5683efce6329669a81c053cb31efca3d35f2fb09274e63c73a147c3d6013272c8468ba7f0266b8b9e7301ac3bc41ebbe", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/37fe31162a2489f4168152cebc2838e83b0409b6f0d516b5097e93f5cf6d28ed5498deb91cc61c818b0c0e86eb6686f22d29837f4c4aa2637a28753e5fa59da5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/96d76c182a28d8b6a920f3fa25bc33336ea6925ee4329277630bc126fa86f8c0a438a7f514039612d4fe23071e1a2d190e9529c4d5e382eaefe53624ae76743a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/de4bec8412fbba86849d56d5e5c9f878984e40aa806503e1028c01c7a1ec09fad8d0938724292f59a9ed4e9bb6ea6749772fa7a061a82d2a00c02abcbd1ead93"} 08:35:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:35:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:35:11 INFO - Contents: 08:35:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/345718ff3e714e50d51108686bc2f64a5683efce6329669a81c053cb31efca3d35f2fb09274e63c73a147c3d6013272c8468ba7f0266b8b9e7301ac3bc41ebbe", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/37fe31162a2489f4168152cebc2838e83b0409b6f0d516b5097e93f5cf6d28ed5498deb91cc61c818b0c0e86eb6686f22d29837f4c4aa2637a28753e5fa59da5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/96d76c182a28d8b6a920f3fa25bc33336ea6925ee4329277630bc126fa86f8c0a438a7f514039612d4fe23071e1a2d190e9529c4d5e382eaefe53624ae76743a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/de4bec8412fbba86849d56d5e5c9f878984e40aa806503e1028c01c7a1ec09fad8d0938724292f59a9ed4e9bb6ea6749772fa7a061a82d2a00c02abcbd1ead93"} 08:35:11 INFO - Running post-run listener: copy_logs_to_upload_dir 08:35:11 INFO - Copying logs to upload dir... 08:35:11 INFO - mkdir: /builds/slave/test/build/upload/logs 08:35:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.333678 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-04-06 08:35:11.300909) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-06 08:35:11.304311) ========= 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=1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/345718ff3e714e50d51108686bc2f64a5683efce6329669a81c053cb31efca3d35f2fb09274e63c73a147c3d6013272c8468ba7f0266b8b9e7301ac3bc41ebbe", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/37fe31162a2489f4168152cebc2838e83b0409b6f0d516b5097e93f5cf6d28ed5498deb91cc61c818b0c0e86eb6686f22d29837f4c4aa2637a28753e5fa59da5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/96d76c182a28d8b6a920f3fa25bc33336ea6925ee4329277630bc126fa86f8c0a438a7f514039612d4fe23071e1a2d190e9529c4d5e382eaefe53624ae76743a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/de4bec8412fbba86849d56d5e5c9f878984e40aa806503e1028c01c7a1ec09fad8d0938724292f59a9ed4e9bb6ea6749772fa7a061a82d2a00c02abcbd1ead93"} build_url:https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011218 build_url: 'https://queue.taskcluster.net/v1/task/CWp0vHGKR6uOc00E_96wMA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/345718ff3e714e50d51108686bc2f64a5683efce6329669a81c053cb31efca3d35f2fb09274e63c73a147c3d6013272c8468ba7f0266b8b9e7301ac3bc41ebbe", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/37fe31162a2489f4168152cebc2838e83b0409b6f0d516b5097e93f5cf6d28ed5498deb91cc61c818b0c0e86eb6686f22d29837f4c4aa2637a28753e5fa59da5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/96d76c182a28d8b6a920f3fa25bc33336ea6925ee4329277630bc126fa86f8c0a438a7f514039612d4fe23071e1a2d190e9529c4d5e382eaefe53624ae76743a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/de4bec8412fbba86849d56d5e5c9f878984e40aa806503e1028c01c7a1ec09fad8d0938724292f59a9ed4e9bb6ea6749772fa7a061a82d2a00c02abcbd1ead93"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-06 08:35:11.330511) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 08:35:11.330925) ========= 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=1258088b6da462a47ba2cd90000001a2-1491491652.371989-1284235845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 08:35:11.413806) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-06 08:35:11.414161) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-06 08:35:11.414522) ========= ========= Total master_lag: 0.16 =========