builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1470405960.26 results: success (0) buildid: 20160805043005 builduid: 1a6acf0a6fdd4ea288c60c4212ed988a revision: 4a431f553e0c8bc5e005f5c1684d4a1da026a47a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 07:06:00.259690) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 07:06:00.260187) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 07:06:00.260523) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 07:06:00.276729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 07:06:00.277098) ========= 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=923d835db2ba3686ebe126b700000192-1470398394.128368-488994872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-05 07:06:01-- 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% 46.1M=0s 2016-08-05 07:06:01 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.266442 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 07:06:00.647121) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 07:06:00.647503) ========= 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=923d835db2ba3686ebe126b700000192-1470398394.128368-488994872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015902 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 07:06:00.676074) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 07:06:00.676459) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4a431f553e0c8bc5e005f5c1684d4a1da026a47a --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 4a431f553e0c8bc5e005f5c1684d4a1da026a47a --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=923d835db2ba3686ebe126b700000192-1470398394.128368-488994872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-05 07:06:01,926 truncating revision to first 12 chars 2016-08-05 07:06:01,927 Setting DEBUG logging. 2016-08-05 07:06:01,927 attempt 1/10 2016-08-05 07:06:01,927 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/4a431f553e0c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 07:06:02,771 unpacking tar archive at: mozilla-inbound-4a431f553e0c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.245362 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 07:06:01.938191) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 07:06:01.938770) ========= script_repo_revision: 4a431f553e0c8bc5e005f5c1684d4a1da026a47a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 07:06:01.939491) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 07:06:01.940035) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 07:06:01.951348) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-05 07:06:01.951656) ========= /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=923d835db2ba3686ebe126b700000192-1470398394.128368-488994872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:06:03 INFO - MultiFileLogger online at 20160805 07:06:03 in /builds/slave/test 07:06:03 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 07:06:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:06:03 INFO - {'append_to_log': False, 07:06:03 INFO - 'base_work_dir': '/builds/slave/test', 07:06:03 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:06:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:06:03 INFO - 'branch': 'Mozilla-Inbound', 07:06:03 INFO - 'buildbot_json_path': 'buildprops.json', 07:06:03 INFO - 'config_files': ('talos/linux_config.py',), 07:06:03 INFO - 'default_actions': ('clobber', 07:06:03 INFO - 'read-buildbot-config', 07:06:03 INFO - 'download-and-extract', 07:06:03 INFO - 'populate-webroot', 07:06:03 INFO - 'create-virtualenv', 07:06:03 INFO - 'install', 07:06:03 INFO - 'run-tests'), 07:06:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:06:03 INFO - 'download_minidump_stackwalk': True, 07:06:03 INFO - 'download_symbols': 'ondemand', 07:06:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:06:03 INFO - 'tooltool.py': '/tools/tooltool.py', 07:06:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:06:03 INFO - '/tools/misc-python/virtualenv.py')}, 07:06:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:06:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:06:03 INFO - 'installer_path': 'installer.exe', 07:06:03 INFO - 'log_level': 'info', 07:06:03 INFO - 'log_name': 'talos', 07:06:03 INFO - 'log_to_console': True, 07:06:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:06:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:06:03 INFO - 'opt_config_files': (), 07:06:03 INFO - 'pip_index': False, 07:06:03 INFO - 'sps_profile': False, 07:06:03 INFO - 'sps_profile_interval': 0, 07:06:03 INFO - 'suite': 'dromaeojs', 07:06:03 INFO - 'system_bits': '32', 07:06:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:06:03 INFO - 'title': 'talos-linux64-ix-007', 07:06:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:06:03 INFO - 'use_talos_json': True, 07:06:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:06:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:06:03 INFO - 'work_dir': 'build'} 07:06:03 INFO - [mozharness: 2016-08-05 14:06:03.297889Z] Running clobber step. 07:06:03 INFO - Running pre-action listener: _resource_record_pre_action 07:06:03 INFO - Running main action method: clobber 07:06:03 INFO - rmtree: /builds/slave/test/build 07:06:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:06:03 INFO - Running post-action listener: _resource_record_post_action 07:06:03 INFO - [mozharness: 2016-08-05 14:06:03.758132Z] Finished clobber step (success) 07:06:03 INFO - [mozharness: 2016-08-05 14:06:03.758231Z] Running read-buildbot-config step. 07:06:03 INFO - Running pre-action listener: _resource_record_pre_action 07:06:03 INFO - Running main action method: read_buildbot_config 07:06:03 INFO - Using buildbot properties: 07:06:03 INFO - { 07:06:03 INFO - "project": "", 07:06:03 INFO - "product": "firefox", 07:06:03 INFO - "script_repo_revision": "production", 07:06:03 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:06:03 INFO - "repository": "", 07:06:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 07:06:03 INFO - "buildid": "20160805043005", 07:06:03 INFO - "pgo_build": "True", 07:06:03 INFO - "basedir": "/builds/slave/test", 07:06:03 INFO - "buildnumber": 1355, 07:06:03 INFO - "slavename": "talos-linux64-ix-007", 07:06:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:06:03 INFO - "platform": "ubuntu64_hw", 07:06:03 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:06:03 INFO - "branch": "mozilla-inbound", 07:06:03 INFO - "repo_path": "integration/mozilla-inbound", 07:06:03 INFO - "revision": "4a431f553e0c8bc5e005f5c1684d4a1da026a47a", 07:06:03 INFO - "stage_platform": "linux64-pgo", 07:06:03 INFO - "builduid": "1a6acf0a6fdd4ea288c60c4212ed988a", 07:06:03 INFO - "slavebuilddir": "test" 07:06:03 INFO - } 07:06:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/WOnIMcsMStOKjEcRVgXp6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 07:06:03 INFO - Running post-action listener: _resource_record_post_action 07:06:03 INFO - [mozharness: 2016-08-05 14:06:03.760661Z] Finished read-buildbot-config step (success) 07:06:03 INFO - [mozharness: 2016-08-05 14:06:03.760748Z] Running download-and-extract step. 07:06:03 INFO - Running pre-action listener: _resource_record_pre_action 07:06:03 INFO - Running main action method: download_and_extract 07:06:03 INFO - mkdir: /builds/slave/test/build/tests 07:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:03 INFO - trying https://queue.taskcluster.net/v1/task/WOnIMcsMStOKjEcRVgXp6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:06:03 INFO - Downloading https://queue.taskcluster.net/v1/task/WOnIMcsMStOKjEcRVgXp6A/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 07:06:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WOnIMcsMStOKjEcRVgXp6A/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 07:06:04 INFO - Downloaded 1361 bytes. 07:06:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:06:04 INFO - Using the following test package requirements: 07:06:04 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:04 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:06:04 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:06:04 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:04 INFO - u'jsshell-linux-x86_64.zip'], 07:06:04 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:06:04 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:04 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:06:04 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:06:04 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:06:04 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:04 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:06:04 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:04 INFO - trying https://queue.taskcluster.net/v1/task/WOnIMcsMStOKjEcRVgXp6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:06:04 INFO - Downloading https://queue.taskcluster.net/v1/task/WOnIMcsMStOKjEcRVgXp6A/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 07:06:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WOnIMcsMStOKjEcRVgXp6A/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 07:06:06 INFO - Downloaded 21824397 bytes. 07:06:06 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 07:06:10 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 07:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:10 INFO - trying https://queue.taskcluster.net/v1/task/WOnIMcsMStOKjEcRVgXp6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:06:10 INFO - Downloading https://queue.taskcluster.net/v1/task/WOnIMcsMStOKjEcRVgXp6A/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 07:06:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WOnIMcsMStOKjEcRVgXp6A/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 07:06:12 INFO - Downloaded 21824397 bytes. 07:06:12 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 07:06: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')]} 07:06:17 INFO - trying https://queue.taskcluster.net/v1/task/WOnIMcsMStOKjEcRVgXp6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:06:17 INFO - Downloading https://queue.taskcluster.net/v1/task/WOnIMcsMStOKjEcRVgXp6A/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 07:06:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WOnIMcsMStOKjEcRVgXp6A/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 07:06:24 INFO - Downloaded 14413723 bytes. 07:06:24 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 07:06:24 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')]} 07:06:24 INFO - trying https://queue.taskcluster.net/v1/task/WOnIMcsMStOKjEcRVgXp6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:06:24 INFO - Downloading https://queue.taskcluster.net/v1/task/WOnIMcsMStOKjEcRVgXp6A/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 07:06:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WOnIMcsMStOKjEcRVgXp6A/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 07:06:27 INFO - Downloaded 59374480 bytes. 07:06:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WOnIMcsMStOKjEcRVgXp6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:06:27 INFO - mkdir: /builds/slave/test/properties 07:06:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:06:27 INFO - Writing to file /builds/slave/test/properties/build_url 07:06:27 INFO - Contents: 07:06:27 INFO - build_url:https://queue.taskcluster.net/v1/task/WOnIMcsMStOKjEcRVgXp6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:06:28 INFO - Running post-action listener: _resource_record_post_action 07:06:28 INFO - Running post-action listener: set_extra_try_arguments 07:06:28 INFO - [mozharness: 2016-08-05 14:06:28.169770Z] Finished download-and-extract step (success) 07:06:28 INFO - [mozharness: 2016-08-05 14:06:28.169994Z] Running populate-webroot step. 07:06:28 INFO - Running pre-action listener: _resource_record_pre_action 07:06:28 INFO - Running main action method: populate_webroot 07:06:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:06:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:06:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:06:28 INFO - '--tppagecycles', 07:06:28 INFO - '7'], 07:06:28 INFO - 'tests': ['tsvgm']}}, 07:06:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:06:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:06:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:06:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:06:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:06:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:06:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:28 INFO - 'talos_options': ['--disable-e10s'], 07:06:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:28 INFO - 'talos_options': ['--disable-e10s'], 07:06:28 INFO - 'tests': ['damp', 'tps']}, 07:06:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:28 INFO - 'tests': ['damp', 'tps']}, 07:06:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:06:28 INFO - 'tests': ['dromaeo_dom']}, 07:06:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:06:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:06:28 INFO - 'tests': ['basic_compositor_video']}, 07:06:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:06:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:06:28 INFO - 'tests': ['a11yr', 07:06:28 INFO - 'ts_paint', 07:06:28 INFO - 'tpaint', 07:06:28 INFO - 'sessionrestore', 07:06:28 INFO - 'sessionrestore_no_auto_restore', 07:06:28 INFO - 'tabpaint']}, 07:06:28 INFO - 'other-e10s': {'tests': ['a11yr', 07:06:28 INFO - 'ts_paint', 07:06:28 INFO - 'tpaint', 07:06:28 INFO - 'sessionrestore', 07:06:28 INFO - 'sessionrestore_no_auto_restore', 07:06:28 INFO - 'tabpaint']}, 07:06:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:06:28 INFO - 'ts_paint', 07:06:28 INFO - 'tpaint', 07:06:28 INFO - 'sessionrestore', 07:06:28 INFO - 'sessionrestore_no_auto_restore', 07:06:28 INFO - 'tabpaint']}, 07:06:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:06:28 INFO - 'ts_paint', 07:06:28 INFO - 'tpaint', 07:06:28 INFO - 'sessionrestore', 07:06:28 INFO - 'sessionrestore_no_auto_restore', 07:06:28 INFO - 'tabpaint']}, 07:06:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:06:28 INFO - 'tests': ['a11yr', 07:06:28 INFO - 'ts_paint', 07:06:28 INFO - 'tpaint', 07:06:28 INFO - 'sessionrestore', 07:06:28 INFO - 'sessionrestore_no_auto_restore', 07:06:28 INFO - 'tabpaint']}, 07:06:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:06:28 INFO - 'tests': ['a11yr', 07:06:28 INFO - 'ts_paint', 07:06:28 INFO - 'tpaint', 07:06:28 INFO - 'sessionrestore', 07:06:28 INFO - 'sessionrestore_no_auto_restore', 07:06:28 INFO - 'tabpaint']}, 07:06:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:06:28 INFO - 'tests': ['tsvgx', 07:06:28 INFO - 'tsvgr_opacity', 07:06:28 INFO - 'tart', 07:06:28 INFO - 'tscrollx', 07:06:28 INFO - 'cart']}, 07:06:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:06:28 INFO - 'tsvgr_opacity', 07:06:28 INFO - 'tart', 07:06:28 INFO - 'tscrollx', 07:06:28 INFO - 'cart']}, 07:06:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:28 INFO - 'talos_options': ['--disable-e10s'], 07:06:28 INFO - 'tests': ['tp5o']}, 07:06:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:28 INFO - 'tests': ['tp5o']}, 07:06:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:28 INFO - 'talos_options': ['--disable-e10s', 07:06:28 INFO - '--xperf_path', 07:06:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:28 INFO - 'tests': ['tp5n']}, 07:06:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:28 INFO - 'talos_options': ['--xperf_path', 07:06:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:28 INFO - 'tests': ['tp5n']}}, 07:06:28 INFO - 'talos.zip': {'path': '', 07:06:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:06:28 INFO - Running post-action listener: _resource_record_post_action 07:06:28 INFO - [mozharness: 2016-08-05 14:06:28.192513Z] Finished populate-webroot step (success) 07:06:28 INFO - [mozharness: 2016-08-05 14:06:28.192611Z] Running create-virtualenv step. 07:06:28 INFO - Running pre-action listener: _resource_record_pre_action 07:06:28 INFO - Running main action method: create_virtualenv 07:06:28 INFO - Creating virtualenv /builds/slave/test/build/venv 07:06:28 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 07:06:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:06:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:06:28 INFO - Using real prefix '/usr' 07:06:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:06:28 INFO - Installing distribute.............................................................................................................................................................................................done. 07:06:30 INFO - Installing pip.................done. 07:06:30 INFO - Return code: 0 07:06:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:30 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 0x2603030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c23b0>, '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 0x28c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3740>, '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': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', '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 07:06:30 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 07:06:30 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 07:06:30 INFO - Using env: {'DISPLAY': ':0', 07:06:30 INFO - 'HOME': '/home/cltbld', 07:06:30 INFO - 'LANG': 'en_US.UTF-8', 07:06:30 INFO - 'LANGUAGE': 'en_US:en', 07:06:30 INFO - 'LOGNAME': 'cltbld', 07:06:30 INFO - 'MAIL': '/var/mail/cltbld', 07:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:30 INFO - 'MOZ_NO_REMOTE': '1', 07:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:30 INFO - 'NO_EM_RESTART': '1', 07:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:30 INFO - 'PWD': '/builds/slave/test', 07:06:30 INFO - 'SHELL': '/bin/bash', 07:06:30 INFO - 'SHLVL': '1', 07:06:30 INFO - 'TERM': 'linux', 07:06:30 INFO - 'TMOUT': '86400', 07:06:30 INFO - 'USER': 'cltbld', 07:06:30 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', 07:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:30 INFO - '_': '/tools/buildbot/bin/python'} 07:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:30 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 07:06:30 INFO - Cleaning up... 07:06:30 INFO - Return code: 0 07:06:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:30 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 0x2603030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c23b0>, '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 0x28c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3740>, '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': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', '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 07:06:30 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 07:06:30 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 07:06:30 INFO - Using env: {'DISPLAY': ':0', 07:06:30 INFO - 'HOME': '/home/cltbld', 07:06:30 INFO - 'LANG': 'en_US.UTF-8', 07:06:30 INFO - 'LANGUAGE': 'en_US:en', 07:06:30 INFO - 'LOGNAME': 'cltbld', 07:06:30 INFO - 'MAIL': '/var/mail/cltbld', 07:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:30 INFO - 'MOZ_NO_REMOTE': '1', 07:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:30 INFO - 'NO_EM_RESTART': '1', 07:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:30 INFO - 'PWD': '/builds/slave/test', 07:06:30 INFO - 'SHELL': '/bin/bash', 07:06:30 INFO - 'SHLVL': '1', 07:06:30 INFO - 'TERM': 'linux', 07:06:30 INFO - 'TMOUT': '86400', 07:06:30 INFO - 'USER': 'cltbld', 07:06:30 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', 07:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:30 INFO - '_': '/tools/buildbot/bin/python'} 07:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:31 INFO - Downloading/unpacking psutil>=3.1.1 07:06:31 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 07:06:31 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 07:06:31 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 07:06:31 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 07:06:31 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 07:06:31 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 07:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:06:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:33 INFO - Installing collected packages: psutil 07:06:33 INFO - Running setup.py install for psutil 07:06:33 INFO - building 'psutil._psutil_linux' extension 07:06:33 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 07:06:33 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 07:06:33 INFO - building 'psutil._psutil_posix' extension 07:06:33 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 07:06:33 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 07:06:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:33 INFO - Successfully installed psutil 07:06:33 INFO - Cleaning up... 07:06:33 INFO - Return code: 0 07:06:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:06: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')]} 07:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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')]} 07:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2603030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c23b0>, '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 0x28c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3740>, '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': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', '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 07:06: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:06: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 mozsystemmonitor==0.3 07:06:33 INFO - Using env: {'DISPLAY': ':0', 07:06:33 INFO - 'HOME': '/home/cltbld', 07:06:33 INFO - 'LANG': 'en_US.UTF-8', 07:06:33 INFO - 'LANGUAGE': 'en_US:en', 07:06:33 INFO - 'LOGNAME': 'cltbld', 07:06:33 INFO - 'MAIL': '/var/mail/cltbld', 07:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:33 INFO - 'MOZ_NO_REMOTE': '1', 07:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:33 INFO - 'NO_EM_RESTART': '1', 07:06:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:33 INFO - 'PWD': '/builds/slave/test', 07:06:33 INFO - 'SHELL': '/bin/bash', 07:06:33 INFO - 'SHLVL': '1', 07:06:33 INFO - 'TERM': 'linux', 07:06:33 INFO - 'TMOUT': '86400', 07:06:33 INFO - 'USER': 'cltbld', 07:06:33 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', 07:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:33 INFO - '_': '/tools/buildbot/bin/python'} 07:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:06:33 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 07:06:33 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 07:06:33 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 07:06:33 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 07:06:33 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 07:06:33 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 07:06:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:06:35 INFO - Installing collected packages: mozsystemmonitor 07:06:35 INFO - Running setup.py install for mozsystemmonitor 07:06:35 INFO - Successfully installed mozsystemmonitor 07:06:35 INFO - Cleaning up... 07:06:36 INFO - Return code: 0 07:06:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:06:36 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')]} 07:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:36 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')]} 07:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:36 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 0x2603030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c23b0>, '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 0x28c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3740>, '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': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', '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 07:06:36 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 07:06:36 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 07:06:36 INFO - Using env: {'DISPLAY': ':0', 07:06:36 INFO - 'HOME': '/home/cltbld', 07:06:36 INFO - 'LANG': 'en_US.UTF-8', 07:06:36 INFO - 'LANGUAGE': 'en_US:en', 07:06:36 INFO - 'LOGNAME': 'cltbld', 07:06:36 INFO - 'MAIL': '/var/mail/cltbld', 07:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:36 INFO - 'MOZ_NO_REMOTE': '1', 07:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:36 INFO - 'NO_EM_RESTART': '1', 07:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:36 INFO - 'PWD': '/builds/slave/test', 07:06:36 INFO - 'SHELL': '/bin/bash', 07:06:36 INFO - 'SHLVL': '1', 07:06:36 INFO - 'TERM': 'linux', 07:06:36 INFO - 'TMOUT': '86400', 07:06:36 INFO - 'USER': 'cltbld', 07:06:36 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', 07:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:36 INFO - '_': '/tools/buildbot/bin/python'} 07:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:36 INFO - Downloading/unpacking jsonschema==2.5.1 07:06:36 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 07:06:36 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 07:06:36 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 07:06:36 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 07:06:36 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 07:06:36 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 07:06:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:06:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:38 INFO - Downloading functools32-3.2.3-2.tar.gz 07:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:06:38 INFO - warning: no files found matching '*.txt' 07:06:38 INFO - no previously-included directories found matching 'build' 07:06:38 INFO - no previously-included directories found matching 'dist' 07:06:38 INFO - no previously-included directories found matching '.git*' 07:06:38 INFO - Installing collected packages: jsonschema, functools32 07:06:38 INFO - Running setup.py install for functools32 07:06:38 INFO - warning: no files found matching '*.txt' 07:06:38 INFO - no previously-included directories found matching 'build' 07:06:38 INFO - no previously-included directories found matching 'dist' 07:06:38 INFO - no previously-included directories found matching '.git*' 07:06:38 INFO - Successfully installed jsonschema functools32 07:06:38 INFO - Cleaning up... 07:06:38 INFO - Return code: 0 07:06:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:06:38 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')]} 07:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:38 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')]} 07:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:38 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 0x2603030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c23b0>, '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 0x28c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3740>, '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': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', '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 07:06:38 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 07:06:38 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 07:06:38 INFO - Using env: {'DISPLAY': ':0', 07:06:38 INFO - 'HOME': '/home/cltbld', 07:06:38 INFO - 'LANG': 'en_US.UTF-8', 07:06:38 INFO - 'LANGUAGE': 'en_US:en', 07:06:38 INFO - 'LOGNAME': 'cltbld', 07:06:38 INFO - 'MAIL': '/var/mail/cltbld', 07:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:38 INFO - 'MOZ_NO_REMOTE': '1', 07:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:38 INFO - 'NO_EM_RESTART': '1', 07:06:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:38 INFO - 'PWD': '/builds/slave/test', 07:06:38 INFO - 'SHELL': '/bin/bash', 07:06:38 INFO - 'SHLVL': '1', 07:06:38 INFO - 'TERM': 'linux', 07:06:38 INFO - 'TMOUT': '86400', 07:06:38 INFO - 'USER': 'cltbld', 07:06:38 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', 07:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:38 INFO - '_': '/tools/buildbot/bin/python'} 07:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:06:38 INFO - Cleaning up... 07:06:38 INFO - Return code: 0 07:06:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:06:38 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')]} 07:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:38 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')]} 07:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:38 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 0x2603030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c23b0>, '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 0x28c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3740>, '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': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', '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 07:06:38 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 07:06:38 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 07:06:38 INFO - Using env: {'DISPLAY': ':0', 07:06:38 INFO - 'HOME': '/home/cltbld', 07:06:38 INFO - 'LANG': 'en_US.UTF-8', 07:06:38 INFO - 'LANGUAGE': 'en_US:en', 07:06:38 INFO - 'LOGNAME': 'cltbld', 07:06:38 INFO - 'MAIL': '/var/mail/cltbld', 07:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:38 INFO - 'MOZ_NO_REMOTE': '1', 07:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:38 INFO - 'NO_EM_RESTART': '1', 07:06:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:38 INFO - 'PWD': '/builds/slave/test', 07:06:38 INFO - 'SHELL': '/bin/bash', 07:06:38 INFO - 'SHLVL': '1', 07:06:38 INFO - 'TERM': 'linux', 07:06:38 INFO - 'TMOUT': '86400', 07:06:38 INFO - 'USER': 'cltbld', 07:06:38 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', 07:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:38 INFO - '_': '/tools/buildbot/bin/python'} 07:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:39 INFO - Downloading/unpacking blobuploader==1.2.4 07:06:39 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 07:06:39 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 07:06:39 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 07:06:39 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 07:06:39 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 07:06:39 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 07:06:40 INFO - Downloading blobuploader-1.2.4.tar.gz 07:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:06:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:06:41 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 07:06:41 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 07:06:41 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 07:06:41 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 07:06:41 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 07:06:41 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 07:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:06:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:06:41 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 07:06:41 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 07:06:41 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 07:06:41 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 07:06:41 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 07:06:41 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 07:06:41 INFO - Downloading docopt-0.6.1.tar.gz 07:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:06:41 INFO - Installing collected packages: blobuploader, requests, docopt 07:06:41 INFO - Running setup.py install for blobuploader 07:06:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:06:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:06:41 INFO - Running setup.py install for requests 07:06:42 INFO - Running setup.py install for docopt 07:06:42 INFO - Successfully installed blobuploader requests docopt 07:06:42 INFO - Cleaning up... 07:06:42 INFO - Return code: 0 07:06:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:42 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 0x2603030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c23b0>, '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 0x28c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3740>, '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': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', '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 07:06:42 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 07:06:42 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 07:06:42 INFO - Using env: {'DISPLAY': ':0', 07:06:42 INFO - 'HOME': '/home/cltbld', 07:06:42 INFO - 'LANG': 'en_US.UTF-8', 07:06:42 INFO - 'LANGUAGE': 'en_US:en', 07:06:42 INFO - 'LOGNAME': 'cltbld', 07:06:42 INFO - 'MAIL': '/var/mail/cltbld', 07:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:42 INFO - 'MOZ_NO_REMOTE': '1', 07:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:42 INFO - 'NO_EM_RESTART': '1', 07:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:42 INFO - 'PWD': '/builds/slave/test', 07:06:42 INFO - 'SHELL': '/bin/bash', 07:06:42 INFO - 'SHLVL': '1', 07:06:42 INFO - 'TERM': 'linux', 07:06:42 INFO - 'TMOUT': '86400', 07:06:42 INFO - 'USER': 'cltbld', 07:06:42 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', 07:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:42 INFO - '_': '/tools/buildbot/bin/python'} 07:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:42 INFO - Running setup.py (path:/tmp/pip-FVls7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:42 INFO - Running setup.py (path:/tmp/pip-71OPMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:42 INFO - Running setup.py (path:/tmp/pip-_l8ptJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:42 INFO - Running setup.py (path:/tmp/pip-IZHtGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:42 INFO - Running setup.py (path:/tmp/pip-mf0_If-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:42 INFO - Running setup.py (path:/tmp/pip-v_iIBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:42 INFO - Running setup.py (path:/tmp/pip-HBNaIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:43 INFO - Running setup.py (path:/tmp/pip-Yc6tTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:43 INFO - Running setup.py (path:/tmp/pip-tYUJ1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:43 INFO - Running setup.py (path:/tmp/pip-cQYrSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:43 INFO - Running setup.py (path:/tmp/pip-My1QP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:43 INFO - Running setup.py (path:/tmp/pip-qHfiuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:43 INFO - Running setup.py (path:/tmp/pip-b4zuI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:43 INFO - Running setup.py (path:/tmp/pip-Ftd9ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:43 INFO - Running setup.py (path:/tmp/pip-1qG3Jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:43 INFO - Running setup.py (path:/tmp/pip-_vEhDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:43 INFO - Running setup.py (path:/tmp/pip-uhzrQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:06:43 INFO - Running setup.py install for manifestparser 07:06:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:06:43 INFO - Running setup.py install for mozcrash 07:06:43 INFO - Running setup.py install for mozdebug 07:06:44 INFO - Running setup.py install for mozdevice 07:06:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:06:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:06:44 INFO - Running setup.py install for mozfile 07:06:44 INFO - Running setup.py install for mozhttpd 07:06:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:06:44 INFO - Running setup.py install for mozinfo 07:06:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:06:44 INFO - Running setup.py install for mozInstall 07:06:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:06:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:06:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:06:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:06:44 INFO - Running setup.py install for mozleak 07:06:44 INFO - Running setup.py install for mozlog 07:06:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:06:44 INFO - Running setup.py install for moznetwork 07:06:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:06:44 INFO - Running setup.py install for mozprocess 07:06:44 INFO - Running setup.py install for mozprofile 07:06:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:06:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:06:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:06:45 INFO - Running setup.py install for mozrunner 07:06:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:06:45 INFO - Running setup.py install for mozscreenshot 07:06:45 INFO - Running setup.py install for moztest 07:06:45 INFO - Running setup.py install for mozversion 07:06:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:06:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:06:45 INFO - Cleaning up... 07:06:45 INFO - Return code: 0 07:06:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:45 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')]} 07:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:45 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')]} 07:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:45 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 0x2603030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c23b0>, '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 0x28c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3740>, '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': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', '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 07:06:45 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 07:06:45 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 07:06:45 INFO - Using env: {'DISPLAY': ':0', 07:06:45 INFO - 'HOME': '/home/cltbld', 07:06:45 INFO - 'LANG': 'en_US.UTF-8', 07:06:45 INFO - 'LANGUAGE': 'en_US:en', 07:06:45 INFO - 'LOGNAME': 'cltbld', 07:06:45 INFO - 'MAIL': '/var/mail/cltbld', 07:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:45 INFO - 'MOZ_NO_REMOTE': '1', 07:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:45 INFO - 'NO_EM_RESTART': '1', 07:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:45 INFO - 'PWD': '/builds/slave/test', 07:06:45 INFO - 'SHELL': '/bin/bash', 07:06:45 INFO - 'SHLVL': '1', 07:06:45 INFO - 'TERM': 'linux', 07:06:45 INFO - 'TMOUT': '86400', 07:06:45 INFO - 'USER': 'cltbld', 07:06:45 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', 07:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:45 INFO - '_': '/tools/buildbot/bin/python'} 07:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:45 INFO - Running setup.py (path:/tmp/pip-bbL19q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:45 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)) 07:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:45 INFO - Running setup.py (path:/tmp/pip-ERPbsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:45 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)) 07:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:45 INFO - Running setup.py (path:/tmp/pip-jvXu_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:45 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)) 07:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:45 INFO - Running setup.py (path:/tmp/pip-8TXKol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:46 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)) 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:46 INFO - Running setup.py (path:/tmp/pip-TXljxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:46 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)) 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:46 INFO - Running setup.py (path:/tmp/pip-Pyex9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:46 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)) 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:46 INFO - Running setup.py (path:/tmp/pip-B8g3ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:46 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)) 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:46 INFO - Running setup.py (path:/tmp/pip-7a8Kku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:46 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)) 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:46 INFO - Running setup.py (path:/tmp/pip-iEY2VQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:46 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)) 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:46 INFO - Running setup.py (path:/tmp/pip-uEymcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:46 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)) 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:46 INFO - Running setup.py (path:/tmp/pip-r5inLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:46 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)) 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:46 INFO - Running setup.py (path:/tmp/pip-z1amEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:46 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)) 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:46 INFO - Running setup.py (path:/tmp/pip-2rl1B_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:46 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)) 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:46 INFO - Running setup.py (path:/tmp/pip-FVexHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:46 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)) 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:46 INFO - Running setup.py (path:/tmp/pip-8QY3WM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:46 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)) 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:46 INFO - Running setup.py (path:/tmp/pip-GNp2V7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:46 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)) 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:46 INFO - Running setup.py (path:/tmp/pip-Dex__g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:47 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)) 07:06:47 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)) 07:06:47 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)) 07:06:47 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)) 07:06:47 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)) 07:06:47 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)) 07:06:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:47 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 07:06:47 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 07:06:47 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 07:06:47 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 07:06:47 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 07:06:47 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 07:06:48 INFO - Downloading blessings-1.6.tar.gz 07:06:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:06:48 INFO - Installing collected packages: blessings 07:06:48 INFO - Running setup.py install for blessings 07:06:49 INFO - Successfully installed blessings 07:06:49 INFO - Cleaning up... 07:06:49 INFO - Return code: 0 07:06:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:06:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:49 INFO - Reading from file tmpfile_stdout 07:06:49 INFO - Current package versions: 07:06:49 INFO - argparse == 1.2.1 07:06:49 INFO - blessings == 1.6 07:06:49 INFO - blobuploader == 1.2.4 07:06:49 INFO - docopt == 0.6.1 07:06:49 INFO - functools32 == 3.2.3-2 07:06:49 INFO - jsonschema == 2.5.1 07:06:49 INFO - manifestparser == 1.1 07:06:49 INFO - mozInstall == 1.12 07:06:49 INFO - mozcrash == 0.17 07:06:49 INFO - mozdebug == 0.1 07:06:49 INFO - mozdevice == 0.48 07:06:49 INFO - mozfile == 1.2 07:06:49 INFO - mozhttpd == 0.7 07:06:49 INFO - mozinfo == 0.9 07:06:49 INFO - mozleak == 0.1 07:06:49 INFO - mozlog == 3.3 07:06:49 INFO - moznetwork == 0.27 07:06:49 INFO - mozprocess == 0.23 07:06:49 INFO - mozprofile == 0.28 07:06:49 INFO - mozrunner == 6.12 07:06:49 INFO - mozscreenshot == 0.1 07:06:49 INFO - mozsystemmonitor == 0.3 07:06:49 INFO - moztest == 0.7 07:06:49 INFO - mozversion == 1.4 07:06:49 INFO - psutil == 3.1.1 07:06:49 INFO - requests == 1.2.3 07:06:49 INFO - wsgiref == 0.1.2 07:06:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:49 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 0x2603030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c23b0>, '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 0x28c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3740>, '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': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', '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 07:06:49 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 07:06:49 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 07:06:49 INFO - Using env: {'DISPLAY': ':0', 07:06:49 INFO - 'HOME': '/home/cltbld', 07:06:49 INFO - 'LANG': 'en_US.UTF-8', 07:06:49 INFO - 'LANGUAGE': 'en_US:en', 07:06:49 INFO - 'LOGNAME': 'cltbld', 07:06:49 INFO - 'MAIL': '/var/mail/cltbld', 07:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:49 INFO - 'MOZ_NO_REMOTE': '1', 07:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:49 INFO - 'NO_EM_RESTART': '1', 07:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:49 INFO - 'PWD': '/builds/slave/test', 07:06:49 INFO - 'SHELL': '/bin/bash', 07:06:49 INFO - 'SHLVL': '1', 07:06:49 INFO - 'TERM': 'linux', 07:06:49 INFO - 'TMOUT': '86400', 07:06:49 INFO - 'USER': 'cltbld', 07:06:49 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', 07:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:49 INFO - '_': '/tools/buildbot/bin/python'} 07:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:49 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)) 07:06:49 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)) 07:06:49 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)) 07:06:49 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)) 07:06:49 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)) 07:06:49 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)) 07:06:49 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)) 07:06:49 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)) 07:06:49 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)) 07:06:49 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)) 07:06:49 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)) 07:06:49 INFO - Cleaning up... 07:06:49 INFO - Return code: 0 07:06:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2603030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c23b0>, '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 0x28c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3740>, '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': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', '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 07:06:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:06:49 INFO - Using env: {'DISPLAY': ':0', 07:06:49 INFO - 'HOME': '/home/cltbld', 07:06:49 INFO - 'LANG': 'en_US.UTF-8', 07:06:49 INFO - 'LANGUAGE': 'en_US:en', 07:06:49 INFO - 'LOGNAME': 'cltbld', 07:06:49 INFO - 'MAIL': '/var/mail/cltbld', 07:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:49 INFO - 'MOZ_NO_REMOTE': '1', 07:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:49 INFO - 'NO_EM_RESTART': '1', 07:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:49 INFO - 'PWD': '/builds/slave/test', 07:06:49 INFO - 'SHELL': '/bin/bash', 07:06:49 INFO - 'SHLVL': '1', 07:06:49 INFO - 'TERM': 'linux', 07:06:49 INFO - 'TMOUT': '86400', 07:06:49 INFO - 'USER': 'cltbld', 07:06:49 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', 07:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:49 INFO - '_': '/tools/buildbot/bin/python'} 07:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:06:49 INFO - Cleaning up... 07:06:49 INFO - Return code: 0 07:06:49 INFO - Running post-action listener: _resource_record_post_action 07:06:49 INFO - Running post-action listener: _start_resource_monitoring 07:06:49 INFO - Starting resource monitoring. 07:06:49 INFO - [mozharness: 2016-08-05 14:06:49.837595Z] Finished create-virtualenv step (success) 07:06:49 INFO - [mozharness: 2016-08-05 14:06:49.838105Z] Running install step. 07:06:49 INFO - Running pre-action listener: _resource_record_pre_action 07:06:49 INFO - Running main action method: install 07:06:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:50 INFO - Reading from file tmpfile_stdout 07:06:50 INFO - Detecting whether we're running mozinstall >=1.0... 07:06:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:06:50 INFO - Reading from file tmpfile_stdout 07:06:50 INFO - Output received: 07:06:50 INFO - Usage: mozinstall [options] installer 07:06:50 INFO - Options: 07:06:50 INFO - -h, --help show this help message and exit 07:06:50 INFO - -d DEST, --destination=DEST 07:06:50 INFO - Directory to install application into. [default: 07:06:50 INFO - "/builds/slave/test"] 07:06:50 INFO - --app=APP Application being installed. [default: firefox] 07:06:50 INFO - mkdir: /builds/slave/test/build/application 07:06:50 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'] 07:06:50 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 07:07:06 INFO - Reading from file tmpfile_stdout 07:07:06 INFO - Output received: 07:07:06 INFO - /builds/slave/test/build/application/firefox/firefox 07:07:06 INFO - Running post-action listener: _resource_record_post_action 07:07:06 INFO - [mozharness: 2016-08-05 14:07:06.995290Z] Finished install step (success) 07:07:06 INFO - [mozharness: 2016-08-05 14:07:06.995623Z] Running run-tests step. 07:07:06 INFO - Running pre-action listener: _resource_record_pre_action 07:07:06 INFO - Running main action method: run_tests 07:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:07:07 INFO - Python 2.7.3 07:07:07 INFO - Return code: 0 07:07:07 INFO - grabbing minidump binary from tooltool 07:07: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')]} 07:07:07 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 0x28c23b0>, '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 0x28c32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:07:07 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 07:07:07 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 07:07:07 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 07:07:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:07:07 INFO - Return code: 0 07:07:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:07:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:07:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:07:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:07:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:07:07 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/WOnIMcsMStOKjEcRVgXp6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 07:07:07 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/WOnIMcsMStOKjEcRVgXp6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 07:07:07 INFO - Using env: {'DISPLAY': ':0', 07:07:07 INFO - 'HOME': '/home/cltbld', 07:07:07 INFO - 'LANG': 'en_US.UTF-8', 07:07:07 INFO - 'LANGUAGE': 'en_US:en', 07:07:07 INFO - 'LOGNAME': 'cltbld', 07:07:07 INFO - 'MAIL': '/var/mail/cltbld', 07:07:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:07:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:07 INFO - 'MOZ_NO_REMOTE': '1', 07:07:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:07 INFO - 'NO_EM_RESTART': '1', 07:07:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:07 INFO - 'PWD': '/builds/slave/test', 07:07:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:07:07 INFO - 'SHELL': '/bin/bash', 07:07:07 INFO - 'SHLVL': '1', 07:07:07 INFO - 'TERM': 'linux', 07:07:07 INFO - 'TMOUT': '86400', 07:07:07 INFO - 'USER': 'cltbld', 07:07:07 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1470398394.128368-488994872', 07:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:07 INFO - '_': '/tools/buildbot/bin/python'} 07:07:07 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/WOnIMcsMStOKjEcRVgXp6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 07:07:07 INFO - mozversion application_buildid: 20160805043005 07:07:07 INFO - mozversion application_changeset: 4a431f553e0c8bc5e005f5c1684d4a1da026a47a 07:07:07 INFO - mozversion application_display_name: Nightly 07:07:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:07:07 INFO - mozversion application_name: Firefox 07:07:07 INFO - mozversion application_remotingname: firefox 07:07:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:07:07 INFO - mozversion application_vendor: Mozilla 07:07:07 INFO - mozversion application_version: 51.0a1 07:07:07 INFO - mozversion platform_buildid: 20160805043005 07:07:07 INFO - mozversion platform_changeset: 4a431f553e0c8bc5e005f5c1684d4a1da026a47a 07:07:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:07:07 INFO - mozversion platform_version: 51.0a1 07:07:07 INFO - using testdate: 1470406027 07:07:07 INFO - actual date: 1470406027 07:07:07 INFO - starting webserver on 'localhost:36936' 07:07:07 INFO - SUITE-START | Running 2 tests 07:07:07 INFO - TEST-START | dromaeo_css 07:07:07 INFO - operating with platform_type : linux_ 07:07:07 INFO - Initialising browser for dromaeo_css test... 07:07:07 INFO - TEST-INFO | started process 24603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ15Vmn/profile http://localhost:36936/getInfo.html) 07:07:10 INFO - PROCESS | 24603 | __metrics Screen width/height:1600/1200 07:07:10 INFO - PROCESS | 24603 | colorDepth:24 07:07:10 INFO - PROCESS | 24603 | Browser inner width/height: 1024/697 07:07:10 INFO - PROCESS | 24603 | __metrics 07:07:11 INFO - PROCESS | 24603 | 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" 07:07:11 INFO - PROCESS | 24603 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:07:12 INFO - TEST-INFO | 24603: exit 0 07:07:12 INFO - Browser initialized. 07:07:12 INFO - Running cycle 1/1 for dromaeo_css test... 07:07:12 INFO - TEST-INFO | started process 24685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ15Vmn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:07:24 INFO - PROCESS | 24685 | RSS: Main: 156930048 07:07:24 INFO - PROCESS | 24685 | 07:08:15 INFO - PROCESS | 24685 | 1470406095893 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] 07:10:25 INFO - PROCESS | 24685 | Cycle 1(1): loaded http://localhost:36936/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36936/tests/dromaeo/cssquery-ext.html) 07:10:26 INFO - PROCESS | 24685 | RSS: Main: 272134144 07:10:26 INFO - PROCESS | 24685 | 07:13:28 INFO - PROCESS | 24685 | Cycle 1(1): loaded http://localhost:36936/tests/dromaeo/cssquery-ext.html (next: http://localhost:36936/tests/dromaeo/cssquery-jquery.html) 07:13:29 INFO - PROCESS | 24685 | RSS: Main: 243634176 07:13:29 INFO - PROCESS | 24685 | 07:16:31 INFO - PROCESS | 24685 | Cycle 1(1): loaded http://localhost:36936/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36936/tests/dromaeo/cssquery-mootools.html) 07:16:31 INFO - PROCESS | 24685 | RSS: Main: 185327616 07:16:31 INFO - PROCESS | 24685 | 07:19:33 INFO - PROCESS | 24685 | Cycle 1(1): loaded http://localhost:36936/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36936/tests/dromaeo/cssquery-prototype.html) 07:19:34 INFO - PROCESS | 24685 | RSS: Main: 230801408 07:19:34 INFO - PROCESS | 24685 | 07:22:37 INFO - PROCESS | 24685 | Cycle 1(1): loaded http://localhost:36936/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36936/tests/dromaeo/cssquery-yui.html) 07:22:37 INFO - PROCESS | 24685 | RSS: Main: 184524800 07:22:37 INFO - PROCESS | 24685 | 07:25:40 INFO - PROCESS | 24685 | Cycle 1(1): loaded http://localhost:36936/tests/dromaeo/cssquery-yui.html (next: http://localhost:36936/tests/dromaeo/cssquery-dojo.html) 07:25:41 INFO - PROCESS | 24685 | RSS: Main: 279756800 07:25:41 INFO - PROCESS | 24685 | 07:25:41 INFO - PROCESS | 24685 | __start_tp_report 07:25:41 INFO - PROCESS | 24685 | _x_x_mozilla_page_load 07:25:41 INFO - PROCESS | 24685 | _x_x_mozilla_page_load_details 07:25:41 INFO - PROCESS | 24685 | |i|pagename|runs| 07:25:41 INFO - PROCESS | 24685 | |0;dojo.html;3020.682828303027;3050.8779648814043;3052.5115981442973;3068.9232769180767;3086.0587520806152;5287.894242115155;5383.246345511622;5385.0576149173885;5456.045192091383;5471.124620060791;5315.495027972346;5370.731463426823;5419.3225846769155;5424.240606315109;5448.509634132927;4779.617630589553;4894;4902.779374928119;4905.558499735023;5093.465186155456;4991.675541089836;5022.397312322526;5031.069252188338;5051.267566202899;5057;4802.447718512363;4809.350737650408;4816.831410900601;4831.661783675144;4983.078130545842;4884.4871288514905;4887.828925987574;4889.731064791435;4891.461939186686;4987.5511203991455;4890.75546222691;4921.581665558432;4929.2113261878285;4931.408231012301;4978.253262010691;5252.1596544552685;5373.543248823855;5402.108652072403;5431.674099553999;5442.401335853053;5844.152597873284;5887.175795388649;5892.764289428418;5898.852528686774;5908.615939963888;5864.296284445851;5889.676067816268;5901.3508514063415;5911.320198177222;5940.31686356066;5186.377634683824;5310.283111779938;5340.145576707747;5345.144776835766;5412.756425960842;5851.180834683148;5905.645661260338;5908.940910590839;5921.792737254175;5922.407759224043;5652.830415087554;5655.745491452894;5677.772889084473;5691.203231547586;5708.372079071299;5634.943650563524;5680.630759000652;5712.7714891403875;5777.422257774189;5868.618539794899;5721.628094173865;5737.454941780524;5737.90979713853;5744.138379243147;5751.281089863767;5751.051076572402;5761.251037365116;5798.82603521895;5808.912866307009;5809.331926828384;4355.8475453359615;4364.3017117261725;4401.867943961686;4447.3329000650165;4462.951206466542;3965.5637879833193;3971.146203566247;3972.08642012333;4002.0995276063236;4011.1376054147913;5545.085060964896;5554.166874968706;5555.638883472642;5593.356763972195;5602.887942241132;5632.52123569493;5787.652740835563;5813.331466881278;5836.737346819404;5902.8819423611285;5518.392976772552;5519.31008623922;5521.116621340647;5521.751521181556;5554.77780888768;5065.442801291855;5076.340075790124;5080.212567052113;5082.695038297714;5121.667091639031;5819.73811178498;5880.794172203952;5908.172855800191;5917.349091600006;6109.389061093855;5778.711064446845;5779.595428319977;5782.190493330853;5782.5373970081455;5825.0388685866355;5936.079907614327;5979.701014949323;5984.97007514977;5985.551083668829;5991.161237426677;5620.12888002344;5648.774049037993;5656.3495198051105;5657.12314591239;5692.943070569241;5797.188393624981;5813.56398270123;5821.621594596338;5831.562632802472;5872.265966754156;5664.348599911063;5667.659940403589;5669.5180909621495;5674.177244299636;5676.403977582295;5490.121580547093;5543;5556.527695145958;5586.916196257141;5666.178404131296;5517.448255174611;5569.498745112959;5573.470520300565;5576.052071147996;5616.326040875121;5660.349059858169;5671.602987790815;5707.857303567444;5717.3996730342715;5719.084946408555;5527.917081243704;5541.224228607917;5561.555075593862;5580.832575022593;5661.631993920382 07:25:41 INFO - PROCESS | 24685 | |1;ext.html;581.2966310763975;603.5202014398553;609.5976655407432;612.9478994285482;616.5622408090255;32567.67432325679;33123.83438082809;35779.82110089449;35787.82106089473;35791.821040894756;48389.27416088753;49508.50491495084;49570.25644615333;49658.25512617305;49745.25382119271;9049.909500904989;9188.219001384858;9192.632294708204;9196.034416386283;9196.954015229914;9186.54067296636;9262.536873156349;9280;9284.350095493319;9284.907150928471;9348.065193480665;9382.624695012226;9383.108604682579;9387.43675379476;9392.43645381276;9269.073092690744;9322;9338.486383248952;9341.953290233574;9346.532673366304;9076.04701506339;9136.634534618608;9179.678711245075;9180.26557875375;9180.44917304964;42625.78687106576;42928.35607465891;43153.56846431527;43269.13461730779;43334.56665433337;3747.194353214072;3795.1840354323676;4206.242876282268;4291.120320334355;4317.913641727179;33152.17119572006;33531.329373412394;33961;34021.489677654856;35288;4411.228035093845;4498.055408364247;4602.562756538124;4623.86128416148;4673.462551806551;263304.68347658333;263419;263665;264334;264534;57698;58613.70693146507;59104;59153.70423147943;59176;61755.6912215436;61820;61863.38136618666;61881;61921.73665238505;16057.277422516016;16331.510054698378;16335.26491307894;16340.918295408446;16341.754873676666;12738.235705857493;12742.171758835646;12748.235105893677;12750.872491274968;12757.04322175822;14682.779758303634;16278.51164465068;16323.510294691177;16328.83671163297;16330.346786128659;6464.935350646433;6676.46588272937;6722.798316050526;6729.5625784323865;6764.2221144569;1099.725068732817;1099.9505022274018;1101.5043230546287;1105.9447027648584;1185.1052455396293;33096.50355244673;33399.66600334014;33424.66575334215;33574.664253357645;33723;1092.4592326798286;1119.227732864321;1142.520141540555;1170.6136974798296;1230.5385480444834;16937.153142342835;17477;17483.125843707763;17507.737383938995;17509.562260943578;534055;538599;538784;538808;540221;59651;59701.70149149226;59985.70007149936;59994;60177.69911150504;1260.7730608490376;1295.7084655952335;1306.9085164038615;1378.3521744780137;1394.8465668776425;29277.560836587043;33913.49129763006;34612;36295.63704362923;36720.81639591785;55917.720411397684;56705.432945670014;56782.71608642096;56791;56811.71594142003;495979;507328;507884;507962;508720;27915.302117446416;28984.42031159323;29030;30387.240318991317;41784;47769.28346074881;48419.27371089366;48558.5144148554;49252.26121608107;49722;40629;40642;41095.589044109176;43297.35053974256;45152;41862.79068604638;42892.78553607212;43003.56996429995;43081.56918430776;43712.28819053072;36374.8181259092;39663.40504892487;41706.37440438335;42754;42819;36846.631533685395;37957.43063853989;38543.614563855124;39043.609563904;39315.60684393119;28660.570091449063;28750.856245718638;28952.276193095342;28954;28955.357587219598 07:25:41 INFO - PROCESS | 24685 | |2;jquery.html;386.6481501833332;389.8693937530927;399.2514036182158;409.57608874814565;417.3843580718441;13015.93492032541;18876.905615471922;20538.99999999998;20545.691814622773;21050.263240786575;15799.92100039501;15823.446179383694;17419.30322787087;20494.69257961128;20513.58972820543;5712.685802280873;5736.311642602883;5883.323417806964;5948.434898684618;5951.018082016462;5764.394738552454;5866.120081987693;5874.441928016853;5878.088896221093;5889.8822023559505;5827.970860145693;5842.357340692521;5842.853928651775;5856.150858125569;5868.061110222366;5826.82519524415;5831.620944638585;5837.387074357195;5839.240898683186;5842.912356314638;5032.194848824171;5213.817516386908;5220.216967454874;5250.264962905197;5254.579633629339;23961.28116156518;24096.156634517884;24669.753302466925;24701.382465438328;25225.24324270275;2195.6706494025866;2415.867127307997;2417.891194896234;2426.6602675625427;2496.6504689343506;15007.099574025593;15215.08709477435;15543;15624.687506249811;16126.274317655616;1873.5409824593062;1909.8567607429497;1917.587718640499;2023.433438637184;2034.9389518314474;81807.18192818055;82149;82280.58859705663;82735;84192;10493.370397776158;10869.510872010778;10873.945630271955;10946.671599852018;11160.776784464266;15244.695106097815;15257.465988690343;15258.694826103416;15262.542123736306;15299.311530981133;8398.244158025807;8533.975922889169;8557;8691.304695624334;8705.564721763887;8168.673253069929;8360.498370097814;8373.623186956602;8534.103919088531;8613.181747733955;6686.197656281277;6720.8319792005595;6787.830304242335;6819.931800681929;6832.555883867532;1904.6190761847408;1979.544704717923;1985.463924740312;2004.3185316992292;2006.3980805758215;1026.8807000369634;1029.1766586730735;1041.1410586266209;1066.4507778494083;1081.9729506762237;19779.802201978084;20731.27440539574;21112.261070862445;21333.35999920005;21459.89270053671;1019.9796004079877;1039.5685790397051;1078.175195975064;1079.2499213047015;1142.1947526993615;11283.66149015531;11836.289822610499;11935.820962685566;11982.820257696141;12093.818592721116;491346;492615;498102;507106;507604;80655.59672201719;81405.59297203476;81607;82690;85899.14100859036;1050.4275170032352;1055.303499690216;1079.2731629392908;1079.8434227037035;1085.1427372375736;17961.73057404114;18295.908520457313;18936.43190704281;18971.62056758885;19214.615707686047;40049.399259010555;42043;43206;43414;43639;57306.713466432404;59716.402835972825;59859.40140598538;61378.693106534185;61944.380556193864;8114.148014458397;8244.258016778518;8393.454425462325;8478.23695867375;8630.697925572826;9278.860817087614;12447.377631118226;13042.608721738363;13167.53913613019;13811.792823107862;11952.223105498115;11969;11992.760144796881;12113.818292725793;12367.93816030914;5878.882422351444;8932.794072800089;11713.1800773945;11765.941065304163;11989.280643161439;11124.443777811239;11956.940215298868;12176.817347739969;12415.689607759878;12757.808632870328;8191.918080819116;8202.548859812767;8368;8519.574021298786;8795;11488.368139752394;11723.882761172279;11999.220050696676;12001.39993000329;12423.254604723745 07:25:41 INFO - PROCESS | 24685 | |3;mootools.html;1334.8665133486659;1472.646564824442;1510.1694068262457;1624.3421414327195;1800.9639807203848;8224.958875205622;8553.144685531452;8553.358498112635;8789.604467798948;8819.691310804123;8678.783030424243;8747.562621868912;8767.824643507127;8770.166834150761;8820.382573219877;2020.0808632072371;2278.9202377916777;2402.3873912152376;2427.4416884116663;2430.4895971845935;2326.348622385735;2379.0602711928777;2383.940401489968;2385.6063749481314;2387.2957477544164;2303.884805759714;2307.5038866643667;2321.8955147018423;2323.860568365895;2349.3891588187107;1930.4691209917244;1996.0518753591928;2247.045005872506;2247.6179049561615;2250.3923940536047;2062;2232.2075663139512;2299.482616411294;2302;2346.378209774411;8853.645854165825;8911.509866957314;8911.643534258621;8921.732348029505;8938.46369217849;5137.691738495702;5262.789488420459;5267.446918073585;5271.789128434858;5273.472652734734;3562.109472631842;3607.5670919489567;3669.614690457517;3697.3899306614376;3713.350163721338;1235.8578763442229;1248.4194849394985;1253.7367152897903;1270.091884302728;1304.5499302740538;12165.695857603541;12174;12176.756464870654;12204.145709800407;12205.680920625053;4433.556644335541;4704.082703872712;4794.137055330004;4857.077155340474;4861.51384861511;10197.898021019695;10259.333143345659;10261.333013354108;10264.332818366782;10275.280730348954;5324.866878328073;5325.307709997675;5327.893442131136;5328.3605967284175;5330.7068111253475;4284.121755040209;4699.271612900006;4748.169070412664;4913.631477639191;4916.680415772963;3877.6703980162;3944.684425245973;3981.442598036277;4030.052937559671;4056.5334986476932;1203.6328919679581;1227.2636418149038;1237.208186760474;1248.619171152789;1253.4484826676232;976.1458723616835;979.8285300072458;995.0596686131536;997.7306127345576;1014.8680671512803;5855.736491857791;5952.345242023374;6008.879822403527;6111.480524155497;6149.569530132937;986.9225280783846;1006.6561140876865;1017.8422344536609;1020.8877023527406;1040.095117247999;4103.958960410358;4215.241256573785;4264.381664658607;4320.719153255029;4344.978275108604;10688.572457101784;10992.395418251914;11031.503582338813;11032.724181895517;11036.558537658564;10857.45712714361;10959.452027398598;10986.780264394667;10994.28537145083;11001.889981100087;8179.918200817916;8206.753797386087;8333.791655208546;8346.081930987586;8395.370347223983;6208.503319734501;6222.408871157233;6256.937430625636;6282.874342513215;6286.214223222098;10122.443265620166;10124.341917775615;10140.188784897338;10160;10168.949155254473;10073.531984663805;10104.545295461576;10223.591056357662;10331.070203681706;10354.1198998083;6584.604923704593;7141.750038748619;7339.77980660581;7409;7518.548887066793;8961.686340978034;9040.954795226246;9054.094590540893;9054.366194366332;9055.728328150166;7745.457817952689;7765.572893490912;7873.133955265031;8012.95993520052;8027.719029833927;7436.702531898663;7599.734009309647;7610.162882083077;7679.884801727867;8006.03927528677;7409.110906691231;7527.134379546423;7528.548287102792;7544.0569928758905;7546.509476883985;5302.257683924331;5316.415194328698;5387.407385187548;5416.2688037114485;5545;5314.335708036496;5356.089464791073;5395.676259424447;5444;5586.52514536269 07:25:41 INFO - PROCESS | 24685 | |4;prototype.html;322.63219929280626;331.2364998678047;340.613403786702;340.9829508524573;344.63296589132574;5261.685138362831;5305.840824775258;5343.812966546172;5382.703951282683;5404.1355732272405;4997.575206107485;5138.48615138486;5141.665791723544;5143.639945203838;5292.523672869441;4038.6567141792834;4091.9999999999927;4106.301928672133;4151.335786274197;4155.522114956773;4143.357779544175;4144.813483393239;4153.688473364495;4161.292580261363;4191.224623444673;4056.574059723731;4113.629773320401;4117.711760176789;4128.3601041838565;4161.771102589371;4128.401381799622;4145.937810932838;4149.83400663973;4157.916841663165;4179.665626749868;3714.4242642390473;3715.5912849586525;3721.6836568891677;3724.8080614203463;3745.8501659933568;5092.236164575306;5099.056674515226;5233.371995360543;5237.162054071368;5251.10731175701;4699.647526435497;4740.336352910595;4769.95230047702;4788.11419887322;4788.4253889533475;5497.505224529771;5498.80754173602;5505.504504594605;5530.806421775219;5572.916406253909;3945.191235796655;4025.194961007781;4049.311617025113;4054.776987265699;4059.4925634295714;5650.29371328584;5662.546996240291;5667.971660141673;5681.23303354046;5683.943160568424;4105.220008198433;4124.443200167999;4128.958710412918;4140.834366625361;4141.0330093206085;4035.455213546192;4218.451601291812;4221.641160501392;4222.345536441795;4225.598568136023;4682.391289132459;4692.7653617319;4709.788059537329;4787.976060119677;4790.257510085942;5552.52803511706;5553.361363443175;5569.721513924287;5572.442755724476;5611.242482264842;1359.626102821732;1428.2858570714643;1438.9712205755827;1445.9204743739194;1448.594393569781;902.6299217320867;919.7884486567993;929.6885543343055;930.265090578449;931.5621657820814;4661.347411362344;4686.406621748622;4687.507811679793;4697.074199578156;4745.786439610226;4589.839355622537;4944;4959.231319145538;4981.576565991859;5002.2496625506465;4606.838760643362;4653.627709783209;4660.347551342815;4666.230072038075;4692.536418380378;2652.986735066351;2655.924350637995;2660.2418310781336;2679.289988153141;2688.8521131337966;4936.2102063669645;4938;5125.308083408767;5155.819546315861;5174.327337446183;5002.424721157041;5032.723200224023;5033.345665063518;5039.370078740158;5040.31955685985;5076.619253555924;5107.284980102789;5117.488251174853;5137.897242055213;5156.2929462032735;4815.277708343777;4890.168671325812;4923.729194894315;4980.431164183271;5001.449840517613;4870.659053866337;4894.804207831647;4900.509949005071;4902.117618828503;4902.803887844446;5050.595952323879;5056.508330042573;5119.334486516729;5130.51215147603;5166.121759300852;3571.3035957987945;3695.6304369562827;3712.8514859405323;3737.2712321097124;3747.9250414992093;4895.363602731764;5392.514673679388;5540.806071787468;5555.444455554412;5558.527525160407;5500.642458240201;5510.476504732044;5514.80698175562;5527.834164974896;5541;5222.634415590872;5493.148561972901;5494.80768173112;5528.281323427928;5543.805966791143;5424.701641409602;5470.070088085115;5477;5487.917681234705;5488.286522752017;5542.750576223999;5558.583106267127;5576.163575463713;5586.435797976573;5600.85997850057;5169.586433085419;5416.783328666809;5446.183072538993;5471.124620060771;5496.258005169411 07:25:41 INFO - PROCESS | 24685 | |5;yui.html;766.540075954427;798.9440739148258;814.3485211830535;843.3632607381426;889.2930120554158;15799.526014219577;17576.472705818815;17583.472495825114;17585.999999999985;17591.560210994714;15956.601084972881;16049.598760031005;16109.597260068504;16117.758233626504;16122.113283769388;671.2549070531705;813.5403497024192;834.1783343406739;838.174398217755;844.3329769482102;835.5947365527715;836.5440834745048;838.1576515601812;838.4089217101958;838.576518857979;882.3955590420551;890.3144578674417;890.461270931087;890.5769759364315;891.2157301574638;706.3960313931592;856.9271611912994;878.3412440669498;880.5861245214738;883.6244596046687;643.2056410333234;645.3256347117274;649.7206201333424;649.746598826458;650.0152269311997;15323.31045102973;15369.308381122877;15374.154421506813;15382.153981531012;15392.769108463383;14240.145591264558;14599.416023359054;14853.405863765436;14904.403823847033;14966.47617333399;13041.217526948414;13051.673708157277;13226.933865330708;13405.46378144873;13431.597052088453;4396.362527433536;4626.930596041062;4704.200285951397;4715.481297057321;4727;82812.58593707053;82987;83790.16209837885;84115;84180.57909710474;10982.725431864108;11493.138014648935;11512.88487115135;11833.467493962793;12163.391830408444;21968.89015554912;21983;22076.11695532193;22085;22123.115075397127;8809.647614095493;8851.645934162561;8882.733517994471;9027.593758280893;9053.59258833354;4797.496262892346;4859.319695242669;4874.293227481995;4934.9753251233515;4948.109340318777;3470.9305813884084;3532.717382609385;3575.4636804479014;3584.444411116281;3585.103724068983;642.2742301199708;646.4149944300416;654.9672516374162;665.3180489997694;668.2515582547578;571.0710313046216;653.8659574787157;683.9897401538981;686.1526015371013;696.4706822814596;9024;9521.714348569554;9651.54660732157;9771.560279787427;10004.599816007278;671.1208317104608;684.4387602166275;685.674304705261;690.3407246079981;700.8212905709012;4373.562643735665;4409.647228221735;4623.260278355447;4773.71357718538;4813.542713442217;77724.61137694275;110981.44509277403;125675;133235;138434.3078284602;113295.86704133017;114377;115282;115627;118456;70397.64801175961;93032;93438;95137;95572;8819.162179592928;8881.866771998555;8935.335599107748;8942.597583108645;9010.63957441695;54410.72794636001;55022.5239864199;55044;55120.72439637776;58606;75015;81457.18542814734;81811;83267.16732832594;86278.56860715656;12174.873831636327;12329.445174966968;12501.187422817487;12532.060095493056;12902.645222251529;13149.53976610814;13185.736285274432;13576.86423135756;13874.375653095432;13875.861241387456;12768.170068945488;13208.933955330162;13238.735225295248;13592.66018349549;13706.109102908278;12659.87340126587;13037.348132593523;13078.888294495075;13211.273379964194;13554.86445135536;12088.75822483563;12189.146759726735;12343.444544995316;12425.254484730945;12737.172083814523;10081.596736130472;10084.394936303845;10336.249017324899;10341.276110672181;10444.738881527719;9681.467519286507;9944.701658950244;10182.694519164437;10248.38509689421;10396.58413663445 07:25:41 INFO - PROCESS | 24685 | __end_tp_report 07:25:41 INFO - PROCESS | 24685 | __start_cc_report 07:25:41 INFO - PROCESS | 24685 | _x_x_mozilla_cycle_collect,1040 07:25:41 INFO - PROCESS | 24685 | __end_cc_report 07:25:41 INFO - PROCESS | 24685 | __startTimestamp1470407141008__endTimestamp 07:25:41 INFO - PROCESS | 24685 | 07:25:41 INFO - PROCESS | 24685 | ------- Summary: start ------- 07:25:41 INFO - PROCESS | 24685 | Number of tests: 6 07:25:41 INFO - PROCESS | 24685 | 07:25:41 INFO - PROCESS | 24685 | [#0] dojo.html Cycles:165 Average:5376.62 Median:5576.05 stddev:615.76 (11.0%) stddev-sans-first:589.26 07:25:41 INFO - PROCESS | 24685 | Values: 3020.7 3050.9 3052.5 3068.9 3086.1 5287.9 5383.2 5385.1 5456.0 5471.1 5315.5 5370.7 5419.3 5424.2 5448.5 4779.6 4894.0 4902.8 4905.6 5093.5 4991.7 5022.4 5031.1 5051.3 5057.0 4802.4 4809.4 4816.8 4831.7 4983.1 4884.5 4887.8 4889.7 4891.5 4987.6 4890.8 4921.6 4929.2 4931.4 4978.3 5252.2 5373.5 5402.1 5431.7 5442.4 5844.2 5887.2 5892.8 5898.9 5908.6 5864.3 5889.7 5901.4 5911.3 5940.3 5186.4 5310.3 5340.1 5345.1 5412.8 5851.2 5905.6 5908.9 5921.8 5922.4 5652.8 5655.7 5677.8 5691.2 5708.4 5634.9 5680.6 5712.8 5777.4 5868.6 5721.6 5737.5 5737.9 5744.1 5751.3 5751.1 5761.3 5798.8 5808.9 5809.3 4355.8 4364.3 4401.9 4447.3 4463.0 3965.6 3971.1 3972.1 4002.1 4011.1 5545.1 5554.2 5555.6 5593.4 5602.9 5632.5 5787.7 5813.3 5836.7 5902.9 5518.4 5519.3 5521.1 5521.8 5554.8 5065.4 5076.3 5080.2 5082.7 5121.7 5819.7 5880.8 5908.2 5917.3 6109.4 5778.7 5779.6 5782.2 5782.5 5825.0 5936.1 5979.7 5985.0 5985.6 5991.2 5620.1 5648.8 5656.3 5657.1 5692.9 5797.2 5813.6 5821.6 5831.6 5872.3 5664.3 5667.7 5669.5 5674.2 5676.4 5490.1 5543.0 5556.5 5586.9 5666.2 5517.4 5569.5 5573.5 5576.1 5616.3 5660.3 5671.6 5707.9 5717.4 5719.1 5527.9 5541.2 5561.6 5580.8 5661.6 07:25:41 INFO - PROCESS | 24685 | 07:25:41 INFO - PROCESS | 24685 | [#1] ext.html Cycles:180 Average:60409.66 Median:42965.96 stddev:120394.98 (280.2%) stddev-sans-first:120648.92 07:25:41 INFO - PROCESS | 24685 | Values: 581.3 603.5 609.6 612.9 616.6 32567.7 33123.8 35779.8 35787.8 35791.8 48389.3 49508.5 49570.3 49658.3 49745.3 9049.9 9188.2 9192.6 9196.0 9197.0 9186.5 9262.5 9280.0 9284.4 9284.9 9348.1 9382.6 9383.1 9387.4 9392.4 9269.1 9322.0 9338.5 9342.0 9346.5 9076.0 9136.6 9179.7 9180.3 9180.4 42625.8 42928.4 43153.6 43269.1 43334.6 3747.2 3795.2 4206.2 4291.1 4317.9 33152.2 33531.3 33961.0 34021.5 35288.0 4411.2 4498.1 4602.6 4623.9 4673.5 263304.7 263419.0 263665.0 264334.0 264534.0 57698.0 58613.7 59104.0 59153.7 59176.0 61755.7 61820.0 61863.4 61881.0 61921.7 16057.3 16331.5 16335.3 16340.9 16341.8 12738.2 12742.2 12748.2 12750.9 12757.0 14682.8 16278.5 16323.5 16328.8 16330.3 6464.9 6676.5 6722.8 6729.6 6764.2 1099.7 1100.0 1101.5 1105.9 1185.1 33096.5 33399.7 33424.7 33574.7 33723.0 1092.5 1119.2 1142.5 1170.6 1230.5 16937.2 17477.0 17483.1 17507.7 17509.6 534055.0 538599.0 538784.0 538808.0 540221.0 59651.0 59701.7 59985.7 59994.0 60177.7 1260.8 1295.7 1306.9 1378.4 1394.8 29277.6 33913.5 34612.0 36295.6 36720.8 55917.7 56705.4 56782.7 56791.0 56811.7 495979.0 507328.0 507884.0 507962.0 508720.0 27915.3 28984.4 29030.0 30387.2 41784.0 47769.3 48419.3 48558.5 49252.3 49722.0 40629.0 40642.0 41095.6 43297.4 45152.0 41862.8 42892.8 43003.6 43081.6 43712.3 36374.8 39663.4 41706.4 42754.0 42819.0 36846.6 37957.4 38543.6 39043.6 39315.6 28660.6 28750.9 28952.3 28954.0 28955.4 07:25:41 INFO - PROCESS | 24685 | 07:25:41 INFO - PROCESS | 24685 | [#2] jquery.html Cycles:180 Average:29412.50 Median:2416.88 stddev:82102.58 (3397.0%) stddev-sans-first:82303.97 07:25:41 INFO - PROCESS | 24685 | Values: 386.6 389.9 399.3 409.6 417.4 13015.9 18876.9 20539.0 20545.7 21050.3 15799.9 15823.4 17419.3 20494.7 20513.6 5712.7 5736.3 5883.3 5948.4 5951.0 5764.4 5866.1 5874.4 5878.1 5889.9 5828.0 5842.4 5842.9 5856.2 5868.1 5826.8 5831.6 5837.4 5839.2 5842.9 5032.2 5213.8 5220.2 5250.3 5254.6 23961.3 24096.2 24669.8 24701.4 25225.2 2195.7 2415.9 2417.9 2426.7 2496.7 15007.1 15215.1 15543.0 15624.7 16126.3 1873.5 1909.9 1917.6 2023.4 2034.9 81807.2 82149.0 82280.6 82735.0 84192.0 10493.4 10869.5 10873.9 10946.7 11160.8 15244.7 15257.5 15258.7 15262.5 15299.3 8398.2 8534.0 8557.0 8691.3 8705.6 8168.7 8360.5 8373.6 8534.1 8613.2 6686.2 6720.8 6787.8 6819.9 6832.6 1904.6 1979.5 1985.5 2004.3 2006.4 1026.9 1029.2 1041.1 1066.5 1082.0 19779.8 20731.3 21112.3 21333.4 21459.9 1020.0 1039.6 1078.2 1079.2 1142.2 11283.7 11836.3 11935.8 11982.8 12093.8 491346.0 492615.0 498102.0 507106.0 507604.0 80655.6 81405.6 81607.0 82690.0 85899.1 1050.4 1055.3 1079.3 1079.8 1085.1 17961.7 18295.9 18936.4 18971.6 19214.6 40049.4 42043.0 43206.0 43414.0 43639.0 57306.7 59716.4 59859.4 61378.7 61944.4 8114.1 8244.3 8393.5 8478.2 8630.7 9278.9 12447.4 13042.6 13167.5 13811.8 11952.2 11969.0 11992.8 12113.8 12367.9 5878.9 8932.8 11713.2 11765.9 11989.3 11124.4 11956.9 12176.8 12415.7 12757.8 8191.9 8202.5 8368.0 8519.6 8795.0 11488.4 11723.9 11999.2 12001.4 12423.3 07:25:41 INFO - PROCESS | 24685 | 07:25:41 INFO - PROCESS | 24685 | [#3] mootools.html Cycles:180 Average:5860.12 Median:4389.27 stddev:3298.13 (75.1%) stddev-sans-first:3289.84 07:25:41 INFO - PROCESS | 24685 | Values: 1334.9 1472.6 1510.2 1624.3 1801.0 8225.0 8553.1 8553.4 8789.6 8819.7 8678.8 8747.6 8767.8 8770.2 8820.4 2020.1 2278.9 2402.4 2427.4 2430.5 2326.3 2379.1 2383.9 2385.6 2387.3 2303.9 2307.5 2321.9 2323.9 2349.4 1930.5 1996.1 2247.0 2247.6 2250.4 2062.0 2232.2 2299.5 2302.0 2346.4 8853.6 8911.5 8911.6 8921.7 8938.5 5137.7 5262.8 5267.4 5271.8 5273.5 3562.1 3607.6 3669.6 3697.4 3713.4 1235.9 1248.4 1253.7 1270.1 1304.5 12165.7 12174.0 12176.8 12204.1 12205.7 4433.6 4704.1 4794.1 4857.1 4861.5 10197.9 10259.3 10261.3 10264.3 10275.3 5324.9 5325.3 5327.9 5328.4 5330.7 4284.1 4699.3 4748.2 4913.6 4916.7 3877.7 3944.7 3981.4 4030.1 4056.5 1203.6 1227.3 1237.2 1248.6 1253.4 976.1 979.8 995.1 997.7 1014.9 5855.7 5952.3 6008.9 6111.5 6149.6 986.9 1006.7 1017.8 1020.9 1040.1 4104.0 4215.2 4264.4 4320.7 4345.0 10688.6 10992.4 11031.5 11032.7 11036.6 10857.5 10959.5 10986.8 10994.3 11001.9 8179.9 8206.8 8333.8 8346.1 8395.4 6208.5 6222.4 6256.9 6282.9 6286.2 10122.4 10124.3 10140.2 10160.0 10168.9 10073.5 10104.5 10223.6 10331.1 10354.1 6584.6 7141.8 7339.8 7409.0 7518.5 8961.7 9041.0 9054.1 9054.4 9055.7 7745.5 7765.6 7873.1 8013.0 8027.7 7436.7 7599.7 7610.2 7679.9 8006.0 7409.1 7527.1 7528.5 7544.1 7546.5 5302.3 5316.4 5387.4 5416.3 5545.0 5314.3 5356.1 5395.7 5444.0 5586.5 07:25:41 INFO - PROCESS | 24685 | 07:25:41 INFO - PROCESS | 24685 | [#4] prototype.html Cycles:180 Average:4465.26 Median:4937.11 stddev:1274.45 (25.8%) stddev-sans-first:1239.52 07:25:41 INFO - PROCESS | 24685 | Values: 322.6 331.2 340.6 341.0 344.6 5261.7 5305.8 5343.8 5382.7 5404.1 4997.6 5138.5 5141.7 5143.6 5292.5 4038.7 4092.0 4106.3 4151.3 4155.5 4143.4 4144.8 4153.7 4161.3 4191.2 4056.6 4113.6 4117.7 4128.4 4161.8 4128.4 4145.9 4149.8 4157.9 4179.7 3714.4 3715.6 3721.7 3724.8 3745.9 5092.2 5099.1 5233.4 5237.2 5251.1 4699.6 4740.3 4770.0 4788.1 4788.4 5497.5 5498.8 5505.5 5530.8 5572.9 3945.2 4025.2 4049.3 4054.8 4059.5 5650.3 5662.5 5668.0 5681.2 5683.9 4105.2 4124.4 4129.0 4140.8 4141.0 4035.5 4218.5 4221.6 4222.3 4225.6 4682.4 4692.8 4709.8 4788.0 4790.3 5552.5 5553.4 5569.7 5572.4 5611.2 1359.6 1428.3 1439.0 1445.9 1448.6 902.6 919.8 929.7 930.3 931.6 4661.3 4686.4 4687.5 4697.1 4745.8 4589.8 4944.0 4959.2 4981.6 5002.2 4606.8 4653.6 4660.3 4666.2 4692.5 2653.0 2655.9 2660.2 2679.3 2688.9 4936.2 4938.0 5125.3 5155.8 5174.3 5002.4 5032.7 5033.3 5039.4 5040.3 5076.6 5107.3 5117.5 5137.9 5156.3 4815.3 4890.2 4923.7 4980.4 5001.4 4870.7 4894.8 4900.5 4902.1 4902.8 5050.6 5056.5 5119.3 5130.5 5166.1 3571.3 3695.6 3712.9 3737.3 3747.9 4895.4 5392.5 5540.8 5555.4 5558.5 5500.6 5510.5 5514.8 5527.8 5541.0 5222.6 5493.1 5494.8 5528.3 5543.8 5424.7 5470.1 5477.0 5487.9 5488.3 5542.8 5558.6 5576.2 5586.4 5600.9 5169.6 5416.8 5446.2 5471.1 5496.3 07:25:41 INFO - PROCESS | 24685 | 07:25:41 INFO - PROCESS | 24685 | [#5] yui.html Cycles:180 Average:21951.40 Median:4750.36 stddev:32679.18 (687.9%) stddev-sans-first:32732.14 07:25:41 INFO - PROCESS | 24685 | Values: 766.5 798.9 814.3 843.4 889.3 15799.5 17576.5 17583.5 17586.0 17591.6 15956.6 16049.6 16109.6 16117.8 16122.1 671.3 813.5 834.2 838.2 844.3 835.6 836.5 838.2 838.4 838.6 882.4 890.3 890.5 890.6 891.2 706.4 856.9 878.3 880.6 883.6 643.2 645.3 649.7 649.7 650.0 15323.3 15369.3 15374.2 15382.2 15392.8 14240.1 14599.4 14853.4 14904.4 14966.5 13041.2 13051.7 13226.9 13405.5 13431.6 4396.4 4626.9 4704.2 4715.5 4727.0 82812.6 82987.0 83790.2 84115.0 84180.6 10982.7 11493.1 11512.9 11833.5 12163.4 21968.9 21983.0 22076.1 22085.0 22123.1 8809.6 8851.6 8882.7 9027.6 9053.6 4797.5 4859.3 4874.3 4935.0 4948.1 3470.9 3532.7 3575.5 3584.4 3585.1 642.3 646.4 655.0 665.3 668.3 571.1 653.9 684.0 686.2 696.5 9024.0 9521.7 9651.5 9771.6 10004.6 671.1 684.4 685.7 690.3 700.8 4373.6 4409.6 4623.3 4773.7 4813.5 77724.6 110981.4 125675.0 133235.0 138434.3 113295.9 114377.0 115282.0 115627.0 118456.0 70397.6 93032.0 93438.0 95137.0 95572.0 8819.2 8881.9 8935.3 8942.6 9010.6 54410.7 55022.5 55044.0 55120.7 58606.0 75015.0 81457.2 81811.0 83267.2 86278.6 12174.9 12329.4 12501.2 12532.1 12902.6 13149.5 13185.7 13576.9 13874.4 13875.9 12768.2 13208.9 13238.7 13592.7 13706.1 12659.9 13037.3 13078.9 13211.3 13554.9 12088.8 12189.1 12343.4 12425.3 12737.2 10081.6 10084.4 10336.2 10341.3 10444.7 9681.5 9944.7 10182.7 10248.4 10396.6 07:25:41 INFO - PROCESS | 24685 | -------- Summary: end -------- 07:25:41 INFO - PROCESS | 24685 | 07:25:41 INFO - TEST-INFO | 24685: exit 0 07:25:41 INFO - TEST-OK | dromaeo_css | took 1114439ms 07:25:41 INFO - TEST-START | kraken 07:25:41 INFO - operating with platform_type : linux_ 07:25:41 INFO - Initialising browser for kraken test... 07:25:41 INFO - TEST-INFO | started process 25002 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppmS1lw/profile http://localhost:36936/getInfo.html) 07:25:45 INFO - PROCESS | 25002 | __metrics Screen width/height:1600/1200 07:25:45 INFO - PROCESS | 25002 | colorDepth:24 07:25:45 INFO - PROCESS | 25002 | Browser inner width/height: 1024/697 07:25:45 INFO - PROCESS | 25002 | __metrics 07:25:46 INFO - PROCESS | 25002 | 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" 07:25:46 INFO - PROCESS | 25002 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:25:46 INFO - TEST-INFO | 25002: exit 0 07:25:46 INFO - Browser initialized. 07:25:46 INFO - Running cycle 1/1 for kraken test... 07:25:46 INFO - TEST-INFO | started process 25086 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppmS1lw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:58 INFO - PROCESS | 25086 | RSS: Main: 156831744 07:25:58 INFO - PROCESS | 25086 | 07:26:01 INFO - PROCESS | 25086 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36936/tests/kraken/driver.html?testName=audio-beat-detection) 07:26:02 INFO - PROCESS | 25086 | RSS: Main: 213520384 07:26:02 INFO - PROCESS | 25086 | 07:26:04 INFO - PROCESS | 25086 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36936/tests/kraken/driver.html?testName=audio-dft) 07:26:05 INFO - PROCESS | 25086 | RSS: Main: 192081920 07:26:05 INFO - PROCESS | 25086 | 07:26:08 INFO - PROCESS | 25086 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36936/tests/kraken/driver.html?testName=audio-fft) 07:26:09 INFO - PROCESS | 25086 | RSS: Main: 269852672 07:26:09 INFO - PROCESS | 25086 | 07:26:11 INFO - PROCESS | 25086 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36936/tests/kraken/driver.html?testName=audio-oscillator) 07:26:11 INFO - PROCESS | 25086 | RSS: Main: 180039680 07:26:11 INFO - PROCESS | 25086 | 07:26:13 INFO - PROCESS | 25086 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36936/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:26:14 INFO - PROCESS | 25086 | RSS: Main: 184258560 07:26:14 INFO - PROCESS | 25086 | 07:26:17 INFO - PROCESS | 25086 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36936/tests/kraken/driver.html?testName=imaging-darkroom) 07:26:18 INFO - PROCESS | 25086 | RSS: Main: 219365376 07:26:18 INFO - PROCESS | 25086 | 07:26:21 INFO - PROCESS | 25086 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36936/tests/kraken/driver.html?testName=imaging-desaturate) 07:26:22 INFO - PROCESS | 25086 | RSS: Main: 220213248 07:26:22 INFO - PROCESS | 25086 | 07:26:24 INFO - PROCESS | 25086 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36936/tests/kraken/driver.html?testName=json-parse-financial) 07:26:25 INFO - PROCESS | 25086 | RSS: Main: 219803648 07:26:25 INFO - PROCESS | 25086 | 07:26:26 INFO - PROCESS | 25086 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36936/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:26:27 INFO - PROCESS | 25086 | RSS: Main: 184442880 07:26:27 INFO - PROCESS | 25086 | 07:26:29 INFO - PROCESS | 25086 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36936/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:26:29 INFO - PROCESS | 25086 | RSS: Main: 190091264 07:26:29 INFO - PROCESS | 25086 | 07:26:31 INFO - PROCESS | 25086 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36936/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:26:32 INFO - PROCESS | 25086 | RSS: Main: 194494464 07:26:32 INFO - PROCESS | 25086 | 07:26:35 INFO - PROCESS | 25086 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36936/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:26:35 INFO - PROCESS | 25086 | RSS: Main: 189632512 07:26:35 INFO - PROCESS | 25086 | 07:26:38 INFO - PROCESS | 25086 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36936/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:26:38 INFO - PROCESS | 25086 | RSS: Main: 192978944 07:26:38 INFO - PROCESS | 25086 | 07:26:40 INFO - PROCESS | 25086 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36936/tests/kraken/driver.html?testName=ai-astar) 07:26:40 INFO - PROCESS | 25086 | RSS: Main: 243638272 07:26:40 INFO - PROCESS | 25086 | 07:26:40 INFO - PROCESS | 25086 | __start_tp_report 07:26:40 INFO - PROCESS | 25086 | _x_x_mozilla_page_load 07:26:40 INFO - PROCESS | 25086 | _x_x_mozilla_page_load_details 07:26:40 INFO - PROCESS | 25086 | |i|pagename|runs| 07:26:40 INFO - PROCESS | 25086 | |0;ai-astar;105;111;114;110;112;110;110;110;113;112 07:26:40 INFO - PROCESS | 25086 | |1;audio-beat-detection;151;117;119;169;119;122;147;120;151;119 07:26:40 INFO - PROCESS | 25086 | |2;audio-dft;162;162;160;161;161;161;161;162;163;161 07:26:40 INFO - PROCESS | 25086 | |3;audio-fft;75;76;76;114;74;75;74;76;111;75 07:26:40 INFO - PROCESS | 25086 | |4;audio-oscillator;84;85;115;83;84;84;118;83;83;128 07:26:40 INFO - PROCESS | 25086 | |5;imaging-gaussian-blur;117;117;118;116;117;116;117;117;117;117 07:26:40 INFO - PROCESS | 25086 | |6;imaging-darkroom;145;145;146;147;146;146;146;146;146;145 07:26:40 INFO - PROCESS | 25086 | |7;imaging-desaturate;96;95;96;95;96;95;95;95;95;95 07:26:40 INFO - PROCESS | 25086 | |8;json-parse-financial;51;50;49;49;50;52;49;49;49;49 07:26:40 INFO - PROCESS | 25086 | |9;json-stringify-tinderbox;62;61;62;61;62;61;62;62;62;61 07:26:40 INFO - PROCESS | 25086 | |10;stanford-crypto-aes;77;76;75;75;79;75;75;75;78;80 07:26:40 INFO - PROCESS | 25086 | |11;stanford-crypto-ccm;121;118;119;118;120;120;119;119;159;130 07:26:40 INFO - PROCESS | 25086 | |12;stanford-crypto-pbkdf2;156;158;161;157;158;161;157;158;155;159 07:26:40 INFO - PROCESS | 25086 | |13;stanford-crypto-sha256-iterative;63;62;62;61;63;63;66;61;60;65 07:26:40 INFO - PROCESS | 25086 | __end_tp_report 07:26:40 INFO - PROCESS | 25086 | __start_cc_report 07:26:40 INFO - PROCESS | 25086 | _x_x_mozilla_cycle_collect,1652 07:26:40 INFO - PROCESS | 25086 | __end_cc_report 07:26:40 INFO - PROCESS | 25086 | __startTimestamp1470407200909__endTimestamp 07:26:40 INFO - PROCESS | 25086 | 07:26:40 INFO - PROCESS | 25086 | ------- Summary: start ------- 07:26:40 INFO - PROCESS | 25086 | Number of tests: 14 07:26:40 INFO - PROCESS | 25086 | 07:26:40 INFO - PROCESS | 25086 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:2.45 (2.2%) stddev-sans-first:1.50 07:26:40 INFO - PROCESS | 25086 | Values: 105.0 111.0 114.0 110.0 112.0 110.0 110.0 110.0 113.0 112.0 07:26:40 INFO - PROCESS | 25086 | 07:26:40 INFO - PROCESS | 25086 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:134.50 stddev:19.07 (14.2%) stddev-sans-first:19.13 07:26:40 INFO - PROCESS | 25086 | Values: 151.0 117.0 119.0 169.0 119.0 122.0 147.0 120.0 151.0 119.0 07:26:40 INFO - PROCESS | 25086 | 07:26:40 INFO - PROCESS | 25086 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 07:26:40 INFO - PROCESS | 25086 | Values: 162.0 162.0 160.0 161.0 161.0 161.0 161.0 162.0 163.0 161.0 07:26:40 INFO - PROCESS | 25086 | 07:26:40 INFO - PROCESS | 25086 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:15.79 (21.1%) stddev-sans-first:16.51 07:26:40 INFO - PROCESS | 25086 | Values: 75.0 76.0 76.0 114.0 74.0 75.0 74.0 76.0 111.0 75.0 07:26:40 INFO - PROCESS | 25086 | 07:26:40 INFO - PROCESS | 25086 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:83.50 stddev:17.99 (21.5%) stddev-sans-first:18.66 07:26:40 INFO - PROCESS | 25086 | Values: 84.0 85.0 115.0 83.0 84.0 84.0 118.0 83.0 83.0 128.0 07:26:40 INFO - PROCESS | 25086 | 07:26:40 INFO - PROCESS | 25086 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:26:40 INFO - PROCESS | 25086 | Values: 117.0 117.0 118.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 07:26:40 INFO - PROCESS | 25086 | 07:26:40 INFO - PROCESS | 25086 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 07:26:40 INFO - PROCESS | 25086 | Values: 145.0 145.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 145.0 07:26:40 INFO - PROCESS | 25086 | 07:26:40 INFO - PROCESS | 25086 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 07:26:40 INFO - PROCESS | 25086 | Values: 96.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 07:26:40 INFO - PROCESS | 25086 | 07:26:40 INFO - PROCESS | 25086 | [#8] json-parse-financial Cycles:10 Average:49.70 Median:49.50 stddev:1.06 (2.1%) stddev-sans-first:1.01 07:26:40 INFO - PROCESS | 25086 | Values: 51.0 50.0 49.0 49.0 50.0 52.0 49.0 49.0 49.0 49.0 07:26:40 INFO - PROCESS | 25086 | 07:26:40 INFO - PROCESS | 25086 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 07:26:40 INFO - PROCESS | 25086 | Values: 62.0 61.0 62.0 61.0 62.0 61.0 62.0 62.0 62.0 61.0 07:26:40 INFO - PROCESS | 25086 | 07:26:40 INFO - PROCESS | 25086 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:76.50 stddev:1.90 (2.5%) stddev-sans-first:2.01 07:26:40 INFO - PROCESS | 25086 | Values: 77.0 76.0 75.0 75.0 79.0 75.0 75.0 75.0 78.0 80.0 07:26:40 INFO - PROCESS | 25086 | 07:26:40 INFO - PROCESS | 25086 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:120.00 stddev:12.68 (10.6%) stddev-sans-first:13.40 07:26:40 INFO - PROCESS | 25086 | Values: 121.0 118.0 119.0 118.0 120.0 120.0 119.0 119.0 159.0 130.0 07:26:40 INFO - PROCESS | 25086 | 07:26:40 INFO - PROCESS | 25086 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:158.00 stddev:1.94 (1.2%) stddev-sans-first:1.92 07:26:40 INFO - PROCESS | 25086 | Values: 156.0 158.0 161.0 157.0 158.0 161.0 157.0 158.0 155.0 159.0 07:26:40 INFO - PROCESS | 25086 | 07:26:40 INFO - PROCESS | 25086 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.84 (2.9%) stddev-sans-first:1.94 07:26:40 INFO - PROCESS | 25086 | Values: 63.0 62.0 62.0 61.0 63.0 63.0 66.0 61.0 60.0 65.0 07:26:40 INFO - PROCESS | 25086 | -------- Summary: end -------- 07:26:40 INFO - PROCESS | 25086 | 07:26:41 INFO - TEST-INFO | 25086: exit 0 07:26:41 INFO - TEST-OK | kraken | took 60205ms 07:26:41 INFO - SUITE-END | took 1174s 07:26:42 INFO - Completed test suite (00:19:34) 07:26:42 INFO - javascript benchmark 07:26:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3020.682828303027, 3050.8779648814043, 3052.5115981442973, 3068.9232769180767, 3086.0587520806152, 5287.894242115155, 5383.246345511622, 5385.0576149173885, 5456.045192091383, 5471.124620060791, 5315.495027972346, 5370.731463426823, 5419.3225846769155, 5424.240606315109, 5448.509634132927, 4779.617630589553, 4894.0, 4902.779374928119, 4905.558499735023, 5093.465186155456, 4991.675541089836, 5022.397312322526, 5031.069252188338, 5051.267566202899, 5057.0, 4802.447718512363, 4809.350737650408, 4816.831410900601, 4831.661783675144, 4983.078130545842, 4884.4871288514905, 4887.828925987574, 4889.731064791435, 4891.461939186686, 4987.5511203991455, 4890.75546222691, 4921.581665558432, 4929.2113261878285, 4931.408231012301, 4978.253262010691, 5252.1596544552685, 5373.543248823855, 5402.108652072403, 5431.674099553999, 5442.401335853053, 5844.152597873284, 5887.175795388649, 5892.764289428418, 5898.852528686774, 5908.615939963888, 5864.296284445851, 5889.676067816268, 5901.3508514063415, 5911.320198177222, 5940.31686356066, 5186.377634683824, 5310.283111779938, 5340.145576707747, 5345.144776835766, 5412.756425960842, 5851.180834683148, 5905.645661260338, 5908.940910590839, 5921.792737254175, 5922.407759224043, 5652.830415087554, 5655.745491452894, 5677.772889084473, 5691.203231547586, 5708.372079071299, 5634.943650563524, 5680.630759000652, 5712.7714891403875, 5777.422257774189, 5868.618539794899, 5721.628094173865, 5737.454941780524, 5737.90979713853, 5744.138379243147, 5751.281089863767, 5751.051076572402, 5761.251037365116, 5798.82603521895, 5808.912866307009, 5809.331926828384, 4355.8475453359615, 4364.3017117261725, 4401.867943961686, 4447.3329000650165, 4462.951206466542, 3965.5637879833193, 3971.146203566247, 3972.08642012333, 4002.0995276063236, 4011.1376054147913, 5545.085060964896, 5554.166874968706, 5555.638883472642, 5593.356763972195, 5602.887942241132, 5632.52123569493, 5787.652740835563, 5813.331466881278, 5836.737346819404, 5902.8819423611285, 5518.392976772552, 5519.31008623922, 5521.116621340647, 5521.751521181556, 5554.77780888768, 5065.442801291855, 5076.340075790124, 5080.212567052113, 5082.695038297714, 5121.667091639031, 5819.73811178498, 5880.794172203952, 5908.172855800191, 5917.349091600006, 6109.389061093855, 5778.711064446845, 5779.595428319977, 5782.190493330853, 5782.5373970081455, 5825.0388685866355, 5936.079907614327, 5979.701014949323, 5984.97007514977, 5985.551083668829, 5991.161237426677, 5620.12888002344, 5648.774049037993, 5656.3495198051105, 5657.12314591239, 5692.943070569241, 5797.188393624981, 5813.56398270123, 5821.621594596338, 5831.562632802472, 5872.265966754156, 5664.348599911063, 5667.659940403589, 5669.5180909621495, 5674.177244299636, 5676.403977582295, 5490.121580547093, 5543.0, 5556.527695145958, 5586.916196257141, 5666.178404131296, 5517.448255174611, 5569.498745112959, 5573.470520300565, 5576.052071147996, 5616.326040875121, 5660.349059858169, 5671.602987790815, 5707.857303567444, 5717.3996730342715, 5719.084946408555, 5527.917081243704, 5541.224228607917, 5561.555075593862, 5580.832575022593, 5661.631993920382], "value": 5334.117848119275, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.2966310763975, 603.5202014398553, 609.5976655407432, 612.9478994285482, 616.5622408090255, 32567.67432325679, 33123.83438082809, 35779.82110089449, 35787.82106089473, 35791.821040894756, 48389.27416088753, 49508.50491495084, 49570.25644615333, 49658.25512617305, 49745.25382119271, 9049.909500904989, 9188.219001384858, 9192.632294708204, 9196.034416386283, 9196.954015229914, 9186.54067296636, 9262.536873156349, 9280.0, 9284.350095493319, 9284.907150928471, 9348.065193480665, 9382.624695012226, 9383.108604682579, 9387.43675379476, 9392.43645381276, 9269.073092690744, 9322.0, 9338.486383248952, 9341.953290233574, 9346.532673366304, 9076.04701506339, 9136.634534618608, 9179.678711245075, 9180.26557875375, 9180.44917304964, 42625.78687106576, 42928.35607465891, 43153.56846431527, 43269.13461730779, 43334.56665433337, 3747.194353214072, 3795.1840354323676, 4206.242876282268, 4291.120320334355, 4317.913641727179, 33152.17119572006, 33531.329373412394, 33961.0, 34021.489677654856, 35288.0, 4411.228035093845, 4498.055408364247, 4602.562756538124, 4623.86128416148, 4673.462551806551, 263304.68347658333, 263419.0, 263665.0, 264334.0, 264534.0, 57698.0, 58613.70693146507, 59104.0, 59153.70423147943, 59176.0, 61755.6912215436, 61820.0, 61863.38136618666, 61881.0, 61921.73665238505, 16057.277422516016, 16331.510054698378, 16335.26491307894, 16340.918295408446, 16341.754873676666, 12738.235705857493, 12742.171758835646, 12748.235105893677, 12750.872491274968, 12757.04322175822, 14682.779758303634, 16278.51164465068, 16323.510294691177, 16328.83671163297, 16330.346786128659, 6464.935350646433, 6676.46588272937, 6722.798316050526, 6729.5625784323865, 6764.2221144569, 1099.725068732817, 1099.9505022274018, 1101.5043230546287, 1105.9447027648584, 1185.1052455396293, 33096.50355244673, 33399.66600334014, 33424.66575334215, 33574.664253357645, 33723.0, 1092.4592326798286, 1119.227732864321, 1142.520141540555, 1170.6136974798296, 1230.5385480444834, 16937.153142342835, 17477.0, 17483.125843707763, 17507.737383938995, 17509.562260943578, 534055.0, 538599.0, 538784.0, 538808.0, 540221.0, 59651.0, 59701.70149149226, 59985.70007149936, 59994.0, 60177.69911150504, 1260.7730608490376, 1295.7084655952335, 1306.9085164038615, 1378.3521744780137, 1394.8465668776425, 29277.560836587043, 33913.49129763006, 34612.0, 36295.63704362923, 36720.81639591785, 55917.720411397684, 56705.432945670014, 56782.71608642096, 56791.0, 56811.71594142003, 495979.0, 507328.0, 507884.0, 507962.0, 508720.0, 27915.302117446416, 28984.42031159323, 29030.0, 30387.240318991317, 41784.0, 47769.28346074881, 48419.27371089366, 48558.5144148554, 49252.26121608107, 49722.0, 40629.0, 40642.0, 41095.589044109176, 43297.35053974256, 45152.0, 41862.79068604638, 42892.78553607212, 43003.56996429995, 43081.56918430776, 43712.28819053072, 36374.8181259092, 39663.40504892487, 41706.37440438335, 42754.0, 42819.0, 36846.631533685395, 37957.43063853989, 38543.614563855124, 39043.609563904, 39315.60684393119, 28660.570091449063, 28750.856245718638, 28952.276193095342, 28954.0, 28955.357587219598], "value": 20474.039567634005, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.6481501833332, 389.8693937530927, 399.2514036182158, 409.57608874814565, 417.3843580718441, 13015.93492032541, 18876.905615471922, 20538.99999999998, 20545.691814622773, 21050.263240786575, 15799.92100039501, 15823.446179383694, 17419.30322787087, 20494.69257961128, 20513.58972820543, 5712.685802280873, 5736.311642602883, 5883.323417806964, 5948.434898684618, 5951.018082016462, 5764.394738552454, 5866.120081987693, 5874.441928016853, 5878.088896221093, 5889.8822023559505, 5827.970860145693, 5842.357340692521, 5842.853928651775, 5856.150858125569, 5868.061110222366, 5826.82519524415, 5831.620944638585, 5837.387074357195, 5839.240898683186, 5842.912356314638, 5032.194848824171, 5213.817516386908, 5220.216967454874, 5250.264962905197, 5254.579633629339, 23961.28116156518, 24096.156634517884, 24669.753302466925, 24701.382465438328, 25225.24324270275, 2195.6706494025866, 2415.867127307997, 2417.891194896234, 2426.6602675625427, 2496.6504689343506, 15007.099574025593, 15215.08709477435, 15543.0, 15624.687506249811, 16126.274317655616, 1873.5409824593062, 1909.8567607429497, 1917.587718640499, 2023.433438637184, 2034.9389518314474, 81807.18192818055, 82149.0, 82280.58859705663, 82735.0, 84192.0, 10493.370397776158, 10869.510872010778, 10873.945630271955, 10946.671599852018, 11160.776784464266, 15244.695106097815, 15257.465988690343, 15258.694826103416, 15262.542123736306, 15299.311530981133, 8398.244158025807, 8533.975922889169, 8557.0, 8691.304695624334, 8705.564721763887, 8168.673253069929, 8360.498370097814, 8373.623186956602, 8534.103919088531, 8613.181747733955, 6686.197656281277, 6720.8319792005595, 6787.830304242335, 6819.931800681929, 6832.555883867532, 1904.6190761847408, 1979.544704717923, 1985.463924740312, 2004.3185316992292, 2006.3980805758215, 1026.8807000369634, 1029.1766586730735, 1041.1410586266209, 1066.4507778494083, 1081.9729506762237, 19779.802201978084, 20731.27440539574, 21112.261070862445, 21333.35999920005, 21459.89270053671, 1019.9796004079877, 1039.5685790397051, 1078.175195975064, 1079.2499213047015, 1142.1947526993615, 11283.66149015531, 11836.289822610499, 11935.820962685566, 11982.820257696141, 12093.818592721116, 491346.0, 492615.0, 498102.0, 507106.0, 507604.0, 80655.59672201719, 81405.59297203476, 81607.0, 82690.0, 85899.14100859036, 1050.4275170032352, 1055.303499690216, 1079.2731629392908, 1079.8434227037035, 1085.1427372375736, 17961.73057404114, 18295.908520457313, 18936.43190704281, 18971.62056758885, 19214.615707686047, 40049.399259010555, 42043.0, 43206.0, 43414.0, 43639.0, 57306.713466432404, 59716.402835972825, 59859.40140598538, 61378.693106534185, 61944.380556193864, 8114.148014458397, 8244.258016778518, 8393.454425462325, 8478.23695867375, 8630.697925572826, 9278.860817087614, 12447.377631118226, 13042.608721738363, 13167.53913613019, 13811.792823107862, 11952.223105498115, 11969.0, 11992.760144796881, 12113.818292725793, 12367.93816030914, 5878.882422351444, 8932.794072800089, 11713.1800773945, 11765.941065304163, 11989.280643161439, 11124.443777811239, 11956.940215298868, 12176.817347739969, 12415.689607759878, 12757.808632870328, 8191.918080819116, 8202.548859812767, 8368.0, 8519.574021298786, 8795.0, 11488.368139752394, 11723.882761172279, 11999.220050696676, 12001.39993000329, 12423.254604723745], "value": 9523.510221072422, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.8665133486659, 1472.646564824442, 1510.1694068262457, 1624.3421414327195, 1800.9639807203848, 8224.958875205622, 8553.144685531452, 8553.358498112635, 8789.604467798948, 8819.691310804123, 8678.783030424243, 8747.562621868912, 8767.824643507127, 8770.166834150761, 8820.382573219877, 2020.0808632072371, 2278.9202377916777, 2402.3873912152376, 2427.4416884116663, 2430.4895971845935, 2326.348622385735, 2379.0602711928777, 2383.940401489968, 2385.6063749481314, 2387.2957477544164, 2303.884805759714, 2307.5038866643667, 2321.8955147018423, 2323.860568365895, 2349.3891588187107, 1930.4691209917244, 1996.0518753591928, 2247.045005872506, 2247.6179049561615, 2250.3923940536047, 2062.0, 2232.2075663139512, 2299.482616411294, 2302.0, 2346.378209774411, 8853.645854165825, 8911.509866957314, 8911.643534258621, 8921.732348029505, 8938.46369217849, 5137.691738495702, 5262.789488420459, 5267.446918073585, 5271.789128434858, 5273.472652734734, 3562.109472631842, 3607.5670919489567, 3669.614690457517, 3697.3899306614376, 3713.350163721338, 1235.8578763442229, 1248.4194849394985, 1253.7367152897903, 1270.091884302728, 1304.5499302740538, 12165.695857603541, 12174.0, 12176.756464870654, 12204.145709800407, 12205.680920625053, 4433.556644335541, 4704.082703872712, 4794.137055330004, 4857.077155340474, 4861.51384861511, 10197.898021019695, 10259.333143345659, 10261.333013354108, 10264.332818366782, 10275.280730348954, 5324.866878328073, 5325.307709997675, 5327.893442131136, 5328.3605967284175, 5330.7068111253475, 4284.121755040209, 4699.271612900006, 4748.169070412664, 4913.631477639191, 4916.680415772963, 3877.6703980162, 3944.684425245973, 3981.442598036277, 4030.052937559671, 4056.5334986476932, 1203.6328919679581, 1227.2636418149038, 1237.208186760474, 1248.619171152789, 1253.4484826676232, 976.1458723616835, 979.8285300072458, 995.0596686131536, 997.7306127345576, 1014.8680671512803, 5855.736491857791, 5952.345242023374, 6008.879822403527, 6111.480524155497, 6149.569530132937, 986.9225280783846, 1006.6561140876865, 1017.8422344536609, 1020.8877023527406, 1040.095117247999, 4103.958960410358, 4215.241256573785, 4264.381664658607, 4320.719153255029, 4344.978275108604, 10688.572457101784, 10992.395418251914, 11031.503582338813, 11032.724181895517, 11036.558537658564, 10857.45712714361, 10959.452027398598, 10986.780264394667, 10994.28537145083, 11001.889981100087, 8179.918200817916, 8206.753797386087, 8333.791655208546, 8346.081930987586, 8395.370347223983, 6208.503319734501, 6222.408871157233, 6256.937430625636, 6282.874342513215, 6286.214223222098, 10122.443265620166, 10124.341917775615, 10140.188784897338, 10160.0, 10168.949155254473, 10073.531984663805, 10104.545295461576, 10223.591056357662, 10331.070203681706, 10354.1198998083, 6584.604923704593, 7141.750038748619, 7339.77980660581, 7409.0, 7518.548887066793, 8961.686340978034, 9040.954795226246, 9054.094590540893, 9054.366194366332, 9055.728328150166, 7745.457817952689, 7765.572893490912, 7873.133955265031, 8012.95993520052, 8027.719029833927, 7436.702531898663, 7599.734009309647, 7610.162882083077, 7679.884801727867, 8006.03927528677, 7409.110906691231, 7527.134379546423, 7528.548287102792, 7544.0569928758905, 7546.509476883985, 5302.257683924331, 5316.415194328698, 5387.407385187548, 5416.2688037114485, 5545.0, 5314.335708036496, 5356.089464791073, 5395.676259424447, 5444.0, 5586.52514536269], "value": 4702.811288775496, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.63219929280626, 331.2364998678047, 340.613403786702, 340.9829508524573, 344.63296589132574, 5261.685138362831, 5305.840824775258, 5343.812966546172, 5382.703951282683, 5404.1355732272405, 4997.575206107485, 5138.48615138486, 5141.665791723544, 5143.639945203838, 5292.523672869441, 4038.6567141792834, 4091.9999999999927, 4106.301928672133, 4151.335786274197, 4155.522114956773, 4143.357779544175, 4144.813483393239, 4153.688473364495, 4161.292580261363, 4191.224623444673, 4056.574059723731, 4113.629773320401, 4117.711760176789, 4128.3601041838565, 4161.771102589371, 4128.401381799622, 4145.937810932838, 4149.83400663973, 4157.916841663165, 4179.665626749868, 3714.4242642390473, 3715.5912849586525, 3721.6836568891677, 3724.8080614203463, 3745.8501659933568, 5092.236164575306, 5099.056674515226, 5233.371995360543, 5237.162054071368, 5251.10731175701, 4699.647526435497, 4740.336352910595, 4769.95230047702, 4788.11419887322, 4788.4253889533475, 5497.505224529771, 5498.80754173602, 5505.504504594605, 5530.806421775219, 5572.916406253909, 3945.191235796655, 4025.194961007781, 4049.311617025113, 4054.776987265699, 4059.4925634295714, 5650.29371328584, 5662.546996240291, 5667.971660141673, 5681.23303354046, 5683.943160568424, 4105.220008198433, 4124.443200167999, 4128.958710412918, 4140.834366625361, 4141.0330093206085, 4035.455213546192, 4218.451601291812, 4221.641160501392, 4222.345536441795, 4225.598568136023, 4682.391289132459, 4692.7653617319, 4709.788059537329, 4787.976060119677, 4790.257510085942, 5552.52803511706, 5553.361363443175, 5569.721513924287, 5572.442755724476, 5611.242482264842, 1359.626102821732, 1428.2858570714643, 1438.9712205755827, 1445.9204743739194, 1448.594393569781, 902.6299217320867, 919.7884486567993, 929.6885543343055, 930.265090578449, 931.5621657820814, 4661.347411362344, 4686.406621748622, 4687.507811679793, 4697.074199578156, 4745.786439610226, 4589.839355622537, 4944.0, 4959.231319145538, 4981.576565991859, 5002.2496625506465, 4606.838760643362, 4653.627709783209, 4660.347551342815, 4666.230072038075, 4692.536418380378, 2652.986735066351, 2655.924350637995, 2660.2418310781336, 2679.289988153141, 2688.8521131337966, 4936.2102063669645, 4938.0, 5125.308083408767, 5155.819546315861, 5174.327337446183, 5002.424721157041, 5032.723200224023, 5033.345665063518, 5039.370078740158, 5040.31955685985, 5076.619253555924, 5107.284980102789, 5117.488251174853, 5137.897242055213, 5156.2929462032735, 4815.277708343777, 4890.168671325812, 4923.729194894315, 4980.431164183271, 5001.449840517613, 4870.659053866337, 4894.804207831647, 4900.509949005071, 4902.117618828503, 4902.803887844446, 5050.595952323879, 5056.508330042573, 5119.334486516729, 5130.51215147603, 5166.121759300852, 3571.3035957987945, 3695.6304369562827, 3712.8514859405323, 3737.2712321097124, 3747.9250414992093, 4895.363602731764, 5392.514673679388, 5540.806071787468, 5555.444455554412, 5558.527525160407, 5500.642458240201, 5510.476504732044, 5514.80698175562, 5527.834164974896, 5541.0, 5222.634415590872, 5493.148561972901, 5494.80768173112, 5528.281323427928, 5543.805966791143, 5424.701641409602, 5470.070088085115, 5477.0, 5487.917681234705, 5488.286522752017, 5542.750576223999, 5558.583106267127, 5576.163575463713, 5586.435797976573, 5600.85997850057, 5169.586433085419, 5416.783328666809, 5446.183072538993, 5471.124620060771, 5496.258005169411], "value": 4065.2926171955, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.540075954427, 798.9440739148258, 814.3485211830535, 843.3632607381426, 889.2930120554158, 15799.526014219577, 17576.472705818815, 17583.472495825114, 17585.999999999985, 17591.560210994714, 15956.601084972881, 16049.598760031005, 16109.597260068504, 16117.758233626504, 16122.113283769388, 671.2549070531705, 813.5403497024192, 834.1783343406739, 838.174398217755, 844.3329769482102, 835.5947365527715, 836.5440834745048, 838.1576515601812, 838.4089217101958, 838.576518857979, 882.3955590420551, 890.3144578674417, 890.461270931087, 890.5769759364315, 891.2157301574638, 706.3960313931592, 856.9271611912994, 878.3412440669498, 880.5861245214738, 883.6244596046687, 643.2056410333234, 645.3256347117274, 649.7206201333424, 649.746598826458, 650.0152269311997, 15323.31045102973, 15369.308381122877, 15374.154421506813, 15382.153981531012, 15392.769108463383, 14240.145591264558, 14599.416023359054, 14853.405863765436, 14904.403823847033, 14966.47617333399, 13041.217526948414, 13051.673708157277, 13226.933865330708, 13405.46378144873, 13431.597052088453, 4396.362527433536, 4626.930596041062, 4704.200285951397, 4715.481297057321, 4727.0, 82812.58593707053, 82987.0, 83790.16209837885, 84115.0, 84180.57909710474, 10982.725431864108, 11493.138014648935, 11512.88487115135, 11833.467493962793, 12163.391830408444, 21968.89015554912, 21983.0, 22076.11695532193, 22085.0, 22123.115075397127, 8809.647614095493, 8851.645934162561, 8882.733517994471, 9027.593758280893, 9053.59258833354, 4797.496262892346, 4859.319695242669, 4874.293227481995, 4934.9753251233515, 4948.109340318777, 3470.9305813884084, 3532.717382609385, 3575.4636804479014, 3584.444411116281, 3585.103724068983, 642.2742301199708, 646.4149944300416, 654.9672516374162, 665.3180489997694, 668.2515582547578, 571.0710313046216, 653.8659574787157, 683.9897401538981, 686.1526015371013, 696.4706822814596, 9024.0, 9521.714348569554, 9651.54660732157, 9771.560279787427, 10004.599816007278, 671.1208317104608, 684.4387602166275, 685.674304705261, 690.3407246079981, 700.8212905709012, 4373.562643735665, 4409.647228221735, 4623.260278355447, 4773.71357718538, 4813.542713442217, 77724.61137694275, 110981.44509277403, 125675.0, 133235.0, 138434.3078284602, 113295.86704133017, 114377.0, 115282.0, 115627.0, 118456.0, 70397.64801175961, 93032.0, 93438.0, 95137.0, 95572.0, 8819.162179592928, 8881.866771998555, 8935.335599107748, 8942.597583108645, 9010.63957441695, 54410.72794636001, 55022.5239864199, 55044.0, 55120.72439637776, 58606.0, 75015.0, 81457.18542814734, 81811.0, 83267.16732832594, 86278.56860715656, 12174.873831636327, 12329.445174966968, 12501.187422817487, 12532.060095493056, 12902.645222251529, 13149.53976610814, 13185.736285274432, 13576.86423135756, 13874.375653095432, 13875.861241387456, 12768.170068945488, 13208.933955330162, 13238.735225295248, 13592.66018349549, 13706.109102908278, 12659.87340126587, 13037.348132593523, 13078.888294495075, 13211.273379964194, 13554.86445135536, 12088.75822483563, 12189.146759726735, 12343.444544995316, 12425.254484730945, 12737.172083814523, 10081.596736130472, 10084.394936303845, 10336.249017324899, 10341.276110672181, 10444.738881527719, 9681.467519286507, 9944.701658950244, 10182.694519164437, 10248.38509689421, 10396.58413663445], "value": 7701.564872602492, "unit": "score"}], "name": "dromaeo_css", "value": 7314.587631033954, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 114.0, 110.0, 112.0, 110.0, 110.0, 110.0, 113.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 117.0, 119.0, 169.0, 119.0, 122.0, 147.0, 120.0, 151.0, 119.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 161.0, 161.0, 161.0, 161.0, 162.0, 163.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 114.0, 74.0, 75.0, 74.0, 76.0, 111.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 115.0, 83.0, 84.0, 84.0, 118.0, 83.0, 83.0, 128.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 49.0, 49.0, 50.0, 52.0, 49.0, 49.0, 49.0, 49.0], "value": 49.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 61.0, 62.0, 61.0, 62.0, 62.0, 62.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 75.0, 79.0, 75.0, 75.0, 75.0, 78.0, 80.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 119.0, 118.0, 120.0, 120.0, 119.0, 119.0, 159.0, 130.0], "value": 124.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 158.0, 161.0, 157.0, 158.0, 161.0, 157.0, 158.0, 155.0, 159.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 61.0, 63.0, 63.0, 66.0, 61.0, 60.0, 65.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1473.4999999999998, "alertThreshold": 2.0}]} 07:26:42 INFO - Return code: 0 07:26:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:26:42 INFO - # TBPL SUCCESS # 07:26:42 INFO - Running post-action listener: _resource_record_post_action 07:26:42 INFO - [mozharness: 2016-08-05 14:26:42.183691Z] Finished run-tests step (success) 07:26:42 INFO - Running post-run listener: _resource_record_post_run 07:26:42 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 409989120; Read time: 0; Write time: 247452 07:26:42 INFO - TinderboxPrint: CPU usage
13.1% 07:26:42 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:26:42 INFO - TinderboxPrint: I/O write bytes / time
409,989,120 / 247,452 07:26:42 INFO - TinderboxPrint: CPU idle
8,269.5 (86.9%) 07:26:42 INFO - TinderboxPrint: CPU user
1,201.9 (12.6%) 07:26:42 INFO - TinderboxPrint: Swap in / out
0 / 0 07:26:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117993472; Read time: 0; Write time: 81136 07:26:42 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 291565568; Read time: 0; Write time: 166228 07:26:42 INFO - Running post-run listener: _upload_blobber_files 07:26:42 INFO - Blob upload gear active. 07:26:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:26:42 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 07:26:42 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'] 07:26:42 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 07:26:43 INFO - (blobuploader) - INFO - Open directory for files ... 07:26:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:26:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:26:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:43 INFO - (blobuploader) - INFO - Done attempting. 07:26:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:26:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:26:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:46 INFO - (blobuploader) - INFO - Done attempting. 07:26:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:26:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:26:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:47 INFO - (blobuploader) - INFO - Done attempting. 07:26:47 INFO - (blobuploader) - INFO - Iteration through files over. 07:26:47 INFO - Return code: 0 07:26:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:26:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:26:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d304d2f19e9cf8e969b93706389faceb3475c73552c304c2bf9a71c8403bb577a3bdcd85f249d786c54a05208d69e3c048699c7f58444f1277e3dc71378dbabe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/90b4b9236fd7264ade8f718ac824cabf7ebf4368b648fefeb127abb40219eda9de05a604639bade043036157fdde46f42d8c1fd5555ed6096a2ec73f8178f407", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b78666c3aabc46b6b2de9330de989f714500546be6413fc2145d7d22cbfb0730438c4fcb2608eb9be97386ea0754a441ac3883ba1d9996f8edd3be7b4fccec3f"} 07:26:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:26:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:26:47 INFO - Contents: 07:26:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d304d2f19e9cf8e969b93706389faceb3475c73552c304c2bf9a71c8403bb577a3bdcd85f249d786c54a05208d69e3c048699c7f58444f1277e3dc71378dbabe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/90b4b9236fd7264ade8f718ac824cabf7ebf4368b648fefeb127abb40219eda9de05a604639bade043036157fdde46f42d8c1fd5555ed6096a2ec73f8178f407", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b78666c3aabc46b6b2de9330de989f714500546be6413fc2145d7d22cbfb0730438c4fcb2608eb9be97386ea0754a441ac3883ba1d9996f8edd3be7b4fccec3f"} 07:26:47 INFO - Running post-run listener: copy_logs_to_upload_dir 07:26:47 INFO - Copying logs to upload dir... 07:26:47 INFO - mkdir: /builds/slave/test/build/upload/logs 07:26:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.573927 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-05 07:26:46.544437) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 07:26:46.547690) ========= 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=923d835db2ba3686ebe126b700000192-1470398394.128368-488994872 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/d304d2f19e9cf8e969b93706389faceb3475c73552c304c2bf9a71c8403bb577a3bdcd85f249d786c54a05208d69e3c048699c7f58444f1277e3dc71378dbabe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/90b4b9236fd7264ade8f718ac824cabf7ebf4368b648fefeb127abb40219eda9de05a604639bade043036157fdde46f42d8c1fd5555ed6096a2ec73f8178f407", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b78666c3aabc46b6b2de9330de989f714500546be6413fc2145d7d22cbfb0730438c4fcb2608eb9be97386ea0754a441ac3883ba1d9996f8edd3be7b4fccec3f"} build_url:https://queue.taskcluster.net/v1/task/WOnIMcsMStOKjEcRVgXp6A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011189 build_url: 'https://queue.taskcluster.net/v1/task/WOnIMcsMStOKjEcRVgXp6A/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/d304d2f19e9cf8e969b93706389faceb3475c73552c304c2bf9a71c8403bb577a3bdcd85f249d786c54a05208d69e3c048699c7f58444f1277e3dc71378dbabe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/90b4b9236fd7264ade8f718ac824cabf7ebf4368b648fefeb127abb40219eda9de05a604639bade043036157fdde46f42d8c1fd5555ed6096a2ec73f8178f407", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b78666c3aabc46b6b2de9330de989f714500546be6413fc2145d7d22cbfb0730438c4fcb2608eb9be97386ea0754a441ac3883ba1d9996f8edd3be7b4fccec3f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 07:26:46.573601) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 07:26:46.573965) ========= 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=923d835db2ba3686ebe126b700000192-1470398394.128368-488994872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 07:26:46.657969) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 07:26:46.658545) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 07:26:46.658996) ========= ========= Total master_lag: 0.25 =========