builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1470331257.01 results: success (0) buildid: 20160804073002 builduid: 75068d66a11a40bd935b2d8a9019af2f revision: d2c3da5ac021138cc92099d2c10b6a591929b6c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 10:20:57.013441) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 10:20:57.013866) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 10:20:57.014166) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 10:20:57.033138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:20:57.033456) ========= 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=0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 10:20:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.0M=0s 2016-08-04 10:20:57 (89.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109569 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:20:57.157048) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:20:57.157372) ========= 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=0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016194 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:20:57.207223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-04 10:20:57.207577) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d2c3da5ac021138cc92099d2c10b6a591929b6c4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d2c3da5ac021138cc92099d2c10b6a591929b6c4 --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=0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 10:20:57,335 truncating revision to first 12 chars 2016-08-04 10:20:57,336 Setting DEBUG logging. 2016-08-04 10:20:57,336 attempt 1/10 2016-08-04 10:20:57,336 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d2c3da5ac021?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 10:20:58,691 unpacking tar archive at: mozilla-inbound-d2c3da5ac021/testing/mozharness/ program finished with exit code 0 elapsedTime=1.755720 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-04 10:20:58.977946) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 10:20:58.978255) ========= script_repo_revision: d2c3da5ac021138cc92099d2c10b6a591929b6c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 10:20:58.978661) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 10:20:58.978941) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 10:20:59.022844) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-04 10:20:59.023182) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:20:59 INFO - MultiFileLogger online at 20160804 10:20:59 in /builds/slave/test 10:20:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 10:20:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:20:59 INFO - {'append_to_log': False, 10:20:59 INFO - 'base_work_dir': '/builds/slave/test', 10:20:59 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:20:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:20:59 INFO - 'branch': 'Mozilla-Inbound', 10:20:59 INFO - 'buildbot_json_path': 'buildprops.json', 10:20:59 INFO - 'config_files': ('talos/linux_config.py',), 10:20:59 INFO - 'default_actions': ('clobber', 10:20:59 INFO - 'read-buildbot-config', 10:20:59 INFO - 'download-and-extract', 10:20:59 INFO - 'populate-webroot', 10:20:59 INFO - 'create-virtualenv', 10:20:59 INFO - 'install', 10:20:59 INFO - 'run-tests'), 10:20:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:20:59 INFO - 'download_minidump_stackwalk': True, 10:20:59 INFO - 'download_symbols': 'ondemand', 10:20:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:20:59 INFO - 'tooltool.py': '/tools/tooltool.py', 10:20:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:20:59 INFO - '/tools/misc-python/virtualenv.py')}, 10:20:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:20:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:20:59 INFO - 'installer_path': 'installer.exe', 10:20:59 INFO - 'log_level': 'info', 10:20:59 INFO - 'log_name': 'talos', 10:20:59 INFO - 'log_to_console': True, 10:20:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:20:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:20:59 INFO - 'opt_config_files': (), 10:20:59 INFO - 'pip_index': False, 10:20:59 INFO - 'sps_profile': False, 10:20:59 INFO - 'sps_profile_interval': 0, 10:20:59 INFO - 'suite': 'dromaeojs', 10:20:59 INFO - 'system_bits': '32', 10:20:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:20:59 INFO - 'title': 'talos-linux64-ix-017', 10:20:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:20:59 INFO - 'use_talos_json': True, 10:20:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:20:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:20:59 INFO - 'work_dir': 'build'} 10:20:59 INFO - [mozharness: 2016-08-04 17:20:59.235978Z] Running clobber step. 10:20:59 INFO - Running pre-action listener: _resource_record_pre_action 10:20:59 INFO - Running main action method: clobber 10:20:59 INFO - rmtree: /builds/slave/test/build 10:20:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:20:59 INFO - Running post-action listener: _resource_record_post_action 10:20:59 INFO - [mozharness: 2016-08-04 17:20:59.695557Z] Finished clobber step (success) 10:20:59 INFO - [mozharness: 2016-08-04 17:20:59.695659Z] Running read-buildbot-config step. 10:20:59 INFO - Running pre-action listener: _resource_record_pre_action 10:20:59 INFO - Running main action method: read_buildbot_config 10:20:59 INFO - Using buildbot properties: 10:20:59 INFO - { 10:20:59 INFO - "project": "", 10:20:59 INFO - "product": "firefox", 10:20:59 INFO - "script_repo_revision": "production", 10:20:59 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 10:20:59 INFO - "repository": "", 10:20:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 10:20:59 INFO - "buildid": "20160804073002", 10:20:59 INFO - "pgo_build": "True", 10:20:59 INFO - "basedir": "/builds/slave/test", 10:20:59 INFO - "buildnumber": 2194, 10:20:59 INFO - "slavename": "talos-linux64-ix-017", 10:20:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:20:59 INFO - "platform": "ubuntu64_hw", 10:20:59 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:20:59 INFO - "branch": "mozilla-inbound", 10:20:59 INFO - "repo_path": "integration/mozilla-inbound", 10:20:59 INFO - "revision": "d2c3da5ac021138cc92099d2c10b6a591929b6c4", 10:20:59 INFO - "stage_platform": "linux64-pgo", 10:20:59 INFO - "builduid": "75068d66a11a40bd935b2d8a9019af2f", 10:20:59 INFO - "slavebuilddir": "test" 10:20:59 INFO - } 10:20:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:20:59 INFO - Running post-action listener: _resource_record_post_action 10:20:59 INFO - [mozharness: 2016-08-04 17:20:59.698202Z] Finished read-buildbot-config step (success) 10:20:59 INFO - [mozharness: 2016-08-04 17:20:59.698291Z] Running download-and-extract step. 10:20:59 INFO - Running pre-action listener: _resource_record_pre_action 10:20:59 INFO - Running main action method: download_and_extract 10:20:59 INFO - mkdir: /builds/slave/test/build/tests 10:20: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')]} 10:20:59 INFO - trying https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:20:59 INFO - Downloading https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:20:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:21:00 INFO - Downloaded 1361 bytes. 10:21:00 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:21:00 INFO - Using the following test package requirements: 10:21:00 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:21:00 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:21:00 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:21:00 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:00 INFO - u'jsshell-linux-x86_64.zip'], 10:21:00 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:21:00 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:21:00 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:21:00 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:21:00 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:21:00 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:21:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:21:00 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:21:00 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')]} 10:21:00 INFO - trying https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:21:00 INFO - Downloading https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:21:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:21:01 INFO - Downloaded 21823750 bytes. 10:21:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:21:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:21:03 INFO - Return code: 0 10:21:03 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:21: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')]} 10:21:03 INFO - trying https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:21:03 INFO - Downloading https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:21:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:21:04 INFO - Downloaded 21823750 bytes. 10:21:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:21:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:21:05 INFO - Return code: 0 10:21:05 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')]} 10:21:05 INFO - trying https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:21:05 INFO - Downloading https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:21:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:21:06 INFO - Downloaded 14413723 bytes. 10:21:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:21:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:21:07 INFO - Return code: 0 10:21:07 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')]} 10:21:07 INFO - trying https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:21:07 INFO - Downloading https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:21:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:21:10 INFO - Downloaded 59363470 bytes. 10:21:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:21:10 INFO - mkdir: /builds/slave/test/properties 10:21:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:21:10 INFO - Writing to file /builds/slave/test/properties/build_url 10:21:10 INFO - Contents: 10:21:10 INFO - build_url:https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:21:11 INFO - Running post-action listener: _resource_record_post_action 10:21:11 INFO - Running post-action listener: set_extra_try_arguments 10:21:11 INFO - [mozharness: 2016-08-04 17:21:11.462996Z] Finished download-and-extract step (success) 10:21:11 INFO - [mozharness: 2016-08-04 17:21:11.463229Z] Running populate-webroot step. 10:21:11 INFO - Running pre-action listener: _resource_record_pre_action 10:21:11 INFO - Running main action method: populate_webroot 10:21:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:21:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:21:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:21:11 INFO - '--tppagecycles', 10:21:11 INFO - '7'], 10:21:11 INFO - 'tests': ['tsvgm']}}, 10:21:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:21:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:21:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:21:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:21:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:21:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:21:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:11 INFO - 'talos_options': ['--disable-e10s'], 10:21:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:21:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:21:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:11 INFO - 'talos_options': ['--disable-e10s'], 10:21:11 INFO - 'tests': ['damp', 'tps']}, 10:21:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:11 INFO - 'tests': ['damp', 'tps']}, 10:21:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:21:11 INFO - 'tests': ['dromaeo_dom']}, 10:21:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:21:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:21:11 INFO - 'tests': ['basic_compositor_video']}, 10:21:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:21:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:21:11 INFO - 'tests': ['a11yr', 10:21:11 INFO - 'ts_paint', 10:21:11 INFO - 'tpaint', 10:21:11 INFO - 'sessionrestore', 10:21:11 INFO - 'sessionrestore_no_auto_restore', 10:21:11 INFO - 'tabpaint']}, 10:21:11 INFO - 'other-e10s': {'tests': ['a11yr', 10:21:11 INFO - 'ts_paint', 10:21:11 INFO - 'tpaint', 10:21:11 INFO - 'sessionrestore', 10:21:11 INFO - 'sessionrestore_no_auto_restore', 10:21:11 INFO - 'tabpaint']}, 10:21:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:21:11 INFO - 'ts_paint', 10:21:11 INFO - 'tpaint', 10:21:11 INFO - 'sessionrestore', 10:21:11 INFO - 'sessionrestore_no_auto_restore', 10:21:11 INFO - 'tabpaint']}, 10:21:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:21:11 INFO - 'ts_paint', 10:21:11 INFO - 'tpaint', 10:21:11 INFO - 'sessionrestore', 10:21:11 INFO - 'sessionrestore_no_auto_restore', 10:21:11 INFO - 'tabpaint']}, 10:21:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:21:11 INFO - 'tests': ['a11yr', 10:21:11 INFO - 'ts_paint', 10:21:11 INFO - 'tpaint', 10:21:11 INFO - 'sessionrestore', 10:21:11 INFO - 'sessionrestore_no_auto_restore', 10:21:11 INFO - 'tabpaint']}, 10:21:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:21:11 INFO - 'tests': ['a11yr', 10:21:11 INFO - 'ts_paint', 10:21:11 INFO - 'tpaint', 10:21:11 INFO - 'sessionrestore', 10:21:11 INFO - 'sessionrestore_no_auto_restore', 10:21:11 INFO - 'tabpaint']}, 10:21:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:21:11 INFO - 'tests': ['tsvgx', 10:21:11 INFO - 'tsvgr_opacity', 10:21:11 INFO - 'tart', 10:21:11 INFO - 'tscrollx', 10:21:11 INFO - 'cart']}, 10:21:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:21:11 INFO - 'tsvgr_opacity', 10:21:11 INFO - 'tart', 10:21:11 INFO - 'tscrollx', 10:21:11 INFO - 'cart']}, 10:21:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:11 INFO - 'talos_options': ['--disable-e10s'], 10:21:11 INFO - 'tests': ['tp5o']}, 10:21:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:11 INFO - 'tests': ['tp5o']}, 10:21:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:11 INFO - 'talos_options': ['--disable-e10s', 10:21:11 INFO - '--xperf_path', 10:21:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:21:11 INFO - 'tests': ['tp5n']}, 10:21:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:11 INFO - 'talos_options': ['--xperf_path', 10:21:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:21:11 INFO - 'tests': ['tp5n']}}, 10:21:11 INFO - 'talos.zip': {'path': '', 10:21:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:21:11 INFO - Running post-action listener: _resource_record_post_action 10:21:11 INFO - [mozharness: 2016-08-04 17:21:11.480375Z] Finished populate-webroot step (success) 10:21:11 INFO - [mozharness: 2016-08-04 17:21:11.480463Z] Running create-virtualenv step. 10:21:11 INFO - Running pre-action listener: _resource_record_pre_action 10:21:11 INFO - Running main action method: create_virtualenv 10:21:11 INFO - Creating virtualenv /builds/slave/test/build/venv 10:21:11 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 10:21:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:21:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:21:11 INFO - Using real prefix '/usr' 10:21:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:21:12 INFO - Installing distribute.............................................................................................................................................................................................done. 10:21:14 INFO - Installing pip.................done. 10:21:14 INFO - Return code: 0 10:21:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:21:14 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')]} 10:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:14 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')]} 10:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:14 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 0xd43030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1004180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10023b0>, '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 0x10032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003740>, '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': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', '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 10:21:14 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 10:21:14 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 10:21:14 INFO - Using env: {'DISPLAY': ':0', 10:21:14 INFO - 'HOME': '/home/cltbld', 10:21:14 INFO - 'LANG': 'en_US.UTF-8', 10:21:14 INFO - 'LANGUAGE': 'en_US:en', 10:21:14 INFO - 'LOGNAME': 'cltbld', 10:21:14 INFO - 'MAIL': '/var/mail/cltbld', 10:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:14 INFO - 'MOZ_NO_REMOTE': '1', 10:21:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:14 INFO - 'NO_EM_RESTART': '1', 10:21:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:14 INFO - 'PWD': '/builds/slave/test', 10:21:14 INFO - 'SHELL': '/bin/bash', 10:21:14 INFO - 'SHLVL': '1', 10:21:14 INFO - 'TERM': 'linux', 10:21:14 INFO - 'TMOUT': '86400', 10:21:14 INFO - 'USER': 'cltbld', 10:21:14 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', 10:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:14 INFO - '_': '/tools/buildbot/bin/python'} 10:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:14 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 10:21:14 INFO - Cleaning up... 10:21:14 INFO - Return code: 0 10:21:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:21:14 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')]} 10:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:14 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')]} 10:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:14 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 0xd43030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1004180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10023b0>, '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 0x10032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003740>, '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': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', '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 10:21:14 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 10:21:14 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 10:21:14 INFO - Using env: {'DISPLAY': ':0', 10:21:14 INFO - 'HOME': '/home/cltbld', 10:21:14 INFO - 'LANG': 'en_US.UTF-8', 10:21:14 INFO - 'LANGUAGE': 'en_US:en', 10:21:14 INFO - 'LOGNAME': 'cltbld', 10:21:14 INFO - 'MAIL': '/var/mail/cltbld', 10:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:14 INFO - 'MOZ_NO_REMOTE': '1', 10:21:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:14 INFO - 'NO_EM_RESTART': '1', 10:21:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:14 INFO - 'PWD': '/builds/slave/test', 10:21:14 INFO - 'SHELL': '/bin/bash', 10:21:14 INFO - 'SHLVL': '1', 10:21:14 INFO - 'TERM': 'linux', 10:21:14 INFO - 'TMOUT': '86400', 10:21:14 INFO - 'USER': 'cltbld', 10:21:14 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', 10:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:14 INFO - '_': '/tools/buildbot/bin/python'} 10:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:14 INFO - Downloading/unpacking psutil>=3.1.1 10:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:21:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:21:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:21:16 INFO - Installing collected packages: psutil 10:21:16 INFO - Running setup.py install for psutil 10:21:16 INFO - building 'psutil._psutil_linux' extension 10:21:16 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 10:21:16 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 10:21:16 INFO - building 'psutil._psutil_posix' extension 10:21:16 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 10:21:16 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 10:21:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:21:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:21:17 INFO - Successfully installed psutil 10:21:17 INFO - Cleaning up... 10:21:17 INFO - Return code: 0 10:21:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:17 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 0xd43030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1004180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10023b0>, '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 0x10032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003740>, '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': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', '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 10:21:17 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 10:21:17 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 10:21:17 INFO - Using env: {'DISPLAY': ':0', 10:21:17 INFO - 'HOME': '/home/cltbld', 10:21:17 INFO - 'LANG': 'en_US.UTF-8', 10:21:17 INFO - 'LANGUAGE': 'en_US:en', 10:21:17 INFO - 'LOGNAME': 'cltbld', 10:21:17 INFO - 'MAIL': '/var/mail/cltbld', 10:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:17 INFO - 'MOZ_NO_REMOTE': '1', 10:21:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:17 INFO - 'NO_EM_RESTART': '1', 10:21:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:17 INFO - 'PWD': '/builds/slave/test', 10:21:17 INFO - 'SHELL': '/bin/bash', 10:21:17 INFO - 'SHLVL': '1', 10:21:17 INFO - 'TERM': 'linux', 10:21:17 INFO - 'TMOUT': '86400', 10:21:17 INFO - 'USER': 'cltbld', 10:21:17 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', 10:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:17 INFO - '_': '/tools/buildbot/bin/python'} 10:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:21:17 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 10:21:17 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 10:21:17 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 10:21:17 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 10:21:17 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 10:21:17 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 10:21:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:21:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:21:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:21:19 INFO - Installing collected packages: mozsystemmonitor 10:21:19 INFO - Running setup.py install for mozsystemmonitor 10:21:19 INFO - Successfully installed mozsystemmonitor 10:21:19 INFO - Cleaning up... 10:21:19 INFO - Return code: 0 10:21:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:21:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd43030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1004180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10023b0>, '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 0x10032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003740>, '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': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', '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 10:21:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:21:19 INFO - Using env: {'DISPLAY': ':0', 10:21:19 INFO - 'HOME': '/home/cltbld', 10:21:19 INFO - 'LANG': 'en_US.UTF-8', 10:21:19 INFO - 'LANGUAGE': 'en_US:en', 10:21:19 INFO - 'LOGNAME': 'cltbld', 10:21:19 INFO - 'MAIL': '/var/mail/cltbld', 10:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:19 INFO - 'MOZ_NO_REMOTE': '1', 10:21:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:19 INFO - 'NO_EM_RESTART': '1', 10:21:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:19 INFO - 'PWD': '/builds/slave/test', 10:21:19 INFO - 'SHELL': '/bin/bash', 10:21:19 INFO - 'SHLVL': '1', 10:21:19 INFO - 'TERM': 'linux', 10:21:19 INFO - 'TMOUT': '86400', 10:21:19 INFO - 'USER': 'cltbld', 10:21:19 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', 10:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:19 INFO - '_': '/tools/buildbot/bin/python'} 10:21:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:19 INFO - Downloading/unpacking jsonschema==2.5.1 10:21:19 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 10:21:19 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 10:21:19 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 10:21:19 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 10:21:19 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 10:21:19 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 10:21:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:21:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:21:21 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 10:21:21 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 10:21:21 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 10:21:21 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 10:21:21 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 10:21:21 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 10:21:21 INFO - Downloading functools32-3.2.3-2.tar.gz 10:21:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:21:21 INFO - warning: no files found matching '*.txt' 10:21:21 INFO - no previously-included directories found matching 'build' 10:21:21 INFO - no previously-included directories found matching 'dist' 10:21:21 INFO - no previously-included directories found matching '.git*' 10:21:21 INFO - Installing collected packages: jsonschema, functools32 10:21:21 INFO - Running setup.py install for functools32 10:21:22 INFO - warning: no files found matching '*.txt' 10:21:22 INFO - no previously-included directories found matching 'build' 10:21:22 INFO - no previously-included directories found matching 'dist' 10:21:22 INFO - no previously-included directories found matching '.git*' 10:21:22 INFO - Successfully installed jsonschema functools32 10:21:22 INFO - Cleaning up... 10:21:22 INFO - Return code: 0 10:21:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:21: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')]} 10:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21: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')]} 10:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:22 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 0xd43030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1004180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10023b0>, '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 0x10032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003740>, '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': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', '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 10:21:22 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 10:21:22 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 10:21:22 INFO - Using env: {'DISPLAY': ':0', 10:21:22 INFO - 'HOME': '/home/cltbld', 10:21:22 INFO - 'LANG': 'en_US.UTF-8', 10:21:22 INFO - 'LANGUAGE': 'en_US:en', 10:21:22 INFO - 'LOGNAME': 'cltbld', 10:21:22 INFO - 'MAIL': '/var/mail/cltbld', 10:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:22 INFO - 'MOZ_NO_REMOTE': '1', 10:21:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:22 INFO - 'NO_EM_RESTART': '1', 10:21:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:22 INFO - 'PWD': '/builds/slave/test', 10:21:22 INFO - 'SHELL': '/bin/bash', 10:21:22 INFO - 'SHLVL': '1', 10:21:22 INFO - 'TERM': 'linux', 10:21:22 INFO - 'TMOUT': '86400', 10:21:22 INFO - 'USER': 'cltbld', 10:21:22 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', 10:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:22 INFO - '_': '/tools/buildbot/bin/python'} 10:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:21:22 INFO - Cleaning up... 10:21:22 INFO - Return code: 0 10:21:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:21: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')]} 10:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21: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')]} 10:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:22 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 0xd43030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1004180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10023b0>, '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 0x10032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003740>, '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': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', '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 10:21:22 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 10:21:22 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 10:21:22 INFO - Using env: {'DISPLAY': ':0', 10:21:22 INFO - 'HOME': '/home/cltbld', 10:21:22 INFO - 'LANG': 'en_US.UTF-8', 10:21:22 INFO - 'LANGUAGE': 'en_US:en', 10:21:22 INFO - 'LOGNAME': 'cltbld', 10:21:22 INFO - 'MAIL': '/var/mail/cltbld', 10:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:22 INFO - 'MOZ_NO_REMOTE': '1', 10:21:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:22 INFO - 'NO_EM_RESTART': '1', 10:21:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:22 INFO - 'PWD': '/builds/slave/test', 10:21:22 INFO - 'SHELL': '/bin/bash', 10:21:22 INFO - 'SHLVL': '1', 10:21:22 INFO - 'TERM': 'linux', 10:21:22 INFO - 'TMOUT': '86400', 10:21:22 INFO - 'USER': 'cltbld', 10:21:22 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', 10:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:22 INFO - '_': '/tools/buildbot/bin/python'} 10:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:22 INFO - Downloading/unpacking blobuploader==1.2.4 10:21:22 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 10:21:22 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 10:21:22 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 10:21:22 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 10:21:22 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 10:21:22 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 10:21:24 INFO - Downloading blobuploader-1.2.4.tar.gz 10:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:21:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:21:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:25 INFO - Downloading docopt-0.6.1.tar.gz 10:21:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:21:25 INFO - Installing collected packages: blobuploader, requests, docopt 10:21:25 INFO - Running setup.py install for blobuploader 10:21:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:21:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:21:25 INFO - Running setup.py install for requests 10:21:25 INFO - Running setup.py install for docopt 10:21:25 INFO - Successfully installed blobuploader requests docopt 10:21:25 INFO - Cleaning up... 10:21:25 INFO - Return code: 0 10:21:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:25 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')]} 10:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:25 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')]} 10:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:25 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 0xd43030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1004180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10023b0>, '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 0x10032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003740>, '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': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', '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 10:21:25 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 10:21:25 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 10:21:25 INFO - Using env: {'DISPLAY': ':0', 10:21:25 INFO - 'HOME': '/home/cltbld', 10:21:25 INFO - 'LANG': 'en_US.UTF-8', 10:21:25 INFO - 'LANGUAGE': 'en_US:en', 10:21:25 INFO - 'LOGNAME': 'cltbld', 10:21:25 INFO - 'MAIL': '/var/mail/cltbld', 10:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:25 INFO - 'MOZ_NO_REMOTE': '1', 10:21:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:25 INFO - 'NO_EM_RESTART': '1', 10:21:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:25 INFO - 'PWD': '/builds/slave/test', 10:21:25 INFO - 'SHELL': '/bin/bash', 10:21:25 INFO - 'SHLVL': '1', 10:21:25 INFO - 'TERM': 'linux', 10:21:25 INFO - 'TMOUT': '86400', 10:21:25 INFO - 'USER': 'cltbld', 10:21:25 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', 10:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:25 INFO - '_': '/tools/buildbot/bin/python'} 10:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:21:25 INFO - Running setup.py (path:/tmp/pip-DWiNCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:21:26 INFO - Running setup.py (path:/tmp/pip-iATypF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:21:26 INFO - Running setup.py (path:/tmp/pip-BgWUGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:21:26 INFO - Running setup.py (path:/tmp/pip-l3clgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:21:26 INFO - Running setup.py (path:/tmp/pip-kVBK1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:21:26 INFO - Running setup.py (path:/tmp/pip-uwT7Vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:21:26 INFO - Running setup.py (path:/tmp/pip-QnkY6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:21:26 INFO - Running setup.py (path:/tmp/pip-LQIGc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:21:26 INFO - Running setup.py (path:/tmp/pip-FGCZ0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:21:26 INFO - Running setup.py (path:/tmp/pip-DADHf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:21:26 INFO - Running setup.py (path:/tmp/pip-OdMgTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:21:26 INFO - Running setup.py (path:/tmp/pip-sFPt8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:21:26 INFO - Running setup.py (path:/tmp/pip-w3OYl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:21:26 INFO - Running setup.py (path:/tmp/pip-KlxEti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:26 INFO - Running setup.py (path:/tmp/pip-o6d2aX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:21:27 INFO - Running setup.py (path:/tmp/pip-rQaF87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:21:27 INFO - Running setup.py (path:/tmp/pip-eyiY8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:21:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:21:27 INFO - Running setup.py install for manifestparser 10:21:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:21:27 INFO - Running setup.py install for mozcrash 10:21:27 INFO - Running setup.py install for mozdebug 10:21:27 INFO - Running setup.py install for mozdevice 10:21:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:21:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:21:27 INFO - Running setup.py install for mozfile 10:21:27 INFO - Running setup.py install for mozhttpd 10:21:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:21:27 INFO - Running setup.py install for mozinfo 10:21:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:21:27 INFO - Running setup.py install for mozInstall 10:21:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:21:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:21:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:21:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:21:27 INFO - Running setup.py install for mozleak 10:21:28 INFO - Running setup.py install for mozlog 10:21:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:21:28 INFO - Running setup.py install for moznetwork 10:21:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:21:28 INFO - Running setup.py install for mozprocess 10:21:28 INFO - Running setup.py install for mozprofile 10:21:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:21:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:21:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:21:28 INFO - Running setup.py install for mozrunner 10:21:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:21:28 INFO - Running setup.py install for mozscreenshot 10:21:28 INFO - Running setup.py install for moztest 10:21:28 INFO - Running setup.py install for mozversion 10:21:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:21:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:21:28 INFO - Cleaning up... 10:21:28 INFO - Return code: 0 10:21:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:28 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 0xd43030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1004180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10023b0>, '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 0x10032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003740>, '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': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', '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 10:21:28 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 10:21:28 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 10:21:28 INFO - Using env: {'DISPLAY': ':0', 10:21:28 INFO - 'HOME': '/home/cltbld', 10:21:28 INFO - 'LANG': 'en_US.UTF-8', 10:21:28 INFO - 'LANGUAGE': 'en_US:en', 10:21:28 INFO - 'LOGNAME': 'cltbld', 10:21:28 INFO - 'MAIL': '/var/mail/cltbld', 10:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:28 INFO - 'MOZ_NO_REMOTE': '1', 10:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:28 INFO - 'NO_EM_RESTART': '1', 10:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:28 INFO - 'PWD': '/builds/slave/test', 10:21:28 INFO - 'SHELL': '/bin/bash', 10:21:28 INFO - 'SHLVL': '1', 10:21:28 INFO - 'TERM': 'linux', 10:21:28 INFO - 'TMOUT': '86400', 10:21:28 INFO - 'USER': 'cltbld', 10:21:28 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', 10:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:28 INFO - '_': '/tools/buildbot/bin/python'} 10:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:21:29 INFO - Running setup.py (path:/tmp/pip-ladqz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:21:29 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)) 10:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:21:29 INFO - Running setup.py (path:/tmp/pip-RcH0BN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:21:29 INFO - Running setup.py (path:/tmp/pip-z7Rv23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:21:29 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)) 10:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:21:29 INFO - Running setup.py (path:/tmp/pip-X9L_Vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:21:29 INFO - Running setup.py (path:/tmp/pip-BUB3XI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:21:29 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)) 10:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:21:29 INFO - Running setup.py (path:/tmp/pip-kIBh1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:21:29 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)) 10:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:21:29 INFO - Running setup.py (path:/tmp/pip-fTXTTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:21:29 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)) 10:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:21:29 INFO - Running setup.py (path:/tmp/pip-idVmS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:21:29 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)) 10:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:21:29 INFO - Running setup.py (path:/tmp/pip-1MNprP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:21:29 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)) 10:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:21:29 INFO - Running setup.py (path:/tmp/pip-lJxYSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:21:29 INFO - Running setup.py (path:/tmp/pip-IedwI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:21:30 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)) 10:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:21:30 INFO - Running setup.py (path:/tmp/pip-8sbcXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:21:30 INFO - Running setup.py (path:/tmp/pip-3ojqwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:21:30 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)) 10:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:21:30 INFO - Running setup.py (path:/tmp/pip-JYLhGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:30 INFO - Running setup.py (path:/tmp/pip-RkgdPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:30 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)) 10:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:21:30 INFO - Running setup.py (path:/tmp/pip-Hjz6fY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:21:30 INFO - Running setup.py (path:/tmp/pip-7bQE12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:21:30 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)) 10:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:21:30 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)) 10:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:21:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:21:30 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 10:21:30 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 10:21:30 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 10:21:30 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 10:21:30 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 10:21:30 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 10:21:32 INFO - Downloading blessings-1.6.tar.gz 10:21:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:21:32 INFO - Installing collected packages: blessings 10:21:32 INFO - Running setup.py install for blessings 10:21:32 INFO - Successfully installed blessings 10:21:32 INFO - Cleaning up... 10:21:32 INFO - Return code: 0 10:21:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:21:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:21:32 INFO - Reading from file tmpfile_stdout 10:21:32 INFO - Current package versions: 10:21:32 INFO - argparse == 1.2.1 10:21:32 INFO - blessings == 1.6 10:21:32 INFO - blobuploader == 1.2.4 10:21:32 INFO - docopt == 0.6.1 10:21:32 INFO - functools32 == 3.2.3-2 10:21:32 INFO - jsonschema == 2.5.1 10:21:32 INFO - manifestparser == 1.1 10:21:32 INFO - mozInstall == 1.12 10:21:32 INFO - mozcrash == 0.17 10:21:32 INFO - mozdebug == 0.1 10:21:32 INFO - mozdevice == 0.48 10:21:32 INFO - mozfile == 1.2 10:21:32 INFO - mozhttpd == 0.7 10:21:32 INFO - mozinfo == 0.9 10:21:32 INFO - mozleak == 0.1 10:21:32 INFO - mozlog == 3.3 10:21:32 INFO - moznetwork == 0.27 10:21:32 INFO - mozprocess == 0.23 10:21:32 INFO - mozprofile == 0.28 10:21:32 INFO - mozrunner == 6.12 10:21:32 INFO - mozscreenshot == 0.1 10:21:32 INFO - mozsystemmonitor == 0.3 10:21:32 INFO - moztest == 0.7 10:21:32 INFO - mozversion == 1.4 10:21:32 INFO - psutil == 3.1.1 10:21:32 INFO - requests == 1.2.3 10:21:32 INFO - wsgiref == 0.1.2 10:21:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:32 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')]} 10:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:32 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')]} 10:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:32 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 0xd43030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1004180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10023b0>, '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 0x10032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003740>, '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': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', '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 10:21:32 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 10:21:32 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 10:21:32 INFO - Using env: {'DISPLAY': ':0', 10:21:32 INFO - 'HOME': '/home/cltbld', 10:21:32 INFO - 'LANG': 'en_US.UTF-8', 10:21:32 INFO - 'LANGUAGE': 'en_US:en', 10:21:32 INFO - 'LOGNAME': 'cltbld', 10:21:32 INFO - 'MAIL': '/var/mail/cltbld', 10:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:32 INFO - 'MOZ_NO_REMOTE': '1', 10:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:32 INFO - 'NO_EM_RESTART': '1', 10:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:32 INFO - 'PWD': '/builds/slave/test', 10:21:32 INFO - 'SHELL': '/bin/bash', 10:21:32 INFO - 'SHLVL': '1', 10:21:32 INFO - 'TERM': 'linux', 10:21:32 INFO - 'TMOUT': '86400', 10:21:32 INFO - 'USER': 'cltbld', 10:21:32 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', 10:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:32 INFO - '_': '/tools/buildbot/bin/python'} 10:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:32 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)) 10:21:32 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)) 10:21:32 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)) 10:21:32 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)) 10:21:32 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)) 10:21:32 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)) 10:21:32 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)) 10:21:32 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)) 10:21:32 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)) 10:21:32 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)) 10:21:32 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)) 10:21:32 INFO - Cleaning up... 10:21:33 INFO - Return code: 0 10:21:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:21:33 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')]} 10:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:33 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')]} 10:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:33 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 0xd43030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1004180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10023b0>, '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 0x10032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003740>, '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': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', '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 10:21:33 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 10:21:33 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 10:21:33 INFO - Using env: {'DISPLAY': ':0', 10:21:33 INFO - 'HOME': '/home/cltbld', 10:21:33 INFO - 'LANG': 'en_US.UTF-8', 10:21:33 INFO - 'LANGUAGE': 'en_US:en', 10:21:33 INFO - 'LOGNAME': 'cltbld', 10:21:33 INFO - 'MAIL': '/var/mail/cltbld', 10:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:33 INFO - 'MOZ_NO_REMOTE': '1', 10:21:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:33 INFO - 'NO_EM_RESTART': '1', 10:21:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:33 INFO - 'PWD': '/builds/slave/test', 10:21:33 INFO - 'SHELL': '/bin/bash', 10:21:33 INFO - 'SHLVL': '1', 10:21:33 INFO - 'TERM': 'linux', 10:21:33 INFO - 'TMOUT': '86400', 10:21:33 INFO - 'USER': 'cltbld', 10:21:33 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', 10:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:33 INFO - '_': '/tools/buildbot/bin/python'} 10:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:21:33 INFO - Cleaning up... 10:21:33 INFO - Return code: 0 10:21:33 INFO - Running post-action listener: _resource_record_post_action 10:21:33 INFO - Running post-action listener: _start_resource_monitoring 10:21:33 INFO - Starting resource monitoring. 10:21:33 INFO - [mozharness: 2016-08-04 17:21:33.264198Z] Finished create-virtualenv step (success) 10:21:33 INFO - [mozharness: 2016-08-04 17:21:33.264637Z] Running install step. 10:21:33 INFO - Running pre-action listener: _resource_record_pre_action 10:21:33 INFO - Running main action method: install 10:21:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:21:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:21:33 INFO - Reading from file tmpfile_stdout 10:21:33 INFO - Detecting whether we're running mozinstall >=1.0... 10:21:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:21:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:21:33 INFO - Reading from file tmpfile_stdout 10:21:33 INFO - Output received: 10:21:33 INFO - Usage: mozinstall [options] installer 10:21:33 INFO - Options: 10:21:33 INFO - -h, --help show this help message and exit 10:21:33 INFO - -d DEST, --destination=DEST 10:21:33 INFO - Directory to install application into. [default: 10:21:33 INFO - "/builds/slave/test"] 10:21:33 INFO - --app=APP Application being installed. [default: firefox] 10:21:33 INFO - mkdir: /builds/slave/test/build/application 10:21:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:21:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:21:50 INFO - Reading from file tmpfile_stdout 10:21:50 INFO - Output received: 10:21:50 INFO - /builds/slave/test/build/application/firefox/firefox 10:21:50 INFO - Running post-action listener: _resource_record_post_action 10:21:50 INFO - [mozharness: 2016-08-04 17:21:50.431586Z] Finished install step (success) 10:21:50 INFO - [mozharness: 2016-08-04 17:21:50.431834Z] Running run-tests step. 10:21:50 INFO - Running pre-action listener: _resource_record_pre_action 10:21:50 INFO - Running main action method: run_tests 10:21:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:21:50 INFO - Python 2.7.3 10:21:50 INFO - Return code: 0 10:21:50 INFO - grabbing minidump binary from tooltool 10:21: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')]} 10:21:50 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 0x10023b0>, '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 0x10032b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1003740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:21:50 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 10:21:50 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 10:21:50 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 10:21:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:21:50 INFO - Return code: 0 10:21:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:21:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:21:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:21:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:21:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:21:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 10:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 10:21:50 INFO - Using env: {'DISPLAY': ':0', 10:21:50 INFO - 'HOME': '/home/cltbld', 10:21:50 INFO - 'LANG': 'en_US.UTF-8', 10:21:50 INFO - 'LANGUAGE': 'en_US:en', 10:21:50 INFO - 'LOGNAME': 'cltbld', 10:21:50 INFO - 'MAIL': '/var/mail/cltbld', 10:21:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:21:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:50 INFO - 'MOZ_NO_REMOTE': '1', 10:21:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:21:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:50 INFO - 'NO_EM_RESTART': '1', 10:21:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:50 INFO - 'PWD': '/builds/slave/test', 10:21:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:21:50 INFO - 'SHELL': '/bin/bash', 10:21:50 INFO - 'SHLVL': '1', 10:21:50 INFO - 'TERM': 'linux', 10:21:50 INFO - 'TMOUT': '86400', 10:21:50 INFO - 'USER': 'cltbld', 10:21:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163', 10:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:50 INFO - '_': '/tools/buildbot/bin/python'} 10:21:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 10:21:50 INFO - mozversion application_buildid: 20160804073002 10:21:50 INFO - mozversion application_changeset: d2c3da5ac021138cc92099d2c10b6a591929b6c4 10:21:50 INFO - mozversion application_display_name: Nightly 10:21:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:21:50 INFO - mozversion application_name: Firefox 10:21:50 INFO - mozversion application_remotingname: firefox 10:21:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:21:50 INFO - mozversion application_vendor: Mozilla 10:21:50 INFO - mozversion application_version: 51.0a1 10:21:50 INFO - mozversion platform_buildid: 20160804073002 10:21:50 INFO - mozversion platform_changeset: d2c3da5ac021138cc92099d2c10b6a591929b6c4 10:21:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:21:50 INFO - mozversion platform_version: 51.0a1 10:21:50 INFO - using testdate: 1470331310 10:21:50 INFO - actual date: 1470331310 10:21:50 INFO - starting webserver on 'localhost:43072' 10:21:50 INFO - SUITE-START | Running 2 tests 10:21:50 INFO - TEST-START | dromaeo_css 10:21:50 INFO - operating with platform_type : linux_ 10:21:50 INFO - Initialising browser for dromaeo_css test... 10:21:50 INFO - TEST-INFO | started process 9090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWOcDaB/profile http://localhost:43072/getInfo.html) 10:21:54 INFO - PROCESS | 9090 | __metrics Screen width/height:1600/1200 10:21:54 INFO - PROCESS | 9090 | colorDepth:24 10:21:54 INFO - PROCESS | 9090 | Browser inner width/height: 1024/697 10:21:54 INFO - PROCESS | 9090 | __metrics 10:21:55 INFO - PROCESS | 9090 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:21:55 INFO - PROCESS | 9090 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:21:56 INFO - TEST-INFO | 9090: exit 0 10:21:56 INFO - Browser initialized. 10:21:56 INFO - Running cycle 1/1 for dromaeo_css test... 10:21:56 INFO - TEST-INFO | started process 9171 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWOcDaB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:22:08 INFO - PROCESS | 9171 | RSS: Main: 157188096 10:22:08 INFO - PROCESS | 9171 | 10:23:00 INFO - PROCESS | 9171 | 1470331380257 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:25:09 INFO - PROCESS | 9171 | Cycle 1(1): loaded http://localhost:43072/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43072/tests/dromaeo/cssquery-ext.html) 10:25:10 INFO - PROCESS | 9171 | RSS: Main: 261500928 10:25:10 INFO - PROCESS | 9171 | 10:28:13 INFO - PROCESS | 9171 | Cycle 1(1): loaded http://localhost:43072/tests/dromaeo/cssquery-ext.html (next: http://localhost:43072/tests/dromaeo/cssquery-jquery.html) 10:28:13 INFO - PROCESS | 9171 | RSS: Main: 238985216 10:28:13 INFO - PROCESS | 9171 | 10:31:15 INFO - PROCESS | 9171 | Cycle 1(1): loaded http://localhost:43072/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43072/tests/dromaeo/cssquery-mootools.html) 10:31:16 INFO - PROCESS | 9171 | RSS: Main: 187080704 10:31:16 INFO - PROCESS | 9171 | 10:34:18 INFO - PROCESS | 9171 | Cycle 1(1): loaded http://localhost:43072/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43072/tests/dromaeo/cssquery-prototype.html) 10:34:19 INFO - PROCESS | 9171 | RSS: Main: 184365056 10:34:19 INFO - PROCESS | 9171 | 10:37:21 INFO - PROCESS | 9171 | Cycle 1(1): loaded http://localhost:43072/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43072/tests/dromaeo/cssquery-yui.html) 10:37:22 INFO - PROCESS | 9171 | RSS: Main: 184664064 10:37:22 INFO - PROCESS | 9171 | 10:40:25 INFO - PROCESS | 9171 | Cycle 1(1): loaded http://localhost:43072/tests/dromaeo/cssquery-yui.html (next: http://localhost:43072/tests/dromaeo/cssquery-dojo.html) 10:40:25 INFO - PROCESS | 9171 | RSS: Main: 275427328 10:40:25 INFO - PROCESS | 9171 | 10:40:25 INFO - PROCESS | 9171 | __start_tp_report 10:40:25 INFO - PROCESS | 9171 | _x_x_mozilla_page_load 10:40:25 INFO - PROCESS | 9171 | _x_x_mozilla_page_load_details 10:40:25 INFO - PROCESS | 9171 | |i|pagename|runs| 10:40:25 INFO - PROCESS | 9171 | |0;dojo.html;2995.385945881094;3005.639323281205;3019.788614796964;3042.9847850760743;3067.6165479315086;5024.271480635306;5055.848324550269;5188.221766734991;5271.393789714184;5284.709340986245;5160.458151894053;5233.084210263199;5251.107311757001;5295.549878260343;5300.151975683892;4729;4740.71555706657;4809.7835597398025;4811.422629284473;4961.727105009223;4876.683015603974;4902.926456103161;4908.141075311806;4925.113479573675;4940.60475161988;4659.906801863961;4689.718616882964;4731.432228132611;4757.904841903177;4782.521747825207;4726.172919739032;4730.337752714623;4750.738709370983;4797.712137271775;4818.807247710122;4726.834560790356;4774.546418090311;4776.450708168571;4793.209120495114;4820.25286080658;4955.306257124005;5144.151215049513;5196.558292545138;5214.582833373321;5224.895502089975;5563.415841336642;5573.359063707685;5606.131049687305;5622.662640241599;5627.465390787868;5624.3531993820825;5656.321241451011;5663.518600918886;5667.319921609392;5683.204351390808;5029.245613158019;5130.050940576006;5131.640785145079;5133.948660513347;5272.340957380327;5661.235733176051;5664.631798933056;5668;5713.971430142823;5724.026915424388;5442.591805614595;5467.398586155519;5495.6153069284765;5498.257735205776;5503.229547863302;5384.596155288369;5387.676739395649;5430.294061772023;5443.755031023614;5572.749226284827;5456.263404440349;5464.0711079116645;5471.50756431923;5472.425395333512;5501.4223506532035;5427.972860135674;5463.344398672105;5465.426130256265;5472.534834539029;5521.420250873601;4114.917701645951;4157.210130075276;4191.497020357577;4195.601417865298;4236.110416812504;3807.809609519513;3817.6754975827366;3848.499695039683;3851.6533511983494;3874.3994680824517;5304.549113325411;5311.3095297611835;5311.49540793624;5359.544438722674;5364.731763411892;5351.3578370595;5525.530329922001;5571.66570005801;5590.2453168821685;5645.830625081254;5337.946620533823;5338.733063346817;5339;5363.061464243741;5378.139497680352;4819.469858315582;4829.13075646387;4831.903361932812;4850.95149048512;4872.902541949141;5482.342118945752;5562.972185139049;5650.519705825051;5834.504067154255;5836.766529338864;5511.393746687781;5516.420775818642;5551.056320425457;5552.305961754781;5555.111182210827;5679.659220446786;5685.431456854281;5688.715564221855;5699.800506982236;5701.800436984686;5312.123499622519;5345.893082138413;5420.674759514442;5430.565554755689;5447.155690867922;5500.697461639488;5514.696691681836;5544.002079625706;5587.664740115606;5594;5406.080966235828;5407.080796264723;5411.648242864201;5416.106342453451;5416.7020813855615;5259.474052594863;5375.247465354775;5401.540869026177;5403.891922161613;5423.620346575702;5351.5451186648015;5416.079266524622;5434.375046869661;5436.320459942507;5463.672179669233;5502.147167189092;5521.972390138024;5555.805546805843;5559.9444005561045;5567.610267281251;5222.451642577475;5280.867978300574;5323.813666521653;5382.327209098863;5390.299261096189 10:40:25 INFO - PROCESS | 9171 | |1;ext.html;585.1602949767084;607.2621764556064;621.9315875253722;630.0360448513774;645.0421124629927;42805;44383;44416;44466;48566.51433485673;45344.3198352025;45837.54162458375;45839.770801146035;45984.77007614957;46008.30987535189;8867.645294188242;9060.320475964296;9062.501562414065;9063.637454501812;9064.410813297147;8929;9010.23413009895;9017.45895246284;9021.548922553879;9031.59357828896;9061.682841100563;9088.136627020456;9094.49980251086;9100.726978190633;9103.135202155818;8985.865212021792;9016.819663606691;9023.819523609523;9027.09729027092;9027.14242146995;8977.147171018743;9022.684206052822;9030.819383612357;9044.457332560067;9066.5920033598;42978;43193.13613727739;43232.35151472731;43295.567044329466;43331.56668433338;3679.0802299425145;3726.888193354204;3791.2796568652143;3834.961650383488;4362.629176519999;33491.66508334934;33691;34143.82928085344;34201.657983420344;34507.654923450944;4331.956680433218;4410.558944105596;4420.513743488214;4435.911281774379;4439.445069366329;256142;258720;258738;259656;260708.9999999981;61955.38044619496;62396.68801656053;62451.375486245466;62508;62566;58510.7074464625;65504.672476637315;65546.34453655402;65597.34402656008;65613;15141.924290378478;15986.520404387888;15995.200239987955;16426.096564689058;16558.089305088095;12140;12279.324637145042;12287.877121228674;12292.938535307267;12293;17336.826631733773;17602;17681.11594420274;17726.113694315234;17827.21727827233;5507.834764957058;6620.139381880324;6636.093876449867;6810.161256460827;6899.344562266577;1010.1918465227935;1058.5342449322275;1067.6156583629886;1114.147677027075;1115.9888401116048;33016.38580722535;33140.005799826045;33217.16957076044;33393.49909751356;33461.83269083639;1097.5993762276712;1128.67268492138;1151.205668089016;1168.199783148546;1219.914605977573;16353.182340882908;17755.822441775676;17880.821191787916;17948;18143.167244691627;560761;569236;569572;570115;572695;62114.37885621086;62547.68726156431;62591.6870415645;62593.37406625967;62633;1247.3950134184913;1364.3314775760005;1377.9173249605055;1381.8134551835374;1403.7964495148146;32029.839850800596;33070.5039424404;33451.66548334583;33562.83218583892;33648.49527257044;48195.51804482051;48918;48995.755021224664;49034;49142.75428622834;438682;440404;440515;442075;442666;26564.468710626064;27265.86367068152;27284.59073113865;28224;29011.12966611005;47719.522804772896;47914.52085479101;48140;48383.27425088556;48936.2659560114;39974;40191.397129043675;40500.59499405086;40851.7957410211;41874;39019;39246.607533924296;39493.80253098716;40122;40820.59179408168;40222.39666405065;40745.38881916714;40812.38781418222;40835.79582102071;40957.79521102375;32995.67004330022;35470.46794298139;35839.283214335046;35924.101897452776;36231.818840905624;27167.320816979733;27301.180964571096;27637.30906727348;27721.765145848916;27794.86102569555 10:40:25 INFO - PROCESS | 9171 | |2;jquery.html;355.4259870309451;371.453962674868;379.75885312826347;386.069572330683;404.8967513284112;15781.763273550905;18325.541861453472;19882.502937426554;20646.174153033862;20971.47571310718;19195.42413727587;19666.13490773732;19884.60230795383;19906.502337441572;20096.39710808678;5679.914801277984;5761.769529218836;5856.736446859902;5977.193078934331;5986.191864098357;4242.681798865082;5779;5838.2702162229725;5849.736761845727;5858.970705146489;6253.405926436982;6504.967475162617;6513.088167656532;6609.966950165242;6618.966905165492;5661.547076233912;5895.587308888379;5926.525877929798;6595.6372399518;6601.108850305195;5816.680082595455;5819.068948968187;5823.796167134173;5827;5828.242328497268;14066.578002659937;14224.573262802132;14359;14421.423143074264;14549.054311469721;2288.25631669708;2444.181199298237;2446.902123915041;2580.974190258092;2673.5454972654697;10432.478376081166;10577.524011419504;10676.786464270748;10881.292715973515;14184;1871.1205733305326;1936.9709454358197;2012.5572374077678;2033.6847788592793;2093.7801530839347;58665.70667146637;61931.38068619301;71904;76587.61706191434;82045.58977205136;10951.11235511382;11011.28426652265;11037.83443248352;11115.333080015063;11470.655880323437;15341.6164595886;15391.538253852403;15397.23013849303;15398.692026159413;15405.614859628375;7814.804629884298;7947.920520794718;7954.761357159295;8154.633041513028;8162.102168761431;7505.474616776883;7505.62471876404;7572.545647261182;7751.1861254568585;7781.494202876795;4671.0891376182;4747.881302967385;4773.570378665867;4775.140474714515;4894.657373983787;1872.1481725814722;1947.4060411574324;1952.2678995376734;1961.401772459385;1982.7422435083347;924.3113880159324;969.3021024862088;983.4640121133999;997.0577803975174;1019.9745006374751;18407.72388414175;19125.33061342874;20298.49253768638;20377.490562735755;20567.691484627743;962.8122516109431;979.9755006124904;988.8269552828226;1009.7728011197422;1035.808375450544;8792.296616270683;10867.347959122479;10983.890161098447;11278.421021057058;11306.321620702784;515936;518838;519382;520306;527667;56119.43880561224;62651;71436.64281678663;86418.56790716131;89653.55173224091;953.8998405167496;954.575214029764;981.3326937682302;991.5538007896475;992.2607657295362;17055.06197159168;17724.822751772317;17738.201780919633;17888.821111789235;18195.81804181994;43310.56689433065;43516.34725479057;43840.780796095816;43902.12195756003;45274.32088518609;57746.4225357741;58029.4197058024;58207;59692.40307596869;60026.699866500385;8436.32509399259;8473.788155296166;8702.91297087021;8776.956115219384;8925.910740892508;12558.777914864295;13380.397882095524;13404.597862064154;13750;13764.93117534446;11420;11491.597794077166;11689.181757276909;12106.75786484283;12146.08904332161;11613.535458581562;11699;11782.175247732577;11828.70428239301;12161.817572736592;11997.82003269969;12129.575464858688;12185.939070304592;12237.449314781034;12415.130940834417;8763.474191548528;8765;8891.422057566237;8926.107389261022;9000.414973026733;11107.222494425312;11989.64031079069;12067.456964436797;12112.333821639895;12148.817767733315 10:40:25 INFO - PROCESS | 9171 | |3;mootools.html;1335.953241636543;1483.162013462394;1509.886758493113;1664.7835781348424;1803.1525183163917;8192.139825318345;8614.698485553006;8617;8624.353173511989;8897.154770296827;8470.66117355305;8666.480011199332;8933.374663773538;8933.597988090536;8945;2353.941151471214;2390.3187591536416;2391.8804059797026;2391.9162829300976;2394.6527753475734;2341.695579574653;2356.7878890899815;2395.2454976682375;2398.6042303020067;2400.2799160251943;2328.604137296664;2340.789328960393;2343.8945247463903;2366.9644955325684;2376.1564644551195;2244.2033078257145;2246.629306164481;2253.8873056347115;2259.5142044460435;2341.8711970841596;2284.1091974130104;2297.7587353327995;2299.298713892262;2300.861948283108;2305.5388922215625;8643.43817651857;8771.386002979794;8796.296296296345;8805.383623146383;8809.559522023937;5380.381256155514;5549.750261238213;5550.139728342114;5555.694436805974;5569.081101618228;3551.1122219445137;3569.214772749991;3621.1128273573145;3626.165981824195;3639.4176931690804;1144.1819099343925;1148.3970915269551;1152.1877076660935;1153.4982282706965;1176.9764604707857;12735.172213806072;12939.417726202344;13029.283389413484;13032.087753857233;13048.804267935988;4751.691140075953;4767.235003697847;4771.117343291502;4866.9513304867205;4958.404991401055;10741.301815381976;10755.677329680122;10766.30019048775;10771.084457821016;10780.353178809297;5457.481539253765;5459.235707001023;5464.699441530674;5469.808556700496;5470.8085217017215;4311.116221174651;4785.569298763128;4950.133726597831;4955.702657840469;5012.523810238022;4151.834594366344;4171.520275168395;4248.235317642854;4263.637590804754;4275.40144379787;1235.2196997619271;1277.048598793886;1280.180684362009;1286.0547497589264;1288.549007847246;767.8502691975011;863.53369180643;929.2473096791621;936.5925822267335;961.1301771896445;5578.97210513953;5682.176084467729;5737.708985702881;5853.7365818538265;5910.34986151523;464.2803654335766;468.8218476978726;471.05318310196066;471.93628860103445;492.03315485072005;3857.61423857612;3920;3921.352976758803;3982.561918188997;4027.4562934003534;11170.553177872956;11540.826887596693;11583;11663.183577149519;11665.88334116648;11138.164637652208;11316.434178291052;11477.885221147848;11560.364179970182;11562.94218528902;8198.057223419382;8222.547759873265;8345.457545259538;8346.374021948257;8359.665613375519;5820.650760954356;5925.733341999534;5960.672163031075;5966.940330596812;6019.157317975574;10443.189051559491;10460.790784184426;10493.632722854663;10539.736506587396;10586.153107751208;10786.892131078903;10824.945875270574;10886.51010704536;10893.836592451278;10920.617778377718;7663.118741344594;7819.100803407453;7918.168592297726;8071.838563228585;8154;8909.643614255358;8938.195562399414;8948.105189481;8955.552222388724;8958.05940376251;7682.270184332479;7736.187700291388;7904.920950790419;7986.041674999037;8125.309348705427;7504.287092726182;7524.962375188089;7620.923790762243;7682.116556596063;7867.763967080997;7278.308560686938;7378.335949764547;7399.038125043709;7399.075115610549;7400.444966627417;4851.56335929768;4931.9753401232765;4937.8271760488215;5035.093683137071;5166.922496162636;4671.672982891165;4854.563089321978;4880.048390563806;4928.137575924271;4930.161872481615 10:40:25 INFO - PROCESS | 9171 | |4;prototype.html;318.90114064639965;324.54401565800043;327.4662300450265;332.3121139241769;333.43316362184265;5237.214417837326;5262.263283140359;5265.315508983832;5298.337707786527;5313.442088580701;5177.757338238824;5191.766370513326;5241.554467870226;5261.789528418859;5265.025615394227;3925.3915643075297;3933.704972127088;4067.2678917794783;4103.405006274089;4125.8968525786795;4101.364288535282;4106.28140075487;4109.239790638727;4110.177964407116;4131.256373852705;4046.109855831712;4050.10897602527;4054.0472988847596;4073.531543872463;4083.693722970789;3891.1905963726863;3975.363941769332;4045.797710114512;4047.9190416191805;4097.959020409818;3624.4563315502887;3629.9128001399035;3642.0894776305922;3654.488371627974;3657.7256705747177;5109.284700141983;5111.744412779383;5112.130937740593;5142.51146141116;5147.279380886679;4572.908541829178;4633.4439867215815;4659.694924472799;4663.580277774982;4705.57662803653;5302.946970530323;5321.920171197435;5351.438098999588;5367.067855571991;5406.378266499363;3968.1865217630316;4010.1779135277197;4023.4970628671417;4033.495813023372;4033.515978082649;5448.038706065813;5567.192757050205;5585.2459917910965;5594.3846176920915;5686.459786320334;4078.3678529827926;4095.9795201023803;4096.644429453077;4096.713230073866;4124.587541245912;4100.118474527991;4126.257273690764;4145.730527515762;4168.291390463629;4169.561501282053;4569.131864945716;4656.743879086683;4687.835925742651;4705.106029854317;4720.763961801897;5348.3849357323625;5353.197020446964;5359.785608575691;5403.594730395157;5441.292631957899;1388.208721029024;1405.3465138710549;1417.2276109520337;1431.5347512058415;1434.5696291112624;876.9342299327576;919.9448033118034;931.5295775633261;940.3699521320732;945.8533927241151;5168.560672342818;5259.39516955555;5268;5287;5315.123004704181;5519.9448005520235;5554.944450555443;5568.385168301228;5568.49883510486;5576.079946808731;5016.272640467112;5295.973520132375;5310.097283461821;5334.759935802898;5366.9534440784455;2936.588877557144;2961.7926745128066;2969.376430949525;2988.9850550747105;2999.865006074732;5863.413658634103;5879.853003674857;5890.175375447441;5892.322382925932;5922.230110085661;5581.944180558224;5715.742791574389;5753.59724819267;5757.625754325955;5780.479756821906;5807.041838096751;5815.743183817076;5819.82540523785;5844.970775146097;5845.970770146122;5406.405295417422;5589.916151257816;5610.438956104357;5702.543796496353;5720.313562372542;5553.611247212818;5563.721813909369;5564.972175139098;5566.638168519034;5604.8318550443555;5810.186573879745;5863.384344643751;5869.882602347844;5875.735591898289;5928.428966324014;3560.1989552350515;3617.4212126059706;3632.1282892106233;3675.3016926783826;3679.816009199476;4976.527229913152;5022.824201152942;5042.2267752735115;5057.848264552069;5063.468335824833;4814.446338671098;4899.706017638953;4907.48511369548;4920.114379411597;4928.630352723631;4844.878878028077;4950.752462376939;5146.665466744649;5533.0081170779295;5556.527695145796;5429.945700543102;5438.673679579238;5455.863603409788;5456.345238571397;5458.617896747349;5256.684598924076;5271.262023316815;5487.463510217146;5489.780408783604;5494.395616482264;5323.600729945347;5366.382865970463;5374.543163831118;5383.138697808332;5405.054115529845 10:40:25 INFO - PROCESS | 9171 | |5;yui.html;663.4824836627431;711.950163488556;767.3132546370995;775.8331958628894;783.189398972064;15833.60415989601;16905.492835214947;17073;17103.23035463404;17182.054986975712;14801.851981480182;15139.848601513982;15263.923680381582;15502.06987580746;15573.143477108755;805.4643661964801;820.6471217376526;822.6298165825373;822.7490615362312;822.8477731619639;677.1535580524345;791.9683212671515;819.2872201184978;827.4166712467726;831.4346244553701;875.7722992022088;876.7545087375545;878;878.8154487557589;879.134052957836;877.0746862060523;878.0780180810156;879.1384443245655;879.1955360844819;879.8196369744219;514.770926937513;618.9597676151036;631.4979591224941;635.9109724638554;637.4263163153153;15615.92192039044;15657.29542170605;15681.980671256331;15684.451044213398;15712;14141.646458838612;14293;14703.705925881422;14910.552683419515;15151.242437878062;12684.30236337001;12924.870751292461;12925.806112908314;12990.22058676473;13399.933000334935;4655.115528049693;4664.510226426244;4704.529547045268;4824.15265851679;4825.276208568707;84906.15093849045;86256;86380.5680971591;87581.56209218912;87854;11375.772484550263;11382.601608943647;11385.544578216779;11492.138089643144;12005.699857503632;20592.27927022547;20637.896810515853;20689;20832.47918802042;20865.478363041046;8723.302135829246;8790.120987901286;8823.647054117764;9125.589348479334;9152.90847091534;4665.720056796603;4929.137400954819;4993.900121997613;5043.571296439771;5147.794088236504;3352.2122301259183;3489.2149266415363;3492.1444246159854;3495.9825200873834;3507.0530956641564;579.7622974580402;585.2596465471182;595.2707932782394;609.5123900879368;612.4579746924004;538.9003034438641;571.6684323092679;584.6638183044766;632.4276529740592;634.5938599296454;8287.875681864776;8654.307655387554;8929.508877011827;9108.59011344491;9198;551.1237132958615;588.808637192914;624.8219257511587;628.8868003759276;655.0698008827476;4245.61789438952;4445.377647129404;4482.496610565136;4487.708298960557;4597.977010114928;117033;124074.37962810308;125783;128928.3553582226;130269;108200;111045;112077;112112;112253;80150;81871.5906420464;94551.52724236334;100121.49939250258;101339;9757.609695612096;9851.704448866545;9859.063388978035;9941.30410871232;10025.649102281677;54354.18468722893;54966;55123.17315240194;55137;55748;67985;75385;75790.24209757832;76761.61619191869;79252.60373698325;12294.754104917673;12908.935455322664;12947.805782913452;12993.350332483527;13258.33708314561;13907.443702252202;13985.58043258704;14356.928215359274;14445.566633001026;14480.565583032527;14074;14267.427091375323;14466;14668.926655366655;14974.700505990037;13003.936068702456;13142.868571314164;13173.670658233621;13245.867541324464;13445.46218151263;13522.661933451349;13582.25297608641;13606;14245.501407450689;14490.782638260645;9966.40201587907;10023.69928902134;10075.244356673133;10122.949385253027;10387.480625968823;9231.261499079923;9343.813123737624;10550.577976880839;11571.421428928352;12263.386830658254 10:40:25 INFO - PROCESS | 9171 | __end_tp_report 10:40:25 INFO - PROCESS | 9171 | __start_cc_report 10:40:25 INFO - PROCESS | 9171 | _x_x_mozilla_cycle_collect,936 10:40:25 INFO - PROCESS | 9171 | __end_cc_report 10:40:25 INFO - PROCESS | 9171 | __startTimestamp1470332425331__endTimestamp 10:40:25 INFO - PROCESS | 9171 | 10:40:25 INFO - PROCESS | 9171 | ------- Summary: start ------- 10:40:25 INFO - PROCESS | 9171 | Number of tests: 6 10:40:25 INFO - PROCESS | 9171 | 10:40:25 INFO - PROCESS | 9171 | [#0] dojo.html Cycles:165 Average:5167.05 Median:5375.25 stddev:570.74 (10.6%) stddev-sans-first:546.48 10:40:25 INFO - PROCESS | 9171 | Values: 2995.4 3005.6 3019.8 3043.0 3067.6 5024.3 5055.8 5188.2 5271.4 5284.7 5160.5 5233.1 5251.1 5295.5 5300.2 4729.0 4740.7 4809.8 4811.4 4961.7 4876.7 4902.9 4908.1 4925.1 4940.6 4659.9 4689.7 4731.4 4757.9 4782.5 4726.2 4730.3 4750.7 4797.7 4818.8 4726.8 4774.5 4776.5 4793.2 4820.3 4955.3 5144.2 5196.6 5214.6 5224.9 5563.4 5573.4 5606.1 5622.7 5627.5 5624.4 5656.3 5663.5 5667.3 5683.2 5029.2 5130.1 5131.6 5133.9 5272.3 5661.2 5664.6 5668.0 5714.0 5724.0 5442.6 5467.4 5495.6 5498.3 5503.2 5384.6 5387.7 5430.3 5443.8 5572.7 5456.3 5464.1 5471.5 5472.4 5501.4 5428.0 5463.3 5465.4 5472.5 5521.4 4114.9 4157.2 4191.5 4195.6 4236.1 3807.8 3817.7 3848.5 3851.7 3874.4 5304.5 5311.3 5311.5 5359.5 5364.7 5351.4 5525.5 5571.7 5590.2 5645.8 5337.9 5338.7 5339.0 5363.1 5378.1 4819.5 4829.1 4831.9 4851.0 4872.9 5482.3 5563.0 5650.5 5834.5 5836.8 5511.4 5516.4 5551.1 5552.3 5555.1 5679.7 5685.4 5688.7 5699.8 5701.8 5312.1 5345.9 5420.7 5430.6 5447.2 5500.7 5514.7 5544.0 5587.7 5594.0 5406.1 5407.1 5411.6 5416.1 5416.7 5259.5 5375.2 5401.5 5403.9 5423.6 5351.5 5416.1 5434.4 5436.3 5463.7 5502.1 5522.0 5555.8 5559.9 5567.6 5222.5 5280.9 5323.8 5382.3 5390.3 10:40:25 INFO - PROCESS | 9171 | 10:40:25 INFO - PROCESS | 9171 | [#1] ext.html Cycles:180 Average:59107.58 Median:43085.57 stddev:117458.39 (272.6%) stddev-sans-first:117705.71 10:40:25 INFO - PROCESS | 9171 | Values: 585.2 607.3 621.9 630.0 645.0 42805.0 44383.0 44416.0 44466.0 48566.5 45344.3 45837.5 45839.8 45984.8 46008.3 8867.6 9060.3 9062.5 9063.6 9064.4 8929.0 9010.2 9017.5 9021.5 9031.6 9061.7 9088.1 9094.5 9100.7 9103.1 8985.9 9016.8 9023.8 9027.1 9027.1 8977.1 9022.7 9030.8 9044.5 9066.6 42978.0 43193.1 43232.4 43295.6 43331.6 3679.1 3726.9 3791.3 3835.0 4362.6 33491.7 33691.0 34143.8 34201.7 34507.7 4332.0 4410.6 4420.5 4435.9 4439.4 256142.0 258720.0 258738.0 259656.0 260709.0 61955.4 62396.7 62451.4 62508.0 62566.0 58510.7 65504.7 65546.3 65597.3 65613.0 15141.9 15986.5 15995.2 16426.1 16558.1 12140.0 12279.3 12287.9 12292.9 12293.0 17336.8 17602.0 17681.1 17726.1 17827.2 5507.8 6620.1 6636.1 6810.2 6899.3 1010.2 1058.5 1067.6 1114.1 1116.0 33016.4 33140.0 33217.2 33393.5 33461.8 1097.6 1128.7 1151.2 1168.2 1219.9 16353.2 17755.8 17880.8 17948.0 18143.2 560761.0 569236.0 569572.0 570115.0 572695.0 62114.4 62547.7 62591.7 62593.4 62633.0 1247.4 1364.3 1377.9 1381.8 1403.8 32029.8 33070.5 33451.7 33562.8 33648.5 48195.5 48918.0 48995.8 49034.0 49142.8 438682.0 440404.0 440515.0 442075.0 442666.0 26564.5 27265.9 27284.6 28224.0 29011.1 47719.5 47914.5 48140.0 48383.3 48936.3 39974.0 40191.4 40500.6 40851.8 41874.0 39019.0 39246.6 39493.8 40122.0 40820.6 40222.4 40745.4 40812.4 40835.8 40957.8 32995.7 35470.5 35839.3 35924.1 36231.8 27167.3 27301.2 27637.3 27721.8 27794.9 10:40:25 INFO - PROCESS | 9171 | 10:40:25 INFO - PROCESS | 9171 | [#2] jquery.html Cycles:180 Average:29009.32 Median:395.48 stddev:85222.50 (21549.0%) stddev-sans-first:85434.42 10:40:25 INFO - PROCESS | 9171 | Values: 355.4 371.5 379.8 386.1 404.9 15781.8 18325.5 19882.5 20646.2 20971.5 19195.4 19666.1 19884.6 19906.5 20096.4 5679.9 5761.8 5856.7 5977.2 5986.2 4242.7 5779.0 5838.3 5849.7 5859.0 6253.4 6505.0 6513.1 6610.0 6619.0 5661.5 5895.6 5926.5 6595.6 6601.1 5816.7 5819.1 5823.8 5827.0 5828.2 14066.6 14224.6 14359.0 14421.4 14549.1 2288.3 2444.2 2446.9 2581.0 2673.5 10432.5 10577.5 10676.8 10881.3 14184.0 1871.1 1937.0 2012.6 2033.7 2093.8 58665.7 61931.4 71904.0 76587.6 82045.6 10951.1 11011.3 11037.8 11115.3 11470.7 15341.6 15391.5 15397.2 15398.7 15405.6 7814.8 7947.9 7954.8 8154.6 8162.1 7505.5 7505.6 7572.5 7751.2 7781.5 4671.1 4747.9 4773.6 4775.1 4894.7 1872.1 1947.4 1952.3 1961.4 1982.7 924.3 969.3 983.5 997.1 1020.0 18407.7 19125.3 20298.5 20377.5 20567.7 962.8 980.0 988.8 1009.8 1035.8 8792.3 10867.3 10983.9 11278.4 11306.3 515936.0 518838.0 519382.0 520306.0 527667.0 56119.4 62651.0 71436.6 86418.6 89653.6 953.9 954.6 981.3 991.6 992.3 17055.1 17724.8 17738.2 17888.8 18195.8 43310.6 43516.3 43840.8 43902.1 45274.3 57746.4 58029.4 58207.0 59692.4 60026.7 8436.3 8473.8 8702.9 8777.0 8925.9 12558.8 13380.4 13404.6 13750.0 13764.9 11420.0 11491.6 11689.2 12106.8 12146.1 11613.5 11699.0 11782.2 11828.7 12161.8 11997.8 12129.6 12185.9 12237.4 12415.1 8763.5 8765.0 8891.4 8926.1 9000.4 11107.2 11989.6 12067.5 12112.3 12148.8 10:40:25 INFO - PROCESS | 9171 | 10:40:25 INFO - PROCESS | 9171 | [#3] mootools.html Cycles:180 Average:5921.29 Median:2611.81 stddev:3470.11 (132.9%) stddev-sans-first:3462.74 10:40:25 INFO - PROCESS | 9171 | Values: 1336.0 1483.2 1509.9 1664.8 1803.2 8192.1 8614.7 8617.0 8624.4 8897.2 8470.7 8666.5 8933.4 8933.6 8945.0 2353.9 2390.3 2391.9 2391.9 2394.7 2341.7 2356.8 2395.2 2398.6 2400.3 2328.6 2340.8 2343.9 2367.0 2376.2 2244.2 2246.6 2253.9 2259.5 2341.9 2284.1 2297.8 2299.3 2300.9 2305.5 8643.4 8771.4 8796.3 8805.4 8809.6 5380.4 5549.8 5550.1 5555.7 5569.1 3551.1 3569.2 3621.1 3626.2 3639.4 1144.2 1148.4 1152.2 1153.5 1177.0 12735.2 12939.4 13029.3 13032.1 13048.8 4751.7 4767.2 4771.1 4867.0 4958.4 10741.3 10755.7 10766.3 10771.1 10780.4 5457.5 5459.2 5464.7 5469.8 5470.8 4311.1 4785.6 4950.1 4955.7 5012.5 4151.8 4171.5 4248.2 4263.6 4275.4 1235.2 1277.0 1280.2 1286.1 1288.5 767.9 863.5 929.2 936.6 961.1 5579.0 5682.2 5737.7 5853.7 5910.3 464.3 468.8 471.1 471.9 492.0 3857.6 3920.0 3921.4 3982.6 4027.5 11170.6 11540.8 11583.0 11663.2 11665.9 11138.2 11316.4 11477.9 11560.4 11562.9 8198.1 8222.5 8345.5 8346.4 8359.7 5820.7 5925.7 5960.7 5966.9 6019.2 10443.2 10460.8 10493.6 10539.7 10586.2 10786.9 10824.9 10886.5 10893.8 10920.6 7663.1 7819.1 7918.2 8071.8 8154.0 8909.6 8938.2 8948.1 8955.6 8958.1 7682.3 7736.2 7904.9 7986.0 8125.3 7504.3 7525.0 7620.9 7682.1 7867.8 7278.3 7378.3 7399.0 7399.1 7400.4 4851.6 4932.0 4937.8 5035.1 5166.9 4671.7 4854.6 4880.0 4928.1 4930.2 10:40:25 INFO - PROCESS | 9171 | 10:40:25 INFO - PROCESS | 9171 | [#4] prototype.html Cycles:180 Average:4570.71 Median:5184.76 stddev:1339.13 (25.8%) stddev-sans-first:1304.31 10:40:25 INFO - PROCESS | 9171 | Values: 318.9 324.5 327.5 332.3 333.4 5237.2 5262.3 5265.3 5298.3 5313.4 5177.8 5191.8 5241.6 5261.8 5265.0 3925.4 3933.7 4067.3 4103.4 4125.9 4101.4 4106.3 4109.2 4110.2 4131.3 4046.1 4050.1 4054.0 4073.5 4083.7 3891.2 3975.4 4045.8 4047.9 4098.0 3624.5 3629.9 3642.1 3654.5 3657.7 5109.3 5111.7 5112.1 5142.5 5147.3 4572.9 4633.4 4659.7 4663.6 4705.6 5302.9 5321.9 5351.4 5367.1 5406.4 3968.2 4010.2 4023.5 4033.5 4033.5 5448.0 5567.2 5585.2 5594.4 5686.5 4078.4 4096.0 4096.6 4096.7 4124.6 4100.1 4126.3 4145.7 4168.3 4169.6 4569.1 4656.7 4687.8 4705.1 4720.8 5348.4 5353.2 5359.8 5403.6 5441.3 1388.2 1405.3 1417.2 1431.5 1434.6 876.9 919.9 931.5 940.4 945.9 5168.6 5259.4 5268.0 5287.0 5315.1 5519.9 5554.9 5568.4 5568.5 5576.1 5016.3 5296.0 5310.1 5334.8 5367.0 2936.6 2961.8 2969.4 2989.0 2999.9 5863.4 5879.9 5890.2 5892.3 5922.2 5581.9 5715.7 5753.6 5757.6 5780.5 5807.0 5815.7 5819.8 5845.0 5846.0 5406.4 5589.9 5610.4 5702.5 5720.3 5553.6 5563.7 5565.0 5566.6 5604.8 5810.2 5863.4 5869.9 5875.7 5928.4 3560.2 3617.4 3632.1 3675.3 3679.8 4976.5 5022.8 5042.2 5057.8 5063.5 4814.4 4899.7 4907.5 4920.1 4928.6 4844.9 4950.8 5146.7 5533.0 5556.5 5429.9 5438.7 5455.9 5456.3 5458.6 5256.7 5271.3 5487.5 5489.8 5494.4 5323.6 5366.4 5374.5 5383.1 5405.1 10:40:25 INFO - PROCESS | 9171 | 10:40:25 INFO - PROCESS | 9171 | [#5] yui.html Cycles:180 Average:22040.36 Median:4659.81 stddev:32761.38 (703.1%) stddev-sans-first:32813.97 10:40:25 INFO - PROCESS | 9171 | Values: 663.5 712.0 767.3 775.8 783.2 15833.6 16905.5 17073.0 17103.2 17182.1 14801.9 15139.8 15263.9 15502.1 15573.1 805.5 820.6 822.6 822.7 822.8 677.2 792.0 819.3 827.4 831.4 875.8 876.8 878.0 878.8 879.1 877.1 878.1 879.1 879.2 879.8 514.8 619.0 631.5 635.9 637.4 15615.9 15657.3 15682.0 15684.5 15712.0 14141.6 14293.0 14703.7 14910.6 15151.2 12684.3 12924.9 12925.8 12990.2 13399.9 4655.1 4664.5 4704.5 4824.2 4825.3 84906.2 86256.0 86380.6 87581.6 87854.0 11375.8 11382.6 11385.5 11492.1 12005.7 20592.3 20637.9 20689.0 20832.5 20865.5 8723.3 8790.1 8823.6 9125.6 9152.9 4665.7 4929.1 4993.9 5043.6 5147.8 3352.2 3489.2 3492.1 3496.0 3507.1 579.8 585.3 595.3 609.5 612.5 538.9 571.7 584.7 632.4 634.6 8287.9 8654.3 8929.5 9108.6 9198.0 551.1 588.8 624.8 628.9 655.1 4245.6 4445.4 4482.5 4487.7 4598.0 117033.0 124074.4 125783.0 128928.4 130269.0 108200.0 111045.0 112077.0 112112.0 112253.0 80150.0 81871.6 94551.5 100121.5 101339.0 9757.6 9851.7 9859.1 9941.3 10025.6 54354.2 54966.0 55123.2 55137.0 55748.0 67985.0 75385.0 75790.2 76761.6 79252.6 12294.8 12908.9 12947.8 12993.4 13258.3 13907.4 13985.6 14356.9 14445.6 14480.6 14074.0 14267.4 14466.0 14668.9 14974.7 13003.9 13142.9 13173.7 13245.9 13445.5 13522.7 13582.3 13606.0 14245.5 14490.8 9966.4 10023.7 10075.2 10122.9 10387.5 9231.3 9343.8 10550.6 11571.4 12263.4 10:40:25 INFO - PROCESS | 9171 | -------- Summary: end -------- 10:40:25 INFO - PROCESS | 9171 | 10:40:26 INFO - TEST-INFO | 9171: exit 0 10:40:26 INFO - TEST-OK | dromaeo_css | took 1115448ms 10:40:26 INFO - TEST-START | kraken 10:40:26 INFO - operating with platform_type : linux_ 10:40:26 INFO - Initialising browser for kraken test... 10:40:26 INFO - TEST-INFO | started process 9360 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQO0xTT/profile http://localhost:43072/getInfo.html) 10:40:29 INFO - PROCESS | 9360 | __metrics Screen width/height:1600/1200 10:40:29 INFO - PROCESS | 9360 | colorDepth:24 10:40:29 INFO - PROCESS | 9360 | Browser inner width/height: 1024/697 10:40:29 INFO - PROCESS | 9360 | __metrics 10:40:30 INFO - PROCESS | 9360 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:40:30 INFO - PROCESS | 9360 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:40:31 INFO - TEST-INFO | 9360: exit 0 10:40:31 INFO - Browser initialized. 10:40:31 INFO - Running cycle 1/1 for kraken test... 10:40:31 INFO - TEST-INFO | started process 9446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQO0xTT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:40:43 INFO - PROCESS | 9446 | RSS: Main: 156807168 10:40:43 INFO - PROCESS | 9446 | 10:40:46 INFO - PROCESS | 9446 | Cycle 1(1): loaded http://localhost:43072/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43072/tests/kraken/driver.html?testName=audio-beat-detection) 10:40:46 INFO - PROCESS | 9446 | RSS: Main: 212574208 10:40:46 INFO - PROCESS | 9446 | 10:40:49 INFO - PROCESS | 9446 | Cycle 1(1): loaded http://localhost:43072/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43072/tests/kraken/driver.html?testName=audio-dft) 10:40:50 INFO - PROCESS | 9446 | RSS: Main: 191623168 10:40:50 INFO - PROCESS | 9446 | 10:40:53 INFO - PROCESS | 9446 | Cycle 1(1): loaded http://localhost:43072/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43072/tests/kraken/driver.html?testName=audio-fft) 10:40:53 INFO - PROCESS | 9446 | RSS: Main: 268779520 10:40:53 INFO - PROCESS | 9446 | 10:40:56 INFO - PROCESS | 9446 | Cycle 1(1): loaded http://localhost:43072/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43072/tests/kraken/driver.html?testName=audio-oscillator) 10:40:56 INFO - PROCESS | 9446 | RSS: Main: 179580928 10:40:56 INFO - PROCESS | 9446 | 10:40:58 INFO - PROCESS | 9446 | Cycle 1(1): loaded http://localhost:43072/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43072/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:40:59 INFO - PROCESS | 9446 | RSS: Main: 184549376 10:40:59 INFO - PROCESS | 9446 | 10:41:02 INFO - PROCESS | 9446 | Cycle 1(1): loaded http://localhost:43072/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43072/tests/kraken/driver.html?testName=imaging-darkroom) 10:41:02 INFO - PROCESS | 9446 | RSS: Main: 219107328 10:41:02 INFO - PROCESS | 9446 | 10:41:06 INFO - PROCESS | 9446 | Cycle 1(1): loaded http://localhost:43072/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43072/tests/kraken/driver.html?testName=imaging-desaturate) 10:41:06 INFO - PROCESS | 9446 | RSS: Main: 220114944 10:41:06 INFO - PROCESS | 9446 | 10:41:09 INFO - PROCESS | 9446 | Cycle 1(1): loaded http://localhost:43072/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43072/tests/kraken/driver.html?testName=json-parse-financial) 10:41:10 INFO - PROCESS | 9446 | RSS: Main: 220602368 10:41:10 INFO - PROCESS | 9446 | 10:41:11 INFO - PROCESS | 9446 | Cycle 1(1): loaded http://localhost:43072/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43072/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:41:12 INFO - PROCESS | 9446 | RSS: Main: 184471552 10:41:12 INFO - PROCESS | 9446 | 10:41:14 INFO - PROCESS | 9446 | Cycle 1(1): loaded http://localhost:43072/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43072/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:41:14 INFO - PROCESS | 9446 | RSS: Main: 190140416 10:41:14 INFO - PROCESS | 9446 | 10:41:16 INFO - PROCESS | 9446 | Cycle 1(1): loaded http://localhost:43072/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43072/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:41:17 INFO - PROCESS | 9446 | RSS: Main: 195018752 10:41:17 INFO - PROCESS | 9446 | 10:41:19 INFO - PROCESS | 9446 | Cycle 1(1): loaded http://localhost:43072/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43072/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:41:20 INFO - PROCESS | 9446 | RSS: Main: 193937408 10:41:20 INFO - PROCESS | 9446 | 10:41:23 INFO - PROCESS | 9446 | Cycle 1(1): loaded http://localhost:43072/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43072/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:41:23 INFO - PROCESS | 9446 | RSS: Main: 195072000 10:41:23 INFO - PROCESS | 9446 | 10:41:25 INFO - PROCESS | 9446 | Cycle 1(1): loaded http://localhost:43072/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43072/tests/kraken/driver.html?testName=ai-astar) 10:41:25 INFO - PROCESS | 9446 | RSS: Main: 243724288 10:41:25 INFO - PROCESS | 9446 | 10:41:25 INFO - PROCESS | 9446 | __start_tp_report 10:41:25 INFO - PROCESS | 9446 | _x_x_mozilla_page_load 10:41:25 INFO - PROCESS | 9446 | _x_x_mozilla_page_load_details 10:41:25 INFO - PROCESS | 9446 | |i|pagename|runs| 10:41:25 INFO - PROCESS | 9446 | |0;ai-astar;102;112;111;110;113;111;111;111;110;109 10:41:25 INFO - PROCESS | 9446 | |1;audio-beat-detection;147;116;119;184;120;121;154;117;159;122 10:41:25 INFO - PROCESS | 9446 | |2;audio-dft;160;162;160;160;160;159;161;162;162;160 10:41:25 INFO - PROCESS | 9446 | |3;audio-fft;75;76;76;125;75;76;74;74;104;74 10:41:25 INFO - PROCESS | 9446 | |4;audio-oscillator;83;84;117;84;83;84;113;84;84;127 10:41:25 INFO - PROCESS | 9446 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;116;116;118 10:41:25 INFO - PROCESS | 9446 | |6;imaging-darkroom;145;146;146;145;146;146;146;146;146;146 10:41:25 INFO - PROCESS | 9446 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 10:41:25 INFO - PROCESS | 9446 | |8;json-parse-financial;49;48;51;47;48;50;48;48;49;48 10:41:25 INFO - PROCESS | 9446 | |9;json-stringify-tinderbox;60;60;60;60;61;60;60;59;60;60 10:41:25 INFO - PROCESS | 9446 | |10;stanford-crypto-aes;76;76;86;76;76;84;76;76;76;76 10:41:25 INFO - PROCESS | 9446 | |11;stanford-crypto-ccm;123;123;122;120;120;121;119;134;134;124 10:41:25 INFO - PROCESS | 9446 | |12;stanford-crypto-pbkdf2;167;168;168;168;166;165;165;167;163;163 10:41:25 INFO - PROCESS | 9446 | |13;stanford-crypto-sha256-iterative;65;63;63;64;65;68;65;62;63;67 10:41:25 INFO - PROCESS | 9446 | __end_tp_report 10:41:25 INFO - PROCESS | 9446 | __start_cc_report 10:41:25 INFO - PROCESS | 9446 | _x_x_mozilla_cycle_collect,1644 10:41:25 INFO - PROCESS | 9446 | __end_cc_report 10:41:25 INFO - PROCESS | 9446 | __startTimestamp1470332485744__endTimestamp 10:41:25 INFO - PROCESS | 9446 | 10:41:25 INFO - PROCESS | 9446 | ------- Summary: start ------- 10:41:25 INFO - PROCESS | 9446 | Number of tests: 14 10:41:25 INFO - PROCESS | 9446 | 10:41:25 INFO - PROCESS | 9446 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:3.02 (2.7%) stddev-sans-first:1.17 10:41:25 INFO - PROCESS | 9446 | Values: 102.0 112.0 111.0 110.0 113.0 111.0 111.0 111.0 110.0 109.0 10:41:25 INFO - PROCESS | 9446 | 10:41:25 INFO - PROCESS | 9446 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:134.50 stddev:23.58 (17.5%) stddev-sans-first:24.67 10:41:25 INFO - PROCESS | 9446 | Values: 147.0 116.0 119.0 184.0 120.0 121.0 154.0 117.0 159.0 122.0 10:41:25 INFO - PROCESS | 9446 | 10:41:25 INFO - PROCESS | 9446 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 10:41:25 INFO - PROCESS | 9446 | Values: 160.0 162.0 160.0 160.0 160.0 159.0 161.0 162.0 162.0 160.0 10:41:25 INFO - PROCESS | 9446 | 10:41:25 INFO - PROCESS | 9446 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.00 stddev:17.39 (23.2%) stddev-sans-first:18.21 10:41:25 INFO - PROCESS | 9446 | Values: 75.0 76.0 76.0 125.0 75.0 76.0 74.0 74.0 104.0 74.0 10:41:25 INFO - PROCESS | 9446 | 10:41:25 INFO - PROCESS | 9446 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:84.00 stddev:17.38 (20.7%) stddev-sans-first:17.95 10:41:25 INFO - PROCESS | 9446 | Values: 83.0 84.0 117.0 84.0 83.0 84.0 113.0 84.0 84.0 127.0 10:41:25 INFO - PROCESS | 9446 | 10:41:25 INFO - PROCESS | 9446 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 10:41:25 INFO - PROCESS | 9446 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 118.0 10:41:25 INFO - PROCESS | 9446 | 10:41:25 INFO - PROCESS | 9446 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 10:41:25 INFO - PROCESS | 9446 | Values: 145.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 10:41:25 INFO - PROCESS | 9446 | 10:41:25 INFO - PROCESS | 9446 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 10:41:25 INFO - PROCESS | 9446 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 10:41:25 INFO - PROCESS | 9446 | 10:41:25 INFO - PROCESS | 9446 | [#8] json-parse-financial Cycles:10 Average:48.60 Median:48.50 stddev:1.17 (2.4%) stddev-sans-first:1.24 10:41:25 INFO - PROCESS | 9446 | Values: 49.0 48.0 51.0 47.0 48.0 50.0 48.0 48.0 49.0 48.0 10:41:25 INFO - PROCESS | 9446 | 10:41:25 INFO - PROCESS | 9446 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 10:41:25 INFO - PROCESS | 9446 | Values: 60.0 60.0 60.0 60.0 61.0 60.0 60.0 59.0 60.0 60.0 10:41:25 INFO - PROCESS | 9446 | 10:41:25 INFO - PROCESS | 9446 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:76.00 stddev:3.82 (5.0%) stddev-sans-first:4.00 10:41:25 INFO - PROCESS | 9446 | Values: 76.0 76.0 86.0 76.0 76.0 84.0 76.0 76.0 76.0 76.0 10:41:25 INFO - PROCESS | 9446 | 10:41:25 INFO - PROCESS | 9446 | [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:123.00 stddev:5.50 (4.5%) stddev-sans-first:5.82 10:41:25 INFO - PROCESS | 9446 | Values: 123.0 123.0 122.0 120.0 120.0 121.0 119.0 134.0 134.0 124.0 10:41:25 INFO - PROCESS | 9446 | 10:41:25 INFO - PROCESS | 9446 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.00 Median:167.00 stddev:1.94 (1.2%) stddev-sans-first:2.03 10:41:25 INFO - PROCESS | 9446 | Values: 167.0 168.0 168.0 168.0 166.0 165.0 165.0 167.0 163.0 163.0 10:41:25 INFO - PROCESS | 9446 | 10:41:25 INFO - PROCESS | 9446 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:1.90 (2.9%) stddev-sans-first:2.01 10:41:25 INFO - PROCESS | 9446 | Values: 65.0 63.0 63.0 64.0 65.0 68.0 65.0 62.0 63.0 67.0 10:41:25 INFO - PROCESS | 9446 | -------- Summary: end -------- 10:41:25 INFO - PROCESS | 9446 | 10:41:26 INFO - TEST-INFO | 9446: exit 0 10:41:26 INFO - TEST-OK | kraken | took 60671ms 10:41:26 INFO - SUITE-END | took 1176s 10:41:26 INFO - Completed test suite (00:19:36) 10:41:26 INFO - javascript benchmark 10:41:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2995.385945881094, 3005.639323281205, 3019.788614796964, 3042.9847850760743, 3067.6165479315086, 5024.271480635306, 5055.848324550269, 5188.221766734991, 5271.393789714184, 5284.709340986245, 5160.458151894053, 5233.084210263199, 5251.107311757001, 5295.549878260343, 5300.151975683892, 4729.0, 4740.71555706657, 4809.7835597398025, 4811.422629284473, 4961.727105009223, 4876.683015603974, 4902.926456103161, 4908.141075311806, 4925.113479573675, 4940.60475161988, 4659.906801863961, 4689.718616882964, 4731.432228132611, 4757.904841903177, 4782.521747825207, 4726.172919739032, 4730.337752714623, 4750.738709370983, 4797.712137271775, 4818.807247710122, 4726.834560790356, 4774.546418090311, 4776.450708168571, 4793.209120495114, 4820.25286080658, 4955.306257124005, 5144.151215049513, 5196.558292545138, 5214.582833373321, 5224.895502089975, 5563.415841336642, 5573.359063707685, 5606.131049687305, 5622.662640241599, 5627.465390787868, 5624.3531993820825, 5656.321241451011, 5663.518600918886, 5667.319921609392, 5683.204351390808, 5029.245613158019, 5130.050940576006, 5131.640785145079, 5133.948660513347, 5272.340957380327, 5661.235733176051, 5664.631798933056, 5668.0, 5713.971430142823, 5724.026915424388, 5442.591805614595, 5467.398586155519, 5495.6153069284765, 5498.257735205776, 5503.229547863302, 5384.596155288369, 5387.676739395649, 5430.294061772023, 5443.755031023614, 5572.749226284827, 5456.263404440349, 5464.0711079116645, 5471.50756431923, 5472.425395333512, 5501.4223506532035, 5427.972860135674, 5463.344398672105, 5465.426130256265, 5472.534834539029, 5521.420250873601, 4114.917701645951, 4157.210130075276, 4191.497020357577, 4195.601417865298, 4236.110416812504, 3807.809609519513, 3817.6754975827366, 3848.499695039683, 3851.6533511983494, 3874.3994680824517, 5304.549113325411, 5311.3095297611835, 5311.49540793624, 5359.544438722674, 5364.731763411892, 5351.3578370595, 5525.530329922001, 5571.66570005801, 5590.2453168821685, 5645.830625081254, 5337.946620533823, 5338.733063346817, 5339.0, 5363.061464243741, 5378.139497680352, 4819.469858315582, 4829.13075646387, 4831.903361932812, 4850.95149048512, 4872.902541949141, 5482.342118945752, 5562.972185139049, 5650.519705825051, 5834.504067154255, 5836.766529338864, 5511.393746687781, 5516.420775818642, 5551.056320425457, 5552.305961754781, 5555.111182210827, 5679.659220446786, 5685.431456854281, 5688.715564221855, 5699.800506982236, 5701.800436984686, 5312.123499622519, 5345.893082138413, 5420.674759514442, 5430.565554755689, 5447.155690867922, 5500.697461639488, 5514.696691681836, 5544.002079625706, 5587.664740115606, 5594.0, 5406.080966235828, 5407.080796264723, 5411.648242864201, 5416.106342453451, 5416.7020813855615, 5259.474052594863, 5375.247465354775, 5401.540869026177, 5403.891922161613, 5423.620346575702, 5351.5451186648015, 5416.079266524622, 5434.375046869661, 5436.320459942507, 5463.672179669233, 5502.147167189092, 5521.972390138024, 5555.805546805843, 5559.9444005561045, 5567.610267281251, 5222.451642577475, 5280.867978300574, 5323.813666521653, 5382.327209098863, 5390.299261096189], "value": 5129.4099067512325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.1602949767084, 607.2621764556064, 621.9315875253722, 630.0360448513774, 645.0421124629927, 42805.0, 44383.0, 44416.0, 44466.0, 48566.51433485673, 45344.3198352025, 45837.54162458375, 45839.770801146035, 45984.77007614957, 46008.30987535189, 8867.645294188242, 9060.320475964296, 9062.501562414065, 9063.637454501812, 9064.410813297147, 8929.0, 9010.23413009895, 9017.45895246284, 9021.548922553879, 9031.59357828896, 9061.682841100563, 9088.136627020456, 9094.49980251086, 9100.726978190633, 9103.135202155818, 8985.865212021792, 9016.819663606691, 9023.819523609523, 9027.09729027092, 9027.14242146995, 8977.147171018743, 9022.684206052822, 9030.819383612357, 9044.457332560067, 9066.5920033598, 42978.0, 43193.13613727739, 43232.35151472731, 43295.567044329466, 43331.56668433338, 3679.0802299425145, 3726.888193354204, 3791.2796568652143, 3834.961650383488, 4362.629176519999, 33491.66508334934, 33691.0, 34143.82928085344, 34201.657983420344, 34507.654923450944, 4331.956680433218, 4410.558944105596, 4420.513743488214, 4435.911281774379, 4439.445069366329, 256142.0, 258720.0, 258738.0, 259656.0, 260708.9999999981, 61955.38044619496, 62396.68801656053, 62451.375486245466, 62508.0, 62566.0, 58510.7074464625, 65504.672476637315, 65546.34453655402, 65597.34402656008, 65613.0, 15141.924290378478, 15986.520404387888, 15995.200239987955, 16426.096564689058, 16558.089305088095, 12140.0, 12279.324637145042, 12287.877121228674, 12292.938535307267, 12293.0, 17336.826631733773, 17602.0, 17681.11594420274, 17726.113694315234, 17827.21727827233, 5507.834764957058, 6620.139381880324, 6636.093876449867, 6810.161256460827, 6899.344562266577, 1010.1918465227935, 1058.5342449322275, 1067.6156583629886, 1114.147677027075, 1115.9888401116048, 33016.38580722535, 33140.005799826045, 33217.16957076044, 33393.49909751356, 33461.83269083639, 1097.5993762276712, 1128.67268492138, 1151.205668089016, 1168.199783148546, 1219.914605977573, 16353.182340882908, 17755.822441775676, 17880.821191787916, 17948.0, 18143.167244691627, 560761.0, 569236.0, 569572.0, 570115.0, 572695.0, 62114.37885621086, 62547.68726156431, 62591.6870415645, 62593.37406625967, 62633.0, 1247.3950134184913, 1364.3314775760005, 1377.9173249605055, 1381.8134551835374, 1403.7964495148146, 32029.839850800596, 33070.5039424404, 33451.66548334583, 33562.83218583892, 33648.49527257044, 48195.51804482051, 48918.0, 48995.755021224664, 49034.0, 49142.75428622834, 438682.0, 440404.0, 440515.0, 442075.0, 442666.0, 26564.468710626064, 27265.86367068152, 27284.59073113865, 28224.0, 29011.12966611005, 47719.522804772896, 47914.52085479101, 48140.0, 48383.27425088556, 48936.2659560114, 39974.0, 40191.397129043675, 40500.59499405086, 40851.7957410211, 41874.0, 39019.0, 39246.607533924296, 39493.80253098716, 40122.0, 40820.59179408168, 40222.39666405065, 40745.38881916714, 40812.38781418222, 40835.79582102071, 40957.79521102375, 32995.67004330022, 35470.46794298139, 35839.283214335046, 35924.101897452776, 36231.818840905624, 27167.320816979733, 27301.180964571096, 27637.30906727348, 27721.765145848916, 27794.86102569555], "value": 20183.473363565292, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.4259870309451, 371.453962674868, 379.75885312826347, 386.069572330683, 404.8967513284112, 15781.763273550905, 18325.541861453472, 19882.502937426554, 20646.174153033862, 20971.47571310718, 19195.42413727587, 19666.13490773732, 19884.60230795383, 19906.502337441572, 20096.39710808678, 5679.914801277984, 5761.769529218836, 5856.736446859902, 5977.193078934331, 5986.191864098357, 4242.681798865082, 5779.0, 5838.2702162229725, 5849.736761845727, 5858.970705146489, 6253.405926436982, 6504.967475162617, 6513.088167656532, 6609.966950165242, 6618.966905165492, 5661.547076233912, 5895.587308888379, 5926.525877929798, 6595.6372399518, 6601.108850305195, 5816.680082595455, 5819.068948968187, 5823.796167134173, 5827.0, 5828.242328497268, 14066.578002659937, 14224.573262802132, 14359.0, 14421.423143074264, 14549.054311469721, 2288.25631669708, 2444.181199298237, 2446.902123915041, 2580.974190258092, 2673.5454972654697, 10432.478376081166, 10577.524011419504, 10676.786464270748, 10881.292715973515, 14184.0, 1871.1205733305326, 1936.9709454358197, 2012.5572374077678, 2033.6847788592793, 2093.7801530839347, 58665.70667146637, 61931.38068619301, 71904.0, 76587.61706191434, 82045.58977205136, 10951.11235511382, 11011.28426652265, 11037.83443248352, 11115.333080015063, 11470.655880323437, 15341.6164595886, 15391.538253852403, 15397.23013849303, 15398.692026159413, 15405.614859628375, 7814.804629884298, 7947.920520794718, 7954.761357159295, 8154.633041513028, 8162.102168761431, 7505.474616776883, 7505.62471876404, 7572.545647261182, 7751.1861254568585, 7781.494202876795, 4671.0891376182, 4747.881302967385, 4773.570378665867, 4775.140474714515, 4894.657373983787, 1872.1481725814722, 1947.4060411574324, 1952.2678995376734, 1961.401772459385, 1982.7422435083347, 924.3113880159324, 969.3021024862088, 983.4640121133999, 997.0577803975174, 1019.9745006374751, 18407.72388414175, 19125.33061342874, 20298.49253768638, 20377.490562735755, 20567.691484627743, 962.8122516109431, 979.9755006124904, 988.8269552828226, 1009.7728011197422, 1035.808375450544, 8792.296616270683, 10867.347959122479, 10983.890161098447, 11278.421021057058, 11306.321620702784, 515936.0, 518838.0, 519382.0, 520306.0, 527667.0, 56119.43880561224, 62651.0, 71436.64281678663, 86418.56790716131, 89653.55173224091, 953.8998405167496, 954.575214029764, 981.3326937682302, 991.5538007896475, 992.2607657295362, 17055.06197159168, 17724.822751772317, 17738.201780919633, 17888.821111789235, 18195.81804181994, 43310.56689433065, 43516.34725479057, 43840.780796095816, 43902.12195756003, 45274.32088518609, 57746.4225357741, 58029.4197058024, 58207.0, 59692.40307596869, 60026.699866500385, 8436.32509399259, 8473.788155296166, 8702.91297087021, 8776.956115219384, 8925.910740892508, 12558.777914864295, 13380.397882095524, 13404.597862064154, 13750.0, 13764.93117534446, 11420.0, 11491.597794077166, 11689.181757276909, 12106.75786484283, 12146.08904332161, 11613.535458581562, 11699.0, 11782.175247732577, 11828.70428239301, 12161.817572736592, 11997.82003269969, 12129.575464858688, 12185.939070304592, 12237.449314781034, 12415.130940834417, 8763.474191548528, 8765.0, 8891.422057566237, 8926.107389261022, 9000.414973026733, 11107.222494425312, 11989.64031079069, 12067.456964436797, 12112.333821639895, 12148.817767733315], "value": 9161.017869444851, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.953241636543, 1483.162013462394, 1509.886758493113, 1664.7835781348424, 1803.1525183163917, 8192.139825318345, 8614.698485553006, 8617.0, 8624.353173511989, 8897.154770296827, 8470.66117355305, 8666.480011199332, 8933.374663773538, 8933.597988090536, 8945.0, 2353.941151471214, 2390.3187591536416, 2391.8804059797026, 2391.9162829300976, 2394.6527753475734, 2341.695579574653, 2356.7878890899815, 2395.2454976682375, 2398.6042303020067, 2400.2799160251943, 2328.604137296664, 2340.789328960393, 2343.8945247463903, 2366.9644955325684, 2376.1564644551195, 2244.2033078257145, 2246.629306164481, 2253.8873056347115, 2259.5142044460435, 2341.8711970841596, 2284.1091974130104, 2297.7587353327995, 2299.298713892262, 2300.861948283108, 2305.5388922215625, 8643.43817651857, 8771.386002979794, 8796.296296296345, 8805.383623146383, 8809.559522023937, 5380.381256155514, 5549.750261238213, 5550.139728342114, 5555.694436805974, 5569.081101618228, 3551.1122219445137, 3569.214772749991, 3621.1128273573145, 3626.165981824195, 3639.4176931690804, 1144.1819099343925, 1148.3970915269551, 1152.1877076660935, 1153.4982282706965, 1176.9764604707857, 12735.172213806072, 12939.417726202344, 13029.283389413484, 13032.087753857233, 13048.804267935988, 4751.691140075953, 4767.235003697847, 4771.117343291502, 4866.9513304867205, 4958.404991401055, 10741.301815381976, 10755.677329680122, 10766.30019048775, 10771.084457821016, 10780.353178809297, 5457.481539253765, 5459.235707001023, 5464.699441530674, 5469.808556700496, 5470.8085217017215, 4311.116221174651, 4785.569298763128, 4950.133726597831, 4955.702657840469, 5012.523810238022, 4151.834594366344, 4171.520275168395, 4248.235317642854, 4263.637590804754, 4275.40144379787, 1235.2196997619271, 1277.048598793886, 1280.180684362009, 1286.0547497589264, 1288.549007847246, 767.8502691975011, 863.53369180643, 929.2473096791621, 936.5925822267335, 961.1301771896445, 5578.97210513953, 5682.176084467729, 5737.708985702881, 5853.7365818538265, 5910.34986151523, 464.2803654335766, 468.8218476978726, 471.05318310196066, 471.93628860103445, 492.03315485072005, 3857.61423857612, 3920.0, 3921.352976758803, 3982.561918188997, 4027.4562934003534, 11170.553177872956, 11540.826887596693, 11583.0, 11663.183577149519, 11665.88334116648, 11138.164637652208, 11316.434178291052, 11477.885221147848, 11560.364179970182, 11562.94218528902, 8198.057223419382, 8222.547759873265, 8345.457545259538, 8346.374021948257, 8359.665613375519, 5820.650760954356, 5925.733341999534, 5960.672163031075, 5966.940330596812, 6019.157317975574, 10443.189051559491, 10460.790784184426, 10493.632722854663, 10539.736506587396, 10586.153107751208, 10786.892131078903, 10824.945875270574, 10886.51010704536, 10893.836592451278, 10920.617778377718, 7663.118741344594, 7819.100803407453, 7918.168592297726, 8071.838563228585, 8154.0, 8909.643614255358, 8938.195562399414, 8948.105189481, 8955.552222388724, 8958.05940376251, 7682.270184332479, 7736.187700291388, 7904.920950790419, 7986.041674999037, 8125.309348705427, 7504.287092726182, 7524.962375188089, 7620.923790762243, 7682.116556596063, 7867.763967080997, 7278.308560686938, 7378.335949764547, 7399.038125043709, 7399.075115610549, 7400.444966627417, 4851.56335929768, 4931.9753401232765, 4937.8271760488215, 5035.093683137071, 5166.922496162636, 4671.672982891165, 4854.563089321978, 4880.048390563806, 4928.137575924271, 4930.161872481615], "value": 4620.08721080137, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.90114064639965, 324.54401565800043, 327.4662300450265, 332.3121139241769, 333.43316362184265, 5237.214417837326, 5262.263283140359, 5265.315508983832, 5298.337707786527, 5313.442088580701, 5177.757338238824, 5191.766370513326, 5241.554467870226, 5261.789528418859, 5265.025615394227, 3925.3915643075297, 3933.704972127088, 4067.2678917794783, 4103.405006274089, 4125.8968525786795, 4101.364288535282, 4106.28140075487, 4109.239790638727, 4110.177964407116, 4131.256373852705, 4046.109855831712, 4050.10897602527, 4054.0472988847596, 4073.531543872463, 4083.693722970789, 3891.1905963726863, 3975.363941769332, 4045.797710114512, 4047.9190416191805, 4097.959020409818, 3624.4563315502887, 3629.9128001399035, 3642.0894776305922, 3654.488371627974, 3657.7256705747177, 5109.284700141983, 5111.744412779383, 5112.130937740593, 5142.51146141116, 5147.279380886679, 4572.908541829178, 4633.4439867215815, 4659.694924472799, 4663.580277774982, 4705.57662803653, 5302.946970530323, 5321.920171197435, 5351.438098999588, 5367.067855571991, 5406.378266499363, 3968.1865217630316, 4010.1779135277197, 4023.4970628671417, 4033.495813023372, 4033.515978082649, 5448.038706065813, 5567.192757050205, 5585.2459917910965, 5594.3846176920915, 5686.459786320334, 4078.3678529827926, 4095.9795201023803, 4096.644429453077, 4096.713230073866, 4124.587541245912, 4100.118474527991, 4126.257273690764, 4145.730527515762, 4168.291390463629, 4169.561501282053, 4569.131864945716, 4656.743879086683, 4687.835925742651, 4705.106029854317, 4720.763961801897, 5348.3849357323625, 5353.197020446964, 5359.785608575691, 5403.594730395157, 5441.292631957899, 1388.208721029024, 1405.3465138710549, 1417.2276109520337, 1431.5347512058415, 1434.5696291112624, 876.9342299327576, 919.9448033118034, 931.5295775633261, 940.3699521320732, 945.8533927241151, 5168.560672342818, 5259.39516955555, 5268.0, 5287.0, 5315.123004704181, 5519.9448005520235, 5554.944450555443, 5568.385168301228, 5568.49883510486, 5576.079946808731, 5016.272640467112, 5295.973520132375, 5310.097283461821, 5334.759935802898, 5366.9534440784455, 2936.588877557144, 2961.7926745128066, 2969.376430949525, 2988.9850550747105, 2999.865006074732, 5863.413658634103, 5879.853003674857, 5890.175375447441, 5892.322382925932, 5922.230110085661, 5581.944180558224, 5715.742791574389, 5753.59724819267, 5757.625754325955, 5780.479756821906, 5807.041838096751, 5815.743183817076, 5819.82540523785, 5844.970775146097, 5845.970770146122, 5406.405295417422, 5589.916151257816, 5610.438956104357, 5702.543796496353, 5720.313562372542, 5553.611247212818, 5563.721813909369, 5564.972175139098, 5566.638168519034, 5604.8318550443555, 5810.186573879745, 5863.384344643751, 5869.882602347844, 5875.735591898289, 5928.428966324014, 3560.1989552350515, 3617.4212126059706, 3632.1282892106233, 3675.3016926783826, 3679.816009199476, 4976.527229913152, 5022.824201152942, 5042.2267752735115, 5057.848264552069, 5063.468335824833, 4814.446338671098, 4899.706017638953, 4907.48511369548, 4920.114379411597, 4928.630352723631, 4844.878878028077, 4950.752462376939, 5146.665466744649, 5533.0081170779295, 5556.527695145796, 5429.945700543102, 5438.673679579238, 5455.863603409788, 5456.345238571397, 5458.617896747349, 5256.684598924076, 5271.262023316815, 5487.463510217146, 5489.780408783604, 5494.395616482264, 5323.600729945347, 5366.382865970463, 5374.543163831118, 5383.138697808332, 5405.054115529845], "value": 4145.7105170802215, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.4824836627431, 711.950163488556, 767.3132546370995, 775.8331958628894, 783.189398972064, 15833.60415989601, 16905.492835214947, 17073.0, 17103.23035463404, 17182.054986975712, 14801.851981480182, 15139.848601513982, 15263.923680381582, 15502.06987580746, 15573.143477108755, 805.4643661964801, 820.6471217376526, 822.6298165825373, 822.7490615362312, 822.8477731619639, 677.1535580524345, 791.9683212671515, 819.2872201184978, 827.4166712467726, 831.4346244553701, 875.7722992022088, 876.7545087375545, 878.0, 878.8154487557589, 879.134052957836, 877.0746862060523, 878.0780180810156, 879.1384443245655, 879.1955360844819, 879.8196369744219, 514.770926937513, 618.9597676151036, 631.4979591224941, 635.9109724638554, 637.4263163153153, 15615.92192039044, 15657.29542170605, 15681.980671256331, 15684.451044213398, 15712.0, 14141.646458838612, 14293.0, 14703.705925881422, 14910.552683419515, 15151.242437878062, 12684.30236337001, 12924.870751292461, 12925.806112908314, 12990.22058676473, 13399.933000334935, 4655.115528049693, 4664.510226426244, 4704.529547045268, 4824.15265851679, 4825.276208568707, 84906.15093849045, 86256.0, 86380.5680971591, 87581.56209218912, 87854.0, 11375.772484550263, 11382.601608943647, 11385.544578216779, 11492.138089643144, 12005.699857503632, 20592.27927022547, 20637.896810515853, 20689.0, 20832.47918802042, 20865.478363041046, 8723.302135829246, 8790.120987901286, 8823.647054117764, 9125.589348479334, 9152.90847091534, 4665.720056796603, 4929.137400954819, 4993.900121997613, 5043.571296439771, 5147.794088236504, 3352.2122301259183, 3489.2149266415363, 3492.1444246159854, 3495.9825200873834, 3507.0530956641564, 579.7622974580402, 585.2596465471182, 595.2707932782394, 609.5123900879368, 612.4579746924004, 538.9003034438641, 571.6684323092679, 584.6638183044766, 632.4276529740592, 634.5938599296454, 8287.875681864776, 8654.307655387554, 8929.508877011827, 9108.59011344491, 9198.0, 551.1237132958615, 588.808637192914, 624.8219257511587, 628.8868003759276, 655.0698008827476, 4245.61789438952, 4445.377647129404, 4482.496610565136, 4487.708298960557, 4597.977010114928, 117033.0, 124074.37962810308, 125783.0, 128928.3553582226, 130269.0, 108200.0, 111045.0, 112077.0, 112112.0, 112253.0, 80150.0, 81871.5906420464, 94551.52724236334, 100121.49939250258, 101339.0, 9757.609695612096, 9851.704448866545, 9859.063388978035, 9941.30410871232, 10025.649102281677, 54354.18468722893, 54966.0, 55123.17315240194, 55137.0, 55748.0, 67985.0, 75385.0, 75790.24209757832, 76761.61619191869, 79252.60373698325, 12294.754104917673, 12908.935455322664, 12947.805782913452, 12993.350332483527, 13258.33708314561, 13907.443702252202, 13985.58043258704, 14356.928215359274, 14445.566633001026, 14480.565583032527, 14074.0, 14267.427091375323, 14466.0, 14668.926655366655, 14974.700505990037, 13003.936068702456, 13142.868571314164, 13173.670658233621, 13245.867541324464, 13445.46218151263, 13522.661933451349, 13582.25297608641, 13606.0, 14245.501407450689, 14490.782638260645, 9966.40201587907, 10023.69928902134, 10075.244356673133, 10122.949385253027, 10387.480625968823, 9231.261499079923, 9343.813123737624, 10550.577976880839, 11571.421428928352, 12263.386830658254], "value": 7633.387323508623, "unit": "score"}], "name": "dromaeo_css", "value": 7194.546474619103, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 110.0, 113.0, 111.0, 111.0, 111.0, 110.0, 109.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 119.0, 184.0, 120.0, 121.0, 154.0, 117.0, 159.0, 122.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 160.0, 160.0, 159.0, 161.0, 162.0, 162.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 125.0, 75.0, 76.0, 74.0, 74.0, 104.0, 74.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 117.0, 84.0, 83.0, 84.0, 113.0, 84.0, 84.0, 127.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 118.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 51.0, 47.0, 48.0, 50.0, 48.0, 48.0, 49.0, 48.0], "value": 48.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0, 59.0, 60.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 86.0, 76.0, 76.0, 84.0, 76.0, 76.0, 76.0, 76.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 123.0, 122.0, 120.0, 120.0, 121.0, 119.0, 134.0, 134.0, 124.0], "value": 124.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 168.0, 168.0, 166.0, 165.0, 165.0, 167.0, 163.0, 163.0], "value": 166.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 64.0, 65.0, 68.0, 65.0, 62.0, 63.0, 67.0], "value": 64.5, "unit": "score"}], "name": "kraken", "value": 1482.3, "alertThreshold": 2.0}]} 10:41:27 INFO - Return code: 0 10:41:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:41:27 INFO - # TBPL SUCCESS # 10:41:27 INFO - Running post-action listener: _resource_record_post_action 10:41:27 INFO - [mozharness: 2016-08-04 17:41:27.069408Z] Finished run-tests step (success) 10:41:27 INFO - Running post-run listener: _resource_record_post_run 10:41:27 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 3416064; Write bytes: 294375424; Read time: 728; Write time: 239952 10:41:27 INFO - TinderboxPrint: CPU usage
13.0% 10:41:27 INFO - TinderboxPrint: I/O read bytes / time
3,416,064 / 728 10:41:27 INFO - TinderboxPrint: I/O write bytes / time
294,375,424 / 239,952 10:41:27 INFO - TinderboxPrint: CPU idle
8,287.3 (87.0%) 10:41:27 INFO - TinderboxPrint: CPU user
1,190.2 (12.5%) 10:41:27 INFO - TinderboxPrint: Swap in / out
0 / 0 10:41:27 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5148672; Read time: 0; Write time: 276 10:41:27 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 3411968; Write bytes: 288849920; Read time: 716; Write time: 239608 10:41:27 INFO - Running post-run listener: _upload_blobber_files 10:41:27 INFO - Blob upload gear active. 10:41:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:41:27 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 10:41:27 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:41:27 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:41:28 INFO - (blobuploader) - INFO - Open directory for files ... 10:41:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:41:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:41:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:28 INFO - (blobuploader) - INFO - Done attempting. 10:41:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:41:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:41:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:29 INFO - (blobuploader) - INFO - Done attempting. 10:41:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:41:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:41:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:34 INFO - (blobuploader) - INFO - Done attempting. 10:41:34 INFO - (blobuploader) - INFO - Iteration through files over. 10:41:34 INFO - Return code: 0 10:41:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:41:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:41:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/55168cd84145d060346763df871b25e27eb81cc89a68c5aadad6297ca1b1d785d9ce379fdcda4762948d1feded1e6c81111491afb8a56a88d2a9ed4d1f5a565f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/58362d6c62db51bcfdc58c886c2f36c47cb81dc29edeab436a6b87e22079beac39e8cfe9fc8268a65d8e5d5ca4a383d337dd05f40ab16cf36d7fdd13a0b5c6b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4d184d3d416c096dcffb827329be353894aa0e65bf68aa1533c62c435067d81c77115483ccae749b65f4c57b79a1fe5e1f6860d617663d3b33d285a760c12be2"} 10:41:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:41:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:41:34 INFO - Contents: 10:41:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/55168cd84145d060346763df871b25e27eb81cc89a68c5aadad6297ca1b1d785d9ce379fdcda4762948d1feded1e6c81111491afb8a56a88d2a9ed4d1f5a565f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/58362d6c62db51bcfdc58c886c2f36c47cb81dc29edeab436a6b87e22079beac39e8cfe9fc8268a65d8e5d5ca4a383d337dd05f40ab16cf36d7fdd13a0b5c6b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4d184d3d416c096dcffb827329be353894aa0e65bf68aa1533c62c435067d81c77115483ccae749b65f4c57b79a1fe5e1f6860d617663d3b33d285a760c12be2"} 10:41:34 INFO - Running post-run listener: copy_logs_to_upload_dir 10:41:34 INFO - Copying logs to upload dir... 10:41:34 INFO - mkdir: /builds/slave/test/build/upload/logs 10:41:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.153986 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-04 10:41:34.189984) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 10:41:34.193546) ========= 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=0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163 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-Inbound/sha512/55168cd84145d060346763df871b25e27eb81cc89a68c5aadad6297ca1b1d785d9ce379fdcda4762948d1feded1e6c81111491afb8a56a88d2a9ed4d1f5a565f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/58362d6c62db51bcfdc58c886c2f36c47cb81dc29edeab436a6b87e22079beac39e8cfe9fc8268a65d8e5d5ca4a383d337dd05f40ab16cf36d7fdd13a0b5c6b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4d184d3d416c096dcffb827329be353894aa0e65bf68aa1533c62c435067d81c77115483ccae749b65f4c57b79a1fe5e1f6860d617663d3b33d285a760c12be2"} build_url:https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/DV7zyf8gTW6sqYUxYCqcYA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/55168cd84145d060346763df871b25e27eb81cc89a68c5aadad6297ca1b1d785d9ce379fdcda4762948d1feded1e6c81111491afb8a56a88d2a9ed4d1f5a565f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/58362d6c62db51bcfdc58c886c2f36c47cb81dc29edeab436a6b87e22079beac39e8cfe9fc8268a65d8e5d5ca4a383d337dd05f40ab16cf36d7fdd13a0b5c6b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4d184d3d416c096dcffb827329be353894aa0e65bf68aa1533c62c435067d81c77115483ccae749b65f4c57b79a1fe5e1f6860d617663d3b33d285a760c12be2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 10:41:34.218952) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:41:34.219279) ========= 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=0333a256a5e4f052382dd180000001b1-1470331136.177278-1487771163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:41:34.302180) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 10:41:34.302565) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 10:41:34.302864) ========= ========= Total master_lag: 0.17 =========