builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1471907449.15 results: success (0) buildid: 20160822143002 builduid: 503c2600f6764e28a171ecf5ffcb612b revision: 08e9ded26ada149385af32e1c1d89f30e3d8279c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 16:10:49.145687) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 16:10:49.146195) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 16:10:49.146537) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 16:10:49.161656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:10:49.162118) ========= 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=52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 16:10:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-08-22 16:10:52 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.071806 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:10:49.248099) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:10:49.248451) ========= 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=52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018464 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:10:49.297582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:10:49.297961) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 08e9ded26ada149385af32e1c1d89f30e3d8279c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 08e9ded26ada149385af32e1c1d89f30e3d8279c --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=52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 16:10:52,457 truncating revision to first 12 chars 2016-08-22 16:10:52,457 Setting DEBUG logging. 2016-08-22 16:10:52,457 attempt 1/10 2016-08-22 16:10:52,457 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/08e9ded26ada?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 16:10:52,830 unpacking tar archive at: fx-team-08e9ded26ada/testing/mozharness/ program finished with exit code 0 elapsedTime=0.694797 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:10:50.116712) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 16:10:50.117027) ========= script_repo_revision: 08e9ded26ada149385af32e1c1d89f30e3d8279c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 16:10:50.117404) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 16:10:50.117674) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 16:10:50.127779) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-22 16:10:50.128049) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:10:53 INFO - MultiFileLogger online at 20160822 16:10:53 in /builds/slave/test 16:10:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:10:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:10:53 INFO - {'append_to_log': False, 16:10:53 INFO - 'base_work_dir': '/builds/slave/test', 16:10:53 INFO - 'blob_upload_branch': 'Fx-Team', 16:10:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:10:53 INFO - 'branch': 'Fx-Team', 16:10:53 INFO - 'buildbot_json_path': 'buildprops.json', 16:10:53 INFO - 'config_files': ('talos/linux_config.py',), 16:10:53 INFO - 'default_actions': ('clobber', 16:10:53 INFO - 'read-buildbot-config', 16:10:53 INFO - 'download-and-extract', 16:10:53 INFO - 'populate-webroot', 16:10:53 INFO - 'create-virtualenv', 16:10:53 INFO - 'install', 16:10:53 INFO - 'run-tests'), 16:10:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:10:53 INFO - 'download_minidump_stackwalk': True, 16:10:53 INFO - 'download_symbols': 'ondemand', 16:10:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:10:53 INFO - 'tooltool.py': '/tools/tooltool.py', 16:10:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:10:53 INFO - '/tools/misc-python/virtualenv.py')}, 16:10:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:10:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:10:53 INFO - 'installer_path': 'installer.exe', 16:10:53 INFO - 'log_level': 'info', 16:10:53 INFO - 'log_name': 'talos', 16:10:53 INFO - 'log_to_console': True, 16:10:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:10:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:10:53 INFO - 'opt_config_files': (), 16:10:53 INFO - 'pip_index': False, 16:10:53 INFO - 'sps_profile': False, 16:10:53 INFO - 'sps_profile_interval': 0, 16:10:53 INFO - 'suite': 'dromaeojs-e10s', 16:10:53 INFO - 'system_bits': '32', 16:10:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:10:53 INFO - 'title': 'talos-linux64-ix-056', 16:10:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:10:53 INFO - 'use_talos_json': True, 16:10:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:10:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:10:53 INFO - 'work_dir': 'build'} 16:10:53 INFO - [mozharness: 2016-08-22 23:10:53.383552Z] Running clobber step. 16:10:53 INFO - Running pre-action listener: _resource_record_pre_action 16:10:53 INFO - Running main action method: clobber 16:10:53 INFO - rmtree: /builds/slave/test/build 16:10:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:10:53 INFO - Running post-action listener: _resource_record_post_action 16:10:53 INFO - [mozharness: 2016-08-22 23:10:53.848596Z] Finished clobber step (success) 16:10:53 INFO - [mozharness: 2016-08-22 23:10:53.848696Z] Running read-buildbot-config step. 16:10:53 INFO - Running pre-action listener: _resource_record_pre_action 16:10:53 INFO - Running main action method: read_buildbot_config 16:10:53 INFO - Using buildbot properties: 16:10:53 INFO - { 16:10:53 INFO - "project": "", 16:10:53 INFO - "product": "firefox", 16:10:53 INFO - "script_repo_revision": "production", 16:10:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:10:53 INFO - "repository": "", 16:10:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 16:10:53 INFO - "buildid": "20160822143002", 16:10:53 INFO - "pgo_build": "True", 16:10:53 INFO - "basedir": "/builds/slave/test", 16:10:53 INFO - "buildnumber": 1070, 16:10:53 INFO - "slavename": "talos-linux64-ix-056", 16:10:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:10:53 INFO - "platform": "ubuntu64_hw", 16:10:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:10:53 INFO - "branch": "fx-team", 16:10:53 INFO - "repo_path": "integration/fx-team", 16:10:53 INFO - "revision": "08e9ded26ada149385af32e1c1d89f30e3d8279c", 16:10:53 INFO - "stage_platform": "linux64-pgo", 16:10:53 INFO - "builduid": "503c2600f6764e28a171ecf5ffcb612b", 16:10:53 INFO - "slavebuilddir": "test" 16:10:53 INFO - } 16:10:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:10:53 INFO - Running post-action listener: _resource_record_post_action 16:10:53 INFO - [mozharness: 2016-08-22 23:10:53.851140Z] Finished read-buildbot-config step (success) 16:10:53 INFO - [mozharness: 2016-08-22 23:10:53.851228Z] Running download-and-extract step. 16:10:53 INFO - Running pre-action listener: _resource_record_pre_action 16:10:53 INFO - Running main action method: download_and_extract 16:10:53 INFO - mkdir: /builds/slave/test/build/tests 16:10:53 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')]} 16:10:53 INFO - trying https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:10:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/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 16:10:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/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 16:10:54 INFO - Downloaded 1361 bytes. 16:10:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:10:54 INFO - Using the following test package requirements: 16:10:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:10:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:10:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:10:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:54 INFO - u'jsshell-linux-x86_64.zip'], 16:10:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:10:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:10:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:10:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:10:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:10:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:10:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:54 INFO - trying https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:10:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/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 16:10:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/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 16:10:55 INFO - Downloaded 21921014 bytes. 16:10:55 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 16:10:59 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 16:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:59 INFO - trying https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:10:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/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 16:10:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/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 16:11:00 INFO - Downloaded 21921014 bytes. 16:11:00 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 16:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:05 INFO - trying https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:11:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/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 16:11:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/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 16:11:05 INFO - Downloaded 14413981 bytes. 16:11:05 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 16:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:06 INFO - trying https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:11:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/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 16:11:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/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 16:11:07 INFO - Downloaded 59778083 bytes. 16:11:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:11:07 INFO - mkdir: /builds/slave/test/properties 16:11:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:11:07 INFO - Writing to file /builds/slave/test/properties/build_url 16:11:07 INFO - Contents: 16:11:07 INFO - build_url:https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:11:07 INFO - Running post-action listener: _resource_record_post_action 16:11:07 INFO - Running post-action listener: set_extra_try_arguments 16:11:07 INFO - [mozharness: 2016-08-22 23:11:07.928623Z] Finished download-and-extract step (success) 16:11:07 INFO - [mozharness: 2016-08-22 23:11:07.928847Z] Running populate-webroot step. 16:11:07 INFO - Running pre-action listener: _resource_record_pre_action 16:11:07 INFO - Running main action method: populate_webroot 16:11:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:11:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:11:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:11:07 INFO - '--tppagecycles', 16:11:07 INFO - '7'], 16:11:07 INFO - 'tests': ['tsvgm']}}, 16:11:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:11:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:11:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:11:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:11:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:11:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:11:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:07 INFO - 'talos_options': ['--disable-e10s'], 16:11:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:07 INFO - 'talos_options': ['--disable-e10s'], 16:11:07 INFO - 'tests': ['damp', 'tps']}, 16:11:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:07 INFO - 'tests': ['damp', 'tps']}, 16:11:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:11:07 INFO - 'tests': ['dromaeo_dom']}, 16:11:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:11:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:11:07 INFO - 'tests': ['basic_compositor_video']}, 16:11:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:11:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:11:07 INFO - 'tests': ['a11yr', 16:11:07 INFO - 'ts_paint', 16:11:07 INFO - 'tpaint', 16:11:07 INFO - 'sessionrestore', 16:11:07 INFO - 'sessionrestore_no_auto_restore', 16:11:07 INFO - 'tabpaint']}, 16:11:07 INFO - 'other-e10s': {'tests': ['a11yr', 16:11:07 INFO - 'ts_paint', 16:11:07 INFO - 'tpaint', 16:11:07 INFO - 'sessionrestore', 16:11:07 INFO - 'sessionrestore_no_auto_restore', 16:11:07 INFO - 'tabpaint']}, 16:11:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:11:07 INFO - 'ts_paint', 16:11:07 INFO - 'tpaint', 16:11:07 INFO - 'sessionrestore', 16:11:07 INFO - 'sessionrestore_no_auto_restore', 16:11:07 INFO - 'tabpaint']}, 16:11:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:11:07 INFO - 'ts_paint', 16:11:07 INFO - 'tpaint', 16:11:07 INFO - 'sessionrestore', 16:11:07 INFO - 'sessionrestore_no_auto_restore', 16:11:07 INFO - 'tabpaint']}, 16:11:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:11:07 INFO - 'tests': ['a11yr', 16:11:07 INFO - 'ts_paint', 16:11:07 INFO - 'tpaint', 16:11:07 INFO - 'sessionrestore', 16:11:07 INFO - 'sessionrestore_no_auto_restore', 16:11:07 INFO - 'tabpaint']}, 16:11:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:11:07 INFO - 'tests': ['a11yr', 16:11:07 INFO - 'ts_paint', 16:11:07 INFO - 'tpaint', 16:11:07 INFO - 'sessionrestore', 16:11:07 INFO - 'sessionrestore_no_auto_restore', 16:11:07 INFO - 'tabpaint']}, 16:11:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:11:07 INFO - 'tests': ['tsvgx', 16:11:07 INFO - 'tsvgr_opacity', 16:11:07 INFO - 'tart', 16:11:07 INFO - 'tscrollx', 16:11:07 INFO - 'cart']}, 16:11:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:11:07 INFO - 'tsvgr_opacity', 16:11:07 INFO - 'tart', 16:11:07 INFO - 'tscrollx', 16:11:07 INFO - 'cart']}, 16:11:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:07 INFO - 'talos_options': ['--disable-e10s'], 16:11:07 INFO - 'tests': ['tp5o']}, 16:11:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:07 INFO - 'tests': ['tp5o']}, 16:11:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:07 INFO - 'talos_options': ['--disable-e10s', 16:11:07 INFO - '--xperf_path', 16:11:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:07 INFO - 'tests': ['tp5n']}, 16:11:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:07 INFO - 'talos_options': ['--xperf_path', 16:11:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:07 INFO - 'tests': ['tp5n']}}, 16:11:07 INFO - 'talos.zip': {'path': '', 16:11:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:11:07 INFO - Running post-action listener: _resource_record_post_action 16:11:07 INFO - [mozharness: 2016-08-22 23:11:07.947930Z] Finished populate-webroot step (success) 16:11:07 INFO - [mozharness: 2016-08-22 23:11:07.948018Z] Running create-virtualenv step. 16:11:07 INFO - Running pre-action listener: _resource_record_pre_action 16:11:07 INFO - Running main action method: create_virtualenv 16:11:07 INFO - Creating virtualenv /builds/slave/test/build/venv 16:11:07 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 16:11:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:11:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:11:08 INFO - Using real prefix '/usr' 16:11:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:11:08 INFO - Installing distribute.............................................................................................................................................................................................done. 16:11:10 INFO - Installing pip.................done. 16:11:10 INFO - Return code: 0 16:11:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:11: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')]} 16:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11: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')]} 16:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3bc3831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1370>, '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 0x1dc48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4d80>, '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': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', '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 16:11:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:11:10 INFO - Using env: {'DISPLAY': ':0', 16:11:10 INFO - 'HOME': '/home/cltbld', 16:11:10 INFO - 'LANG': 'en_US.UTF-8', 16:11:10 INFO - 'LANGUAGE': 'en_US:en', 16:11:10 INFO - 'LOGNAME': 'cltbld', 16:11:10 INFO - 'MAIL': '/var/mail/cltbld', 16:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:10 INFO - 'MOZ_NO_REMOTE': '1', 16:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:10 INFO - 'NO_EM_RESTART': '1', 16:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:10 INFO - 'PWD': '/builds/slave/test', 16:11:10 INFO - 'SHELL': '/bin/bash', 16:11:10 INFO - 'SHLVL': '1', 16:11:10 INFO - 'TERM': 'linux', 16:11:10 INFO - 'TMOUT': '86400', 16:11:10 INFO - 'USER': 'cltbld', 16:11:10 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', 16:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:10 INFO - '_': '/tools/buildbot/bin/python'} 16:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:10 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 16:11:10 INFO - Cleaning up... 16:11:10 INFO - Return code: 0 16:11:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:11: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')]} 16:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11: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')]} 16:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3bc3831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1370>, '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 0x1dc48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4d80>, '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': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', '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 16:11:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:11:10 INFO - Using env: {'DISPLAY': ':0', 16:11:10 INFO - 'HOME': '/home/cltbld', 16:11:10 INFO - 'LANG': 'en_US.UTF-8', 16:11:10 INFO - 'LANGUAGE': 'en_US:en', 16:11:10 INFO - 'LOGNAME': 'cltbld', 16:11:10 INFO - 'MAIL': '/var/mail/cltbld', 16:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:10 INFO - 'MOZ_NO_REMOTE': '1', 16:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:10 INFO - 'NO_EM_RESTART': '1', 16:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:10 INFO - 'PWD': '/builds/slave/test', 16:11:10 INFO - 'SHELL': '/bin/bash', 16:11:10 INFO - 'SHLVL': '1', 16:11:10 INFO - 'TERM': 'linux', 16:11:10 INFO - 'TMOUT': '86400', 16:11:10 INFO - 'USER': 'cltbld', 16:11:10 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', 16:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:10 INFO - '_': '/tools/buildbot/bin/python'} 16:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:10 INFO - Downloading/unpacking psutil>=3.1.1 16:11:10 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 16:11:10 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 16:11:10 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 16:11:10 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 16:11:10 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 16:11:10 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 16:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:11:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:11:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:11:12 INFO - Installing collected packages: psutil 16:11:12 INFO - Running setup.py install for psutil 16:11:13 INFO - building 'psutil._psutil_linux' extension 16:11:13 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 16:11:13 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 16:11:13 INFO - building 'psutil._psutil_posix' extension 16:11:13 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 16:11:13 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 16:11:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:11:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:11:13 INFO - Successfully installed psutil 16:11:13 INFO - Cleaning up... 16:11:13 INFO - Return code: 0 16:11:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:11:13 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')]} 16:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:13 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')]} 16:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:13 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 0x7f3bc3831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1370>, '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 0x1dc48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4d80>, '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': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', '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 16:11:13 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 16:11:13 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 16:11:13 INFO - Using env: {'DISPLAY': ':0', 16:11:13 INFO - 'HOME': '/home/cltbld', 16:11:13 INFO - 'LANG': 'en_US.UTF-8', 16:11:13 INFO - 'LANGUAGE': 'en_US:en', 16:11:13 INFO - 'LOGNAME': 'cltbld', 16:11:13 INFO - 'MAIL': '/var/mail/cltbld', 16:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:13 INFO - 'MOZ_NO_REMOTE': '1', 16:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:13 INFO - 'NO_EM_RESTART': '1', 16:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:13 INFO - 'PWD': '/builds/slave/test', 16:11:13 INFO - 'SHELL': '/bin/bash', 16:11:13 INFO - 'SHLVL': '1', 16:11:13 INFO - 'TERM': 'linux', 16:11:13 INFO - 'TMOUT': '86400', 16:11:13 INFO - 'USER': 'cltbld', 16:11:13 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', 16:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:13 INFO - '_': '/tools/buildbot/bin/python'} 16:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:11:13 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 16:11:13 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 16:11:13 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 16:11:13 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 16:11:13 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 16:11:13 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 16:11:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:11:15 INFO - Installing collected packages: mozsystemmonitor 16:11:15 INFO - Running setup.py install for mozsystemmonitor 16:11:15 INFO - Successfully installed mozsystemmonitor 16:11:15 INFO - Cleaning up... 16:11:15 INFO - Return code: 0 16:11:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:11:15 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')]} 16:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:15 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')]} 16:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:15 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 0x7f3bc3831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1370>, '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 0x1dc48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4d80>, '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': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', '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 16:11:15 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 16:11:15 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 16:11:15 INFO - Using env: {'DISPLAY': ':0', 16:11:15 INFO - 'HOME': '/home/cltbld', 16:11:15 INFO - 'LANG': 'en_US.UTF-8', 16:11:15 INFO - 'LANGUAGE': 'en_US:en', 16:11:15 INFO - 'LOGNAME': 'cltbld', 16:11:15 INFO - 'MAIL': '/var/mail/cltbld', 16:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:15 INFO - 'MOZ_NO_REMOTE': '1', 16:11:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:15 INFO - 'NO_EM_RESTART': '1', 16:11:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:15 INFO - 'PWD': '/builds/slave/test', 16:11:15 INFO - 'SHELL': '/bin/bash', 16:11:15 INFO - 'SHLVL': '1', 16:11:15 INFO - 'TERM': 'linux', 16:11:15 INFO - 'TMOUT': '86400', 16:11:15 INFO - 'USER': 'cltbld', 16:11:15 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', 16:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:15 INFO - '_': '/tools/buildbot/bin/python'} 16:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:16 INFO - Downloading/unpacking jsonschema==2.5.1 16:11:16 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 16:11:16 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 16:11:16 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 16:11:16 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 16:11:16 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 16:11:16 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 16:11:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:11:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:18 INFO - Downloading functools32-3.2.3-2.tar.gz 16:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:11:18 INFO - warning: no files found matching '*.txt' 16:11:18 INFO - no previously-included directories found matching 'build' 16:11:18 INFO - no previously-included directories found matching 'dist' 16:11:18 INFO - no previously-included directories found matching '.git*' 16:11:18 INFO - Installing collected packages: jsonschema, functools32 16:11:18 INFO - Running setup.py install for functools32 16:11:18 INFO - warning: no files found matching '*.txt' 16:11:18 INFO - no previously-included directories found matching 'build' 16:11:18 INFO - no previously-included directories found matching 'dist' 16:11:18 INFO - no previously-included directories found matching '.git*' 16:11:18 INFO - Successfully installed jsonschema functools32 16:11:18 INFO - Cleaning up... 16:11:18 INFO - Return code: 0 16:11:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:11:18 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')]} 16:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:18 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')]} 16:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:18 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 0x7f3bc3831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1370>, '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 0x1dc48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4d80>, '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': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', '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 16:11:18 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 16:11:18 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 16:11:18 INFO - Using env: {'DISPLAY': ':0', 16:11:18 INFO - 'HOME': '/home/cltbld', 16:11:18 INFO - 'LANG': 'en_US.UTF-8', 16:11:18 INFO - 'LANGUAGE': 'en_US:en', 16:11:18 INFO - 'LOGNAME': 'cltbld', 16:11:18 INFO - 'MAIL': '/var/mail/cltbld', 16:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:18 INFO - 'MOZ_NO_REMOTE': '1', 16:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:18 INFO - 'NO_EM_RESTART': '1', 16:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:18 INFO - 'PWD': '/builds/slave/test', 16:11:18 INFO - 'SHELL': '/bin/bash', 16:11:18 INFO - 'SHLVL': '1', 16:11:18 INFO - 'TERM': 'linux', 16:11:18 INFO - 'TMOUT': '86400', 16:11:18 INFO - 'USER': 'cltbld', 16:11:18 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', 16:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:18 INFO - '_': '/tools/buildbot/bin/python'} 16:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:11:18 INFO - Cleaning up... 16:11:18 INFO - Return code: 0 16:11:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:11:18 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')]} 16:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:18 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')]} 16:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:18 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 0x7f3bc3831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1370>, '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 0x1dc48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4d80>, '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': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', '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 16:11:18 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 16:11:18 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 16:11:18 INFO - Using env: {'DISPLAY': ':0', 16:11:18 INFO - 'HOME': '/home/cltbld', 16:11:18 INFO - 'LANG': 'en_US.UTF-8', 16:11:18 INFO - 'LANGUAGE': 'en_US:en', 16:11:18 INFO - 'LOGNAME': 'cltbld', 16:11:18 INFO - 'MAIL': '/var/mail/cltbld', 16:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:18 INFO - 'MOZ_NO_REMOTE': '1', 16:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:18 INFO - 'NO_EM_RESTART': '1', 16:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:18 INFO - 'PWD': '/builds/slave/test', 16:11:18 INFO - 'SHELL': '/bin/bash', 16:11:18 INFO - 'SHLVL': '1', 16:11:18 INFO - 'TERM': 'linux', 16:11:18 INFO - 'TMOUT': '86400', 16:11:18 INFO - 'USER': 'cltbld', 16:11:18 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', 16:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:18 INFO - '_': '/tools/buildbot/bin/python'} 16:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:18 INFO - Downloading/unpacking blobuploader==1.2.4 16:11:18 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 16:11:18 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 16:11:18 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 16:11:18 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 16:11:18 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 16:11:18 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 16:11:20 INFO - Downloading blobuploader-1.2.4.tar.gz 16:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:11:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:11:20 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 16:11:20 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 16:11:20 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 16:11:20 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 16:11:20 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 16:11:20 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 16:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:11:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:21 INFO - Downloading docopt-0.6.1.tar.gz 16:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:11:21 INFO - Installing collected packages: blobuploader, requests, docopt 16:11:21 INFO - Running setup.py install for blobuploader 16:11:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:11:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:11:21 INFO - Running setup.py install for requests 16:11:21 INFO - Running setup.py install for docopt 16:11:22 INFO - Successfully installed blobuploader requests docopt 16:11:22 INFO - Cleaning up... 16:11:22 INFO - Return code: 0 16:11:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:22 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 0x7f3bc3831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1370>, '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 0x1dc48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4d80>, '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': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', '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 16:11:22 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 16:11:22 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 16:11:22 INFO - Using env: {'DISPLAY': ':0', 16:11:22 INFO - 'HOME': '/home/cltbld', 16:11:22 INFO - 'LANG': 'en_US.UTF-8', 16:11:22 INFO - 'LANGUAGE': 'en_US:en', 16:11:22 INFO - 'LOGNAME': 'cltbld', 16:11:22 INFO - 'MAIL': '/var/mail/cltbld', 16:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:22 INFO - 'MOZ_NO_REMOTE': '1', 16:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:22 INFO - 'NO_EM_RESTART': '1', 16:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:22 INFO - 'PWD': '/builds/slave/test', 16:11:22 INFO - 'SHELL': '/bin/bash', 16:11:22 INFO - 'SHLVL': '1', 16:11:22 INFO - 'TERM': 'linux', 16:11:22 INFO - 'TMOUT': '86400', 16:11:22 INFO - 'USER': 'cltbld', 16:11:22 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', 16:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:22 INFO - '_': '/tools/buildbot/bin/python'} 16:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:11:22 INFO - Running setup.py (path:/tmp/pip-QUc8j7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:11:22 INFO - Running setup.py (path:/tmp/pip-CdYvmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:11:22 INFO - Running setup.py (path:/tmp/pip-A5tkAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:11:22 INFO - Running setup.py (path:/tmp/pip-8q9cQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:11:22 INFO - Running setup.py (path:/tmp/pip-1VNwKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:11:22 INFO - Running setup.py (path:/tmp/pip-cnkVXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:11:22 INFO - Running setup.py (path:/tmp/pip-ArHFVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:11:22 INFO - Running setup.py (path:/tmp/pip-B5EZqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:11:22 INFO - Running setup.py (path:/tmp/pip-m729xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:11:22 INFO - Running setup.py (path:/tmp/pip-2dl422-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:11:23 INFO - Running setup.py (path:/tmp/pip-Aj2OYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:11:23 INFO - Running setup.py (path:/tmp/pip-0sAsDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:11:23 INFO - Running setup.py (path:/tmp/pip-TclUoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:11:23 INFO - Running setup.py (path:/tmp/pip-pm8wCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:23 INFO - Running setup.py (path:/tmp/pip-I5b3fF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:11:23 INFO - Running setup.py (path:/tmp/pip-qbWz6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:11:23 INFO - Running setup.py (path:/tmp/pip-1y6AAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:11:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:11:23 INFO - Running setup.py install for manifestparser 16:11:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:11:23 INFO - Running setup.py install for mozcrash 16:11:23 INFO - Running setup.py install for mozdebug 16:11:23 INFO - Running setup.py install for mozdevice 16:11:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:11:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:11:23 INFO - Running setup.py install for mozfile 16:11:24 INFO - Running setup.py install for mozhttpd 16:11:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:11:24 INFO - Running setup.py install for mozinfo 16:11:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:11:24 INFO - Running setup.py install for mozInstall 16:11:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:11:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:11:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:11:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:11:24 INFO - Running setup.py install for mozleak 16:11:24 INFO - Running setup.py install for mozlog 16:11:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:11:24 INFO - Running setup.py install for moznetwork 16:11:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:11:24 INFO - Running setup.py install for mozprocess 16:11:24 INFO - Running setup.py install for mozprofile 16:11:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:11:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:11:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:11:24 INFO - Running setup.py install for mozrunner 16:11:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:11:25 INFO - Running setup.py install for mozscreenshot 16:11:25 INFO - Running setup.py install for moztest 16:11:25 INFO - Running setup.py install for mozversion 16:11:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:11:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:11:25 INFO - Cleaning up... 16:11:25 INFO - Return code: 0 16:11:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:25 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 0x7f3bc3831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1370>, '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 0x1dc48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4d80>, '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': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', '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 16:11:25 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 16:11:25 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 16:11:25 INFO - Using env: {'DISPLAY': ':0', 16:11:25 INFO - 'HOME': '/home/cltbld', 16:11:25 INFO - 'LANG': 'en_US.UTF-8', 16:11:25 INFO - 'LANGUAGE': 'en_US:en', 16:11:25 INFO - 'LOGNAME': 'cltbld', 16:11:25 INFO - 'MAIL': '/var/mail/cltbld', 16:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:25 INFO - 'MOZ_NO_REMOTE': '1', 16:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:25 INFO - 'NO_EM_RESTART': '1', 16:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:25 INFO - 'PWD': '/builds/slave/test', 16:11:25 INFO - 'SHELL': '/bin/bash', 16:11:25 INFO - 'SHLVL': '1', 16:11:25 INFO - 'TERM': 'linux', 16:11:25 INFO - 'TMOUT': '86400', 16:11:25 INFO - 'USER': 'cltbld', 16:11:25 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', 16:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:25 INFO - '_': '/tools/buildbot/bin/python'} 16:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:11:25 INFO - Running setup.py (path:/tmp/pip-9NQa2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:11:25 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)) 16:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:11:25 INFO - Running setup.py (path:/tmp/pip-Mschho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:11:25 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)) 16:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:11:25 INFO - Running setup.py (path:/tmp/pip-862z9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:11:25 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)) 16:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:11:25 INFO - Running setup.py (path:/tmp/pip-dAbHAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:11:25 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)) 16:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:11:25 INFO - Running setup.py (path:/tmp/pip-2Ltur8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:11:25 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)) 16:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:11:25 INFO - Running setup.py (path:/tmp/pip-fR7P5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:11:25 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)) 16:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:11:25 INFO - Running setup.py (path:/tmp/pip-4QMKRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:11:26 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)) 16:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:11:26 INFO - Running setup.py (path:/tmp/pip-va7RDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:11:26 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)) 16:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:11:26 INFO - Running setup.py (path:/tmp/pip-f19EYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:11:26 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)) 16:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:11:26 INFO - Running setup.py (path:/tmp/pip-UClW9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:11:26 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)) 16:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:11:26 INFO - Running setup.py (path:/tmp/pip-2GVVZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:11:26 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)) 16:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:11:26 INFO - Running setup.py (path:/tmp/pip-b5voS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:11:26 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)) 16:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:11:26 INFO - Running setup.py (path:/tmp/pip-HjN0AI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:11:26 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)) 16:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:11:26 INFO - Running setup.py (path:/tmp/pip-C3wMxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:11:26 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)) 16:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:26 INFO - Running setup.py (path:/tmp/pip-J9E0Pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:26 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)) 16:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:11:26 INFO - Running setup.py (path:/tmp/pip-DfP8fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:11:26 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)) 16:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:11:26 INFO - Running setup.py (path:/tmp/pip-9qd4kB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:11:26 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)) 16:11:26 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)) 16:11:26 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)) 16:11:26 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)) 16:11:26 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)) 16:11:26 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)) 16:11:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:11:26 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 16:11:26 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 16:11:26 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 16:11:26 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 16:11:26 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 16:11:26 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 16:11:28 INFO - Downloading blessings-1.6.tar.gz 16:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:11:28 INFO - Installing collected packages: blessings 16:11:28 INFO - Running setup.py install for blessings 16:11:28 INFO - Successfully installed blessings 16:11:28 INFO - Cleaning up... 16:11:28 INFO - Return code: 0 16:11:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:11:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:11:29 INFO - Reading from file tmpfile_stdout 16:11:29 INFO - Current package versions: 16:11:29 INFO - argparse == 1.2.1 16:11:29 INFO - blessings == 1.6 16:11:29 INFO - blobuploader == 1.2.4 16:11:29 INFO - docopt == 0.6.1 16:11:29 INFO - functools32 == 3.2.3-2 16:11:29 INFO - jsonschema == 2.5.1 16:11:29 INFO - manifestparser == 1.1 16:11:29 INFO - mozInstall == 1.12 16:11:29 INFO - mozcrash == 0.17 16:11:29 INFO - mozdebug == 0.1 16:11:29 INFO - mozdevice == 0.48 16:11:29 INFO - mozfile == 1.2 16:11:29 INFO - mozhttpd == 0.7 16:11:29 INFO - mozinfo == 0.9 16:11:29 INFO - mozleak == 0.1 16:11:29 INFO - mozlog == 3.3 16:11:29 INFO - moznetwork == 0.27 16:11:29 INFO - mozprocess == 0.23 16:11:29 INFO - mozprofile == 0.28 16:11:29 INFO - mozrunner == 6.12 16:11:29 INFO - mozscreenshot == 0.1 16:11:29 INFO - mozsystemmonitor == 0.3 16:11:29 INFO - moztest == 0.7 16:11:29 INFO - mozversion == 1.4 16:11:29 INFO - psutil == 3.1.1 16:11:29 INFO - requests == 1.2.3 16:11:29 INFO - wsgiref == 0.1.2 16:11:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:11:29 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')]} 16:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:29 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')]} 16:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:29 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 0x7f3bc3831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1370>, '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 0x1dc48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4d80>, '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': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', '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 16:11:29 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 16:11:29 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 16:11:29 INFO - Using env: {'DISPLAY': ':0', 16:11:29 INFO - 'HOME': '/home/cltbld', 16:11:29 INFO - 'LANG': 'en_US.UTF-8', 16:11:29 INFO - 'LANGUAGE': 'en_US:en', 16:11:29 INFO - 'LOGNAME': 'cltbld', 16:11:29 INFO - 'MAIL': '/var/mail/cltbld', 16:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:29 INFO - 'MOZ_NO_REMOTE': '1', 16:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:29 INFO - 'NO_EM_RESTART': '1', 16:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:29 INFO - 'PWD': '/builds/slave/test', 16:11:29 INFO - 'SHELL': '/bin/bash', 16:11:29 INFO - 'SHLVL': '1', 16:11:29 INFO - 'TERM': 'linux', 16:11:29 INFO - 'TMOUT': '86400', 16:11:29 INFO - 'USER': 'cltbld', 16:11:29 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', 16:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:29 INFO - '_': '/tools/buildbot/bin/python'} 16:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:29 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)) 16:11:29 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)) 16:11:29 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)) 16:11:29 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)) 16:11:29 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)) 16:11:29 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)) 16:11:29 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)) 16:11:29 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)) 16:11:29 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)) 16:11:29 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)) 16:11:29 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)) 16:11:29 INFO - Cleaning up... 16:11:29 INFO - Return code: 0 16:11:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:11:29 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')]} 16:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:29 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')]} 16:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:29 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 0x7f3bc3831f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1370>, '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 0x1dc48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4d80>, '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': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', '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 16:11:29 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 16:11:29 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 16:11:29 INFO - Using env: {'DISPLAY': ':0', 16:11:29 INFO - 'HOME': '/home/cltbld', 16:11:29 INFO - 'LANG': 'en_US.UTF-8', 16:11:29 INFO - 'LANGUAGE': 'en_US:en', 16:11:29 INFO - 'LOGNAME': 'cltbld', 16:11:29 INFO - 'MAIL': '/var/mail/cltbld', 16:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:29 INFO - 'MOZ_NO_REMOTE': '1', 16:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:29 INFO - 'NO_EM_RESTART': '1', 16:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:29 INFO - 'PWD': '/builds/slave/test', 16:11:29 INFO - 'SHELL': '/bin/bash', 16:11:29 INFO - 'SHLVL': '1', 16:11:29 INFO - 'TERM': 'linux', 16:11:29 INFO - 'TMOUT': '86400', 16:11:29 INFO - 'USER': 'cltbld', 16:11:29 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', 16:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:29 INFO - '_': '/tools/buildbot/bin/python'} 16:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:11:29 INFO - Cleaning up... 16:11:29 INFO - Return code: 0 16:11:29 INFO - Running post-action listener: _resource_record_post_action 16:11:29 INFO - Running post-action listener: _start_resource_monitoring 16:11:29 INFO - Starting resource monitoring. 16:11:29 INFO - [mozharness: 2016-08-22 23:11:29.627563Z] Finished create-virtualenv step (success) 16:11:29 INFO - [mozharness: 2016-08-22 23:11:29.628032Z] Running install step. 16:11:29 INFO - Running pre-action listener: _resource_record_pre_action 16:11:29 INFO - Running main action method: install 16:11:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:11:29 INFO - Reading from file tmpfile_stdout 16:11:29 INFO - Detecting whether we're running mozinstall >=1.0... 16:11:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:11:29 INFO - Reading from file tmpfile_stdout 16:11:29 INFO - Output received: 16:11:29 INFO - Usage: mozinstall [options] installer 16:11:29 INFO - Options: 16:11:29 INFO - -h, --help show this help message and exit 16:11:29 INFO - -d DEST, --destination=DEST 16:11:29 INFO - Directory to install application into. [default: 16:11:29 INFO - "/builds/slave/test"] 16:11:29 INFO - --app=APP Application being installed. [default: firefox] 16:11:29 INFO - mkdir: /builds/slave/test/build/application 16:11:29 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'] 16:11:29 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 16:11:46 INFO - Reading from file tmpfile_stdout 16:11:46 INFO - Output received: 16:11:46 INFO - /builds/slave/test/build/application/firefox/firefox 16:11:46 INFO - Running post-action listener: _resource_record_post_action 16:11:46 INFO - [mozharness: 2016-08-22 23:11:46.975722Z] Finished install step (success) 16:11:46 INFO - [mozharness: 2016-08-22 23:11:46.975969Z] Running run-tests step. 16:11:46 INFO - Running pre-action listener: _resource_record_pre_action 16:11:46 INFO - Running main action method: run_tests 16:11:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:11:46 INFO - Python 2.7.3 16:11:46 INFO - Return code: 0 16:11:46 INFO - grabbing minidump binary from tooltool 16:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:46 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 0x1dc1370>, '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 0x1dc48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:11:46 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 16:11:46 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 16:11:46 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 16:11:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:11:47 INFO - Return code: 0 16:11:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:11:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:11:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:11:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:11:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:11:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:11:47 INFO - Using env: {'DISPLAY': ':0', 16:11:47 INFO - 'HOME': '/home/cltbld', 16:11:47 INFO - 'LANG': 'en_US.UTF-8', 16:11:47 INFO - 'LANGUAGE': 'en_US:en', 16:11:47 INFO - 'LOGNAME': 'cltbld', 16:11:47 INFO - 'MAIL': '/var/mail/cltbld', 16:11:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:11:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:47 INFO - 'MOZ_NO_REMOTE': '1', 16:11:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:47 INFO - 'NO_EM_RESTART': '1', 16:11:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:47 INFO - 'PWD': '/builds/slave/test', 16:11:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:11:47 INFO - 'SHELL': '/bin/bash', 16:11:47 INFO - 'SHLVL': '1', 16:11:47 INFO - 'TERM': 'linux', 16:11:47 INFO - 'TMOUT': '86400', 16:11:47 INFO - 'USER': 'cltbld', 16:11:47 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242', 16:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:47 INFO - '_': '/tools/buildbot/bin/python'} 16:11:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:11:47 INFO - mozversion application_buildid: 20160822143002 16:11:47 INFO - mozversion application_changeset: 08e9ded26ada149385af32e1c1d89f30e3d8279c 16:11:47 INFO - mozversion application_display_name: Nightly 16:11:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:11:47 INFO - mozversion application_name: Firefox 16:11:47 INFO - mozversion application_remotingname: firefox 16:11:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:11:47 INFO - mozversion application_vendor: Mozilla 16:11:47 INFO - mozversion application_version: 51.0a1 16:11:47 INFO - mozversion platform_buildid: 20160822143002 16:11:47 INFO - mozversion platform_changeset: 08e9ded26ada149385af32e1c1d89f30e3d8279c 16:11:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:11:47 INFO - mozversion platform_version: 51.0a1 16:11:47 INFO - using testdate: 1471907507 16:11:47 INFO - actual date: 1471907507 16:11:47 INFO - starting webserver on 'localhost:47702' 16:11:47 INFO - SUITE-START | Running 2 tests 16:11:47 INFO - TEST-START | dromaeo_css 16:11:47 INFO - operating with platform_type : linux_ 16:11:47 INFO - Initialising browser for dromaeo_css test... 16:11:47 INFO - TEST-INFO | started process 3182 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZkL7Lg/profile http://localhost:47702/getInfo.html) 16:11:52 INFO - PROCESS | 3182 | __metrics Screen width/height:1600/1200 16:11:52 INFO - PROCESS | 3182 | colorDepth:24 16:11:52 INFO - PROCESS | 3182 | Browser inner width/height: 1024/697 16:11:52 INFO - PROCESS | 3182 | __metrics 16:11:52 ERROR - PROCESS | 3182 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2993: TypeError: this.tabs is undefined 16:11:53 INFO - TEST-INFO | 3182: exit 0 16:11:53 INFO - Browser initialized. 16:11:53 INFO - Running cycle 1/1 for dromaeo_css test... 16:11:53 INFO - TEST-INFO | started process 3302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZkL7Lg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:05 INFO - PROCESS | 3302 | RSS: Main: 187428864 16:12:05 INFO - PROCESS | 3302 | 16:12:55 INFO - PROCESS | 3302 | 1471907575600 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] 16:15:05 INFO - PROCESS | 3302 | Cycle 1(1): loaded http://localhost:47702/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47702/tests/dromaeo/cssquery-ext.html) 16:15:06 INFO - PROCESS | 3302 | RSS: Main: 199475200 16:15:06 INFO - PROCESS | 3302 | 16:18:08 INFO - PROCESS | 3302 | Cycle 1(1): loaded http://localhost:47702/tests/dromaeo/cssquery-ext.html (next: http://localhost:47702/tests/dromaeo/cssquery-jquery.html) 16:18:09 INFO - PROCESS | 3302 | RSS: Main: 198524928 16:18:09 INFO - PROCESS | 3302 | 16:21:11 INFO - PROCESS | 3302 | Cycle 1(1): loaded http://localhost:47702/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47702/tests/dromaeo/cssquery-mootools.html) 16:21:11 INFO - PROCESS | 3302 | RSS: Main: 199696384 16:21:11 INFO - PROCESS | 3302 | 16:24:13 INFO - PROCESS | 3302 | Cycle 1(1): loaded http://localhost:47702/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47702/tests/dromaeo/cssquery-prototype.html) 16:24:14 INFO - PROCESS | 3302 | RSS: Main: 197148672 16:24:14 INFO - PROCESS | 3302 | 16:27:16 INFO - PROCESS | 3302 | Cycle 1(1): loaded http://localhost:47702/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47702/tests/dromaeo/cssquery-yui.html) 16:27:17 INFO - PROCESS | 3302 | RSS: Main: 199278592 16:27:17 INFO - PROCESS | 3302 | 16:30:20 INFO - PROCESS | 3302 | Cycle 1(1): loaded http://localhost:47702/tests/dromaeo/cssquery-yui.html (next: http://localhost:47702/tests/dromaeo/cssquery-dojo.html) 16:30:20 INFO - PROCESS | 3302 | RSS: Main: 200028160 16:30:20 INFO - PROCESS | 3302 | 16:30:20 INFO - PROCESS | 3302 | __start_tp_report 16:30:20 INFO - PROCESS | 3302 | _x_x_mozilla_page_load 16:30:20 INFO - PROCESS | 3302 | _x_x_mozilla_page_load_details 16:30:20 INFO - PROCESS | 3302 | |i|pagename|runs| 16:30:20 INFO - PROCESS | 3302 | |0;dojo.html;3058.1284333964823;3079.214800225942;3089.274020605159;3097.5198844179145;3100.178452710031;5409.188621706746;5470.699111548864;5484.670919744818;5554.750036248379;5555.722213889305;5423.593230507708;5446.455354464551;5457.099578569531;5462.399136095027;5554.2779438672915;4794.83218087367;4908.141075311824;4986.850394488153;5142.948570514303;5144.536991670768;5073.239014147871;5140.4859514048485;5150.304708864312;5152.072626927152;5180.948190518103;4815.301781241736;4959.305697202394;4987.376577927759;5002.774875130628;5068.79724811009;5068.138416469209;5075.441701412841;5094.337736094284;5096.592272618182;5116.616253780981;4972.602191824645;5021.497850214986;5042.823501177478;5075.98480303937;5088.821891233826;5310.36275646921;5393.8112166074;5396.136618141118;5509.118541033456;5591.7483713233005;5799.159121927297;5830.47525722687;5835.387284335126;5835.503982161479;5869.7652093916195;5850;5850.795222167247;5895.970520147414;5904.468597826173;5930.169776231331;5328.973355133199;5364.302640656729;5399.163129714901;5458.263134476795;5474.7810087596445;5945.583809133405;5953.374895635896;5963.7912673056235;5974.731137098841;5981.611195272293;5727.226824378656;5744.885102297931;5757.827265182052;5762.855928601818;5764.423557644202;5658.490735833795;5823.56323275756;5877.853053673693;5906.704664766745;6001.549883758736;5918.2898052234;5958.076498142795;5971.701414929323;5981.0729336952845;6009.128676341906;5957.672328021914;5985.940140598538;5993.550483713739;6002.63984160943;6012.338642749294;4455.532169122261;4490.259107247268;4490.910181796411;4494.12364588902;4558.407407037131;4017.819198136091;4024.63778259958;4029.315016447211;4036.8990775230855;4049.149678567534;5587.329520457572;5621.128725047624;5626.634268772516;5627;5641.097424412074;5764.07774756037;5765.106408506688;5803.593748437654;5861.472467477862;5893.911591326134;5570.387257401682;5575.1915972184615;5583.553315734732;5595.160725891067;5595.440455954372;5036.219385995177;5079.8984020319385;5090.9236361454605;5102.872428189251;5105.642605017687;6100.816975490654;6203.565750397519;6208.937910620836;6212.720427580679;6234.189555357865;5952.404759524013;5968.045112781934;5971.0744834550715;5973.283206015306;6004.459598636144;5948.4943779779205;6080.787172448943;6177.2587289525545;6196.256449226122;6196.659183744938;5814.3604203538425;5941.494972927349;5960.850978725566;5962.25471816023;5966.105084237399;5923.437273459014;5930.199423077829;5983.9401605983385;6021.2473440819895;6049.425304596057;5709.029464991045;5753.971230143822;5919.171316015847;5923.318818335946;5932.4957378621575;5758.193852860687;5861.120831875082;5868.970655146697;5877.089051197071;5881.647101173943;5756.107803290497;5814.94185058144;5815.563832712648;5818.883622327615;5827.79602713903;5633.6619802811965;5769.134629805395;5918.704064796657;5948.524118070631;5949.672767997628;5672.4894759471845;5776.42235776419;5784.99597847867;5786.942130578809;5801.36185019639 16:30:20 INFO - PROCESS | 3302 | |1;ext.html;555.336373034224;569.2429069337778;569.3537834557778;575.5050656435466;610.6549799363362;39173.80413097934;42757.57242427575;42794.572054279444;42811;42911.78544107283;43345.56654433455;43937.34093988593;43991.340129897995;44142.77928610361;44202.55797442025;8896.777580560505;8962.327825413087;8963.641454341818;8983;9046.819063618757;8300.418970672055;8602.397832151752;8641.26549243312;8699.217070463657;8743.169398907094;8817.456945034626;8952.731418057436;8964.731058068235;9004.459732416077;9008.504532250723;8871.866921996176;8884.378093533454;8926.776830579223;8978.326625503081;9011.504367259799;8733.737987860375;8869.955650221773;8907.732768016906;8929.642814287421;8931.50876701781;40517.18965620671;40667.186656267004;40669.593304066875;40864.18271634581;40869.79565102155;3357;3455.4989526518766;3500.5449291592186;3502.2645244498685;3566.7681600696133;30469;32428.837855810805;32685.50971735426;32773.83613081943;34770.478442823376;4290.613844753987;4388.758618275993;4444.6666500012625;4451.688381813242;4489.932651010237;357035.2148239268;362005;362214;363340;365129;59251.407485925454;59431.40568594345;59883;60267;60480;36135;36887.26225475529;37115.81442092772;39202;39210.60789392127;16296;16375.09936953479;16384.75422868658;16493.752593711102;16496.25766840495;12272.38638068111;12410.81383779244;12414.937925310316;12505.249685018927;12563.057770667236;18487;18523.166457509175;18652.160652770657;18737.81262187388;18810.81189188118;7054.823629409306;7077.532009315399;7092.184398794205;7143.9285607143265;7180.856382872314;956.6651671914774;1052.6368402900987;1080.4111759091313;1080.983785243222;1141.08713029576;32383.514247286308;32472.350552988806;32703;33145;33595.66404335974;1095.8137116690182;1161.5760247509768;1199.8620158681688;1221.6640423883503;1228.6314105768233;17130.571735706708;17150.399736009178;17152.31390744381;17217.741733874;17302.480925572254;576430;577465;581625;583364;584380;58323.41676583265;59301.703491482265;59549.70225148933;59684.70157649184;59698.40301597015;1314.90795644304;1346.3806648941597;1351.6620844788804;1359.5513480551197;1376.0436496634943;27575.862120689268;31232.531512026882;31592;32195.35609287848;33014.33971320608;50994;55041;56412.71793641005;56419.43580564142;60976;506295;513765;515657;516268;516613;43356.56643433651;43892.78053609712;44254;44299.33550996673;44504.77747611241;48511;49812.25281620851;49897;50133.74933125311;50327.49672503228;41212.1757564841;41258.793706031276;42324.57675423206;43263.13473730571;43570.78214608907;42120.57879421289;42665.78667106769;43020.35469467898;43861.56138438575;44598.3310250353;41345.379819302136;41695.58304417038;41802.37296440495;42014.36978445387;43046;30702.539461907643;35978.4603230957;37327;38106.237875241786;38263.2347353057;27941.44117117687;28105.578416323362;28187;28253.43493130167;28441.28896777597 16:30:20 INFO - PROCESS | 3302 | |2;jquery.html;373.1771443966055;379.87271280827355;397.37413573621546;402.8690675530452;410.44179915315163;13715;18536.721949170755;19736.506587335323;20398.184072637094;20421.081051352707;19226.327078552255;19420.698481258183;19643.410697679057;19796.30712925048;20066.49833754157;5768.682722450264;5787.594868359217;5926.674032928187;5983.551233657493;6008.128821320905;5830.854228644275;5841.824745257649;5872.647641141545;5905.438983296602;5907.291125064977;5632.9436705632825;5847.736851841656;5888.558358123137;5931.466168044875;5971.581989260753;5803.854903627401;5931.881362372772;5936.673482958436;6003.099535069731;6021.819345419644;5731.684757338345;5768;5779.768809247625;5781.421857814227;5792.957267691814;14643.121412715165;14676;14800.555983320517;14908;14959.700805983928;2153.7307836520436;2198.318521258415;2239.876806775627;2332.54515369503;2524.709658389272;10133;10313.48432578368;10711.410872402015;10806.621768238074;13498.987575931844;1844.8985305808176;1973.6644770389069;1995.720599116125;1996.670549359354;2003.5091402606308;83282;87891.56054219752;87969;88389;92352;11223;11226.55093796239;11265.54937802495;11285.379304138187;11755.294682319089;15915.204239788196;15956.840431595767;16025.118618476095;16026.439074632332;16026.439074632564;7853.214678532101;8077.838443231102;8160.836783264302;8203.83592328162;8299.012355551997;7515.173330933593;7578.886316705254;7624.733134340271;7805.765827025199;7824.178461261599;4603.631709463235;4815.783289751969;4884.340614017062;4907.116718990616;5059.392872855281;2003.7996200379846;2005.6891181866833;2032.6341258573302;2040.1023549638408;2050.29264903608;910.1217325281135;958.3435346787472;997.9700608981742;1003.8745156855393;1027.3219675014454;20265.49336266605;20487.28294509685;20520.897395512926;20785.1685932561;20790.064447099918;918.2424499787702;935.7988032573029;945.8155659646303;1005.1205195453978;1023.9385636861812;10751.892481075089;10896.509657065451;11293.43532823372;11452.198346115858;11528.654140375802;542242;545645;549664;554257;555724.6489118665;87866;88588.5570572143;91595;96256;97133;1014.3305418423805;1045.8588090607823;1056.339787632745;1061.0927656853435;1067.7010437077631;18635.90682046581;18636.813631863508;19244.807551924303;19282.32511862078;19457.12442940043;43002.78498607487;44475.55524444714;44556.554434456535;45482.77258613686;45885;61349.38650613615;62807.38216808852;63723.36276637174;63826.68086659537;66028.33971660222;8554.144585541397;8602.612882420432;8702.260307873901;8752.387332886638;8897.73306800797;8953.820923581361;9209.631614735603;9233.399829011092;9472.95263523678;9536.523173841142;8182.631781569725;8581.570921454027;8616.138386161334;9079.273658107468;9242.537873106183;4849.80600775965;7171.605561694157;7440.92559074424;8872.86690699627;8889.555522223734;8787.472751634923;8849.159329863653;8927.687530936386;8958.910410895807;9150.542472876197;12688.429020694275;12927.288999104763;12982;13225.611310812226;13295.933520332337;12308.076894232789;12472.75054498923;12734.172278801849;12772.680682982627;13066.216027038408 16:30:20 INFO - PROCESS | 3302 | |3;mootools.html;1496.3939604460195;1516.1206500229869;1650.364609625294;1720.7590937268776;1760.7006808842505;7569.091708994914;8683.956580217098;8801.207891289783;9169;9202.355835091555;8782.868256976151;9138.13187747163;9154.176124148826;9160.908390916089;9164.633414663422;2400.867952262625;2401.7478164792665;2418.1657328221822;2418.3591348292716;2422.6366045093287;2369.609014512603;2383.165891937825;2405.8797060147012;2422.794062504689;2440.5606990741658;2368.8815559222057;2395.3053614451874;2398.46034642205;2414.2757172848164;2417.226487523993;2324.6164382876805;2349.201271567675;2354.9646755298686;2365.66880636711;2386.976130238693;2287.1994801819396;2296.850704704189;2319.6288593825075;2327.511222643247;2346.9882650586637;9116.4074335168;9140.40587361826;9217.63129474827;9228.492432916188;9238.16856482913;5279.049771041211;5392.595555333366;5397.622166448311;5408.972955135238;5411.675299482044;3416.145963509123;3440.9483857742152;3447.293304872495;3503.4569641705575;3505.7545971781988;1051.437480947697;1052.7999680060764;1064.0264158295151;1064.9574017039308;1071.7159952612565;12416.875831241663;12541.56104536346;12579.874201257962;12631.621051368566;12664.303463309514;4253.3194688849635;4492.124035812985;4535.206338890681;4662.650301227422;4735.715857048588;10484.528196231187;10509.106725928228;10524.684259472227;10587.15302775776;10614.946925265478;5262.71055091966;5270.49930256625;5274.683518988873;5289.2330612061805;5295.364556253275;4351.608355248043;4639.582437580634;4640.419947506562;4725.740084295328;4807.543283388142;3899.732586909266;3949.5063117110362;4070.653994410449;4137.97931010343;4162.62536371728;1307.8103674967267;1331.3542931678128;1334.359507436436;1336.1849271944106;1339.7454483648075;970.737900766789;986.1420564109271;1003.7590978165334;1013.4172850610781;1016.1413605503337;5956.761729530857;6051.909221361683;6105.145279660851;6203.906941395882;6453.967365221542;448.84290498325976;452.81887245102223;466.9136209801198;506.88341681412743;508.96691715038406;3973.4039894016128;4107.199096176217;4158.8336466541605;4180.832766689298;4275.0594869128745;10703.197260205516;11113;11117.221794474472;11206.439678016066;11239.269447485887;10937.343759374464;10951.83572246417;10978.341299522055;11007.559697612005;11095.1123910087;8228.876566851503;8296.792580185424;8314.70898518561;8338.916610833814;8376.874346884802;6056.303525094494;6098.969505152446;6162.476189523941;6183.567150299616;6195.628262304276;9822.901770982484;10102.545385457524;10110.191184705352;10134.682491276088;10257.33327333721;10235.795284094425;10300;10338.121259692709;10386.844197336895;10428.895711043097;7638.388928885787;7881.211878812073;7902.525848449111;7959.164287749934;7995.240452157036;8650;8714;8748;8749.65001399937;8823.338249631432;7426.2945020223;7720.112187098555;7865;7873.921260787319;8037.156098609562;7779.844403112019;7794.22057794216;7887.132415434183;8006.239407256301;8260;7024.648767561704;7293.890591641236;7393.704251829867;7394.630268486661;7530.962345188239;4993.775280112476;5054.1660625997765;5144.614153938544;5172.431032586488;5219.347581552306;5510.779568817203;5539.695316757617;5545.417731138173;5599.608027438203;5775.364709881994 16:30:20 INFO - PROCESS | 3302 | |4;prototype.html;291.2238883375804;304.65421746317935;311.4052160373687;313.5970278192522;319.76657040360544;5275.419703832576;5329.227262047001;5417.241586177934;5515.227868098465;5576.219329293897;5373.167159090338;5425.294711687475;5487.396386397493;5501.4223506531835;5510.9448905510935;4256.553061928499;4280.453130387415;4298.226319262531;4323.481182258133;4330.891727706801;4172.16556688662;4288.721233119837;4299.957000430002;4309.612134907858;4329.891752706176;4247.25673007224;4248.214080395137;4255.191513612419;4259.212045771526;4267.871963841089;4263.18999390118;4266.552012038722;4270.829166833323;4290.849820256307;4300.591443812864;3667.3582123128344;3794.3739283018544;3807.447920051605;3810.2189051244427;3817.4846395736777;5293.153095504739;5300.867478313035;5334.733263336856;5342.973285133549;5389.622726409114;4814.711117332971;4894.926576101361;4901.681390709592;4913.238448040559;4918.729469879156;5510.669359838383;5680.630759000693;5710.657360558338;5730.7707691692285;5763.279590051244;4096.303628383182;4103.563752686566;4114;4116.91766164675;4133.42132101506;5894.58737888348;5943.940560594425;5952.9107063394085;5953.077273022688;6047.546434017422;4114.321137012419;4132.628063474302;4241.406203131564;4243.5119961204855;4260.510041345223;4119.258533464005;4149.813258403379;4150.896227594334;4158.960259935016;4160.521540022875;4796.640251981115;4810.879728006757;4823.769938665618;4839;4844.442889067732;5609.354924183771;5758.510526605285;5804.970975145097;5810.978291288507;5877.47102760745;1441.0633088492355;1464.4288727396324;1465.4354878961817;1467.207707837777;1467.4130347860942;889.3996552327153;915.6520522201654;918.3433844801;931.3713243560569;944.7874228298715;4695.694779839299;4726.180420538118;4756.738379389098;4784.976075119602;4839.370881785346;5122.206058061007;5132.743362831843;5159.896802064013;5184.248283998874;5193.195054766517;4756.571908528249;4879;4879.511748916614;4880.487049014817;4922.630802689812;2691.4347986922576;2705.742954419327;2714.9592756108673;2743.245607457965;2757.765589924879;5271.367435907716;5276.815311464157;5281.57047758028;5333.999750093715;5343.679379237258;4891.951080489221;5090.905455327123;5128.8461346159675;5191.273221748958;5207.427183009866;5229.372475302988;5290.576753859682;5294.311739473921;5310.203469479532;5356.196570514454;5059.266406371129;5072.99616651428;5101.821436249714;5128.461511541234;5206.245094461357;4782.856514304576;5016.4983501651;5021.4225364083595;5041.2438134280155;5131.820386286462;5248.501392367719;5272.9736351318;5296.867578310573;5308;5337.146056630921;3816.2749077675153;3907.5701672816535;4047.655949244347;4063.6342729154517;4072.266991941479;5834.737436815269;5852.239208902815;5858.765649373977;5860.765569377348;5884.558658100574;5618.831435056954;5718.170865224436;5727.713614319351;5778.104393818965;5784.7107644618445;5644.915326270191;5659.066254068032;5660.349059858169;5691.800786972436;5702.800401986076;5631.732860106444;5656.43435656431;5665.886682266414;5675.2475049601735;5699.544036477155;5599.384067752625;5698.2592263005545;5769.624974376652;5774.826755197183;5780.913286300793;5591.189277554813;5592.741633132513;5607.915881261702;5616.354119276172;5621.690807005654 16:30:20 INFO - PROCESS | 3302 | |5;yui.html;733.4425836364363;744.3672878053652;775.9253433993916;779.2752739951844;812.7683610171102;16252.918735406322;16871.40950066748;17524.82475175248;17555.82444175558;17611.383601573947;15989.600259993505;16212.594685132877;16214.513564593051;16233.512994610152;16255;638.2659941067762;779.6530543907963;789.2541548236918;802.450321529751;810.2707563193144;784.831261278825;794.1859593916224;794.2375319693101;794.253401802304;794.4557977785236;814.6212011414691;817.1379194949326;818.1123481023097;819.6598411659185;821.8233079887823;801.703369753195;802.5987006496752;807.9313258373045;808.1474044882647;812.8577498937692;586.4458087107685;588.4292236530558;588.9146073819272;590.8877313310501;591.9526437884958;15407.229638518029;15440.845591544054;15501.147436890966;15576.844231557652;15587.220638968007;14779.261036948217;15427.460038898585;15547.766783498257;15600.921995390065;16017.839821601752;11758.706032349173;11836.704082397922;11963.282203067844;12043.819342709867;12263.75472490554;3916.667083297895;3919.8432062717743;4034.8097311292945;4124.752514849089;4144.046869220097;80973;81493;83032;83051;88442.11557884404;11082;11197.328160310244;11529.596464123882;11667.6499705009;11931.522739090513;21114.155433782784;21148.47128821792;21364.572708545744;21406.464838378855;21423.78576214218;8385.221669965238;8409.369297302726;8450.943632045994;8551.444156129832;8614.44006139599;4733.171694953369;4791.401074865642;4806.086843499724;4844.467108618049;4881.170201065827;3560.5549306336707;3652.872149474809;3667.651573100551;3669.192777588926;3673.7061035117126;609.759145137677;612.5314134686968;613.1599708399522;617.1113596421139;632.8481164520574;559.5132234955533;620.8137558732362;621.0652967284299;626.5488848029412;702.8875379939185;8425;8691.304695624334;8746;8901.688440904538;9242.21441177494;603.9033754599243;646.7768619826153;672.226939020121;683.4976292425064;696.1506961506954;4075.3886916962692;4273;4408.933865991949;4485.641148708096;4538.432695913011;119614;125286;125310;126009;130583;60793.145336659814;62015;80743.59628201938;82016.58991705003;96265;60338.69830650907;94593.52703236578;95149.5242523783;97044.51477742566;98785.01214987902;8243.091952087132;8406.243438090602;8641.740747777576;8648.43785153963;8660.78348041304;38428.42357364698;44088.55911440973;48552.271715924995;49178.75410622924;49870.25194622011;46554.767226163654;48306.5169348302;48732;57734;73438.64786930503;12720.96464565702;12909.677258068623;13091.869081309445;13104.2137471752;13163.67090822737;13332.666683332607;13408.128471649312;13682.93158534201;13719;13735.587932362045;11510.59712910044;11822.704432388915;12135.878641213829;12294.20087694297;12541.874581254071;12381.504739810667;12559.93720031394;12809.167404118702;12956.28740419286;13170.407331670289;12880.935595321964;13201.867981320063;13250.204987700768;13275.601731948056;13325.933370333087;10844.449737970575;10940.507677154706;11172.441377931233;11417;11418.942905285421;11076.280041797258;11281.605143819927;11522.251053681484;11649.359285239394;11681.707957301136 16:30:20 INFO - PROCESS | 3302 | __end_tp_report 16:30:20 INFO - PROCESS | 3302 | __start_cc_report 16:30:20 INFO - PROCESS | 3302 | _x_x_mozilla_cycle_collect,339 16:30:20 INFO - PROCESS | 3302 | __end_cc_report 16:30:20 INFO - PROCESS | 3302 | __startTimestamp1471908620506__endTimestamp 16:30:20 INFO - PROCESS | 3302 | 16:30:20 INFO - PROCESS | 3302 | ------- Summary: start ------- 16:30:20 INFO - PROCESS | 3302 | Number of tests: 6 16:30:20 INFO - PROCESS | 3302 | 16:30:20 INFO - PROCESS | 3302 | [#0] dojo.html Cycles:165 Average:5494.44 Median:5756.11 stddev:644.34 (11.2%) stddev-sans-first:617.32 16:30:20 INFO - PROCESS | 3302 | Values: 3058.1 3079.2 3089.3 3097.5 3100.2 5409.2 5470.7 5484.7 5554.8 5555.7 5423.6 5446.5 5457.1 5462.4 5554.3 4794.8 4908.1 4986.9 5142.9 5144.5 5073.2 5140.5 5150.3 5152.1 5180.9 4815.3 4959.3 4987.4 5002.8 5068.8 5068.1 5075.4 5094.3 5096.6 5116.6 4972.6 5021.5 5042.8 5076.0 5088.8 5310.4 5393.8 5396.1 5509.1 5591.7 5799.2 5830.5 5835.4 5835.5 5869.8 5850.0 5850.8 5896.0 5904.5 5930.2 5329.0 5364.3 5399.2 5458.3 5474.8 5945.6 5953.4 5963.8 5974.7 5981.6 5727.2 5744.9 5757.8 5762.9 5764.4 5658.5 5823.6 5877.9 5906.7 6001.5 5918.3 5958.1 5971.7 5981.1 6009.1 5957.7 5985.9 5993.6 6002.6 6012.3 4455.5 4490.3 4490.9 4494.1 4558.4 4017.8 4024.6 4029.3 4036.9 4049.1 5587.3 5621.1 5626.6 5627.0 5641.1 5764.1 5765.1 5803.6 5861.5 5893.9 5570.4 5575.2 5583.6 5595.2 5595.4 5036.2 5079.9 5090.9 5102.9 5105.6 6100.8 6203.6 6208.9 6212.7 6234.2 5952.4 5968.0 5971.1 5973.3 6004.5 5948.5 6080.8 6177.3 6196.3 6196.7 5814.4 5941.5 5960.9 5962.3 5966.1 5923.4 5930.2 5983.9 6021.2 6049.4 5709.0 5754.0 5919.2 5923.3 5932.5 5758.2 5861.1 5869.0 5877.1 5881.6 5756.1 5814.9 5815.6 5818.9 5827.8 5633.7 5769.1 5918.7 5948.5 5949.7 5672.5 5776.4 5785.0 5786.9 5801.4 16:30:20 INFO - PROCESS | 3302 | 16:30:20 INFO - PROCESS | 3302 | [#1] ext.html Cycles:180 Average:64063.85 Median:42802.79 stddev:131386.23 (307.0%) stddev-sans-first:131668.27 16:30:20 INFO - PROCESS | 3302 | Values: 555.3 569.2 569.4 575.5 610.7 39173.8 42757.6 42794.6 42811.0 42911.8 43345.6 43937.3 43991.3 44142.8 44202.6 8896.8 8962.3 8963.6 8983.0 9046.8 8300.4 8602.4 8641.3 8699.2 8743.2 8817.5 8952.7 8964.7 9004.5 9008.5 8871.9 8884.4 8926.8 8978.3 9011.5 8733.7 8870.0 8907.7 8929.6 8931.5 40517.2 40667.2 40669.6 40864.2 40869.8 3357.0 3455.5 3500.5 3502.3 3566.8 30469.0 32428.8 32685.5 32773.8 34770.5 4290.6 4388.8 4444.7 4451.7 4489.9 357035.2 362005.0 362214.0 363340.0 365129.0 59251.4 59431.4 59883.0 60267.0 60480.0 36135.0 36887.3 37115.8 39202.0 39210.6 16296.0 16375.1 16384.8 16493.8 16496.3 12272.4 12410.8 12414.9 12505.2 12563.1 18487.0 18523.2 18652.2 18737.8 18810.8 7054.8 7077.5 7092.2 7143.9 7180.9 956.7 1052.6 1080.4 1081.0 1141.1 32383.5 32472.4 32703.0 33145.0 33595.7 1095.8 1161.6 1199.9 1221.7 1228.6 17130.6 17150.4 17152.3 17217.7 17302.5 576430.0 577465.0 581625.0 583364.0 584380.0 58323.4 59301.7 59549.7 59684.7 59698.4 1314.9 1346.4 1351.7 1359.6 1376.0 27575.9 31232.5 31592.0 32195.4 33014.3 50994.0 55041.0 56412.7 56419.4 60976.0 506295.0 513765.0 515657.0 516268.0 516613.0 43356.6 43892.8 44254.0 44299.3 44504.8 48511.0 49812.3 49897.0 50133.7 50327.5 41212.2 41258.8 42324.6 43263.1 43570.8 42120.6 42665.8 43020.4 43861.6 44598.3 41345.4 41695.6 41802.4 42014.4 43046.0 30702.5 35978.5 37327.0 38106.2 38263.2 27941.4 28105.6 28187.0 28253.4 28441.3 16:30:20 INFO - PROCESS | 3302 | 16:30:20 INFO - PROCESS | 3302 | [#2] jquery.html Cycles:180 Average:30796.28 Median:4832.79 stddev:90556.48 (1873.8%) stddev-sans-first:90781.70 16:30:20 INFO - PROCESS | 3302 | Values: 373.2 379.9 397.4 402.9 410.4 13715.0 18536.7 19736.5 20398.2 20421.1 19226.3 19420.7 19643.4 19796.3 20066.5 5768.7 5787.6 5926.7 5983.6 6008.1 5830.9 5841.8 5872.6 5905.4 5907.3 5632.9 5847.7 5888.6 5931.5 5971.6 5803.9 5931.9 5936.7 6003.1 6021.8 5731.7 5768.0 5779.8 5781.4 5793.0 14643.1 14676.0 14800.6 14908.0 14959.7 2153.7 2198.3 2239.9 2332.5 2524.7 10133.0 10313.5 10711.4 10806.6 13499.0 1844.9 1973.7 1995.7 1996.7 2003.5 83282.0 87891.6 87969.0 88389.0 92352.0 11223.0 11226.6 11265.5 11285.4 11755.3 15915.2 15956.8 16025.1 16026.4 16026.4 7853.2 8077.8 8160.8 8203.8 8299.0 7515.2 7578.9 7624.7 7805.8 7824.2 4603.6 4815.8 4884.3 4907.1 5059.4 2003.8 2005.7 2032.6 2040.1 2050.3 910.1 958.3 998.0 1003.9 1027.3 20265.5 20487.3 20520.9 20785.2 20790.1 918.2 935.8 945.8 1005.1 1023.9 10751.9 10896.5 11293.4 11452.2 11528.7 542242.0 545645.0 549664.0 554257.0 555724.6 87866.0 88588.6 91595.0 96256.0 97133.0 1014.3 1045.9 1056.3 1061.1 1067.7 18635.9 18636.8 19244.8 19282.3 19457.1 43002.8 44475.6 44556.6 45482.8 45885.0 61349.4 62807.4 63723.4 63826.7 66028.3 8554.1 8602.6 8702.3 8752.4 8897.7 8953.8 9209.6 9233.4 9473.0 9536.5 8182.6 8581.6 8616.1 9079.3 9242.5 4849.8 7171.6 7440.9 8872.9 8889.6 8787.5 8849.2 8927.7 8958.9 9150.5 12688.4 12927.3 12982.0 13225.6 13295.9 12308.1 12472.8 12734.2 12772.7 13066.2 16:30:20 INFO - PROCESS | 3302 | 16:30:20 INFO - PROCESS | 3302 | [#3] mootools.html Cycles:180 Average:5899.91 Median:2472.47 stddev:3377.42 (136.6%) stddev-sans-first:3370.68 16:30:20 INFO - PROCESS | 3302 | Values: 1496.4 1516.1 1650.4 1720.8 1760.7 7569.1 8684.0 8801.2 9169.0 9202.4 8782.9 9138.1 9154.2 9160.9 9164.6 2400.9 2401.7 2418.2 2418.4 2422.6 2369.6 2383.2 2405.9 2422.8 2440.6 2368.9 2395.3 2398.5 2414.3 2417.2 2324.6 2349.2 2355.0 2365.7 2387.0 2287.2 2296.9 2319.6 2327.5 2347.0 9116.4 9140.4 9217.6 9228.5 9238.2 5279.0 5392.6 5397.6 5409.0 5411.7 3416.1 3440.9 3447.3 3503.5 3505.8 1051.4 1052.8 1064.0 1065.0 1071.7 12416.9 12541.6 12579.9 12631.6 12664.3 4253.3 4492.1 4535.2 4662.7 4735.7 10484.5 10509.1 10524.7 10587.2 10614.9 5262.7 5270.5 5274.7 5289.2 5295.4 4351.6 4639.6 4640.4 4725.7 4807.5 3899.7 3949.5 4070.7 4138.0 4162.6 1307.8 1331.4 1334.4 1336.2 1339.7 970.7 986.1 1003.8 1013.4 1016.1 5956.8 6051.9 6105.1 6203.9 6454.0 448.8 452.8 466.9 506.9 509.0 3973.4 4107.2 4158.8 4180.8 4275.1 10703.2 11113.0 11117.2 11206.4 11239.3 10937.3 10951.8 10978.3 11007.6 11095.1 8228.9 8296.8 8314.7 8338.9 8376.9 6056.3 6099.0 6162.5 6183.6 6195.6 9822.9 10102.5 10110.2 10134.7 10257.3 10235.8 10300.0 10338.1 10386.8 10428.9 7638.4 7881.2 7902.5 7959.2 7995.2 8650.0 8714.0 8748.0 8749.7 8823.3 7426.3 7720.1 7865.0 7873.9 8037.2 7779.8 7794.2 7887.1 8006.2 8260.0 7024.6 7293.9 7393.7 7394.6 7531.0 4993.8 5054.2 5144.6 5172.4 5219.3 5510.8 5539.7 5545.4 5599.6 5775.4 16:30:20 INFO - PROCESS | 3302 | 16:30:20 INFO - PROCESS | 3302 | [#4] prototype.html Cycles:180 Average:4617.20 Median:5128.65 stddev:1336.34 (26.1%) stddev-sans-first:1300.04 16:30:20 INFO - PROCESS | 3302 | Values: 291.2 304.7 311.4 313.6 319.8 5275.4 5329.2 5417.2 5515.2 5576.2 5373.2 5425.3 5487.4 5501.4 5510.9 4256.6 4280.5 4298.2 4323.5 4330.9 4172.2 4288.7 4300.0 4309.6 4329.9 4247.3 4248.2 4255.2 4259.2 4267.9 4263.2 4266.6 4270.8 4290.8 4300.6 3667.4 3794.4 3807.4 3810.2 3817.5 5293.2 5300.9 5334.7 5343.0 5389.6 4814.7 4894.9 4901.7 4913.2 4918.7 5510.7 5680.6 5710.7 5730.8 5763.3 4096.3 4103.6 4114.0 4116.9 4133.4 5894.6 5943.9 5952.9 5953.1 6047.5 4114.3 4132.6 4241.4 4243.5 4260.5 4119.3 4149.8 4150.9 4159.0 4160.5 4796.6 4810.9 4823.8 4839.0 4844.4 5609.4 5758.5 5805.0 5811.0 5877.5 1441.1 1464.4 1465.4 1467.2 1467.4 889.4 915.7 918.3 931.4 944.8 4695.7 4726.2 4756.7 4785.0 4839.4 5122.2 5132.7 5159.9 5184.2 5193.2 4756.6 4879.0 4879.5 4880.5 4922.6 2691.4 2705.7 2715.0 2743.2 2757.8 5271.4 5276.8 5281.6 5334.0 5343.7 4892.0 5090.9 5128.8 5191.3 5207.4 5229.4 5290.6 5294.3 5310.2 5356.2 5059.3 5073.0 5101.8 5128.5 5206.2 4782.9 5016.5 5021.4 5041.2 5131.8 5248.5 5273.0 5296.9 5308.0 5337.1 3816.3 3907.6 4047.7 4063.6 4072.3 5834.7 5852.2 5858.8 5860.8 5884.6 5618.8 5718.2 5727.7 5778.1 5784.7 5644.9 5659.1 5660.3 5691.8 5702.8 5631.7 5656.4 5665.9 5675.2 5699.5 5599.4 5698.3 5769.6 5774.8 5780.9 5591.2 5592.7 5607.9 5616.4 5621.7 16:30:20 INFO - PROCESS | 3302 | 16:30:20 INFO - PROCESS | 3302 | [#5] yui.html Cycles:180 Average:20017.72 Median:4512.04 stddev:29355.91 (650.6%) stddev-sans-first:29402.55 16:30:20 INFO - PROCESS | 3302 | Values: 733.4 744.4 775.9 779.3 812.8 16252.9 16871.4 17524.8 17555.8 17611.4 15989.6 16212.6 16214.5 16233.5 16255.0 638.3 779.7 789.3 802.5 810.3 784.8 794.2 794.2 794.3 794.5 814.6 817.1 818.1 819.7 821.8 801.7 802.6 807.9 808.1 812.9 586.4 588.4 588.9 590.9 592.0 15407.2 15440.8 15501.1 15576.8 15587.2 14779.3 15427.5 15547.8 15600.9 16017.8 11758.7 11836.7 11963.3 12043.8 12263.8 3916.7 3919.8 4034.8 4124.8 4144.0 80973.0 81493.0 83032.0 83051.0 88442.1 11082.0 11197.3 11529.6 11667.6 11931.5 21114.2 21148.5 21364.6 21406.5 21423.8 8385.2 8409.4 8450.9 8551.4 8614.4 4733.2 4791.4 4806.1 4844.5 4881.2 3560.6 3652.9 3667.7 3669.2 3673.7 609.8 612.5 613.2 617.1 632.8 559.5 620.8 621.1 626.5 702.9 8425.0 8691.3 8746.0 8901.7 9242.2 603.9 646.8 672.2 683.5 696.2 4075.4 4273.0 4408.9 4485.6 4538.4 119614.0 125286.0 125310.0 126009.0 130583.0 60793.1 62015.0 80743.6 82016.6 96265.0 60338.7 94593.5 95149.5 97044.5 98785.0 8243.1 8406.2 8641.7 8648.4 8660.8 38428.4 44088.6 48552.3 49178.8 49870.3 46554.8 48306.5 48732.0 57734.0 73438.6 12721.0 12909.7 13091.9 13104.2 13163.7 13332.7 13408.1 13682.9 13719.0 13735.6 11510.6 11822.7 12135.9 12294.2 12541.9 12381.5 12559.9 12809.2 12956.3 13170.4 12880.9 13201.9 13250.2 13275.6 13325.9 10844.4 10940.5 11172.4 11417.0 11418.9 11076.3 11281.6 11522.3 11649.4 11681.7 16:30:20 INFO - PROCESS | 3302 | -------- Summary: end -------- 16:30:20 INFO - PROCESS | 3302 | 16:30:21 INFO - TEST-INFO | 3302: exit 0 16:30:21 INFO - TEST-OK | dromaeo_css | took 1114229ms 16:30:21 INFO - TEST-START | kraken 16:30:21 INFO - operating with platform_type : linux_ 16:30:21 INFO - Initialising browser for kraken test... 16:30:21 INFO - TEST-INFO | started process 3659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHCSErG/profile http://localhost:47702/getInfo.html) 16:30:26 INFO - PROCESS | 3659 | __metrics Screen width/height:1600/1200 16:30:26 INFO - PROCESS | 3659 | colorDepth:24 16:30:26 INFO - PROCESS | 3659 | Browser inner width/height: 1024/697 16:30:26 INFO - PROCESS | 3659 | __metrics 16:30:26 ERROR - PROCESS | 3659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2993: TypeError: this.tabs is undefined 16:30:27 INFO - TEST-INFO | 3659: exit 0 16:30:27 INFO - Browser initialized. 16:30:27 INFO - Running cycle 1/1 for kraken test... 16:30:27 INFO - TEST-INFO | started process 3778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHCSErG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:30:39 INFO - PROCESS | 3778 | RSS: Main: 186458112 16:30:39 INFO - PROCESS | 3778 | 16:30:42 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:47702/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47702/tests/kraken/driver.html?testName=audio-beat-detection) 16:30:43 INFO - PROCESS | 3778 | RSS: Main: 199618560 16:30:43 INFO - PROCESS | 3778 | 16:30:46 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:47702/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47702/tests/kraken/driver.html?testName=audio-dft) 16:30:46 INFO - PROCESS | 3778 | RSS: Main: 199344128 16:30:46 INFO - PROCESS | 3778 | 16:30:49 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:47702/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47702/tests/kraken/driver.html?testName=audio-fft) 16:30:50 INFO - PROCESS | 3778 | RSS: Main: 195321856 16:30:50 INFO - PROCESS | 3778 | 16:30:52 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:47702/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47702/tests/kraken/driver.html?testName=audio-oscillator) 16:30:53 INFO - PROCESS | 3778 | RSS: Main: 195878912 16:30:53 INFO - PROCESS | 3778 | 16:30:55 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:47702/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47702/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:30:56 INFO - PROCESS | 3778 | RSS: Main: 196063232 16:30:56 INFO - PROCESS | 3778 | 16:30:59 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:47702/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47702/tests/kraken/driver.html?testName=imaging-darkroom) 16:30:59 INFO - PROCESS | 3778 | RSS: Main: 196493312 16:30:59 INFO - PROCESS | 3778 | 16:31:03 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:47702/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47702/tests/kraken/driver.html?testName=imaging-desaturate) 16:31:04 INFO - PROCESS | 3778 | RSS: Main: 193216512 16:31:04 INFO - PROCESS | 3778 | 16:31:07 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:47702/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47702/tests/kraken/driver.html?testName=json-parse-financial) 16:31:07 INFO - PROCESS | 3778 | RSS: Main: 195117056 16:31:07 INFO - PROCESS | 3778 | 16:31:09 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:47702/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47702/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:31:09 INFO - PROCESS | 3778 | RSS: Main: 195325952 16:31:09 INFO - PROCESS | 3778 | 16:31:11 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:47702/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47702/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:31:12 INFO - PROCESS | 3778 | RSS: Main: 195174400 16:31:12 INFO - PROCESS | 3778 | 16:31:14 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:47702/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47702/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:31:15 INFO - PROCESS | 3778 | RSS: Main: 196157440 16:31:15 INFO - PROCESS | 3778 | 16:31:17 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:47702/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47702/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:31:18 INFO - PROCESS | 3778 | RSS: Main: 196169728 16:31:18 INFO - PROCESS | 3778 | 16:31:21 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:47702/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47702/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:31:21 INFO - PROCESS | 3778 | RSS: Main: 196681728 16:31:21 INFO - PROCESS | 3778 | 16:31:23 INFO - PROCESS | 3778 | Cycle 1(1): loaded http://localhost:47702/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47702/tests/kraken/driver.html?testName=ai-astar) 16:31:23 INFO - PROCESS | 3778 | RSS: Main: 198639616 16:31:23 INFO - PROCESS | 3778 | 16:31:23 INFO - PROCESS | 3778 | __start_tp_report 16:31:23 INFO - PROCESS | 3778 | _x_x_mozilla_page_load 16:31:23 INFO - PROCESS | 3778 | _x_x_mozilla_page_load_details 16:31:23 INFO - PROCESS | 3778 | |i|pagename|runs| 16:31:23 INFO - PROCESS | 3778 | |0;ai-astar;106;115;110;113;115;116;118;116;116;112 16:31:23 INFO - PROCESS | 3778 | |1;audio-beat-detection;151;123;150;180;126;159;158;125;181;122 16:31:23 INFO - PROCESS | 3778 | |2;audio-dft;168;168;168;173;168;175;167;169;168;165 16:31:23 INFO - PROCESS | 3778 | |3;audio-fft;77;76;77;187;78;77;87;76;187;76 16:31:23 INFO - PROCESS | 3778 | |4;audio-oscillator;85;88;151;88;87;86;135;87;88;152 16:31:23 INFO - PROCESS | 3778 | |5;imaging-gaussian-blur;118;120;119;118;118;120;119;138;118;118 16:31:23 INFO - PROCESS | 3778 | |6;imaging-darkroom;148;152;148;149;149;150;150;152;150;148 16:31:23 INFO - PROCESS | 3778 | |7;imaging-desaturate;96;97;96;97;96;97;96;98;97;97 16:31:23 INFO - PROCESS | 3778 | |8;json-parse-financial;51;52;57;60;54;54;53;52;52;52 16:31:23 INFO - PROCESS | 3778 | |9;json-stringify-tinderbox;63;65;70;63;62;63;63;62;63;63 16:31:23 INFO - PROCESS | 3778 | |10;stanford-crypto-aes;81;83;84;83;88;81;81;80;80;81 16:31:23 INFO - PROCESS | 3778 | |11;stanford-crypto-ccm;140;131;138;127;132;135;127;129;150;136 16:31:23 INFO - PROCESS | 3778 | |12;stanford-crypto-pbkdf2;172;169;188;172;174;172;165;168;168;169 16:31:23 INFO - PROCESS | 3778 | |13;stanford-crypto-sha256-iterative;71;68;70;69;70;72;69;67;67;67 16:31:23 INFO - PROCESS | 3778 | __end_tp_report 16:31:23 INFO - PROCESS | 3778 | __start_cc_report 16:31:23 INFO - PROCESS | 3778 | _x_x_mozilla_cycle_collect,829 16:31:23 INFO - PROCESS | 3778 | __end_cc_report 16:31:23 INFO - PROCESS | 3778 | __startTimestamp1471908683919__endTimestamp 16:31:23 INFO - PROCESS | 3778 | 16:31:23 INFO - PROCESS | 3778 | ------- Summary: start ------- 16:31:23 INFO - PROCESS | 3778 | Number of tests: 14 16:31:23 INFO - PROCESS | 3778 | 16:31:23 INFO - PROCESS | 3778 | [#0] ai-astar Cycles:10 Average:113.70 Median:115.50 stddev:3.56 (3.1%) stddev-sans-first:2.46 16:31:23 INFO - PROCESS | 3778 | Values: 106.0 115.0 110.0 113.0 115.0 116.0 118.0 116.0 116.0 112.0 16:31:23 INFO - PROCESS | 3778 | 16:31:23 INFO - PROCESS | 3778 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:154.50 stddev:22.75 (14.7%) stddev-sans-first:24.10 16:31:23 INFO - PROCESS | 3778 | Values: 151.0 123.0 150.0 180.0 126.0 159.0 158.0 125.0 181.0 122.0 16:31:23 INFO - PROCESS | 3778 | 16:31:23 INFO - PROCESS | 3778 | [#2] audio-dft Cycles:10 Average:168.90 Median:168.00 stddev:2.92 (1.7%) stddev-sans-first:3.08 16:31:23 INFO - PROCESS | 3778 | Values: 168.0 168.0 168.0 173.0 168.0 175.0 167.0 169.0 168.0 165.0 16:31:23 INFO - PROCESS | 3778 | 16:31:23 INFO - PROCESS | 3778 | [#3] audio-fft Cycles:10 Average:99.80 Median:77.00 stddev:46.07 (59.8%) stddev-sans-first:48.12 16:31:23 INFO - PROCESS | 3778 | Values: 77.0 76.0 77.0 187.0 78.0 77.0 87.0 76.0 187.0 76.0 16:31:23 INFO - PROCESS | 3778 | 16:31:23 INFO - PROCESS | 3778 | [#4] audio-oscillator Cycles:10 Average:104.70 Median:87.00 stddev:28.87 (33.2%) stddev-sans-first:29.73 16:31:23 INFO - PROCESS | 3778 | Values: 85.0 88.0 151.0 88.0 87.0 86.0 135.0 87.0 88.0 152.0 16:31:23 INFO - PROCESS | 3778 | 16:31:23 INFO - PROCESS | 3778 | [#5] imaging-gaussian-blur Cycles:10 Average:120.60 Median:119.00 stddev:6.17 (5.2%) stddev-sans-first:6.47 16:31:23 INFO - PROCESS | 3778 | Values: 118.0 120.0 119.0 118.0 118.0 120.0 119.0 138.0 118.0 118.0 16:31:23 INFO - PROCESS | 3778 | 16:31:23 INFO - PROCESS | 3778 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.00 stddev:1.51 (1.0%) stddev-sans-first:1.48 16:31:23 INFO - PROCESS | 3778 | Values: 148.0 152.0 148.0 149.0 149.0 150.0 150.0 152.0 150.0 148.0 16:31:23 INFO - PROCESS | 3778 | 16:31:23 INFO - PROCESS | 3778 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 16:31:23 INFO - PROCESS | 3778 | Values: 96.0 97.0 96.0 97.0 96.0 97.0 96.0 98.0 97.0 97.0 16:31:23 INFO - PROCESS | 3778 | 16:31:23 INFO - PROCESS | 3778 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.50 stddev:2.79 (5.2%) stddev-sans-first:2.78 16:31:23 INFO - PROCESS | 3778 | Values: 51.0 52.0 57.0 60.0 54.0 54.0 53.0 52.0 52.0 52.0 16:31:23 INFO - PROCESS | 3778 | 16:31:23 INFO - PROCESS | 3778 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:63.00 stddev:2.36 (3.7%) stddev-sans-first:2.49 16:31:23 INFO - PROCESS | 3778 | Values: 63.0 65.0 70.0 63.0 62.0 63.0 63.0 62.0 63.0 63.0 16:31:23 INFO - PROCESS | 3778 | 16:31:23 INFO - PROCESS | 3778 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:2.44 (3.0%) stddev-sans-first:2.55 16:31:23 INFO - PROCESS | 3778 | Values: 81.0 83.0 84.0 83.0 88.0 81.0 81.0 80.0 80.0 81.0 16:31:23 INFO - PROCESS | 3778 | 16:31:23 INFO - PROCESS | 3778 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:135.50 stddev:7.04 (5.2%) stddev-sans-first:7.18 16:31:23 INFO - PROCESS | 3778 | Values: 140.0 131.0 138.0 127.0 132.0 135.0 127.0 129.0 150.0 136.0 16:31:23 INFO - PROCESS | 3778 | 16:31:23 INFO - PROCESS | 3778 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:172.00 stddev:6.31 (3.7%) stddev-sans-first:6.69 16:31:23 INFO - PROCESS | 3778 | Values: 172.0 169.0 188.0 172.0 174.0 172.0 165.0 168.0 168.0 169.0 16:31:23 INFO - PROCESS | 3778 | 16:31:23 INFO - PROCESS | 3778 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:1.76 (2.5%) stddev-sans-first:1.72 16:31:23 INFO - PROCESS | 3778 | Values: 71.0 68.0 70.0 69.0 70.0 72.0 69.0 67.0 67.0 67.0 16:31:23 INFO - PROCESS | 3778 | -------- Summary: end -------- 16:31:23 INFO - PROCESS | 3778 | 16:31:25 INFO - TEST-INFO | 3778: exit 0 16:31:25 INFO - TEST-OK | kraken | took 63589ms 16:31:25 INFO - SUITE-END | took 1177s 16:31:25 INFO - Completed test suite (00:19:38) 16:31:25 INFO - javascript benchmark 16:31:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7240.805522874435, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3058.1284333964823, 3079.214800225942, 3089.274020605159, 3097.5198844179145, 3100.178452710031, 5409.188621706746, 5470.699111548864, 5484.670919744818, 5554.750036248379, 5555.722213889305, 5423.593230507708, 5446.455354464551, 5457.099578569531, 5462.399136095027, 5554.2779438672915, 4794.83218087367, 4908.141075311824, 4986.850394488153, 5142.948570514303, 5144.536991670768, 5073.239014147871, 5140.4859514048485, 5150.304708864312, 5152.072626927152, 5180.948190518103, 4815.301781241736, 4959.305697202394, 4987.376577927759, 5002.774875130628, 5068.79724811009, 5068.138416469209, 5075.441701412841, 5094.337736094284, 5096.592272618182, 5116.616253780981, 4972.602191824645, 5021.497850214986, 5042.823501177478, 5075.98480303937, 5088.821891233826, 5310.36275646921, 5393.8112166074, 5396.136618141118, 5509.118541033456, 5591.7483713233005, 5799.159121927297, 5830.47525722687, 5835.387284335126, 5835.503982161479, 5869.7652093916195, 5850.0, 5850.795222167247, 5895.970520147414, 5904.468597826173, 5930.169776231331, 5328.973355133199, 5364.302640656729, 5399.163129714901, 5458.263134476795, 5474.7810087596445, 5945.583809133405, 5953.374895635896, 5963.7912673056235, 5974.731137098841, 5981.611195272293, 5727.226824378656, 5744.885102297931, 5757.827265182052, 5762.855928601818, 5764.423557644202, 5658.490735833795, 5823.56323275756, 5877.853053673693, 5906.704664766745, 6001.549883758736, 5918.2898052234, 5958.076498142795, 5971.701414929323, 5981.0729336952845, 6009.128676341906, 5957.672328021914, 5985.940140598538, 5993.550483713739, 6002.63984160943, 6012.338642749294, 4455.532169122261, 4490.259107247268, 4490.910181796411, 4494.12364588902, 4558.407407037131, 4017.819198136091, 4024.63778259958, 4029.315016447211, 4036.8990775230855, 4049.149678567534, 5587.329520457572, 5621.128725047624, 5626.634268772516, 5627.0, 5641.097424412074, 5764.07774756037, 5765.106408506688, 5803.593748437654, 5861.472467477862, 5893.911591326134, 5570.387257401682, 5575.1915972184615, 5583.553315734732, 5595.160725891067, 5595.440455954372, 5036.219385995177, 5079.8984020319385, 5090.9236361454605, 5102.872428189251, 5105.642605017687, 6100.816975490654, 6203.565750397519, 6208.937910620836, 6212.720427580679, 6234.189555357865, 5952.404759524013, 5968.045112781934, 5971.0744834550715, 5973.283206015306, 6004.459598636144, 5948.4943779779205, 6080.787172448943, 6177.2587289525545, 6196.256449226122, 6196.659183744938, 5814.3604203538425, 5941.494972927349, 5960.850978725566, 5962.25471816023, 5966.105084237399, 5923.437273459014, 5930.199423077829, 5983.9401605983385, 6021.2473440819895, 6049.425304596057, 5709.029464991045, 5753.971230143822, 5919.171316015847, 5923.318818335946, 5932.4957378621575, 5758.193852860687, 5861.120831875082, 5868.970655146697, 5877.089051197071, 5881.647101173943, 5756.107803290497, 5814.94185058144, 5815.563832712648, 5818.883622327615, 5827.79602713903, 5633.6619802811965, 5769.134629805395, 5918.704064796657, 5948.524118070631, 5949.672767997628, 5672.4894759471845, 5776.42235776419, 5784.99597847867, 5786.942130578809, 5801.36185019639], "value": 5448.938355963367, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.336373034224, 569.2429069337778, 569.3537834557778, 575.5050656435466, 610.6549799363362, 39173.80413097934, 42757.57242427575, 42794.572054279444, 42811.0, 42911.78544107283, 43345.56654433455, 43937.34093988593, 43991.340129897995, 44142.77928610361, 44202.55797442025, 8896.777580560505, 8962.327825413087, 8963.641454341818, 8983.0, 9046.819063618757, 8300.418970672055, 8602.397832151752, 8641.26549243312, 8699.217070463657, 8743.169398907094, 8817.456945034626, 8952.731418057436, 8964.731058068235, 9004.459732416077, 9008.504532250723, 8871.866921996176, 8884.378093533454, 8926.776830579223, 8978.326625503081, 9011.504367259799, 8733.737987860375, 8869.955650221773, 8907.732768016906, 8929.642814287421, 8931.50876701781, 40517.18965620671, 40667.186656267004, 40669.593304066875, 40864.18271634581, 40869.79565102155, 3357.0, 3455.4989526518766, 3500.5449291592186, 3502.2645244498685, 3566.7681600696133, 30469.0, 32428.837855810805, 32685.50971735426, 32773.83613081943, 34770.478442823376, 4290.613844753987, 4388.758618275993, 4444.6666500012625, 4451.688381813242, 4489.932651010237, 357035.2148239268, 362005.0, 362214.0, 363340.0, 365129.0, 59251.407485925454, 59431.40568594345, 59883.0, 60267.0, 60480.0, 36135.0, 36887.26225475529, 37115.81442092772, 39202.0, 39210.60789392127, 16296.0, 16375.09936953479, 16384.75422868658, 16493.752593711102, 16496.25766840495, 12272.38638068111, 12410.81383779244, 12414.937925310316, 12505.249685018927, 12563.057770667236, 18487.0, 18523.166457509175, 18652.160652770657, 18737.81262187388, 18810.81189188118, 7054.823629409306, 7077.532009315399, 7092.184398794205, 7143.9285607143265, 7180.856382872314, 956.6651671914774, 1052.6368402900987, 1080.4111759091313, 1080.983785243222, 1141.08713029576, 32383.514247286308, 32472.350552988806, 32703.0, 33145.0, 33595.66404335974, 1095.8137116690182, 1161.5760247509768, 1199.8620158681688, 1221.6640423883503, 1228.6314105768233, 17130.571735706708, 17150.399736009178, 17152.31390744381, 17217.741733874, 17302.480925572254, 576430.0, 577465.0, 581625.0, 583364.0, 584380.0, 58323.41676583265, 59301.703491482265, 59549.70225148933, 59684.70157649184, 59698.40301597015, 1314.90795644304, 1346.3806648941597, 1351.6620844788804, 1359.5513480551197, 1376.0436496634943, 27575.862120689268, 31232.531512026882, 31592.0, 32195.35609287848, 33014.33971320608, 50994.0, 55041.0, 56412.71793641005, 56419.43580564142, 60976.0, 506295.0, 513765.0, 515657.0, 516268.0, 516613.0, 43356.56643433651, 43892.78053609712, 44254.0, 44299.33550996673, 44504.77747611241, 48511.0, 49812.25281620851, 49897.0, 50133.74933125311, 50327.49672503228, 41212.1757564841, 41258.793706031276, 42324.57675423206, 43263.13473730571, 43570.78214608907, 42120.57879421289, 42665.78667106769, 43020.35469467898, 43861.56138438575, 44598.3310250353, 41345.379819302136, 41695.58304417038, 41802.37296440495, 42014.36978445387, 43046.0, 30702.539461907643, 35978.4603230957, 37327.0, 38106.237875241786, 38263.2347353057, 27941.44117117687, 28105.578416323362, 28187.0, 28253.43493130167, 28441.28896777597], "value": 20370.783896548943, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.1771443966055, 379.87271280827355, 397.37413573621546, 402.8690675530452, 410.44179915315163, 13715.0, 18536.721949170755, 19736.506587335323, 20398.184072637094, 20421.081051352707, 19226.327078552255, 19420.698481258183, 19643.410697679057, 19796.30712925048, 20066.49833754157, 5768.682722450264, 5787.594868359217, 5926.674032928187, 5983.551233657493, 6008.128821320905, 5830.854228644275, 5841.824745257649, 5872.647641141545, 5905.438983296602, 5907.291125064977, 5632.9436705632825, 5847.736851841656, 5888.558358123137, 5931.466168044875, 5971.581989260753, 5803.854903627401, 5931.881362372772, 5936.673482958436, 6003.099535069731, 6021.819345419644, 5731.684757338345, 5768.0, 5779.768809247625, 5781.421857814227, 5792.957267691814, 14643.121412715165, 14676.0, 14800.555983320517, 14908.0, 14959.700805983928, 2153.7307836520436, 2198.318521258415, 2239.876806775627, 2332.54515369503, 2524.709658389272, 10133.0, 10313.48432578368, 10711.410872402015, 10806.621768238074, 13498.987575931844, 1844.8985305808176, 1973.6644770389069, 1995.720599116125, 1996.670549359354, 2003.5091402606308, 83282.0, 87891.56054219752, 87969.0, 88389.0, 92352.0, 11223.0, 11226.55093796239, 11265.54937802495, 11285.379304138187, 11755.294682319089, 15915.204239788196, 15956.840431595767, 16025.118618476095, 16026.439074632332, 16026.439074632564, 7853.214678532101, 8077.838443231102, 8160.836783264302, 8203.83592328162, 8299.012355551997, 7515.173330933593, 7578.886316705254, 7624.733134340271, 7805.765827025199, 7824.178461261599, 4603.631709463235, 4815.783289751969, 4884.340614017062, 4907.116718990616, 5059.392872855281, 2003.7996200379846, 2005.6891181866833, 2032.6341258573302, 2040.1023549638408, 2050.29264903608, 910.1217325281135, 958.3435346787472, 997.9700608981742, 1003.8745156855393, 1027.3219675014454, 20265.49336266605, 20487.28294509685, 20520.897395512926, 20785.1685932561, 20790.064447099918, 918.2424499787702, 935.7988032573029, 945.8155659646303, 1005.1205195453978, 1023.9385636861812, 10751.892481075089, 10896.509657065451, 11293.43532823372, 11452.198346115858, 11528.654140375802, 542242.0, 545645.0, 549664.0, 554257.0, 555724.6489118665, 87866.0, 88588.5570572143, 91595.0, 96256.0, 97133.0, 1014.3305418423805, 1045.8588090607823, 1056.339787632745, 1061.0927656853435, 1067.7010437077631, 18635.90682046581, 18636.813631863508, 19244.807551924303, 19282.32511862078, 19457.12442940043, 43002.78498607487, 44475.55524444714, 44556.554434456535, 45482.77258613686, 45885.0, 61349.38650613615, 62807.38216808852, 63723.36276637174, 63826.68086659537, 66028.33971660222, 8554.144585541397, 8602.612882420432, 8702.260307873901, 8752.387332886638, 8897.73306800797, 8953.820923581361, 9209.631614735603, 9233.399829011092, 9472.95263523678, 9536.523173841142, 8182.631781569725, 8581.570921454027, 8616.138386161334, 9079.273658107468, 9242.537873106183, 4849.80600775965, 7171.605561694157, 7440.92559074424, 8872.86690699627, 8889.555522223734, 8787.472751634923, 8849.159329863653, 8927.687530936386, 8958.910410895807, 9150.542472876197, 12688.429020694275, 12927.288999104763, 12982.0, 13225.611310812226, 13295.933520332337, 12308.076894232789, 12472.75054498923, 12734.172278801849, 12772.680682982627, 13066.216027038408], "value": 9110.907653686068, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1496.3939604460195, 1516.1206500229869, 1650.364609625294, 1720.7590937268776, 1760.7006808842505, 7569.091708994914, 8683.956580217098, 8801.207891289783, 9169.0, 9202.355835091555, 8782.868256976151, 9138.13187747163, 9154.176124148826, 9160.908390916089, 9164.633414663422, 2400.867952262625, 2401.7478164792665, 2418.1657328221822, 2418.3591348292716, 2422.6366045093287, 2369.609014512603, 2383.165891937825, 2405.8797060147012, 2422.794062504689, 2440.5606990741658, 2368.8815559222057, 2395.3053614451874, 2398.46034642205, 2414.2757172848164, 2417.226487523993, 2324.6164382876805, 2349.201271567675, 2354.9646755298686, 2365.66880636711, 2386.976130238693, 2287.1994801819396, 2296.850704704189, 2319.6288593825075, 2327.511222643247, 2346.9882650586637, 9116.4074335168, 9140.40587361826, 9217.63129474827, 9228.492432916188, 9238.16856482913, 5279.049771041211, 5392.595555333366, 5397.622166448311, 5408.972955135238, 5411.675299482044, 3416.145963509123, 3440.9483857742152, 3447.293304872495, 3503.4569641705575, 3505.7545971781988, 1051.437480947697, 1052.7999680060764, 1064.0264158295151, 1064.9574017039308, 1071.7159952612565, 12416.875831241663, 12541.56104536346, 12579.874201257962, 12631.621051368566, 12664.303463309514, 4253.3194688849635, 4492.124035812985, 4535.206338890681, 4662.650301227422, 4735.715857048588, 10484.528196231187, 10509.106725928228, 10524.684259472227, 10587.15302775776, 10614.946925265478, 5262.71055091966, 5270.49930256625, 5274.683518988873, 5289.2330612061805, 5295.364556253275, 4351.608355248043, 4639.582437580634, 4640.419947506562, 4725.740084295328, 4807.543283388142, 3899.732586909266, 3949.5063117110362, 4070.653994410449, 4137.97931010343, 4162.62536371728, 1307.8103674967267, 1331.3542931678128, 1334.359507436436, 1336.1849271944106, 1339.7454483648075, 970.737900766789, 986.1420564109271, 1003.7590978165334, 1013.4172850610781, 1016.1413605503337, 5956.761729530857, 6051.909221361683, 6105.145279660851, 6203.906941395882, 6453.967365221542, 448.84290498325976, 452.81887245102223, 466.9136209801198, 506.88341681412743, 508.96691715038406, 3973.4039894016128, 4107.199096176217, 4158.8336466541605, 4180.832766689298, 4275.0594869128745, 10703.197260205516, 11113.0, 11117.221794474472, 11206.439678016066, 11239.269447485887, 10937.343759374464, 10951.83572246417, 10978.341299522055, 11007.559697612005, 11095.1123910087, 8228.876566851503, 8296.792580185424, 8314.70898518561, 8338.916610833814, 8376.874346884802, 6056.303525094494, 6098.969505152446, 6162.476189523941, 6183.567150299616, 6195.628262304276, 9822.901770982484, 10102.545385457524, 10110.191184705352, 10134.682491276088, 10257.33327333721, 10235.795284094425, 10300.0, 10338.121259692709, 10386.844197336895, 10428.895711043097, 7638.388928885787, 7881.211878812073, 7902.525848449111, 7959.164287749934, 7995.240452157036, 8650.0, 8714.0, 8748.0, 8749.65001399937, 8823.338249631432, 7426.2945020223, 7720.112187098555, 7865.0, 7873.921260787319, 8037.156098609562, 7779.844403112019, 7794.22057794216, 7887.132415434183, 8006.239407256301, 8260.0, 7024.648767561704, 7293.890591641236, 7393.704251829867, 7394.630268486661, 7530.962345188239, 4993.775280112476, 5054.1660625997765, 5144.614153938544, 5172.431032586488, 5219.347581552306, 5510.779568817203, 5539.695316757617, 5545.417731138173, 5599.608027438203, 5775.364709881994], "value": 4639.61654147618, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.2238883375804, 304.65421746317935, 311.4052160373687, 313.5970278192522, 319.76657040360544, 5275.419703832576, 5329.227262047001, 5417.241586177934, 5515.227868098465, 5576.219329293897, 5373.167159090338, 5425.294711687475, 5487.396386397493, 5501.4223506531835, 5510.9448905510935, 4256.553061928499, 4280.453130387415, 4298.226319262531, 4323.481182258133, 4330.891727706801, 4172.16556688662, 4288.721233119837, 4299.957000430002, 4309.612134907858, 4329.891752706176, 4247.25673007224, 4248.214080395137, 4255.191513612419, 4259.212045771526, 4267.871963841089, 4263.18999390118, 4266.552012038722, 4270.829166833323, 4290.849820256307, 4300.591443812864, 3667.3582123128344, 3794.3739283018544, 3807.447920051605, 3810.2189051244427, 3817.4846395736777, 5293.153095504739, 5300.867478313035, 5334.733263336856, 5342.973285133549, 5389.622726409114, 4814.711117332971, 4894.926576101361, 4901.681390709592, 4913.238448040559, 4918.729469879156, 5510.669359838383, 5680.630759000693, 5710.657360558338, 5730.7707691692285, 5763.279590051244, 4096.303628383182, 4103.563752686566, 4114.0, 4116.91766164675, 4133.42132101506, 5894.58737888348, 5943.940560594425, 5952.9107063394085, 5953.077273022688, 6047.546434017422, 4114.321137012419, 4132.628063474302, 4241.406203131564, 4243.5119961204855, 4260.510041345223, 4119.258533464005, 4149.813258403379, 4150.896227594334, 4158.960259935016, 4160.521540022875, 4796.640251981115, 4810.879728006757, 4823.769938665618, 4839.0, 4844.442889067732, 5609.354924183771, 5758.510526605285, 5804.970975145097, 5810.978291288507, 5877.47102760745, 1441.0633088492355, 1464.4288727396324, 1465.4354878961817, 1467.207707837777, 1467.4130347860942, 889.3996552327153, 915.6520522201654, 918.3433844801, 931.3713243560569, 944.7874228298715, 4695.694779839299, 4726.180420538118, 4756.738379389098, 4784.976075119602, 4839.370881785346, 5122.206058061007, 5132.743362831843, 5159.896802064013, 5184.248283998874, 5193.195054766517, 4756.571908528249, 4879.0, 4879.511748916614, 4880.487049014817, 4922.630802689812, 2691.4347986922576, 2705.742954419327, 2714.9592756108673, 2743.245607457965, 2757.765589924879, 5271.367435907716, 5276.815311464157, 5281.57047758028, 5333.999750093715, 5343.679379237258, 4891.951080489221, 5090.905455327123, 5128.8461346159675, 5191.273221748958, 5207.427183009866, 5229.372475302988, 5290.576753859682, 5294.311739473921, 5310.203469479532, 5356.196570514454, 5059.266406371129, 5072.99616651428, 5101.821436249714, 5128.461511541234, 5206.245094461357, 4782.856514304576, 5016.4983501651, 5021.4225364083595, 5041.2438134280155, 5131.820386286462, 5248.501392367719, 5272.9736351318, 5296.867578310573, 5308.0, 5337.146056630921, 3816.2749077675153, 3907.5701672816535, 4047.655949244347, 4063.6342729154517, 4072.266991941479, 5834.737436815269, 5852.239208902815, 5858.765649373977, 5860.765569377348, 5884.558658100574, 5618.831435056954, 5718.170865224436, 5727.713614319351, 5778.104393818965, 5784.7107644618445, 5644.915326270191, 5659.066254068032, 5660.349059858169, 5691.800786972436, 5702.800401986076, 5631.732860106444, 5656.43435656431, 5665.886682266414, 5675.2475049601735, 5699.544036477155, 5599.384067752625, 5698.2592263005545, 5769.624974376652, 5774.826755197183, 5780.913286300793, 5591.189277554813, 5592.741633132513, 5607.915881261702, 5616.354119276172, 5621.690807005654], "value": 4183.670632098319, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.4425836364363, 744.3672878053652, 775.9253433993916, 779.2752739951844, 812.7683610171102, 16252.918735406322, 16871.40950066748, 17524.82475175248, 17555.82444175558, 17611.383601573947, 15989.600259993505, 16212.594685132877, 16214.513564593051, 16233.512994610152, 16255.0, 638.2659941067762, 779.6530543907963, 789.2541548236918, 802.450321529751, 810.2707563193144, 784.831261278825, 794.1859593916224, 794.2375319693101, 794.253401802304, 794.4557977785236, 814.6212011414691, 817.1379194949326, 818.1123481023097, 819.6598411659185, 821.8233079887823, 801.703369753195, 802.5987006496752, 807.9313258373045, 808.1474044882647, 812.8577498937692, 586.4458087107685, 588.4292236530558, 588.9146073819272, 590.8877313310501, 591.9526437884958, 15407.229638518029, 15440.845591544054, 15501.147436890966, 15576.844231557652, 15587.220638968007, 14779.261036948217, 15427.460038898585, 15547.766783498257, 15600.921995390065, 16017.839821601752, 11758.706032349173, 11836.704082397922, 11963.282203067844, 12043.819342709867, 12263.75472490554, 3916.667083297895, 3919.8432062717743, 4034.8097311292945, 4124.752514849089, 4144.046869220097, 80973.0, 81493.0, 83032.0, 83051.0, 88442.11557884404, 11082.0, 11197.328160310244, 11529.596464123882, 11667.6499705009, 11931.522739090513, 21114.155433782784, 21148.47128821792, 21364.572708545744, 21406.464838378855, 21423.78576214218, 8385.221669965238, 8409.369297302726, 8450.943632045994, 8551.444156129832, 8614.44006139599, 4733.171694953369, 4791.401074865642, 4806.086843499724, 4844.467108618049, 4881.170201065827, 3560.5549306336707, 3652.872149474809, 3667.651573100551, 3669.192777588926, 3673.7061035117126, 609.759145137677, 612.5314134686968, 613.1599708399522, 617.1113596421139, 632.8481164520574, 559.5132234955533, 620.8137558732362, 621.0652967284299, 626.5488848029412, 702.8875379939185, 8425.0, 8691.304695624334, 8746.0, 8901.688440904538, 9242.21441177494, 603.9033754599243, 646.7768619826153, 672.226939020121, 683.4976292425064, 696.1506961506954, 4075.3886916962692, 4273.0, 4408.933865991949, 4485.641148708096, 4538.432695913011, 119614.0, 125286.0, 125310.0, 126009.0, 130583.0, 60793.145336659814, 62015.0, 80743.59628201938, 82016.58991705003, 96265.0, 60338.69830650907, 94593.52703236578, 95149.5242523783, 97044.51477742566, 98785.01214987902, 8243.091952087132, 8406.243438090602, 8641.740747777576, 8648.43785153963, 8660.78348041304, 38428.42357364698, 44088.55911440973, 48552.271715924995, 49178.75410622924, 49870.25194622011, 46554.767226163654, 48306.5169348302, 48732.0, 57734.0, 73438.64786930503, 12720.96464565702, 12909.677258068623, 13091.869081309445, 13104.2137471752, 13163.67090822737, 13332.666683332607, 13408.128471649312, 13682.93158534201, 13719.0, 13735.587932362045, 11510.59712910044, 11822.704432388915, 12135.878641213829, 12294.20087694297, 12541.874581254071, 12381.504739810667, 12559.93720031394, 12809.167404118702, 12956.28740419286, 13170.407331670289, 12880.935595321964, 13201.867981320063, 13250.204987700768, 13275.601731948056, 13325.933370333087, 10844.449737970575, 10940.507677154706, 11172.441377931233, 11417.0, 11418.942905285421, 11076.280041797258, 11281.605143819927, 11522.251053681484, 11649.359285239394, 11681.707957301136], "value": 7340.997316409734, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 110.0, 113.0, 115.0, 116.0, 118.0, 116.0, 116.0, 112.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 150.0, 180.0, 126.0, 159.0, 158.0, 125.0, 181.0, 122.0], "value": 147.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 168.0, 173.0, 168.0, 175.0, 167.0, 169.0, 168.0, 165.0], "value": 168.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 187.0, 78.0, 77.0, 87.0, 76.0, 187.0, 76.0], "value": 99.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 151.0, 88.0, 87.0, 86.0, 135.0, 87.0, 88.0, 152.0], "value": 104.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 119.0, 118.0, 118.0, 120.0, 119.0, 138.0, 118.0, 118.0], "value": 120.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 152.0, 148.0, 149.0, 149.0, 150.0, 150.0, 152.0, 150.0, 148.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 97.0, 96.0, 97.0, 96.0, 98.0, 97.0, 97.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 57.0, 60.0, 54.0, 54.0, 53.0, 52.0, 52.0, 52.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 70.0, 63.0, 62.0, 63.0, 63.0, 62.0, 63.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 84.0, 83.0, 88.0, 81.0, 81.0, 80.0, 80.0, 81.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 131.0, 138.0, 127.0, 132.0, 135.0, 127.0, 129.0, 150.0, 136.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 188.0, 172.0, 174.0, 172.0, 165.0, 168.0, 168.0, 169.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 70.0, 69.0, 70.0, 72.0, 69.0, 67.0, 67.0, 67.0], "value": 69.0, "unit": "score"}]}]} 16:31:25 INFO - Return code: 0 16:31:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:31:25 ERROR - # TBPL SUCCESS # 16:31:25 INFO - Running post-action listener: _resource_record_post_action 16:31:25 INFO - [mozharness: 2016-08-22 23:31:25.729702Z] Finished run-tests step (success) 16:31:25 INFO - Running post-run listener: _resource_record_post_run 16:31:25 INFO - Total resource usage - Wall time: 1196s; CPU: 14.0%; Read bytes: 4096; Write bytes: 407240704; Read time: 4; Write time: 429436 16:31:25 INFO - TinderboxPrint: CPU usage
13.9% 16:31:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 16:31:25 INFO - TinderboxPrint: I/O write bytes / time
407,240,704 / 429,436 16:31:25 INFO - TinderboxPrint: CPU idle
8,205.8 (86.0%) 16:31:25 INFO - TinderboxPrint: CPU user
1,230.8 (12.9%) 16:31:25 INFO - TinderboxPrint: Swap in / out
0 / 0 16:31:25 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117522432; Read time: 0; Write time: 121444 16:31:25 INFO - run-tests - Wall time: 1179s; CPU: 14.0%; Read bytes: 0; Write bytes: 288825344; Read time: 0; Write time: 307968 16:31:26 INFO - Running post-run listener: _upload_blobber_files 16:31:26 INFO - Blob upload gear active. 16:31:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:31:26 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 16:31:26 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:31:26 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:31:26 INFO - (blobuploader) - INFO - Open directory for files ... 16:31:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:31:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:31:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:27 INFO - (blobuploader) - INFO - Done attempting. 16:31:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:31:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:31:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:30 INFO - (blobuploader) - INFO - Done attempting. 16:31:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:31:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:31:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:31 INFO - (blobuploader) - INFO - Done attempting. 16:31:31 INFO - (blobuploader) - INFO - Iteration through files over. 16:31:31 INFO - Return code: 0 16:31:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:31:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:31:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6f47ebca7ae9b9f82191737f9ed8ec2bc7c9dd5cebd1a866e07e721bed66a6d692483b3b0ef89ef407e7d39ab1139cfc23994e2b699d4b3d65f6726ba8480cf6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f24cc8a3ca42e135c27d6553bc26cd692cbe87d0b47babf10d1c4ad0d53a77fe1fd27323156cc9318d72195cf30ad2ec93218d60591798d3856154e21e0a816b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a7e614e69e08b618a18cc6d612528229f974b0f7e6cb061e1164c9b512990b93ecf410ef4aea3873f3239ffb41aff380e34ad220e6aeb8d6238006ad9232b75"} 16:31:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:31:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:31:31 INFO - Contents: 16:31:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6f47ebca7ae9b9f82191737f9ed8ec2bc7c9dd5cebd1a866e07e721bed66a6d692483b3b0ef89ef407e7d39ab1139cfc23994e2b699d4b3d65f6726ba8480cf6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f24cc8a3ca42e135c27d6553bc26cd692cbe87d0b47babf10d1c4ad0d53a77fe1fd27323156cc9318d72195cf30ad2ec93218d60591798d3856154e21e0a816b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a7e614e69e08b618a18cc6d612528229f974b0f7e6cb061e1164c9b512990b93ecf410ef4aea3873f3239ffb41aff380e34ad220e6aeb8d6238006ad9232b75"} 16:31:31 INFO - Running post-run listener: copy_logs_to_upload_dir 16:31:31 INFO - Copying logs to upload dir... 16:31:31 INFO - mkdir: /builds/slave/test/build/upload/logs 16:31:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.464998 ========= master_lag: 0.78 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-22 16:31:29.373988) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 16:31:29.377069) ========= 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=52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6f47ebca7ae9b9f82191737f9ed8ec2bc7c9dd5cebd1a866e07e721bed66a6d692483b3b0ef89ef407e7d39ab1139cfc23994e2b699d4b3d65f6726ba8480cf6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f24cc8a3ca42e135c27d6553bc26cd692cbe87d0b47babf10d1c4ad0d53a77fe1fd27323156cc9318d72195cf30ad2ec93218d60591798d3856154e21e0a816b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a7e614e69e08b618a18cc6d612528229f974b0f7e6cb061e1164c9b512990b93ecf410ef4aea3873f3239ffb41aff380e34ad220e6aeb8d6238006ad9232b75"} build_url:https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6f47ebca7ae9b9f82191737f9ed8ec2bc7c9dd5cebd1a866e07e721bed66a6d692483b3b0ef89ef407e7d39ab1139cfc23994e2b699d4b3d65f6726ba8480cf6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f24cc8a3ca42e135c27d6553bc26cd692cbe87d0b47babf10d1c4ad0d53a77fe1fd27323156cc9318d72195cf30ad2ec93218d60591798d3856154e21e0a816b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a7e614e69e08b618a18cc6d612528229f974b0f7e6cb061e1164c9b512990b93ecf410ef4aea3873f3239ffb41aff380e34ad220e6aeb8d6238006ad9232b75"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 16:31:29.401712) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:31:29.402041) ========= 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=52faae308a556c440401f8e5000001e8-1471907451.353019-2129301242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:31:29.451435) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 16:31:29.451756) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 16:31:29.452033) ========= ========= Total master_lag: 1.01 =========