builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1492081519.09 results: success (0) revision: acf78d5d6ef2854753586cb5827a59e76ce22bb1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-13 04:05:19.091182) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-13 04:05:19.091600) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-13 04:05:19.091871) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-13 04:05:19.106431) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 04:05:19.106716) ========= 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=5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-13 04:05:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2017-04-13 04:05:19 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127555 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 04:05:19.248075) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 04:05:19.248392) ========= 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=5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013790 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 04:05:19.297898) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 04:05:19.298237) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev acf78d5d6ef2854753586cb5827a59e76ce22bb1 --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 acf78d5d6ef2854753586cb5827a59e76ce22bb1 --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=5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-13 04:05:19,458 truncating revision to first 12 chars 2017-04-13 04:05:19,458 Setting DEBUG logging. 2017-04-13 04:05:19,458 attempt 1/10 2017-04-13 04:05:19,458 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/acf78d5d6ef2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-13 04:05:19,978 unpacking tar archive at: mozilla-aurora-acf78d5d6ef2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.826930 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 04:05:20.138355) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-13 04:05:20.138665) ========= script_repo_revision: acf78d5d6ef2854753586cb5827a59e76ce22bb1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-13 04:05:20.139034) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-13 04:05:20.139307) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-13 04:05:20.148746) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-04-13 04:05:20.149069) ========= /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=5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:05:20 INFO - MultiFileLogger online at 20170413 04:05:20 in /builds/slave/test 04:05:20 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 04:05:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:05:20 INFO - {'append_to_log': False, 04:05:20 INFO - 'base_work_dir': '/builds/slave/test', 04:05:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 04:05:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:05:20 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 04:05:20 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:20 INFO - 'config_files': ('talos/linux_config.py',), 04:05:20 INFO - 'default_actions': ('clobber', 04:05:20 INFO - 'read-buildbot-config', 04:05:20 INFO - 'download-and-extract', 04:05:20 INFO - 'populate-webroot', 04:05:20 INFO - 'create-virtualenv', 04:05:20 INFO - 'install', 04:05:20 INFO - 'run-tests'), 04:05:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:20 INFO - 'download_minidump_stackwalk': True, 04:05:20 INFO - 'download_symbols': 'ondemand', 04:05:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:05:20 INFO - 'tooltool.py': '/tools/tooltool.py', 04:05:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:05:20 INFO - '/tools/misc-python/virtualenv.py')}, 04:05:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:20 INFO - 'gecko_profile': False, 04:05:20 INFO - 'gecko_profile_interval': 0, 04:05:20 INFO - 'installer_path': 'installer.exe', 04:05:20 INFO - 'log_level': 'info', 04:05:20 INFO - 'log_name': 'talos', 04:05:20 INFO - 'log_to_console': True, 04:05:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:05:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:05:20 INFO - 'opt_config_files': (), 04:05:20 INFO - 'pip_index': False, 04:05:20 INFO - 'suite': 'dromaeojs', 04:05:20 INFO - 'system_bits': '32', 04:05:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:20 INFO - 'title': 'talos-linux64-ix-011', 04:05:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:20 INFO - 'use_talos_json': True, 04:05:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:05:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:20 INFO - 'work_dir': 'build'} 04:05:20 INFO - [mozharness: 2017-04-13 11:05:20.411121Z] Running clobber step. 04:05:20 INFO - Running pre-action listener: _resource_record_pre_action 04:05:20 INFO - Running main action method: clobber 04:05:20 INFO - rmtree: /builds/slave/test/build 04:05:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:05:21 INFO - Running post-action listener: _resource_record_post_action 04:05:21 INFO - [mozharness: 2017-04-13 11:05:21.346526Z] Finished clobber step (success) 04:05:21 INFO - [mozharness: 2017-04-13 11:05:21.346625Z] Running read-buildbot-config step. 04:05:21 INFO - Running pre-action listener: _resource_record_pre_action 04:05:21 INFO - Running main action method: read_buildbot_config 04:05:21 INFO - Using buildbot properties: 04:05:21 INFO - { 04:05:21 INFO - "project": "", 04:05:21 INFO - "product": "firefox", 04:05:21 INFO - "who": "cbook@mozilla.com", 04:05:21 INFO - "installer_path": "public/build/target.tar.bz2", 04:05:21 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:05:21 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 04:05:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 04:05:21 INFO - "stage_platform": "linux64", 04:05:21 INFO - "basedir": "/builds/slave/test", 04:05:21 INFO - "buildnumber": 124, 04:05:21 INFO - "platform": "ubuntu64_hw", 04:05:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:05:21 INFO - "slavebuilddir": "test", 04:05:21 INFO - "taskId": "AYnLkhcvRt6Q73sx9Y-9hg", 04:05:21 INFO - "branch": "mozilla-aurora", 04:05:21 INFO - "script_repo_revision": "production", 04:05:21 INFO - "revision": "acf78d5d6ef2854753586cb5827a59e76ce22bb1", 04:05:21 INFO - "slavename": "talos-linux64-ix-011", 04:05:21 INFO - "repo_path": "releases/mozilla-aurora" 04:05:21 INFO - } 04:05:21 INFO - Finding installer, test and symbols from parent task. 04:05:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AYnLkhcvRt6Q73sx9Y-9hg'}, attempt #1 04:05:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AYnLkhcvRt6Q73sx9Y-9hg'}, attempt #1 04:05:22 INFO - Task dependencies: FYDrf0apQS6js0f34GMuYw 04:05:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw'}, attempt #1 04:05:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.tar.bz2 04:05:22 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/test_packages.json 04:05:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.crashreporter-symbols.zip 04:05:22 INFO - Running post-action listener: _resource_record_post_action 04:05:22 INFO - [mozharness: 2017-04-13 11:05:22.729679Z] Finished read-buildbot-config step (success) 04:05:22 INFO - [mozharness: 2017-04-13 11:05:22.729898Z] Running download-and-extract step. 04:05:22 INFO - Running pre-action listener: _resource_record_pre_action 04:05:22 INFO - Running main action method: download_and_extract 04:05:22 INFO - mkdir: /builds/slave/test/build/tests 04:05:22 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')]} 04:05:22 INFO - trying https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.test_packages.json 04:05:22 INFO - Downloading https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:05:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:05:23 INFO - Downloaded 896 bytes. 04:05:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:05:23 INFO - Using the following test package requirements: 04:05:23 INFO - {u'common': [u'target.common.tests.zip'], 04:05:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:05:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:05:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:05:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:05:23 INFO - u'mozbase': [u'target.common.tests.zip'], 04:05:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:05:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:05:23 INFO - u'web-platform': [u'target.common.tests.zip', 04:05:23 INFO - u'target.web-platform.tests.zip'], 04:05:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:05:23 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:05:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.common.tests.zip 04:05:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:05:23 INFO - Fetch https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.common.tests.zip into memory 04:05:24 INFO - Expected file size: 59542400 04:05:24 INFO - Obtained file size: 59542400 04:05:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:05:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.common.tests.zip 04:05:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:05:34 INFO - Fetch https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.common.tests.zip into memory 04:05:35 INFO - Expected file size: 59542400 04:05:35 INFO - Obtained file size: 59542400 04:05:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.talos.tests.zip 04:05:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:05:45 INFO - Fetch https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.talos.tests.zip into memory 04:05:46 INFO - Expected file size: 14404424 04:05:46 INFO - Obtained file size: 14404424 04:05: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')]} 04:05:46 INFO - trying https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.tar.bz2 04:05:46 INFO - Downloading https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:05:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:05:48 INFO - Downloaded 66709778 bytes. 04:05:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.tar.bz2 04:05:48 INFO - mkdir: /builds/slave/test/properties 04:05:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:05:48 INFO - Writing to file /builds/slave/test/properties/build_url 04:05:48 INFO - Contents: 04:05:48 INFO - build_url:https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.tar.bz2 04:05:48 INFO - Running post-action listener: _resource_record_post_action 04:05:48 INFO - Running post-action listener: set_extra_try_arguments 04:05:48 INFO - [mozharness: 2017-04-13 11:05:48.110876Z] Finished download-and-extract step (success) 04:05:48 INFO - [mozharness: 2017-04-13 11:05:48.110972Z] Running populate-webroot step. 04:05:48 INFO - Running pre-action listener: _resource_record_pre_action 04:05:48 INFO - Running main action method: populate_webroot 04:05:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:05:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:05:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:05:48 INFO - '--tppagecycles', 04:05:48 INFO - '7'], 04:05:48 INFO - 'tests': ['tsvgm']}}, 04:05:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:05:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:05:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:05:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:05:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:05:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:05:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:05:48 INFO - 'talos_options': ['--disable-e10s'], 04:05:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:05:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:05:48 INFO - 'talos_options': ['--disable-e10s'], 04:05:48 INFO - 'tests': ['damp', 'tps']}, 04:05:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:05:48 INFO - 'tests': ['damp', 'tps']}, 04:05:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:05:48 INFO - 'tests': ['dromaeo_dom']}, 04:05:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:05:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:05:48 INFO - 'tests': ['basic_compositor_video']}, 04:05:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:05:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:05:48 INFO - 'tests': ['a11yr', 04:05:48 INFO - 'ts_paint', 04:05:48 INFO - 'tpaint', 04:05:48 INFO - 'sessionrestore', 04:05:48 INFO - 'sessionrestore_no_auto_restore', 04:05:48 INFO - 'tabpaint']}, 04:05:48 INFO - 'other-e10s': {'tests': ['a11yr', 04:05:48 INFO - 'ts_paint', 04:05:48 INFO - 'tpaint', 04:05:48 INFO - 'sessionrestore', 04:05:48 INFO - 'sessionrestore_no_auto_restore', 04:05:48 INFO - 'tabpaint']}, 04:05:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:05:48 INFO - 'ts_paint', 04:05:48 INFO - 'tpaint', 04:05:48 INFO - 'sessionrestore', 04:05:48 INFO - 'sessionrestore_no_auto_restore', 04:05:48 INFO - 'tabpaint']}, 04:05:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:05:48 INFO - 'ts_paint', 04:05:48 INFO - 'tpaint', 04:05:48 INFO - 'sessionrestore', 04:05:48 INFO - 'sessionrestore_no_auto_restore', 04:05:48 INFO - 'tabpaint']}, 04:05:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:05:48 INFO - 'tests': ['a11yr', 04:05:48 INFO - 'ts_paint', 04:05:48 INFO - 'tpaint', 04:05:48 INFO - 'sessionrestore', 04:05:48 INFO - 'sessionrestore_no_auto_restore', 04:05:48 INFO - 'tabpaint']}, 04:05:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:05:48 INFO - 'tests': ['a11yr', 04:05:48 INFO - 'ts_paint', 04:05:48 INFO - 'tpaint', 04:05:48 INFO - 'sessionrestore', 04:05:48 INFO - 'sessionrestore_no_auto_restore', 04:05:48 INFO - 'tabpaint']}, 04:05:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:05:48 INFO - 'tests': ['tsvgx', 04:05:48 INFO - 'tsvgr_opacity', 04:05:48 INFO - 'tart', 04:05:48 INFO - 'tscrollx', 04:05:48 INFO - 'cart', 04:05:48 INFO - 'tsvg_static']}, 04:05:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:05:48 INFO - 'tsvgr_opacity', 04:05:48 INFO - 'tart', 04:05:48 INFO - 'tscrollx', 04:05:48 INFO - 'cart', 04:05:48 INFO - 'tsvg_static']}, 04:05:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:05:48 INFO - 'talos_options': ['--disable-e10s'], 04:05:48 INFO - 'tests': ['tp5o']}, 04:05:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:05:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:05:48 INFO - 'talos_options': ['--disable-e10s', 04:05:48 INFO - '--xperf_path', 04:05:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:48 INFO - 'tests': ['tp5n']}, 04:05:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:05:48 INFO - 'talos_options': ['--xperf_path', 04:05:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:48 INFO - 'tests': ['tp5n']}}, 04:05:48 INFO - 'talos.zip': {'path': '', 04:05:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:05:48 INFO - Running post-action listener: _resource_record_post_action 04:05:48 INFO - [mozharness: 2017-04-13 11:05:48.124134Z] Finished populate-webroot step (success) 04:05:48 INFO - [mozharness: 2017-04-13 11:05:48.124225Z] Running create-virtualenv step. 04:05:48 INFO - Running pre-action listener: _resource_record_pre_action 04:05:48 INFO - Running main action method: create_virtualenv 04:05:48 INFO - Creating virtualenv /builds/slave/test/build/venv 04:05:48 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 04:05:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:05:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:05:48 INFO - Using real prefix '/usr' 04:05:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:05:48 INFO - Installing distribute.............................................................................................................................................................................................done. 04:05:50 INFO - Installing pip.................done. 04:05:50 INFO - Return code: 0 04:05:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:05:50 INFO - Reading from file tmpfile_stdout 04:05:50 INFO - Output received: 04:05:50 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) 04:05:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:50 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 0x180e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aac310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9400>, '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 0x1aaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa840>, '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': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', '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 04:05:50 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 04:05:50 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 04:05:50 INFO - Using env: {'DISPLAY': ':0', 04:05:50 INFO - 'HOME': '/home/cltbld', 04:05:50 INFO - 'LANG': 'en_US.UTF-8', 04:05:50 INFO - 'LANGUAGE': 'en_US:en', 04:05:50 INFO - 'LOGNAME': 'cltbld', 04:05:50 INFO - 'MAIL': '/var/mail/cltbld', 04:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:50 INFO - 'MOZ_NO_REMOTE': '1', 04:05:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:50 INFO - 'NO_EM_RESTART': '1', 04:05:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:50 INFO - 'PWD': '/builds/slave/test', 04:05:50 INFO - 'SHELL': '/bin/bash', 04:05:50 INFO - 'SHLVL': '1', 04:05:50 INFO - 'TERM': 'linux', 04:05:50 INFO - 'TMOUT': '86400', 04:05:50 INFO - 'USER': 'cltbld', 04:05:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', 04:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:50 INFO - '_': '/tools/buildbot/bin/python'} 04:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:51 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 04:05:51 INFO - Cleaning up... 04:05:51 INFO - Return code: 0 04:05:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:05:51 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')]} 04:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:51 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')]} 04:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:51 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 0x180e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aac310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9400>, '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 0x1aaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa840>, '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': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', '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 04:05:51 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 04:05:51 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 04:05:51 INFO - Using env: {'DISPLAY': ':0', 04:05:51 INFO - 'HOME': '/home/cltbld', 04:05:51 INFO - 'LANG': 'en_US.UTF-8', 04:05:51 INFO - 'LANGUAGE': 'en_US:en', 04:05:51 INFO - 'LOGNAME': 'cltbld', 04:05:51 INFO - 'MAIL': '/var/mail/cltbld', 04:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:51 INFO - 'MOZ_NO_REMOTE': '1', 04:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:51 INFO - 'NO_EM_RESTART': '1', 04:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:51 INFO - 'PWD': '/builds/slave/test', 04:05:51 INFO - 'SHELL': '/bin/bash', 04:05:51 INFO - 'SHLVL': '1', 04:05:51 INFO - 'TERM': 'linux', 04:05:51 INFO - 'TMOUT': '86400', 04:05:51 INFO - 'USER': 'cltbld', 04:05:51 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', 04:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:51 INFO - '_': '/tools/buildbot/bin/python'} 04:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:51 INFO - Downloading/unpacking psutil>=3.1.1 04:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:05:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:53 INFO - Installing collected packages: psutil 04:05:53 INFO - Running setup.py install for psutil 04:05:53 INFO - building 'psutil._psutil_linux' extension 04:05:53 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 04:05:53 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 04:05:53 INFO - building 'psutil._psutil_posix' extension 04:05:53 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 04:05:53 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 04:05:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:53 INFO - Successfully installed psutil 04:05:53 INFO - Cleaning up... 04:05:54 INFO - Return code: 0 04:05:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aac310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9400>, '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 0x1aaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa840>, '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': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', '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 04:05:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:05:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:05:54 INFO - Using env: {'DISPLAY': ':0', 04:05:54 INFO - 'HOME': '/home/cltbld', 04:05:54 INFO - 'LANG': 'en_US.UTF-8', 04:05:54 INFO - 'LANGUAGE': 'en_US:en', 04:05:54 INFO - 'LOGNAME': 'cltbld', 04:05:54 INFO - 'MAIL': '/var/mail/cltbld', 04:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:54 INFO - 'MOZ_NO_REMOTE': '1', 04:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:54 INFO - 'NO_EM_RESTART': '1', 04:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:54 INFO - 'PWD': '/builds/slave/test', 04:05:54 INFO - 'SHELL': '/bin/bash', 04:05:54 INFO - 'SHLVL': '1', 04:05:54 INFO - 'TERM': 'linux', 04:05:54 INFO - 'TMOUT': '86400', 04:05:54 INFO - 'USER': 'cltbld', 04:05:54 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', 04:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:54 INFO - '_': '/tools/buildbot/bin/python'} 04:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:05:54 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 04:05:54 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 04:05:54 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 04:05:54 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 04:05:54 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 04:05:54 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 04:05:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:05:56 INFO - Installing collected packages: mozsystemmonitor 04:05:56 INFO - Running setup.py install for mozsystemmonitor 04:05:56 INFO - Successfully installed mozsystemmonitor 04:05:56 INFO - Cleaning up... 04:05:56 INFO - Return code: 0 04:05:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:05: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')]} 04:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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')]} 04:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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', '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 0x180e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aac310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9400>, '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 0x1aaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa840>, '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': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', '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 04:05: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:05: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 jsonschema==2.5.1 04:05:56 INFO - Using env: {'DISPLAY': ':0', 04:05:56 INFO - 'HOME': '/home/cltbld', 04:05:56 INFO - 'LANG': 'en_US.UTF-8', 04:05:56 INFO - 'LANGUAGE': 'en_US:en', 04:05:56 INFO - 'LOGNAME': 'cltbld', 04:05:56 INFO - 'MAIL': '/var/mail/cltbld', 04:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:56 INFO - 'MOZ_NO_REMOTE': '1', 04:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:56 INFO - 'NO_EM_RESTART': '1', 04:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:56 INFO - 'PWD': '/builds/slave/test', 04:05:56 INFO - 'SHELL': '/bin/bash', 04:05:56 INFO - 'SHLVL': '1', 04:05:56 INFO - 'TERM': 'linux', 04:05:56 INFO - 'TMOUT': '86400', 04:05:56 INFO - 'USER': 'cltbld', 04:05:56 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', 04:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:56 INFO - '_': '/tools/buildbot/bin/python'} 04:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:56 INFO - Downloading/unpacking jsonschema==2.5.1 04:05:56 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 04:05:56 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 04:05:56 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 04:05:56 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 04:05:56 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 04:05:56 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 04:05:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:05:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:05:58 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 04:05:58 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 04:05:58 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 04:05:58 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 04:05:58 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 04:05:58 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 04:05:58 INFO - Downloading functools32-3.2.3-2.tar.gz 04:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:05:58 INFO - warning: no files found matching '*.txt' 04:05:58 INFO - no previously-included directories found matching 'build' 04:05:58 INFO - no previously-included directories found matching 'dist' 04:05:58 INFO - no previously-included directories found matching '.git*' 04:05:58 INFO - Installing collected packages: jsonschema, functools32 04:05:59 INFO - Running setup.py install for functools32 04:05:59 INFO - warning: no files found matching '*.txt' 04:05:59 INFO - no previously-included directories found matching 'build' 04:05:59 INFO - no previously-included directories found matching 'dist' 04:05:59 INFO - no previously-included directories found matching '.git*' 04:05:59 INFO - Successfully installed jsonschema functools32 04:05:59 INFO - Cleaning up... 04:05:59 INFO - Return code: 0 04:05:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:59 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 0x180e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aac310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9400>, '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 0x1aaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa840>, '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': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', '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 04:05:59 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 04:05:59 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 04:05:59 INFO - Using env: {'DISPLAY': ':0', 04:05:59 INFO - 'HOME': '/home/cltbld', 04:05:59 INFO - 'LANG': 'en_US.UTF-8', 04:05:59 INFO - 'LANGUAGE': 'en_US:en', 04:05:59 INFO - 'LOGNAME': 'cltbld', 04:05:59 INFO - 'MAIL': '/var/mail/cltbld', 04:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:59 INFO - 'MOZ_NO_REMOTE': '1', 04:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:59 INFO - 'NO_EM_RESTART': '1', 04:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:59 INFO - 'PWD': '/builds/slave/test', 04:05:59 INFO - 'SHELL': '/bin/bash', 04:05:59 INFO - 'SHLVL': '1', 04:05:59 INFO - 'TERM': 'linux', 04:05:59 INFO - 'TMOUT': '86400', 04:05:59 INFO - 'USER': 'cltbld', 04:05:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', 04:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:59 INFO - '_': '/tools/buildbot/bin/python'} 04:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:05:59 INFO - Cleaning up... 04:05:59 INFO - Return code: 0 04:05:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:59 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 0x180e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aac310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9400>, '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 0x1aaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa840>, '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': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', '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 04:05:59 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 04:05:59 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 04:05:59 INFO - Using env: {'DISPLAY': ':0', 04:05:59 INFO - 'HOME': '/home/cltbld', 04:05:59 INFO - 'LANG': 'en_US.UTF-8', 04:05:59 INFO - 'LANGUAGE': 'en_US:en', 04:05:59 INFO - 'LOGNAME': 'cltbld', 04:05:59 INFO - 'MAIL': '/var/mail/cltbld', 04:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:59 INFO - 'MOZ_NO_REMOTE': '1', 04:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:59 INFO - 'NO_EM_RESTART': '1', 04:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:59 INFO - 'PWD': '/builds/slave/test', 04:05:59 INFO - 'SHELL': '/bin/bash', 04:05:59 INFO - 'SHLVL': '1', 04:05:59 INFO - 'TERM': 'linux', 04:05:59 INFO - 'TMOUT': '86400', 04:05:59 INFO - 'USER': 'cltbld', 04:05:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', 04:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:59 INFO - '_': '/tools/buildbot/bin/python'} 04:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:59 INFO - Downloading/unpacking blobuploader==1.2.4 04:05:59 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 04:05:59 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 04:05:59 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 04:05:59 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 04:05:59 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 04:05:59 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 04:06:01 INFO - Downloading blobuploader-1.2.4.tar.gz 04:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:06:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:06:01 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 04:06:01 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 04:06:01 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 04:06:01 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 04:06:01 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 04:06:01 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 04:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:06:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:06:02 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 04:06:02 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 04:06:02 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 04:06:02 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 04:06:02 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 04:06:02 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 04:06:02 INFO - Downloading docopt-0.6.1.tar.gz 04:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:06:02 INFO - Installing collected packages: blobuploader, requests, docopt 04:06:02 INFO - Running setup.py install for blobuploader 04:06:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:06:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:06:02 INFO - Running setup.py install for requests 04:06:02 INFO - Running setup.py install for docopt 04:06:03 INFO - Successfully installed blobuploader requests docopt 04:06:03 INFO - Cleaning up... 04:06:03 INFO - Return code: 0 04:06:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:03 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 0x180e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aac310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9400>, '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 0x1aaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa840>, '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': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', '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 04:06:03 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 04:06:03 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 04:06:03 INFO - Using env: {'DISPLAY': ':0', 04:06:03 INFO - 'HOME': '/home/cltbld', 04:06:03 INFO - 'LANG': 'en_US.UTF-8', 04:06:03 INFO - 'LANGUAGE': 'en_US:en', 04:06:03 INFO - 'LOGNAME': 'cltbld', 04:06:03 INFO - 'MAIL': '/var/mail/cltbld', 04:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:03 INFO - 'MOZ_NO_REMOTE': '1', 04:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:03 INFO - 'NO_EM_RESTART': '1', 04:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:03 INFO - 'PWD': '/builds/slave/test', 04:06:03 INFO - 'SHELL': '/bin/bash', 04:06:03 INFO - 'SHLVL': '1', 04:06:03 INFO - 'TERM': 'linux', 04:06:03 INFO - 'TMOUT': '86400', 04:06:03 INFO - 'USER': 'cltbld', 04:06:03 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', 04:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:03 INFO - '_': '/tools/buildbot/bin/python'} 04:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:03 INFO - Running setup.py (path:/tmp/pip-Y30HmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:03 INFO - Running setup.py (path:/tmp/pip-tH7EXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:03 INFO - Running setup.py (path:/tmp/pip-pyiR6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:03 INFO - Running setup.py (path:/tmp/pip-3o_ubo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:03 INFO - Running setup.py (path:/tmp/pip-Q10HB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:03 INFO - Running setup.py (path:/tmp/pip-IEf169-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:03 INFO - Running setup.py (path:/tmp/pip-HKUUpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:03 INFO - Running setup.py (path:/tmp/pip-93FFEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:03 INFO - Running setup.py (path:/tmp/pip-sazRy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:03 INFO - Running setup.py (path:/tmp/pip-nvzWQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:04 INFO - Running setup.py (path:/tmp/pip-PWIC0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:04 INFO - Running setup.py (path:/tmp/pip-jPEc8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:04 INFO - Running setup.py (path:/tmp/pip-rMYjll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:04 INFO - Running setup.py (path:/tmp/pip-nk2rkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:04 INFO - Running setup.py (path:/tmp/pip-tk2ueg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:04 INFO - Running setup.py (path:/tmp/pip-hBrLmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:04 INFO - Running setup.py (path:/tmp/pip-_ZDYOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:06:04 INFO - Running setup.py install for manifestparser 04:06:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:06:04 INFO - Running setup.py install for mozcrash 04:06:04 INFO - Running setup.py install for mozdebug 04:06:04 INFO - Running setup.py install for mozdevice 04:06:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:06:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:06:05 INFO - Running setup.py install for mozfile 04:06:05 INFO - Running setup.py install for mozhttpd 04:06:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:06:05 INFO - Running setup.py install for mozinfo 04:06:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:06:05 INFO - Running setup.py install for mozInstall 04:06:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:06:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:06:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:06:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:06:05 INFO - Running setup.py install for mozleak 04:06:05 INFO - Running setup.py install for mozlog 04:06:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:06:05 INFO - Running setup.py install for moznetwork 04:06:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:06:05 INFO - Running setup.py install for mozprocess 04:06:05 INFO - Running setup.py install for mozprofile 04:06:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:06:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:06:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:06:05 INFO - Running setup.py install for mozrunner 04:06:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:06:06 INFO - Running setup.py install for mozscreenshot 04:06:06 INFO - Running setup.py install for moztest 04:06:06 INFO - Running setup.py install for mozversion 04:06:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:06:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:06:06 INFO - Cleaning up... 04:06:06 INFO - Return code: 0 04:06:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:06 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 0x180e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aac310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9400>, '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 0x1aaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa840>, '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': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', '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 04:06:06 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 04:06:06 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 04:06:06 INFO - Using env: {'DISPLAY': ':0', 04:06:06 INFO - 'HOME': '/home/cltbld', 04:06:06 INFO - 'LANG': 'en_US.UTF-8', 04:06:06 INFO - 'LANGUAGE': 'en_US:en', 04:06:06 INFO - 'LOGNAME': 'cltbld', 04:06:06 INFO - 'MAIL': '/var/mail/cltbld', 04:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:06 INFO - 'MOZ_NO_REMOTE': '1', 04:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:06 INFO - 'NO_EM_RESTART': '1', 04:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:06 INFO - 'PWD': '/builds/slave/test', 04:06:06 INFO - 'SHELL': '/bin/bash', 04:06:06 INFO - 'SHLVL': '1', 04:06:06 INFO - 'TERM': 'linux', 04:06:06 INFO - 'TMOUT': '86400', 04:06:06 INFO - 'USER': 'cltbld', 04:06:06 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', 04:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:06 INFO - '_': '/tools/buildbot/bin/python'} 04:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:06 INFO - Running setup.py (path:/tmp/pip-WiQOFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:06 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)) 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:06 INFO - Running setup.py (path:/tmp/pip-RZHWOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:06 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)) 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:06 INFO - Running setup.py (path:/tmp/pip-RVrCpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:06 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)) 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:06 INFO - Running setup.py (path:/tmp/pip-J3Si4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:06 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)) 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:06 INFO - Running setup.py (path:/tmp/pip-PkEzja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:06 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)) 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:06 INFO - Running setup.py (path:/tmp/pip-4l0S95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:07 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)) 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:07 INFO - Running setup.py (path:/tmp/pip-DcFZYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:07 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)) 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:07 INFO - Running setup.py (path:/tmp/pip-1G9Sgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:07 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)) 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:07 INFO - Running setup.py (path:/tmp/pip-JdC_CD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:07 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)) 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:07 INFO - Running setup.py (path:/tmp/pip-AC80fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:07 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)) 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:07 INFO - Running setup.py (path:/tmp/pip-_hoKnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:07 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)) 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:07 INFO - Running setup.py (path:/tmp/pip-04MVlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:07 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)) 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:07 INFO - Running setup.py (path:/tmp/pip-6dQCsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:07 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)) 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:07 INFO - Running setup.py (path:/tmp/pip-hjWBzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:07 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)) 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:07 INFO - Running setup.py (path:/tmp/pip-JMSABX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:07 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)) 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:07 INFO - Running setup.py (path:/tmp/pip-MpSo7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:07 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)) 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:07 INFO - Running setup.py (path:/tmp/pip-EJPIPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:07 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)) 04:06:07 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)) 04:06:07 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)) 04:06:07 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)) 04:06:07 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)) 04:06:07 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)) 04:06:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:09 INFO - Downloading blessings-1.6.tar.gz 04:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:06:09 INFO - Installing collected packages: blessings 04:06:09 INFO - Running setup.py install for blessings 04:06:10 INFO - Successfully installed blessings 04:06:10 INFO - Cleaning up... 04:06:10 INFO - Return code: 0 04:06:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:06:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:10 INFO - Reading from file tmpfile_stdout 04:06:10 INFO - Current package versions: 04:06:10 INFO - argparse == 1.2.1 04:06:10 INFO - blessings == 1.6 04:06:10 INFO - blobuploader == 1.2.4 04:06:10 INFO - docopt == 0.6.1 04:06:10 INFO - functools32 == 3.2.3-2 04:06:10 INFO - jsonschema == 2.5.1 04:06:10 INFO - manifestparser == 1.1 04:06:10 INFO - mozInstall == 1.12 04:06:10 INFO - mozcrash == 1.0 04:06:10 INFO - mozdebug == 0.1 04:06:10 INFO - mozdevice == 0.49 04:06:10 INFO - mozfile == 1.2 04:06:10 INFO - mozhttpd == 0.7 04:06:10 INFO - mozinfo == 0.9 04:06:10 INFO - mozleak == 0.1 04:06:10 INFO - mozlog == 3.4 04:06:10 INFO - moznetwork == 0.27 04:06:10 INFO - mozprocess == 0.25 04:06:10 INFO - mozprofile == 0.28 04:06:10 INFO - mozrunner == 6.13 04:06:10 INFO - mozscreenshot == 0.1 04:06:10 INFO - mozsystemmonitor == 0.3 04:06:10 INFO - moztest == 0.8 04:06:10 INFO - mozversion == 1.4 04:06:10 INFO - psutil == 3.1.1 04:06:10 INFO - requests == 1.2.3 04:06:10 INFO - wsgiref == 0.1.2 04:06:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:10 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')]} 04:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:10 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')]} 04:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:10 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 0x180e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aac310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9400>, '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 0x1aaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa840>, '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': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', '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 04:06:10 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 04:06:10 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 04:06:10 INFO - Using env: {'DISPLAY': ':0', 04:06:10 INFO - 'HOME': '/home/cltbld', 04:06:10 INFO - 'LANG': 'en_US.UTF-8', 04:06:10 INFO - 'LANGUAGE': 'en_US:en', 04:06:10 INFO - 'LOGNAME': 'cltbld', 04:06:10 INFO - 'MAIL': '/var/mail/cltbld', 04:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:10 INFO - 'MOZ_NO_REMOTE': '1', 04:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:10 INFO - 'NO_EM_RESTART': '1', 04:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:10 INFO - 'PWD': '/builds/slave/test', 04:06:10 INFO - 'SHELL': '/bin/bash', 04:06:10 INFO - 'SHLVL': '1', 04:06:10 INFO - 'TERM': 'linux', 04:06:10 INFO - 'TMOUT': '86400', 04:06:10 INFO - 'USER': 'cltbld', 04:06:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', 04:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:10 INFO - '_': '/tools/buildbot/bin/python'} 04:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:10 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)) 04:06:10 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)) 04:06:10 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)) 04:06:10 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)) 04:06:10 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)) 04:06:10 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)) 04:06:10 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)) 04:06:10 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)) 04:06:10 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)) 04:06:10 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)) 04:06:10 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)) 04:06:10 INFO - Cleaning up... 04:06:10 INFO - Return code: 0 04:06:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:06:10 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')]} 04:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:10 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')]} 04:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:10 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 0x180e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aac310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9400>, '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 0x1aaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa840>, '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': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', '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 04:06:10 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 04:06:10 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 04:06:10 INFO - Using env: {'DISPLAY': ':0', 04:06:10 INFO - 'HOME': '/home/cltbld', 04:06:10 INFO - 'LANG': 'en_US.UTF-8', 04:06:10 INFO - 'LANGUAGE': 'en_US:en', 04:06:10 INFO - 'LOGNAME': 'cltbld', 04:06:10 INFO - 'MAIL': '/var/mail/cltbld', 04:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:10 INFO - 'MOZ_NO_REMOTE': '1', 04:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:10 INFO - 'NO_EM_RESTART': '1', 04:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:10 INFO - 'PWD': '/builds/slave/test', 04:06:10 INFO - 'SHELL': '/bin/bash', 04:06:10 INFO - 'SHLVL': '1', 04:06:10 INFO - 'TERM': 'linux', 04:06:10 INFO - 'TMOUT': '86400', 04:06:10 INFO - 'USER': 'cltbld', 04:06:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', 04:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:10 INFO - '_': '/tools/buildbot/bin/python'} 04:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:06:10 INFO - Cleaning up... 04:06:10 INFO - Return code: 0 04:06:10 INFO - Running post-action listener: _resource_record_post_action 04:06:10 INFO - Running post-action listener: _start_resource_monitoring 04:06:10 INFO - Starting resource monitoring. 04:06:10 INFO - [mozharness: 2017-04-13 11:06:10.812314Z] Finished create-virtualenv step (success) 04:06:10 INFO - [mozharness: 2017-04-13 11:06:10.812786Z] Running install step. 04:06:10 INFO - Running pre-action listener: _resource_record_pre_action 04:06:10 INFO - Running main action method: install 04:06:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:11 INFO - Reading from file tmpfile_stdout 04:06:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:06:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:06:11 INFO - Reading from file tmpfile_stdout 04:06:11 INFO - Output received: 04:06:11 INFO - Usage: mozinstall [options] installer 04:06:11 INFO - Options: 04:06:11 INFO - -h, --help show this help message and exit 04:06:11 INFO - -d DEST, --destination=DEST 04:06:11 INFO - Directory to install application into. [default: 04:06:11 INFO - "/builds/slave/test"] 04:06:11 INFO - --app=APP Application being installed. [default: firefox] 04:06:11 INFO - mkdir: /builds/slave/test/build/application 04:06:11 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'] 04:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:06:27 INFO - Reading from file tmpfile_stdout 04:06:27 INFO - Output received: 04:06:27 INFO - /builds/slave/test/build/application/firefox/firefox 04:06:27 INFO - Running post-action listener: _resource_record_post_action 04:06:27 INFO - [mozharness: 2017-04-13 11:06:27.701823Z] Finished install step (success) 04:06:27 INFO - [mozharness: 2017-04-13 11:06:27.701967Z] Running run-tests step. 04:06:27 INFO - Running pre-action listener: _resource_record_pre_action 04:06:27 INFO - Running main action method: run_tests 04:06:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:06:27 INFO - Python 2.7.3 04:06:27 INFO - Return code: 0 04:06:27 INFO - grabbing minidump binary from tooltool 04:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:27 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 0x1aa9400>, '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 0x1aaa3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:06:27 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 04:06:27 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 04:06:27 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 04:06:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:06:27 INFO - Return code: 0 04:06:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:06:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:06:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:06:27 INFO - ENV: RUST_BACKTRACE is now 1 04:06:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:06:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:06:27 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/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 04:06:27 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/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 04:06:27 INFO - Using env: {'DISPLAY': ':0', 04:06:27 INFO - 'HOME': '/home/cltbld', 04:06:27 INFO - 'LANG': 'en_US.UTF-8', 04:06:27 INFO - 'LANGUAGE': 'en_US:en', 04:06:27 INFO - 'LOGNAME': 'cltbld', 04:06:27 INFO - 'MAIL': '/var/mail/cltbld', 04:06:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:06:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:27 INFO - 'MOZ_NO_REMOTE': '1', 04:06:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:27 INFO - 'NO_EM_RESTART': '1', 04:06:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:27 INFO - 'PWD': '/builds/slave/test', 04:06:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:06:27 INFO - 'RUST_BACKTRACE': '1', 04:06:27 INFO - 'SHELL': '/bin/bash', 04:06:27 INFO - 'SHLVL': '1', 04:06:27 INFO - 'TERM': 'linux', 04:06:27 INFO - 'TMOUT': '86400', 04:06:27 INFO - 'USER': 'cltbld', 04:06:27 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661', 04:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:27 INFO - '_': '/tools/buildbot/bin/python'} 04:06:27 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/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 04:06:27 INFO - mozversion application_buildid: 20170413100903 04:06:27 INFO - mozversion application_changeset: acf78d5d6ef2854753586cb5827a59e76ce22bb1 04:06:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:06:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:06:27 INFO - mozversion application_name: Firefox 04:06:27 INFO - mozversion application_remotingname: firefox-dev 04:06:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:06:27 INFO - mozversion application_vendor: Mozilla 04:06:27 INFO - mozversion application_version: 54.0a2 04:06:27 INFO - mozversion platform_buildid: 20170413100903 04:06:27 INFO - mozversion platform_changeset: acf78d5d6ef2854753586cb5827a59e76ce22bb1 04:06:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:06:27 INFO - mozversion platform_version: 54.0a2 04:06:27 INFO - using testdate: 1492081587 04:06:27 INFO - actual date: 1492081587 04:06:27 INFO - starting webserver on 'localhost:36087' 04:06:27 INFO - SUITE-START | Running 2 tests 04:06:27 INFO - TEST-START | dromaeo_css 04:06:27 INFO - operating with platform_type : linux_ 04:06:27 INFO - Initialising browser for dromaeo_css test... 04:06:27 INFO - TEST-INFO | started process 8138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphqxz3T/profile http://localhost:36087/getInfo.html) 04:06:32 INFO - PROCESS | 8138 | __metrics Screen width/height:1600/1200 04:06:32 INFO - PROCESS | 8138 | colorDepth:24 04:06:32 INFO - PROCESS | 8138 | Browser inner width/height: 1024/697 04:06:32 INFO - PROCESS | 8138 | __metrics 04:06:33 INFO - PROCESS | 8138 | 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" 04:06:33 INFO - PROCESS | 8138 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:06:33 INFO - PROCESS | 8138 | console.error: PushService: 04:06:33 INFO - PROCESS | 8138 | stateChangeProcessEnqueue: Error transitioning state 04:06:33 INFO - PROCESS | 8138 | UnknownError 04:06:34 INFO - TEST-INFO | 8138: exit 0 04:06:34 INFO - Browser initialized. 04:06:34 INFO - Running cycle 1/1 for dromaeo_css test... 04:06:34 INFO - TEST-INFO | started process 8231 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphqxz3T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:46 INFO - PROCESS | 8231 | RSS: Main: 140087296 04:06:46 INFO - PROCESS | 8231 | 04:09:47 INFO - PROCESS | 8231 | Cycle 1(1): loaded http://localhost:36087/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36087/tests/dromaeo/cssquery-ext.html) 04:09:48 INFO - PROCESS | 8231 | RSS: Main: 280174592 04:09:48 INFO - PROCESS | 8231 | 04:11:36 INFO - PROCESS | 8231 | ************************* 04:11:36 INFO - PROCESS | 8231 | A coding exception was thrown and uncaught in a Task. 04:11:36 INFO - PROCESS | 8231 | 04:11:36 ERROR - PROCESS | 8231 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:11:36 INFO - PROCESS | 8231 | Full stack: 04:11:36 INFO - PROCESS | 8231 | ************************* 04:11:36 INFO - PROCESS | 8231 | ************************* 04:11:36 INFO - PROCESS | 8231 | A coding exception was thrown and uncaught in a Task. 04:11:36 INFO - PROCESS | 8231 | 04:11:36 ERROR - PROCESS | 8231 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:11:36 INFO - PROCESS | 8231 | Full stack: 04:11:36 INFO - PROCESS | 8231 | ************************* 04:11:36 INFO - PROCESS | 8231 | ************************* 04:11:36 INFO - PROCESS | 8231 | A coding exception was thrown and uncaught in a Task. 04:11:36 INFO - PROCESS | 8231 | 04:11:36 ERROR - PROCESS | 8231 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:11:36 INFO - PROCESS | 8231 | Full stack: 04:11:36 INFO - PROCESS | 8231 | ************************* 04:11:36 INFO - PROCESS | 8231 | ************************* 04:11:36 INFO - PROCESS | 8231 | A coding exception was thrown and uncaught in a Task. 04:11:36 INFO - PROCESS | 8231 | 04:11:36 ERROR - PROCESS | 8231 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:11:36 INFO - PROCESS | 8231 | Full stack: 04:11:36 INFO - PROCESS | 8231 | ************************* 04:12:51 INFO - PROCESS | 8231 | Cycle 1(1): loaded http://localhost:36087/tests/dromaeo/cssquery-ext.html (next: http://localhost:36087/tests/dromaeo/cssquery-jquery.html) 04:12:51 INFO - PROCESS | 8231 | RSS: Main: 228220928 04:12:51 INFO - PROCESS | 8231 | 04:15:53 INFO - PROCESS | 8231 | Cycle 1(1): loaded http://localhost:36087/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36087/tests/dromaeo/cssquery-mootools.html) 04:15:54 INFO - PROCESS | 8231 | RSS: Main: 170184704 04:15:54 INFO - PROCESS | 8231 | 04:18:56 INFO - PROCESS | 8231 | Cycle 1(1): loaded http://localhost:36087/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36087/tests/dromaeo/cssquery-prototype.html) 04:18:56 INFO - PROCESS | 8231 | RSS: Main: 169693184 04:18:56 INFO - PROCESS | 8231 | 04:21:59 INFO - PROCESS | 8231 | Cycle 1(1): loaded http://localhost:36087/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36087/tests/dromaeo/cssquery-yui.html) 04:22:00 INFO - PROCESS | 8231 | RSS: Main: 177549312 04:22:00 INFO - PROCESS | 8231 | 04:25:02 INFO - PROCESS | 8231 | Cycle 1(1): loaded http://localhost:36087/tests/dromaeo/cssquery-yui.html (next: http://localhost:36087/tests/dromaeo/cssquery-dojo.html) 04:25:02 INFO - PROCESS | 8231 | RSS: Main: 261529600 04:25:02 INFO - PROCESS | 8231 | 04:25:02 INFO - PROCESS | 8231 | __start_tp_report 04:25:02 INFO - PROCESS | 8231 | _x_x_mozilla_page_load 04:25:02 INFO - PROCESS | 8231 | _x_x_mozilla_page_load_details 04:25:02 INFO - PROCESS | 8231 | |i|pagename|runs| 04:25:02 INFO - PROCESS | 8231 | |0;dojo.html;3383.898483045509;3393.0838673558137;3431.571053618299;3454.809985450799;3479.2867462170257;5585.972070139649;5633.943660563398;5638.689872057035;5652.321721393433;5691.288588926384;5621.8032368867;5667.0932650775885;5687.033204355259;5689.203511508392;5716.571257155709;5147.48525147486;5164.535191832734;5180.171172612383;5201.349831271091;5236.7119808410525;5024.849254522352;5040.949590504085;5257;5258.44786297439;5296.894062118756;5133.768980395891;5161.4322424533275;5216.374035115791;5229.398619158807;5243.344581927259;5250.107481728096;5251.658642188246;5252.448492908228;5254.65844720092;5285.524302812765;4978.925316120261;5087.872803179913;5159.380874295071;5210.843674689765;5214.322138122057;5503.532199763025;5541.141123125922;5601.075822489284;5645.576581756343;5647.407022262644;6059;6102.176206212149;6105.725242364104;6108.358622344679;6127.84680382994;6115.174451449042;6132.846678833021;6141.631502109843;6147.600405973598;6155.661438620874;5448.673079615236;5482.780688772445;5493.670379777186;5567.359753628384;5568.303962004749;6125.908111378333;6130.693465326716;6131.724072416752;6132.662703551258;6137.263528376623;5845.853853653693;5893.882122357529;5898.14476900847;5900.734466948998;5906.586538942319;5797.043487824546;5822.0684690449325;5980.700964951735;5998.940010599838;6021;5979.282486101695;6044.274687037496;6053.51571874249;6071.362506936796;6076.270847498328;5786.334571524244;5789.218455508452;5792.565557583198;5923.614965027259;6053.7578496860515;4545.818167273338;4593.035462552834;4605.03294308199;4615.561521655437;4620.44554653437;4036.7779772112817;4041.2523683118716;4100.610442008005;4129;4151;5792.82621521355;5818.854528636733;5858.209141765892;5895.823125306248;5908.379620139909;6113.877722445526;6118.296395914527;6128.233970753656;6136.478399336017;6137.96931015351;5583.441655834466;5859.2090067841145;5873.647581145145;5879.823605291848;5880.353161152356;4962.60299176065;5034.0686972910125;5060.2156665716875;5125.051865404912;5127.9230811537855;6377;6402.135711678864;6405.743770249138;6423.229212494437;6426.8714625707225;6078.422549857756;6122.510199183966;6126.938730612636;6130.203073600582;6144.047672610753;6131.77428366204;6180.042093475518;6268.404501572343;6312.179416675803;6377.649229292248;6045.244344456943;6048.939510604838;6050.183225264533;6050.606710563799;6087.299960504599;6141.938580614136;6143.109249158936;6143.723532440961;6151.84620384494;6156.476699480594;5623.100303951348;5734.340550836707;5876.236089308362;5917.733701983335;5992.67040312787;5960.552958528041;5962.135490353961;5976.850578735566;5989.041753319622;5995.490383317292;5889.970550147222;5913.290405151237;5935.732892019783;5942.10868369748;5958.851028724316;5702.372738998624;5724.4561766632105;5760.769569217185;5771.711414429178;5838.766449341979;5773.595848290579;5798.6810725410505;5874.441928017002;5878.735456904535;5892.145638882253 04:25:02 INFO - PROCESS | 8231 | |1;ext.html;764.5756605084176;832.4755404095418;850.8808766772653;908.1690253418122;919.8850143732034;31098;31424.68575314246;33496.497552536704;44903.55096449043;45310.77344613281;45669.54330456694;45827.77086114573;45862.77068614652;45947.310790338175;45982.770086149605;8953.91046089539;9162.450252984809;9168.679096231634;9172.587233574472;9174;7575.772726818204;7732.961335193316;8786.341024423162;10162.237832162617;10357.171426285879;10473.057424831764;10491.73770655732;10499.580016799318;10502.422366769824;10510.054095131436;10399.636012739556;10399.896001039968;10423.374597524096;10431.634892778717;10432.791344173113;10543.578256869716;10625.256232063759;10626.149908007419;10635.52140153695;10645;42202;42361;42382.57617423817;42396.364054539205;42407.151856963;4247.660187185018;4254.936175957363;4295.377170310318;4331.891702707426;4380.01449673824;30166.396672066654;30473;30611.38777224443;31303.217419564695;31495.37009259825;4364.258076127066;4396.626286765629;4435.268180750172;4438.511763705989;4488.236999710057;222748;223852;224303;225197;225275.8736206341;53852;53922.460775391744;53943.73028134834;54004.45995539994;54058.45941540613;55987;56069.43930560724;56479.43520564824;56530.717346413;56585.43414565884;15402.691946161014;15706.9214653926;15813.05121692702;15831.920840395724;15836.28736706851;13449.596512104652;13565.796513052312;13570;13571.59285221445;13579.388927498287;12016;12112.09159313055;13214.537491187762;13428.597142085753;13430;5604.523615492729;5629.24005259293;5674.886502269931;5710.114932185518;5722.856928576735;999.5252255178732;999.6551189839494;1014.3660212367271;1015.1523477895892;1020.2908978260186;28490.572641410396;28516.572251416244;28566;28659.856700716362;29000.564991525145;1061.989380106189;1082.437132691012;1086.6739978006724;1105.0993440346253;1111.9777604447866;14906.678056678398;15395.846041539442;15410.537683869501;15425.691486170213;15532.456364027204;300689;301957;302006;302131;302313;58743;58792.70603646954;59131.40868591345;59301.70349148313;59365;1483.3769816677022;1496.2144873941268;1500.3541394411684;1523.1242035829443;1542.8997115187476;26046.479070418864;27251.59122613202;27643.44713105767;27726.168214953585;27808.582871257353;43331;43359.783201085054;43522;43535.78232108819;43550.56449435465;284304;285475;285566;287280;287768;29928.401431971673;29961.700382995892;35668.82165589155;35696.64303357037;35823.82088089543;39407.60592394154;39493.40759888547;39560.208795823346;40380.798096009334;40470.59529404668;30682;31144.377112458078;31610.841945790125;31650.68349316477;31858.522122167724;30739.846300768353;30910;31028.53457198189;31059.534106988864;31716.682833172297;34751.47872781961;35029;35149;35221.471677925365;35540.46689299611;29189.270268243465;29332.706672932996;29543.704562954095;29699.703002969694;29933.70066299309;24696.25911222666;24728.752712472644;24825.25524234276;25054.62418063767;25164.24507264785 04:25:02 INFO - PROCESS | 8231 | |2;jquery.html;420.30859236555847;473.23099962560826;476.29746124466396;477.8255936583148;498.5338708307732;18325.541861453472;19551.706724399126;19990.7001394979;21426.785732142675;21462.89268553659;21137.57724845502;21875.90620468978;22080.22719204828;22103.336899892987;22204;6702.262751097388;6835.931640683604;6900.585964842126;6973.302669733037;6980.406665433445;6618.702158402859;6864.382205601495;6873.278305777896;6877.7592784252565;6878.209005964328;6637.701303441332;6888.75889343873;6891.379775820175;6919.135108111486;6926.68829902653;6793.45652347811;6797.218319893226;6816.863662726742;6866.347696968805;6923.723051077951;6532.314107018789;6771.4582833373215;6773.153355830521;6781.355771201728;6788.626625535593;25252.621210681853;25301;25357.239282821545;25542.23373298804;25572.104976325925;3248.204189973448;3270.1497610621172;3277.10121780796;3304.471284594453;3369.5619569456057;16114.75827862583;16158.676826463523;16488.34046638133;16733.748993765104;17101;2327.104064934995;2366.1127077345996;2390.988045059781;2434.5861203595255;2451.82837201396;94806;96946;98133.5093324536;98578;99528.50235748847;15291.847081529042;17747.556311092325;18948.347231387343;18957;18970.525736856413;27504.58743118855;29003.564946525818;34946.650533494845;35061.29877402489;35126.29747405038;10098.545565449573;10102.989701029837;10136.949315253523;10326.948365258277;10375.896241037493;8787.472751634923;8800.823983520293;8887.644494220289;9051.59267832949;9070.86393704095;8980.416272942239;9041.457512549268;9078.137576930314;9191.540422978824;9298.488583127857;3525.9294814103573;3939.2318497893207;4003.259397011562;4024.879253622396;4062.756234625932;978.4569563892109;980.3235767320668;983.1102851919024;985.1183191043975;995.1392045880406;21317.25389611356;21682.891585541973;21906.23328183538;21952;22001.66997495039;986.7977064701719;994.5524513968743;1004.3371374892536;1007.0634310091685;1031.1750599520353;11407.48666310018;11935.761284774257;11987.981021613261;12025.63923082309;12106.213096148722;482832;662664;662978;669050;688048;108111;130231;132294;132566.33716831353;132743;1325.7679906016601;1351.8445378781369;1371.0950772490307;1394.4282844033899;1395.2744572822278;14314.642133946734;18188;19704.90147549253;19730.802691972898;19836.750945649896;50385.74807125941;50947.49052509576;51002.48997509977;51489.485105148466;51867.740661296455;65351;65458.672706636164;65919;66265.33734662592;66735.3326466729;12289.815652765037;12764.29796361209;12797.552085676956;12820.423080961566;12843.229406235656;14089.225092619594;14105.153690778587;14300.070495417765;14350.569482915529;14538.418463261774;12398.876011239772;12657.177283476545;12682.809757853454;12683.11218214716;12736.745265094462;11877.524899003944;12008.339541324962;12012.159148859497;12043.036557075588;12197.390130493617;12136.939315303367;12175.208611440228;12795.552155674879;12988.35058247065;13236.933815330862;12661.93669031649;12702.555410560586;12754.808677869654;12933.159344642569;13005.61853918007;12721.173123746927;12884.549040783528;12890;12952.481900723866;13045.282509461691 04:25:02 INFO - PROCESS | 8231 | |3;mootools.html;1510.6374470127166;1544.011832427246;1550.81390233172;1553.3320672110995;1566.115144943107;10884.564617415304;11628.941855290712;11637.767244655102;11642.650720478388;11651.533938642444;11104.27822191557;11367.204295699285;11421.143414243923;11727.120465965065;11741.941290293558;2420.794232490236;2452.47271836556;2453.313072339739;2454.5213683331667;2457.594496908008;2347.9060837566476;2415.613501839706;2459.1515927005244;2460.151247819508;2462.396712805365;2373.6795532603137;2425.9514809703796;2439.329184474266;2440.1581454398206;2444.1811992982284;2256.165218869029;2287.6797248385155;2295.598270302699;2297.517521320516;2392.83250172488;2261.1068627892055;2284.6001949658744;2289.3360925331635;2295.735990361113;2298.6207275799475;11277.774444511146;11476.4835582399;11496.540138394454;11512.712182195428;11518.654440366803;5794.21778059965;5919.970400148015;5924.851878703023;5934.376890426486;5937.495312898365;3457.083872773717;3492.5634295713035;3550;3557.5019497270405;3582.4089025311055;1318.8417389913177;1337.177635754014;1354.7155097429552;1377.2769296119618;1416.7591509443419;14760.409583616642;15178.696426071418;16773.412930547493;17197.656046878994;17429.825701742946;4730.432348118248;4778.641601879873;4780.306855505932;4869.683470574401;4899.951000489949;13039.934800325938;13048.54330098442;13049.151805132826;13049.869501305055;13051.086423950423;5885.499732522783;5896.380880007623;5903.144044113579;5916.290045194518;5919.230500034968;5520.365158006881;5553.916691249635;5588;5600.439956004367;5660.094384898396;3854.402567602026;3958.129211573449;4000.6799456044027;4030.556638769733;4040.2929487339597;991.9107280344659;992.7121134870806;995.2582979785376;1009.1119814563137;1013.2755080117752;1036.1503567074926;1040.0795296162798;1047.3977462958828;1049.7585555322319;1052.736815796051;6768.357006084414;6997;7012.964935175393;7116.71533138679;7148.92851071493;1019.3781793106199;1051.574112484445;1063.5798859450629;1069.6897899609025;1099.9395033273088;4476.597106260452;4544.045750392388;4556.817727290938;4578.084383123389;4622.329762184531;13115.409806558537;13447.798283025762;13448.394822233024;13619.795703064265;14038.298085095705;14403;14497.347619356944;14509.85490145106;14537.563873083824;14547.927260363842;8704.390692651454;10608.734781630521;10854.131669466424;10858.619948301772;10864;6354.52341074412;6966.582005079711;7052.717891284291;7228.385587225145;7290.5625662460425;13017.739645206853;13123.67190820199;13124.671883202614;13447.327633618475;13581.86418135806;13444.126131801402;13544.796828047783;13560.86439135596;13601.183928964294;13726.176429414267;9466.621335146518;9644.614215431304;9731.756706082404;9738.464384458923;9757.365771224848;10922.344659320466;10951.890481095086;10958.397288149228;10984.670459886216;11011.229213954946;9027.187553120251;9051.547422628973;9066.138716821892;9199.402038867453;9403.43579385239;9254.35219534653;9316.394434361744;9468.100530449596;9496.382735122195;9623.230141588516;8307.376946728898;8331.916680833114;8403.117672644285;8438.578071096543;8468.322534197372;6134;6138.355472675305;6186.721597528032;6204.224471941007;6329.841753956004;6044.758209671564;6157.722902469489;6218.657973811484;6278.968605156945;6300.149479820349 04:25:02 INFO - PROCESS | 8231 | |4;prototype.html;421.82915919052795;431.5447203200623;438.78280251275623;441.3930845088004;443.6605996412744;5238.84283471496;5286.656367336125;5321.494458026481;5344.743985163484;5346.385165705945;5088.440271570124;5235.947640523594;5271.310082941946;5273.813391986801;5281.445448227938;4442.777861106948;4448.130955533687;4462.263726485126;4471.7987690554;4493.910121797562;4445.911081778362;4491.326301054852;4492.303692927601;4492.573205545468;4492.820287188509;4421.717701866455;4507.256302710049;4509.759816050596;4522.457305123374;4524.2082635538645;4496.842610508616;4499.75251361175;4502.684812063157;4503.684742068057;4560.361549383089;4205.91588168238;4214.873553793391;4217;4235.411720604773;4256.829726810924;5113.284140220372;5140.203268493389;5153;5178.229647138763;5250.264962905197;4928.778204980785;5097.388313402415;5135.969777831097;5145.922811157836;5156.813932795478;5463.426340234298;5504.082836096875;5515.993783388063;5524.779008839641;5559.193916882029;4394.62645675118;4637.536246375335;4651.3255577941345;4651.674382793172;4654.627629789608;5484.369297530795;5558.221848941152;5562;5736.368999410061;5742.626729262626;4672.415948006499;4675.620691895899;4680;4685.8594242172785;4702.388689470347;4743.241081426955;4764.976175119103;4770.379850619467;4770.546798054179;4778.259369797687;4946.826861059845;5069.518395752398;5081.8729531762;5099.821506247264;5157.690538567698;5534.557235421156;5538;5542.778288868481;5548.86127846799;5552.361478429952;1665.5669525923347;1665.7168281392192;1673.272126624922;1678.1944666560119;1679.3030892179609;1228.4901765767286;1281.6795801049739;1281.9551315703904;1290.6902343437507;1320.2672516753103;5388.299521062237;5391.433899440581;5436.640839790052;5466.933947880125;5474.343078830566;5681.744321505542;5686.44110150434;5704.3154821421695;5730.398308177665;5744.597878148573;5142.871428214325;5298.523132917979;5322.574194064466;5324.733763311819;5341.946580534145;2932.8680209390627;2953.9113826585235;2956.4530561846127;2973.152651494357;2996.625421822272;5585.664860108406;5890.67601281925;5907.763689452459;5913.46778789911;5936.851578710567;5700.525087806135;5753.993051216021;5757.798477053283;5786.537077033827;5788.971055144697;5852.9807216510235;5891.175235467038;5900.4984576310635;5911.9113213301835;5914.556408269483;5429.457054294539;5647.745851436613;5698.715064246854;5735.7418916148035;5770.422957704196;5423.2407462954425;5633.2113504110275;5635.9436405635415;5648.305508347561;5685.204071430086;5583.743657677152;5768.480836724715;5817.447342502455;5820.417958204146;5826.796062137805;4731.384919960383;4752.6197904168275;4782.473927867863;4786.6410019248;4789.018251258414;5497.47773961473;5648.887022259614;5705.516565692867;5729.68486733217;5757.683327417032;5485.6434331768305;5520.337559492887;5525.475079867406;5565.30433695788;5612.214289999321;5547.306586676666;5557.555035690669;5561.193626924154;5561.581796641831;5569.331680198402;5396.679427846064;5550.222968784293;5569.55443564522;5631.2960879890015;5634.464725851038;5602.635828671123;5642.279104873053;5643.689597072201;5654.830355089354;5656.660600363992;5327.680339179662;5477.315335583052;5510.8071217507195;5545.3622833373065;5573.244428005165 04:25:02 INFO - PROCESS | 8231 | |5;yui.html;820.0323618130607;832.3466079127882;889.2796834564003;899.7390756680563;937.3485427627797;16882.324707011703;17176.39882604109;17582.296708131675;17715.02567358795;17877.28490860364;15825.920870395632;16530.752038719398;16711.916440417812;16758.664826703458;16858.83141168588;867.6659486097866;888.471359541072;888.835565420396;891.2468963725673;892.6117139044536;864.8010957479784;880.9207171354577;887.4941283468394;896.3501461440469;898.7528429681824;943.1558754914347;949.1742184299634;952.2286947572454;952.347641865321;952.4333021851987;940.5532372123221;941.6845356805478;941.7127776028309;942.2038377570976;942.5098948546786;692.9099217101794;693.774523279936;694.8540806430656;695.3220609905352;695.3637421759084;17363.739543906853;17623.206955687026;17714.557136071573;17866.821331786774;18135.4559363218;15892.364305427769;15954.28205730745;16074.75887861683;16267.430639927665;16393.6721265574;13433.798493022612;13913.58259252224;13945.860541394557;13976.161430314112;14066.578002659937;3968.72218944674;4024.6176613221696;4037.6769858411258;4105.096878686684;4117.279476091672;88927;89207.10792892118;89680.5515972416;90845;93307;12274.938625306817;12349.814752778715;12362.814557781641;12509.311987840756;12546.435410406553;23509.529809403717;24186;24284.75715242825;24333.7566624335;24343.513129737305;8811.603477843384;8952.776180595538;9012.954935225282;9042.321825863086;9102.817943641223;5025.095482813055;5040.823571174991;5112.565431938253;5203.60972927032;5238;3593.748437609342;3667.7065834733157;3689.6494832990825;3707.2029513654693;3711.5175027246823;612.4243211381288;615.9137720719013;618.088319728397;626.7117126121943;627.5513008199159;774.2180397798264;783.561205724796;795.7533164718956;795.777182388932;808.6684459371629;10884.891151088546;10915.508802103925;11148.498317575728;11332.376719280353;11499.425028748696;617.2654541096082;623.9968800155971;624.9312575616678;625.1497962770628;651.547174713579;5322.707251101227;5331.973340133352;5363.463653634605;5390.676559406448;5425.457454254622;77903.61048194836;78575;79267.20732792598;79572.20427795764;80138;43206;45762;46402.535974639824;67902;72899;50645.49354506408;63824.36175638277;64161;64211.678941604994;64902.350976490576;11480.598179063692;11863.34751588671;11953.402329883296;11966.940165299118;12134.635960921187;40580.59419405886;41332.58667413287;41761.58238417698;41788.79105604452;42852.57147428486;46189.051749925486;46264.30603541017;46768;47209.29186062143;48520.5147948516;12520.812187817008;12577.748445031231;12599.811002835148;12741.10812243134;12858.67853303675;16109.597260068593;16126.919365403099;16162.515124546282;16428.425005125242;16435.26041328119;12604.810927835906;12666.493340266656;12749.553765618159;12750.107492475438;12835;15046;15073;15099;15242.314095865935;15475.690486189987;14637.707245855236;14643;14661.780073298696;14696;14782.704345912807;10186.46702217506;10392.480375981322;10487.213458990454;10571.841422378517;10668.679939601825;11237.60668376603;12584.874151258737;13300.135491193041;13349.933250333686;13399.732005360032 04:25:02 INFO - PROCESS | 8231 | __end_tp_report 04:25:02 INFO - PROCESS | 8231 | __start_cc_report 04:25:02 INFO - PROCESS | 8231 | _x_x_mozilla_cycle_collect,1427 04:25:02 INFO - PROCESS | 8231 | __end_cc_report 04:25:02 INFO - PROCESS | 8231 | __startTimestamp1492082702652__endTimestamp 04:25:02 INFO - PROCESS | 8231 | 04:25:02 INFO - PROCESS | 8231 | ------- Summary: start ------- 04:25:02 INFO - PROCESS | 8231 | Number of tests: 6 04:25:02 INFO - PROCESS | 8231 | 04:25:02 INFO - PROCESS | 8231 | [#0] dojo.html Cycles:165 Average:5629.08 Median:5845.85 stddev:633.23 (10.8%) stddev-sans-first:610.18 04:25:02 INFO - PROCESS | 8231 | Values: 3383.9 3393.1 3431.6 3454.8 3479.3 5586.0 5633.9 5638.7 5652.3 5691.3 5621.8 5667.1 5687.0 5689.2 5716.6 5147.5 5164.5 5180.2 5201.3 5236.7 5024.8 5040.9 5257.0 5258.4 5296.9 5133.8 5161.4 5216.4 5229.4 5243.3 5250.1 5251.7 5252.4 5254.7 5285.5 4978.9 5087.9 5159.4 5210.8 5214.3 5503.5 5541.1 5601.1 5645.6 5647.4 6059.0 6102.2 6105.7 6108.4 6127.8 6115.2 6132.8 6141.6 6147.6 6155.7 5448.7 5482.8 5493.7 5567.4 5568.3 6125.9 6130.7 6131.7 6132.7 6137.3 5845.9 5893.9 5898.1 5900.7 5906.6 5797.0 5822.1 5980.7 5998.9 6021.0 5979.3 6044.3 6053.5 6071.4 6076.3 5786.3 5789.2 5792.6 5923.6 6053.8 4545.8 4593.0 4605.0 4615.6 4620.4 4036.8 4041.3 4100.6 4129.0 4151.0 5792.8 5818.9 5858.2 5895.8 5908.4 6113.9 6118.3 6128.2 6136.5 6138.0 5583.4 5859.2 5873.6 5879.8 5880.4 4962.6 5034.1 5060.2 5125.1 5127.9 6377.0 6402.1 6405.7 6423.2 6426.9 6078.4 6122.5 6126.9 6130.2 6144.0 6131.8 6180.0 6268.4 6312.2 6377.6 6045.2 6048.9 6050.2 6050.6 6087.3 6141.9 6143.1 6143.7 6151.8 6156.5 5623.1 5734.3 5876.2 5917.7 5992.7 5960.6 5962.1 5976.9 5989.0 5995.5 5890.0 5913.3 5935.7 5942.1 5958.9 5702.4 5724.5 5760.8 5771.7 5838.8 5773.6 5798.7 5874.4 5878.7 5892.1 04:25:02 INFO - PROCESS | 8231 | 04:25:02 INFO - PROCESS | 8231 | [#1] ext.html Cycles:180 Average:44122.19 Median:30710.92 stddev:71154.34 (231.7%) stddev-sans-first:71279.48 04:25:02 INFO - PROCESS | 8231 | Values: 764.6 832.5 850.9 908.2 919.9 31098.0 31424.7 33496.5 44903.6 45310.8 45669.5 45827.8 45862.8 45947.3 45982.8 8953.9 9162.5 9168.7 9172.6 9174.0 7575.8 7733.0 8786.3 10162.2 10357.2 10473.1 10491.7 10499.6 10502.4 10510.1 10399.6 10399.9 10423.4 10431.6 10432.8 10543.6 10625.3 10626.1 10635.5 10645.0 42202.0 42361.0 42382.6 42396.4 42407.2 4247.7 4254.9 4295.4 4331.9 4380.0 30166.4 30473.0 30611.4 31303.2 31495.4 4364.3 4396.6 4435.3 4438.5 4488.2 222748.0 223852.0 224303.0 225197.0 225275.9 53852.0 53922.5 53943.7 54004.5 54058.5 55987.0 56069.4 56479.4 56530.7 56585.4 15402.7 15706.9 15813.1 15831.9 15836.3 13449.6 13565.8 13570.0 13571.6 13579.4 12016.0 12112.1 13214.5 13428.6 13430.0 5604.5 5629.2 5674.9 5710.1 5722.9 999.5 999.7 1014.4 1015.2 1020.3 28490.6 28516.6 28566.0 28659.9 29000.6 1062.0 1082.4 1086.7 1105.1 1112.0 14906.7 15395.8 15410.5 15425.7 15532.5 300689.0 301957.0 302006.0 302131.0 302313.0 58743.0 58792.7 59131.4 59301.7 59365.0 1483.4 1496.2 1500.4 1523.1 1542.9 26046.5 27251.6 27643.4 27726.2 27808.6 43331.0 43359.8 43522.0 43535.8 43550.6 284304.0 285475.0 285566.0 287280.0 287768.0 29928.4 29961.7 35668.8 35696.6 35823.8 39407.6 39493.4 39560.2 40380.8 40470.6 30682.0 31144.4 31610.8 31650.7 31858.5 30739.8 30910.0 31028.5 31059.5 31716.7 34751.5 35029.0 35149.0 35221.5 35540.5 29189.3 29332.7 29543.7 29699.7 29933.7 24696.3 24728.8 24825.3 25054.6 25164.2 04:25:02 INFO - PROCESS | 8231 | 04:25:02 INFO - PROCESS | 8231 | [#2] jquery.html Cycles:180 Average:36863.43 Median:2412.79 stddev:105206.16 (4360.4%) stddev-sans-first:105465.71 04:25:02 INFO - PROCESS | 8231 | Values: 420.3 473.2 476.3 477.8 498.5 18325.5 19551.7 19990.7 21426.8 21462.9 21137.6 21875.9 22080.2 22103.3 22204.0 6702.3 6835.9 6900.6 6973.3 6980.4 6618.7 6864.4 6873.3 6877.8 6878.2 6637.7 6888.8 6891.4 6919.1 6926.7 6793.5 6797.2 6816.9 6866.3 6923.7 6532.3 6771.5 6773.2 6781.4 6788.6 25252.6 25301.0 25357.2 25542.2 25572.1 3248.2 3270.1 3277.1 3304.5 3369.6 16114.8 16158.7 16488.3 16733.7 17101.0 2327.1 2366.1 2391.0 2434.6 2451.8 94806.0 96946.0 98133.5 98578.0 99528.5 15291.8 17747.6 18948.3 18957.0 18970.5 27504.6 29003.6 34946.7 35061.3 35126.3 10098.5 10103.0 10136.9 10326.9 10375.9 8787.5 8800.8 8887.6 9051.6 9070.9 8980.4 9041.5 9078.1 9191.5 9298.5 3525.9 3939.2 4003.3 4024.9 4062.8 978.5 980.3 983.1 985.1 995.1 21317.3 21682.9 21906.2 21952.0 22001.7 986.8 994.6 1004.3 1007.1 1031.2 11407.5 11935.8 11988.0 12025.6 12106.2 482832.0 662664.0 662978.0 669050.0 688048.0 108111.0 130231.0 132294.0 132566.3 132743.0 1325.8 1351.8 1371.1 1394.4 1395.3 14314.6 18188.0 19704.9 19730.8 19836.8 50385.7 50947.5 51002.5 51489.5 51867.7 65351.0 65458.7 65919.0 66265.3 66735.3 12289.8 12764.3 12797.6 12820.4 12843.2 14089.2 14105.2 14300.1 14350.6 14538.4 12398.9 12657.2 12682.8 12683.1 12736.7 11877.5 12008.3 12012.2 12043.0 12197.4 12136.9 12175.2 12795.6 12988.4 13236.9 12661.9 12702.6 12754.8 12933.2 13005.6 12721.2 12884.5 12890.0 12952.5 13045.3 04:25:02 INFO - PROCESS | 8231 | 04:25:02 INFO - PROCESS | 8231 | [#3] mootools.html Cycles:180 Average:7087.18 Median:2432.64 stddev:4501.51 (185.0%) stddev-sans-first:4494.63 04:25:02 INFO - PROCESS | 8231 | Values: 1510.6 1544.0 1550.8 1553.3 1566.1 10884.6 11628.9 11637.8 11642.7 11651.5 11104.3 11367.2 11421.1 11727.1 11741.9 2420.8 2452.5 2453.3 2454.5 2457.6 2347.9 2415.6 2459.2 2460.2 2462.4 2373.7 2426.0 2439.3 2440.2 2444.2 2256.2 2287.7 2295.6 2297.5 2392.8 2261.1 2284.6 2289.3 2295.7 2298.6 11277.8 11476.5 11496.5 11512.7 11518.7 5794.2 5920.0 5924.9 5934.4 5937.5 3457.1 3492.6 3550.0 3557.5 3582.4 1318.8 1337.2 1354.7 1377.3 1416.8 14760.4 15178.7 16773.4 17197.7 17429.8 4730.4 4778.6 4780.3 4869.7 4900.0 13039.9 13048.5 13049.2 13049.9 13051.1 5885.5 5896.4 5903.1 5916.3 5919.2 5520.4 5553.9 5588.0 5600.4 5660.1 3854.4 3958.1 4000.7 4030.6 4040.3 991.9 992.7 995.3 1009.1 1013.3 1036.2 1040.1 1047.4 1049.8 1052.7 6768.4 6997.0 7013.0 7116.7 7148.9 1019.4 1051.6 1063.6 1069.7 1099.9 4476.6 4544.0 4556.8 4578.1 4622.3 13115.4 13447.8 13448.4 13619.8 14038.3 14403.0 14497.3 14509.9 14537.6 14547.9 8704.4 10608.7 10854.1 10858.6 10864.0 6354.5 6966.6 7052.7 7228.4 7290.6 13017.7 13123.7 13124.7 13447.3 13581.9 13444.1 13544.8 13560.9 13601.2 13726.2 9466.6 9644.6 9731.8 9738.5 9757.4 10922.3 10951.9 10958.4 10984.7 11011.2 9027.2 9051.5 9066.1 9199.4 9403.4 9254.4 9316.4 9468.1 9496.4 9623.2 8307.4 8331.9 8403.1 8438.6 8468.3 6134.0 6138.4 6186.7 6204.2 6329.8 6044.8 6157.7 6218.7 6279.0 6300.1 04:25:02 INFO - PROCESS | 8231 | 04:25:02 INFO - PROCESS | 8231 | [#4] prototype.html Cycles:180 Average:4841.51 Median:5323.65 stddev:1278.47 (24.0%) stddev-sans-first:1238.27 04:25:02 INFO - PROCESS | 8231 | Values: 421.8 431.5 438.8 441.4 443.7 5238.8 5286.7 5321.5 5344.7 5346.4 5088.4 5235.9 5271.3 5273.8 5281.4 4442.8 4448.1 4462.3 4471.8 4493.9 4445.9 4491.3 4492.3 4492.6 4492.8 4421.7 4507.3 4509.8 4522.5 4524.2 4496.8 4499.8 4502.7 4503.7 4560.4 4205.9 4214.9 4217.0 4235.4 4256.8 5113.3 5140.2 5153.0 5178.2 5250.3 4928.8 5097.4 5136.0 5145.9 5156.8 5463.4 5504.1 5516.0 5524.8 5559.2 4394.6 4637.5 4651.3 4651.7 4654.6 5484.4 5558.2 5562.0 5736.4 5742.6 4672.4 4675.6 4680.0 4685.9 4702.4 4743.2 4765.0 4770.4 4770.5 4778.3 4946.8 5069.5 5081.9 5099.8 5157.7 5534.6 5538.0 5542.8 5548.9 5552.4 1665.6 1665.7 1673.3 1678.2 1679.3 1228.5 1281.7 1282.0 1290.7 1320.3 5388.3 5391.4 5436.6 5466.9 5474.3 5681.7 5686.4 5704.3 5730.4 5744.6 5142.9 5298.5 5322.6 5324.7 5341.9 2932.9 2953.9 2956.5 2973.2 2996.6 5585.7 5890.7 5907.8 5913.5 5936.9 5700.5 5754.0 5757.8 5786.5 5789.0 5853.0 5891.2 5900.5 5911.9 5914.6 5429.5 5647.7 5698.7 5735.7 5770.4 5423.2 5633.2 5635.9 5648.3 5685.2 5583.7 5768.5 5817.4 5820.4 5826.8 4731.4 4752.6 4782.5 4786.6 4789.0 5497.5 5648.9 5705.5 5729.7 5757.7 5485.6 5520.3 5525.5 5565.3 5612.2 5547.3 5557.6 5561.2 5561.6 5569.3 5396.7 5550.2 5569.6 5631.3 5634.5 5602.6 5642.3 5643.7 5654.8 5656.7 5327.7 5477.3 5510.8 5545.4 5573.2 04:25:02 INFO - PROCESS | 8231 | 04:25:02 INFO - PROCESS | 8231 | [#5] yui.html Cycles:180 Average:17928.33 Median:22724.93 stddev:22206.59 (97.7%) stddev-sans-first:22231.73 04:25:02 INFO - PROCESS | 8231 | Values: 820.0 832.3 889.3 899.7 937.3 16882.3 17176.4 17582.3 17715.0 17877.3 15825.9 16530.8 16711.9 16758.7 16858.8 867.7 888.5 888.8 891.2 892.6 864.8 880.9 887.5 896.4 898.8 943.2 949.2 952.2 952.3 952.4 940.6 941.7 941.7 942.2 942.5 692.9 693.8 694.9 695.3 695.4 17363.7 17623.2 17714.6 17866.8 18135.5 15892.4 15954.3 16074.8 16267.4 16393.7 13433.8 13913.6 13945.9 13976.2 14066.6 3968.7 4024.6 4037.7 4105.1 4117.3 88927.0 89207.1 89680.6 90845.0 93307.0 12274.9 12349.8 12362.8 12509.3 12546.4 23509.5 24186.0 24284.8 24333.8 24343.5 8811.6 8952.8 9013.0 9042.3 9102.8 5025.1 5040.8 5112.6 5203.6 5238.0 3593.7 3667.7 3689.6 3707.2 3711.5 612.4 615.9 618.1 626.7 627.6 774.2 783.6 795.8 795.8 808.7 10884.9 10915.5 11148.5 11332.4 11499.4 617.3 624.0 624.9 625.1 651.5 5322.7 5332.0 5363.5 5390.7 5425.5 77903.6 78575.0 79267.2 79572.2 80138.0 43206.0 45762.0 46402.5 67902.0 72899.0 50645.5 63824.4 64161.0 64211.7 64902.4 11480.6 11863.3 11953.4 11966.9 12134.6 40580.6 41332.6 41761.6 41788.8 42852.6 46189.1 46264.3 46768.0 47209.3 48520.5 12520.8 12577.7 12599.8 12741.1 12858.7 16109.6 16126.9 16162.5 16428.4 16435.3 12604.8 12666.5 12749.6 12750.1 12835.0 15046.0 15073.0 15099.0 15242.3 15475.7 14637.7 14643.0 14661.8 14696.0 14782.7 10186.5 10392.5 10487.2 10571.8 10668.7 11237.6 12584.9 13300.1 13349.9 13399.7 04:25:02 INFO - PROCESS | 8231 | -------- Summary: end -------- 04:25:02 INFO - PROCESS | 8231 | 04:25:03 INFO - TEST-INFO | 8231: exit 0 04:25:03 INFO - TEST-OK | dromaeo_css | took 1115530ms 04:25:03 INFO - TEST-START | kraken 04:25:03 INFO - operating with platform_type : linux_ 04:25:03 INFO - Initialising browser for kraken test... 04:25:03 INFO - TEST-INFO | started process 8551 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpplZFzU/profile http://localhost:36087/getInfo.html) 04:25:07 INFO - PROCESS | 8551 | __metrics Screen width/height:1600/1200 04:25:07 INFO - PROCESS | 8551 | colorDepth:24 04:25:07 INFO - PROCESS | 8551 | Browser inner width/height: 1024/697 04:25:07 INFO - PROCESS | 8551 | __metrics 04:25:08 INFO - PROCESS | 8551 | 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" 04:25:08 INFO - PROCESS | 8551 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:25:09 INFO - PROCESS | 8551 | console.error: PushService: 04:25:09 INFO - PROCESS | 8551 | stateChangeProcessEnqueue: Error transitioning state 04:25:09 INFO - PROCESS | 8551 | UnknownError 04:25:09 INFO - TEST-INFO | 8551: exit 0 04:25:09 INFO - Browser initialized. 04:25:09 INFO - Running cycle 1/1 for kraken test... 04:25:09 INFO - TEST-INFO | started process 8643 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpplZFzU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:21 INFO - PROCESS | 8643 | RSS: Main: 140136448 04:25:21 INFO - PROCESS | 8643 | 04:25:23 INFO - PROCESS | 8643 | Cycle 1(1): loaded http://localhost:36087/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36087/tests/kraken/driver.html?testName=audio-beat-detection) 04:25:24 INFO - PROCESS | 8643 | RSS: Main: 183103488 04:25:24 INFO - PROCESS | 8643 | 04:25:27 INFO - PROCESS | 8643 | Cycle 1(1): loaded http://localhost:36087/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36087/tests/kraken/driver.html?testName=audio-dft) 04:25:27 INFO - PROCESS | 8643 | RSS: Main: 173699072 04:25:27 INFO - PROCESS | 8643 | 04:25:30 INFO - PROCESS | 8643 | Cycle 1(1): loaded http://localhost:36087/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36087/tests/kraken/driver.html?testName=audio-fft) 04:25:31 INFO - PROCESS | 8643 | RSS: Main: 265560064 04:25:31 INFO - PROCESS | 8643 | 04:25:33 INFO - PROCESS | 8643 | Cycle 1(1): loaded http://localhost:36087/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36087/tests/kraken/driver.html?testName=audio-oscillator) 04:25:33 INFO - PROCESS | 8643 | RSS: Main: 172023808 04:25:33 INFO - PROCESS | 8643 | 04:25:35 INFO - PROCESS | 8643 | Cycle 1(1): loaded http://localhost:36087/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36087/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:25:36 INFO - PROCESS | 8643 | RSS: Main: 174493696 04:25:36 INFO - PROCESS | 8643 | 04:25:39 INFO - PROCESS | 8643 | Cycle 1(1): loaded http://localhost:36087/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36087/tests/kraken/driver.html?testName=imaging-darkroom) 04:25:40 INFO - PROCESS | 8643 | RSS: Main: 210354176 04:25:40 INFO - PROCESS | 8643 | 04:25:43 INFO - PROCESS | 8643 | Cycle 1(1): loaded http://localhost:36087/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36087/tests/kraken/driver.html?testName=imaging-desaturate) 04:25:44 INFO - PROCESS | 8643 | RSS: Main: 212037632 04:25:44 INFO - PROCESS | 8643 | 04:25:46 INFO - PROCESS | 8643 | Cycle 1(1): loaded http://localhost:36087/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36087/tests/kraken/driver.html?testName=json-parse-financial) 04:25:47 INFO - PROCESS | 8643 | RSS: Main: 210698240 04:25:47 INFO - PROCESS | 8643 | 04:25:48 INFO - PROCESS | 8643 | Cycle 1(1): loaded http://localhost:36087/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36087/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:25:49 INFO - PROCESS | 8643 | RSS: Main: 172945408 04:25:49 INFO - PROCESS | 8643 | 04:25:51 INFO - PROCESS | 8643 | Cycle 1(1): loaded http://localhost:36087/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36087/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:25:51 INFO - PROCESS | 8643 | RSS: Main: 179695616 04:25:51 INFO - PROCESS | 8643 | 04:25:53 INFO - PROCESS | 8643 | Cycle 1(1): loaded http://localhost:36087/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36087/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:25:54 INFO - PROCESS | 8643 | RSS: Main: 188723200 04:25:54 INFO - PROCESS | 8643 | 04:25:56 INFO - PROCESS | 8643 | Cycle 1(1): loaded http://localhost:36087/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36087/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:25:57 INFO - PROCESS | 8643 | RSS: Main: 199196672 04:25:57 INFO - PROCESS | 8643 | 04:26:00 INFO - PROCESS | 8643 | Cycle 1(1): loaded http://localhost:36087/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36087/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:26:00 INFO - PROCESS | 8643 | RSS: Main: 194580480 04:26:00 INFO - PROCESS | 8643 | 04:26:02 INFO - PROCESS | 8643 | Cycle 1(1): loaded http://localhost:36087/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36087/tests/kraken/driver.html?testName=ai-astar) 04:26:02 INFO - PROCESS | 8643 | RSS: Main: 245747712 04:26:02 INFO - PROCESS | 8643 | 04:26:02 INFO - PROCESS | 8643 | __start_tp_report 04:26:02 INFO - PROCESS | 8643 | _x_x_mozilla_page_load 04:26:02 INFO - PROCESS | 8643 | _x_x_mozilla_page_load_details 04:26:02 INFO - PROCESS | 8643 | |i|pagename|runs| 04:26:02 INFO - PROCESS | 8643 | |0;ai-astar;105;113;113;113;111;113;111;112;112;112 04:26:02 INFO - PROCESS | 8643 | |1;audio-beat-detection;143;114;115;153;120;120;115;116;140;115 04:26:02 INFO - PROCESS | 8643 | |2;audio-dft;160;161;160;161;161;160;160;160;159;159 04:26:02 INFO - PROCESS | 8643 | |3;audio-fft;74;74;75;111;75;82;75;75;88;74 04:26:02 INFO - PROCESS | 8643 | |4;audio-oscillator;82;81;112;82;83;82;92;81;81;104 04:26:02 INFO - PROCESS | 8643 | |5;imaging-gaussian-blur;113;113;113;113;113;113;112;113;113;112 04:26:02 INFO - PROCESS | 8643 | |6;imaging-darkroom;150;146;146;146;146;146;147;146;146;146 04:26:02 INFO - PROCESS | 8643 | |7;imaging-desaturate;94;95;94;95;94;94;94;94;94;93 04:26:02 INFO - PROCESS | 8643 | |8;json-parse-financial;56;54;56;56;56;56;55;58;56;58 04:26:02 INFO - PROCESS | 8643 | |9;json-stringify-tinderbox;52;52;52;52;52;52;52;53;52;53 04:26:02 INFO - PROCESS | 8643 | |10;stanford-crypto-aes;79;76;78;76;75;75;77;78;81;75 04:26:02 INFO - PROCESS | 8643 | |11;stanford-crypto-ccm;122;120;121;123;121;126;126;124;157;122 04:26:02 INFO - PROCESS | 8643 | |12;stanford-crypto-pbkdf2;157;160;173;159;154;161;163;161;157;158 04:26:02 INFO - PROCESS | 8643 | |13;stanford-crypto-sha256-iterative;59;59;63;60;59;67;59;59;58;59 04:26:02 INFO - PROCESS | 8643 | __end_tp_report 04:26:02 INFO - PROCESS | 8643 | __start_cc_report 04:26:02 INFO - PROCESS | 8643 | _x_x_mozilla_cycle_collect,1647 04:26:02 INFO - PROCESS | 8643 | __end_cc_report 04:26:02 INFO - PROCESS | 8643 | __startTimestamp1492082762803__endTimestamp 04:26:02 INFO - PROCESS | 8643 | 04:26:02 INFO - PROCESS | 8643 | ------- Summary: start ------- 04:26:02 INFO - PROCESS | 8643 | Number of tests: 14 04:26:02 INFO - PROCESS | 8643 | 04:26:02 INFO - PROCESS | 8643 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.50 stddev:2.42 (2.1%) stddev-sans-first:0.83 04:26:02 INFO - PROCESS | 8643 | Values: 105.0 113.0 113.0 113.0 111.0 113.0 111.0 112.0 112.0 112.0 04:26:02 INFO - PROCESS | 8643 | 04:26:02 INFO - PROCESS | 8643 | [#1] audio-beat-detection Cycles:10 Average:125.10 Median:120.00 stddev:14.47 (12.1%) stddev-sans-first:13.82 04:26:02 INFO - PROCESS | 8643 | Values: 143.0 114.0 115.0 153.0 120.0 120.0 115.0 116.0 140.0 115.0 04:26:02 INFO - PROCESS | 8643 | 04:26:02 INFO - PROCESS | 8643 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 04:26:02 INFO - PROCESS | 8643 | Values: 160.0 161.0 160.0 161.0 161.0 160.0 160.0 160.0 159.0 159.0 04:26:02 INFO - PROCESS | 8643 | 04:26:02 INFO - PROCESS | 8643 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.00 stddev:11.72 (15.6%) stddev-sans-first:12.21 04:26:02 INFO - PROCESS | 8643 | Values: 74.0 74.0 75.0 111.0 75.0 82.0 75.0 75.0 88.0 74.0 04:26:02 INFO - PROCESS | 8643 | 04:26:02 INFO - PROCESS | 8643 | [#4] audio-oscillator Cycles:10 Average:88.00 Median:82.00 stddev:11.20 (13.7%) stddev-sans-first:11.66 04:26:02 INFO - PROCESS | 8643 | Values: 82.0 81.0 112.0 82.0 83.0 82.0 92.0 81.0 81.0 104.0 04:26:02 INFO - PROCESS | 8643 | 04:26:02 INFO - PROCESS | 8643 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:26:02 INFO - PROCESS | 8643 | Values: 113.0 113.0 113.0 113.0 113.0 113.0 112.0 113.0 113.0 112.0 04:26:02 INFO - PROCESS | 8643 | 04:26:02 INFO - PROCESS | 8643 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:1.27 (0.9%) stddev-sans-first:0.33 04:26:02 INFO - PROCESS | 8643 | Values: 150.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 04:26:02 INFO - PROCESS | 8643 | 04:26:02 INFO - PROCESS | 8643 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:26:02 INFO - PROCESS | 8643 | Values: 94.0 95.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 93.0 04:26:02 INFO - PROCESS | 8643 | 04:26:02 INFO - PROCESS | 8643 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:1.20 (2.1%) stddev-sans-first:1.27 04:26:02 INFO - PROCESS | 8643 | Values: 56.0 54.0 56.0 56.0 56.0 56.0 55.0 58.0 56.0 58.0 04:26:02 INFO - PROCESS | 8643 | 04:26:02 INFO - PROCESS | 8643 | [#9] json-stringify-tinderbox Cycles:10 Average:52.20 Median:52.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 04:26:02 INFO - PROCESS | 8643 | Values: 52.0 52.0 52.0 52.0 52.0 52.0 52.0 53.0 52.0 53.0 04:26:02 INFO - PROCESS | 8643 | 04:26:02 INFO - PROCESS | 8643 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:77.50 stddev:2.00 (2.6%) stddev-sans-first:1.99 04:26:02 INFO - PROCESS | 8643 | Values: 79.0 76.0 78.0 76.0 75.0 75.0 77.0 78.0 81.0 75.0 04:26:02 INFO - PROCESS | 8643 | 04:26:02 INFO - PROCESS | 8643 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:123.50 stddev:11.01 (8.9%) stddev-sans-first:11.58 04:26:02 INFO - PROCESS | 8643 | Values: 122.0 120.0 121.0 123.0 121.0 126.0 126.0 124.0 157.0 122.0 04:26:02 INFO - PROCESS | 8643 | 04:26:02 INFO - PROCESS | 8643 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:160.50 stddev:5.14 (3.2%) stddev-sans-first:5.32 04:26:02 INFO - PROCESS | 8643 | Values: 157.0 160.0 173.0 159.0 154.0 161.0 163.0 161.0 157.0 158.0 04:26:02 INFO - PROCESS | 8643 | 04:26:02 INFO - PROCESS | 8643 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.20 Median:59.00 stddev:2.74 (4.6%) stddev-sans-first:2.87 04:26:02 INFO - PROCESS | 8643 | Values: 59.0 59.0 63.0 60.0 59.0 67.0 59.0 59.0 58.0 59.0 04:26:02 INFO - PROCESS | 8643 | -------- Summary: end -------- 04:26:02 INFO - PROCESS | 8643 | 04:26:03 INFO - TEST-INFO | 8643: exit 0 04:26:03 INFO - TEST-OK | kraken | took 60404ms 04:26:03 INFO - SUITE-END | took 1175s 04:26:03 INFO - Completed test suite (00:19:35) 04:26:03 INFO - javascript benchmark 04:26:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7784.257089661281, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3383.898483045509, 3393.0838673558137, 3431.571053618299, 3454.809985450799, 3479.2867462170257, 5585.972070139649, 5633.943660563398, 5638.689872057035, 5652.321721393433, 5691.288588926384, 5621.8032368867, 5667.0932650775885, 5687.033204355259, 5689.203511508392, 5716.571257155709, 5147.48525147486, 5164.535191832734, 5180.171172612383, 5201.349831271091, 5236.7119808410525, 5024.849254522352, 5040.949590504085, 5257.0, 5258.44786297439, 5296.894062118756, 5133.768980395891, 5161.4322424533275, 5216.374035115791, 5229.398619158807, 5243.344581927259, 5250.107481728096, 5251.658642188246, 5252.448492908228, 5254.65844720092, 5285.524302812765, 4978.925316120261, 5087.872803179913, 5159.380874295071, 5210.843674689765, 5214.322138122057, 5503.532199763025, 5541.141123125922, 5601.075822489284, 5645.576581756343, 5647.407022262644, 6059.0, 6102.176206212149, 6105.725242364104, 6108.358622344679, 6127.84680382994, 6115.174451449042, 6132.846678833021, 6141.631502109843, 6147.600405973598, 6155.661438620874, 5448.673079615236, 5482.780688772445, 5493.670379777186, 5567.359753628384, 5568.303962004749, 6125.908111378333, 6130.693465326716, 6131.724072416752, 6132.662703551258, 6137.263528376623, 5845.853853653693, 5893.882122357529, 5898.14476900847, 5900.734466948998, 5906.586538942319, 5797.043487824546, 5822.0684690449325, 5980.700964951735, 5998.940010599838, 6021.0, 5979.282486101695, 6044.274687037496, 6053.51571874249, 6071.362506936796, 6076.270847498328, 5786.334571524244, 5789.218455508452, 5792.565557583198, 5923.614965027259, 6053.7578496860515, 4545.818167273338, 4593.035462552834, 4605.03294308199, 4615.561521655437, 4620.44554653437, 4036.7779772112817, 4041.2523683118716, 4100.610442008005, 4129.0, 4151.0, 5792.82621521355, 5818.854528636733, 5858.209141765892, 5895.823125306248, 5908.379620139909, 6113.877722445526, 6118.296395914527, 6128.233970753656, 6136.478399336017, 6137.96931015351, 5583.441655834466, 5859.2090067841145, 5873.647581145145, 5879.823605291848, 5880.353161152356, 4962.60299176065, 5034.0686972910125, 5060.2156665716875, 5125.051865404912, 5127.9230811537855, 6377.0, 6402.135711678864, 6405.743770249138, 6423.229212494437, 6426.8714625707225, 6078.422549857756, 6122.510199183966, 6126.938730612636, 6130.203073600582, 6144.047672610753, 6131.77428366204, 6180.042093475518, 6268.404501572343, 6312.179416675803, 6377.649229292248, 6045.244344456943, 6048.939510604838, 6050.183225264533, 6050.606710563799, 6087.299960504599, 6141.938580614136, 6143.109249158936, 6143.723532440961, 6151.84620384494, 6156.476699480594, 5623.100303951348, 5734.340550836707, 5876.236089308362, 5917.733701983335, 5992.67040312787, 5960.552958528041, 5962.135490353961, 5976.850578735566, 5989.041753319622, 5995.490383317292, 5889.970550147222, 5913.290405151237, 5935.732892019783, 5942.10868369748, 5958.851028724316, 5702.372738998624, 5724.4561766632105, 5760.769569217185, 5771.711414429178, 5838.766449341979, 5773.595848290579, 5798.6810725410505, 5874.441928017002, 5878.735456904535, 5892.145638882253], "value": 5587.72327230389, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [764.5756605084176, 832.4755404095418, 850.8808766772653, 908.1690253418122, 919.8850143732034, 31098.0, 31424.68575314246, 33496.497552536704, 44903.55096449043, 45310.77344613281, 45669.54330456694, 45827.77086114573, 45862.77068614652, 45947.310790338175, 45982.770086149605, 8953.91046089539, 9162.450252984809, 9168.679096231634, 9172.587233574472, 9174.0, 7575.772726818204, 7732.961335193316, 8786.341024423162, 10162.237832162617, 10357.171426285879, 10473.057424831764, 10491.73770655732, 10499.580016799318, 10502.422366769824, 10510.054095131436, 10399.636012739556, 10399.896001039968, 10423.374597524096, 10431.634892778717, 10432.791344173113, 10543.578256869716, 10625.256232063759, 10626.149908007419, 10635.52140153695, 10645.0, 42202.0, 42361.0, 42382.57617423817, 42396.364054539205, 42407.151856963, 4247.660187185018, 4254.936175957363, 4295.377170310318, 4331.891702707426, 4380.01449673824, 30166.396672066654, 30473.0, 30611.38777224443, 31303.217419564695, 31495.37009259825, 4364.258076127066, 4396.626286765629, 4435.268180750172, 4438.511763705989, 4488.236999710057, 222748.0, 223852.0, 224303.0, 225197.0, 225275.8736206341, 53852.0, 53922.460775391744, 53943.73028134834, 54004.45995539994, 54058.45941540613, 55987.0, 56069.43930560724, 56479.43520564824, 56530.717346413, 56585.43414565884, 15402.691946161014, 15706.9214653926, 15813.05121692702, 15831.920840395724, 15836.28736706851, 13449.596512104652, 13565.796513052312, 13570.0, 13571.59285221445, 13579.388927498287, 12016.0, 12112.09159313055, 13214.537491187762, 13428.597142085753, 13430.0, 5604.523615492729, 5629.24005259293, 5674.886502269931, 5710.114932185518, 5722.856928576735, 999.5252255178732, 999.6551189839494, 1014.3660212367271, 1015.1523477895892, 1020.2908978260186, 28490.572641410396, 28516.572251416244, 28566.0, 28659.856700716362, 29000.564991525145, 1061.989380106189, 1082.437132691012, 1086.6739978006724, 1105.0993440346253, 1111.9777604447866, 14906.678056678398, 15395.846041539442, 15410.537683869501, 15425.691486170213, 15532.456364027204, 300689.0, 301957.0, 302006.0, 302131.0, 302313.0, 58743.0, 58792.70603646954, 59131.40868591345, 59301.70349148313, 59365.0, 1483.3769816677022, 1496.2144873941268, 1500.3541394411684, 1523.1242035829443, 1542.8997115187476, 26046.479070418864, 27251.59122613202, 27643.44713105767, 27726.168214953585, 27808.582871257353, 43331.0, 43359.783201085054, 43522.0, 43535.78232108819, 43550.56449435465, 284304.0, 285475.0, 285566.0, 287280.0, 287768.0, 29928.401431971673, 29961.700382995892, 35668.82165589155, 35696.64303357037, 35823.82088089543, 39407.60592394154, 39493.40759888547, 39560.208795823346, 40380.798096009334, 40470.59529404668, 30682.0, 31144.377112458078, 31610.841945790125, 31650.68349316477, 31858.522122167724, 30739.846300768353, 30910.0, 31028.53457198189, 31059.534106988864, 31716.682833172297, 34751.47872781961, 35029.0, 35149.0, 35221.471677925365, 35540.46689299611, 29189.270268243465, 29332.706672932996, 29543.704562954095, 29699.703002969694, 29933.70066299309, 24696.25911222666, 24728.752712472644, 24825.25524234276, 25054.62418063767, 25164.24507264785], "value": 18634.642831507168, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.30859236555847, 473.23099962560826, 476.29746124466396, 477.8255936583148, 498.5338708307732, 18325.541861453472, 19551.706724399126, 19990.7001394979, 21426.785732142675, 21462.89268553659, 21137.57724845502, 21875.90620468978, 22080.22719204828, 22103.336899892987, 22204.0, 6702.262751097388, 6835.931640683604, 6900.585964842126, 6973.302669733037, 6980.406665433445, 6618.702158402859, 6864.382205601495, 6873.278305777896, 6877.7592784252565, 6878.209005964328, 6637.701303441332, 6888.75889343873, 6891.379775820175, 6919.135108111486, 6926.68829902653, 6793.45652347811, 6797.218319893226, 6816.863662726742, 6866.347696968805, 6923.723051077951, 6532.314107018789, 6771.4582833373215, 6773.153355830521, 6781.355771201728, 6788.626625535593, 25252.621210681853, 25301.0, 25357.239282821545, 25542.23373298804, 25572.104976325925, 3248.204189973448, 3270.1497610621172, 3277.10121780796, 3304.471284594453, 3369.5619569456057, 16114.75827862583, 16158.676826463523, 16488.34046638133, 16733.748993765104, 17101.0, 2327.104064934995, 2366.1127077345996, 2390.988045059781, 2434.5861203595255, 2451.82837201396, 94806.0, 96946.0, 98133.5093324536, 98578.0, 99528.50235748847, 15291.847081529042, 17747.556311092325, 18948.347231387343, 18957.0, 18970.525736856413, 27504.58743118855, 29003.564946525818, 34946.650533494845, 35061.29877402489, 35126.29747405038, 10098.545565449573, 10102.989701029837, 10136.949315253523, 10326.948365258277, 10375.896241037493, 8787.472751634923, 8800.823983520293, 8887.644494220289, 9051.59267832949, 9070.86393704095, 8980.416272942239, 9041.457512549268, 9078.137576930314, 9191.540422978824, 9298.488583127857, 3525.9294814103573, 3939.2318497893207, 4003.259397011562, 4024.879253622396, 4062.756234625932, 978.4569563892109, 980.3235767320668, 983.1102851919024, 985.1183191043975, 995.1392045880406, 21317.25389611356, 21682.891585541973, 21906.23328183538, 21952.0, 22001.66997495039, 986.7977064701719, 994.5524513968743, 1004.3371374892536, 1007.0634310091685, 1031.1750599520353, 11407.48666310018, 11935.761284774257, 11987.981021613261, 12025.63923082309, 12106.213096148722, 482832.0, 662664.0, 662978.0, 669050.0, 688048.0, 108111.0, 130231.0, 132294.0, 132566.33716831353, 132743.0, 1325.7679906016601, 1351.8445378781369, 1371.0950772490307, 1394.4282844033899, 1395.2744572822278, 14314.642133946734, 18188.0, 19704.90147549253, 19730.802691972898, 19836.750945649896, 50385.74807125941, 50947.49052509576, 51002.48997509977, 51489.485105148466, 51867.740661296455, 65351.0, 65458.672706636164, 65919.0, 66265.33734662592, 66735.3326466729, 12289.815652765037, 12764.29796361209, 12797.552085676956, 12820.423080961566, 12843.229406235656, 14089.225092619594, 14105.153690778587, 14300.070495417765, 14350.569482915529, 14538.418463261774, 12398.876011239772, 12657.177283476545, 12682.809757853454, 12683.11218214716, 12736.745265094462, 11877.524899003944, 12008.339541324962, 12012.159148859497, 12043.036557075588, 12197.390130493617, 12136.939315303367, 12175.208611440228, 12795.552155674879, 12988.35058247065, 13236.933815330862, 12661.93669031649, 12702.555410560586, 12754.808677869654, 12933.159344642569, 13005.61853918007, 12721.173123746927, 12884.549040783528, 12890.0, 12952.481900723866, 13045.282509461691], "value": 11567.310965622824, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1510.6374470127166, 1544.011832427246, 1550.81390233172, 1553.3320672110995, 1566.115144943107, 10884.564617415304, 11628.941855290712, 11637.767244655102, 11642.650720478388, 11651.533938642444, 11104.27822191557, 11367.204295699285, 11421.143414243923, 11727.120465965065, 11741.941290293558, 2420.794232490236, 2452.47271836556, 2453.313072339739, 2454.5213683331667, 2457.594496908008, 2347.9060837566476, 2415.613501839706, 2459.1515927005244, 2460.151247819508, 2462.396712805365, 2373.6795532603137, 2425.9514809703796, 2439.329184474266, 2440.1581454398206, 2444.1811992982284, 2256.165218869029, 2287.6797248385155, 2295.598270302699, 2297.517521320516, 2392.83250172488, 2261.1068627892055, 2284.6001949658744, 2289.3360925331635, 2295.735990361113, 2298.6207275799475, 11277.774444511146, 11476.4835582399, 11496.540138394454, 11512.712182195428, 11518.654440366803, 5794.21778059965, 5919.970400148015, 5924.851878703023, 5934.376890426486, 5937.495312898365, 3457.083872773717, 3492.5634295713035, 3550.0, 3557.5019497270405, 3582.4089025311055, 1318.8417389913177, 1337.177635754014, 1354.7155097429552, 1377.2769296119618, 1416.7591509443419, 14760.409583616642, 15178.696426071418, 16773.412930547493, 17197.656046878994, 17429.825701742946, 4730.432348118248, 4778.641601879873, 4780.306855505932, 4869.683470574401, 4899.951000489949, 13039.934800325938, 13048.54330098442, 13049.151805132826, 13049.869501305055, 13051.086423950423, 5885.499732522783, 5896.380880007623, 5903.144044113579, 5916.290045194518, 5919.230500034968, 5520.365158006881, 5553.916691249635, 5588.0, 5600.439956004367, 5660.094384898396, 3854.402567602026, 3958.129211573449, 4000.6799456044027, 4030.556638769733, 4040.2929487339597, 991.9107280344659, 992.7121134870806, 995.2582979785376, 1009.1119814563137, 1013.2755080117752, 1036.1503567074926, 1040.0795296162798, 1047.3977462958828, 1049.7585555322319, 1052.736815796051, 6768.357006084414, 6997.0, 7012.964935175393, 7116.71533138679, 7148.92851071493, 1019.3781793106199, 1051.574112484445, 1063.5798859450629, 1069.6897899609025, 1099.9395033273088, 4476.597106260452, 4544.045750392388, 4556.817727290938, 4578.084383123389, 4622.329762184531, 13115.409806558537, 13447.798283025762, 13448.394822233024, 13619.795703064265, 14038.298085095705, 14403.0, 14497.347619356944, 14509.85490145106, 14537.563873083824, 14547.927260363842, 8704.390692651454, 10608.734781630521, 10854.131669466424, 10858.619948301772, 10864.0, 6354.52341074412, 6966.582005079711, 7052.717891284291, 7228.385587225145, 7290.5625662460425, 13017.739645206853, 13123.67190820199, 13124.671883202614, 13447.327633618475, 13581.86418135806, 13444.126131801402, 13544.796828047783, 13560.86439135596, 13601.183928964294, 13726.176429414267, 9466.621335146518, 9644.614215431304, 9731.756706082404, 9738.464384458923, 9757.365771224848, 10922.344659320466, 10951.890481095086, 10958.397288149228, 10984.670459886216, 11011.229213954946, 9027.187553120251, 9051.547422628973, 9066.138716821892, 9199.402038867453, 9403.43579385239, 9254.35219534653, 9316.394434361744, 9468.100530449596, 9496.382735122195, 9623.230141588516, 8307.376946728898, 8331.916680833114, 8403.117672644285, 8438.578071096543, 8468.322534197372, 6134.0, 6138.355472675305, 6186.721597528032, 6204.224471941007, 6329.841753956004, 6044.758209671564, 6157.722902469489, 6218.657973811484, 6278.968605156945, 6300.149479820349], "value": 5362.141951606097, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.82915919052795, 431.5447203200623, 438.78280251275623, 441.3930845088004, 443.6605996412744, 5238.84283471496, 5286.656367336125, 5321.494458026481, 5344.743985163484, 5346.385165705945, 5088.440271570124, 5235.947640523594, 5271.310082941946, 5273.813391986801, 5281.445448227938, 4442.777861106948, 4448.130955533687, 4462.263726485126, 4471.7987690554, 4493.910121797562, 4445.911081778362, 4491.326301054852, 4492.303692927601, 4492.573205545468, 4492.820287188509, 4421.717701866455, 4507.256302710049, 4509.759816050596, 4522.457305123374, 4524.2082635538645, 4496.842610508616, 4499.75251361175, 4502.684812063157, 4503.684742068057, 4560.361549383089, 4205.91588168238, 4214.873553793391, 4217.0, 4235.411720604773, 4256.829726810924, 5113.284140220372, 5140.203268493389, 5153.0, 5178.229647138763, 5250.264962905197, 4928.778204980785, 5097.388313402415, 5135.969777831097, 5145.922811157836, 5156.813932795478, 5463.426340234298, 5504.082836096875, 5515.993783388063, 5524.779008839641, 5559.193916882029, 4394.62645675118, 4637.536246375335, 4651.3255577941345, 4651.674382793172, 4654.627629789608, 5484.369297530795, 5558.221848941152, 5562.0, 5736.368999410061, 5742.626729262626, 4672.415948006499, 4675.620691895899, 4680.0, 4685.8594242172785, 4702.388689470347, 4743.241081426955, 4764.976175119103, 4770.379850619467, 4770.546798054179, 4778.259369797687, 4946.826861059845, 5069.518395752398, 5081.8729531762, 5099.821506247264, 5157.690538567698, 5534.557235421156, 5538.0, 5542.778288868481, 5548.86127846799, 5552.361478429952, 1665.5669525923347, 1665.7168281392192, 1673.272126624922, 1678.1944666560119, 1679.3030892179609, 1228.4901765767286, 1281.6795801049739, 1281.9551315703904, 1290.6902343437507, 1320.2672516753103, 5388.299521062237, 5391.433899440581, 5436.640839790052, 5466.933947880125, 5474.343078830566, 5681.744321505542, 5686.44110150434, 5704.3154821421695, 5730.398308177665, 5744.597878148573, 5142.871428214325, 5298.523132917979, 5322.574194064466, 5324.733763311819, 5341.946580534145, 2932.8680209390627, 2953.9113826585235, 2956.4530561846127, 2973.152651494357, 2996.625421822272, 5585.664860108406, 5890.67601281925, 5907.763689452459, 5913.46778789911, 5936.851578710567, 5700.525087806135, 5753.993051216021, 5757.798477053283, 5786.537077033827, 5788.971055144697, 5852.9807216510235, 5891.175235467038, 5900.4984576310635, 5911.9113213301835, 5914.556408269483, 5429.457054294539, 5647.745851436613, 5698.715064246854, 5735.7418916148035, 5770.422957704196, 5423.2407462954425, 5633.2113504110275, 5635.9436405635415, 5648.305508347561, 5685.204071430086, 5583.743657677152, 5768.480836724715, 5817.447342502455, 5820.417958204146, 5826.796062137805, 4731.384919960383, 4752.6197904168275, 4782.473927867863, 4786.6410019248, 4789.018251258414, 5497.47773961473, 5648.887022259614, 5705.516565692867, 5729.68486733217, 5757.683327417032, 5485.6434331768305, 5520.337559492887, 5525.475079867406, 5565.30433695788, 5612.214289999321, 5547.306586676666, 5557.555035690669, 5561.193626924154, 5561.581796641831, 5569.331680198402, 5396.679427846064, 5550.222968784293, 5569.55443564522, 5631.2960879890015, 5634.464725851038, 5602.635828671123, 5642.279104873053, 5643.689597072201, 5654.830355089354, 5656.660600363992, 5327.680339179662, 5477.315335583052, 5510.8071217507195, 5545.3622833373065, 5573.244428005165], "value": 4472.9571272056655, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.0323618130607, 832.3466079127882, 889.2796834564003, 899.7390756680563, 937.3485427627797, 16882.324707011703, 17176.39882604109, 17582.296708131675, 17715.02567358795, 17877.28490860364, 15825.920870395632, 16530.752038719398, 16711.916440417812, 16758.664826703458, 16858.83141168588, 867.6659486097866, 888.471359541072, 888.835565420396, 891.2468963725673, 892.6117139044536, 864.8010957479784, 880.9207171354577, 887.4941283468394, 896.3501461440469, 898.7528429681824, 943.1558754914347, 949.1742184299634, 952.2286947572454, 952.347641865321, 952.4333021851987, 940.5532372123221, 941.6845356805478, 941.7127776028309, 942.2038377570976, 942.5098948546786, 692.9099217101794, 693.774523279936, 694.8540806430656, 695.3220609905352, 695.3637421759084, 17363.739543906853, 17623.206955687026, 17714.557136071573, 17866.821331786774, 18135.4559363218, 15892.364305427769, 15954.28205730745, 16074.75887861683, 16267.430639927665, 16393.6721265574, 13433.798493022612, 13913.58259252224, 13945.860541394557, 13976.161430314112, 14066.578002659937, 3968.72218944674, 4024.6176613221696, 4037.6769858411258, 4105.096878686684, 4117.279476091672, 88927.0, 89207.10792892118, 89680.5515972416, 90845.0, 93307.0, 12274.938625306817, 12349.814752778715, 12362.814557781641, 12509.311987840756, 12546.435410406553, 23509.529809403717, 24186.0, 24284.75715242825, 24333.7566624335, 24343.513129737305, 8811.603477843384, 8952.776180595538, 9012.954935225282, 9042.321825863086, 9102.817943641223, 5025.095482813055, 5040.823571174991, 5112.565431938253, 5203.60972927032, 5238.0, 3593.748437609342, 3667.7065834733157, 3689.6494832990825, 3707.2029513654693, 3711.5175027246823, 612.4243211381288, 615.9137720719013, 618.088319728397, 626.7117126121943, 627.5513008199159, 774.2180397798264, 783.561205724796, 795.7533164718956, 795.777182388932, 808.6684459371629, 10884.891151088546, 10915.508802103925, 11148.498317575728, 11332.376719280353, 11499.425028748696, 617.2654541096082, 623.9968800155971, 624.9312575616678, 625.1497962770628, 651.547174713579, 5322.707251101227, 5331.973340133352, 5363.463653634605, 5390.676559406448, 5425.457454254622, 77903.61048194836, 78575.0, 79267.20732792598, 79572.20427795764, 80138.0, 43206.0, 45762.0, 46402.535974639824, 67902.0, 72899.0, 50645.49354506408, 63824.36175638277, 64161.0, 64211.678941604994, 64902.350976490576, 11480.598179063692, 11863.34751588671, 11953.402329883296, 11966.940165299118, 12134.635960921187, 40580.59419405886, 41332.58667413287, 41761.58238417698, 41788.79105604452, 42852.57147428486, 46189.051749925486, 46264.30603541017, 46768.0, 47209.29186062143, 48520.5147948516, 12520.812187817008, 12577.748445031231, 12599.811002835148, 12741.10812243134, 12858.67853303675, 16109.597260068593, 16126.919365403099, 16162.515124546282, 16428.425005125242, 16435.26041328119, 12604.810927835906, 12666.493340266656, 12749.553765618159, 12750.107492475438, 12835.0, 15046.0, 15073.0, 15099.0, 15242.314095865935, 15475.690486189987, 14637.707245855236, 14643.0, 14661.780073298696, 14696.0, 14782.704345912807, 10186.46702217506, 10392.480375981322, 10487.213458990454, 10571.841422378517, 10668.679939601825, 11237.60668376603, 12584.874151258737, 13300.135491193041, 13349.933250333686, 13399.732005360032], "value": 7700.932420367683, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1450.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 113.0, 111.0, 113.0, 111.0, 112.0, 112.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 114.0, 115.0, 153.0, 120.0, 120.0, 115.0, 116.0, 140.0, 115.0], "value": 125.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 161.0, 160.0, 160.0, 160.0, 159.0, 159.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 111.0, 75.0, 82.0, 75.0, 75.0, 88.0, 74.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 112.0, 82.0, 83.0, 82.0, 92.0, 81.0, 81.0, 104.0], "value": 88.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 56.0, 56.0, 56.0, 56.0, 55.0, 58.0, 56.0, 58.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 53.0, 52.0, 53.0], "value": 52.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 78.0, 76.0, 75.0, 75.0, 77.0, 78.0, 81.0, 75.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 120.0, 121.0, 123.0, 121.0, 126.0, 126.0, 124.0, 157.0, 122.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 160.0, 173.0, 159.0, 154.0, 161.0, 163.0, 161.0, 157.0, 158.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 63.0, 60.0, 59.0, 67.0, 59.0, 59.0, 58.0, 59.0], "value": 60.2, "unit": "score"}]}]} 04:26:04 INFO - Return code: 0 04:26:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:26:04 ERROR - # TBPL SUCCESS # 04:26:04 INFO - Running post-action listener: _resource_record_post_action 04:26:04 INFO - [mozharness: 2017-04-13 11:26:04.139276Z] Finished run-tests step (success) 04:26:04 INFO - Running post-run listener: _resource_record_post_run 04:26:04 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 266240; Write bytes: 364232704; Read time: 32; Write time: 393944 04:26:04 INFO - TinderboxPrint: CPU usage
13.1% 04:26:04 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 04:26:04 INFO - TinderboxPrint: I/O write bytes / time
364,232,704 / 393,944 04:26:04 INFO - TinderboxPrint: CPU idle
8,270.1 (86.8%) 04:26:04 INFO - TinderboxPrint: CPU user
1,202.7 (12.6%) 04:26:04 INFO - TinderboxPrint: Swap in / out
0 / 0 04:26:04 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110321664; Read time: 0; Write time: 149036 04:26:04 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 253911040; Read time: 32; Write time: 244908 04:26:04 INFO - Running post-run listener: _upload_blobber_files 04:26:04 INFO - Blob upload gear active. 04:26:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:26: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 04:26: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'] 04:26: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 04:26:05 INFO - (blobuploader) - INFO - Open directory for files ... 04:26:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:26:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:26:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:07 INFO - (blobuploader) - INFO - Done attempting. 04:26:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:26:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:26:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:09 INFO - (blobuploader) - INFO - Done attempting. 04:26:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:26:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:26:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:21 INFO - (blobuploader) - INFO - Done attempting. 04:26:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:26:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:26:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:22 INFO - (blobuploader) - INFO - Done attempting. 04:26:22 INFO - (blobuploader) - INFO - Iteration through files over. 04:26:22 INFO - Return code: 0 04:26:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:26:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:26:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/0bddc1a013d154af2f6eafbc3a02a3ff94c08974e3dfc977a7333896db2cce4a1973f1f52182fc484301f272ad4fd35f4f3a9d4172cb20b38f30c9dbfe8cc052", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c0c3b80cbddd893caa11b0d9320b38d21a937517038bc7fd5ae84550a6b780b50302e49b6b745f8448dc696b8a3696e31413293696ff518d65732dbb9c2ac8d7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4b6280646f491c313d10a78475b6703952625d0fac400604389b8f236c3f24a3f51606653845770cec171e2d1ae238588c4aa49bfdabf862131732cb9a1e1176", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/cbebdc79e65a1ace17287c20fd6e09dc7aec57e38594c8730f610d8f1c9574117cf20f23fcca142fa9beddf93be3f5cfc38e2736e8bbdd1b61e776d6e7648961"} 04:26:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:26:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:26:22 INFO - Contents: 04:26:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/0bddc1a013d154af2f6eafbc3a02a3ff94c08974e3dfc977a7333896db2cce4a1973f1f52182fc484301f272ad4fd35f4f3a9d4172cb20b38f30c9dbfe8cc052", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c0c3b80cbddd893caa11b0d9320b38d21a937517038bc7fd5ae84550a6b780b50302e49b6b745f8448dc696b8a3696e31413293696ff518d65732dbb9c2ac8d7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4b6280646f491c313d10a78475b6703952625d0fac400604389b8f236c3f24a3f51606653845770cec171e2d1ae238588c4aa49bfdabf862131732cb9a1e1176", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/cbebdc79e65a1ace17287c20fd6e09dc7aec57e38594c8730f610d8f1c9574117cf20f23fcca142fa9beddf93be3f5cfc38e2736e8bbdd1b61e776d6e7648961"} 04:26:22 INFO - Running post-run listener: copy_logs_to_upload_dir 04:26:22 INFO - Copying logs to upload dir... 04:26:22 INFO - mkdir: /builds/slave/test/build/upload/logs 04:26:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.698460 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-04-13 04:26:22.866398) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-13 04:26:22.869776) ========= 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=5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661 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/0bddc1a013d154af2f6eafbc3a02a3ff94c08974e3dfc977a7333896db2cce4a1973f1f52182fc484301f272ad4fd35f4f3a9d4172cb20b38f30c9dbfe8cc052", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c0c3b80cbddd893caa11b0d9320b38d21a937517038bc7fd5ae84550a6b780b50302e49b6b745f8448dc696b8a3696e31413293696ff518d65732dbb9c2ac8d7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4b6280646f491c313d10a78475b6703952625d0fac400604389b8f236c3f24a3f51606653845770cec171e2d1ae238588c4aa49bfdabf862131732cb9a1e1176", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/cbebdc79e65a1ace17287c20fd6e09dc7aec57e38594c8730f610d8f1c9574117cf20f23fcca142fa9beddf93be3f5cfc38e2736e8bbdd1b61e776d6e7648961"} build_url:https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://queue.taskcluster.net/v1/task/FYDrf0apQS6js0f34GMuYw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/0bddc1a013d154af2f6eafbc3a02a3ff94c08974e3dfc977a7333896db2cce4a1973f1f52182fc484301f272ad4fd35f4f3a9d4172cb20b38f30c9dbfe8cc052", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c0c3b80cbddd893caa11b0d9320b38d21a937517038bc7fd5ae84550a6b780b50302e49b6b745f8448dc696b8a3696e31413293696ff518d65732dbb9c2ac8d7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4b6280646f491c313d10a78475b6703952625d0fac400604389b8f236c3f24a3f51606653845770cec171e2d1ae238588c4aa49bfdabf862131732cb9a1e1176", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/cbebdc79e65a1ace17287c20fd6e09dc7aec57e38594c8730f610d8f1c9574117cf20f23fcca142fa9beddf93be3f5cfc38e2736e8bbdd1b61e776d6e7648961"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-13 04:26:22.895551) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 04:26:22.895890) ========= 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=5cf47e208febbcd81da23b2e0000026f-1492081518.563893-775211661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 04:26:22.981237) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-13 04:26:22.981558) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-13 04:26:22.981869) ========= ========= Total master_lag: 0.18 =========