builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1471318806.57 results: success (0) buildid: 20160815191423 builduid: f5518cf516f8405db7bcf0d1907d64ff revision: c9d9d817ae305b37464b7e5b222c1113c0646fd0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 20:40:06.568644) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 20:40:06.569069) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 20:40:06.569356) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 20:40:06.584464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 20:40:06.584745) ========= 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=232498196343f89f466a4a9a000001c8-1471318805.403569-442925375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-15 20:40:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.1M=0s 2016-08-15 20:40:06 (47.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123521 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 20:40:06.736499) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 20:40:06.736839) ========= 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=232498196343f89f466a4a9a000001c8-1471318805.403569-442925375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016048 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 20:40:06.786168) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 20:40:06.786510) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c9d9d817ae305b37464b7e5b222c1113c0646fd0 --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 c9d9d817ae305b37464b7e5b222c1113c0646fd0 --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=232498196343f89f466a4a9a000001c8-1471318805.403569-442925375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-15 20:40:06,841 truncating revision to first 12 chars 2016-08-15 20:40:06,841 Setting DEBUG logging. 2016-08-15 20:40:06,841 attempt 1/10 2016-08-15 20:40:06,841 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c9d9d817ae30?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-15 20:40:07,153 unpacking tar archive at: fx-team-c9d9d817ae30/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684834 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 20:40:07.484913) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 20:40:07.485290) ========= script_repo_revision: c9d9d817ae305b37464b7e5b222c1113c0646fd0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 20:40:07.485675) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 20:40:07.485936) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 20:40:07.494191) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-08-15 20:40:07.494532) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1471318805.403569-442925375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:40:07 INFO - MultiFileLogger online at 20160815 20:40:07 in /builds/slave/test 20:40:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 20:40:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:40:07 INFO - {'append_to_log': False, 20:40:07 INFO - 'base_work_dir': '/builds/slave/test', 20:40:07 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 20:40:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:40:07 INFO - 'branch': 'Fx-Team-Non-PGO', 20:40:07 INFO - 'buildbot_json_path': 'buildprops.json', 20:40:07 INFO - 'config_files': ('talos/linux_config.py',), 20:40:07 INFO - 'default_actions': ('clobber', 20:40:07 INFO - 'read-buildbot-config', 20:40:07 INFO - 'download-and-extract', 20:40:07 INFO - 'populate-webroot', 20:40:07 INFO - 'create-virtualenv', 20:40:07 INFO - 'install', 20:40:07 INFO - 'run-tests'), 20:40:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:40:07 INFO - 'download_minidump_stackwalk': True, 20:40:07 INFO - 'download_symbols': 'ondemand', 20:40:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:40:07 INFO - 'tooltool.py': '/tools/tooltool.py', 20:40:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:40:07 INFO - '/tools/misc-python/virtualenv.py')}, 20:40:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:40:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:40:07 INFO - 'installer_path': 'installer.exe', 20:40:07 INFO - 'log_level': 'info', 20:40:07 INFO - 'log_name': 'talos', 20:40:07 INFO - 'log_to_console': True, 20:40:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:40:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:40:07 INFO - 'opt_config_files': (), 20:40:07 INFO - 'pip_index': False, 20:40:07 INFO - 'sps_profile': False, 20:40:07 INFO - 'sps_profile_interval': 0, 20:40:07 INFO - 'suite': 'dromaeojs', 20:40:07 INFO - 'system_bits': '32', 20:40:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:40:07 INFO - 'title': 'talos-linux64-ix-025', 20:40:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:40:07 INFO - 'use_talos_json': True, 20:40:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:40:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:40:07 INFO - 'work_dir': 'build'} 20:40:07 INFO - [mozharness: 2016-08-16 03:40:07.690836Z] Running clobber step. 20:40:07 INFO - Running pre-action listener: _resource_record_pre_action 20:40:07 INFO - Running main action method: clobber 20:40:07 INFO - rmtree: /builds/slave/test/build 20:40:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:40:08 INFO - Running post-action listener: _resource_record_post_action 20:40:08 INFO - [mozharness: 2016-08-16 03:40:08.117067Z] Finished clobber step (success) 20:40:08 INFO - [mozharness: 2016-08-16 03:40:08.117169Z] Running read-buildbot-config step. 20:40:08 INFO - Running pre-action listener: _resource_record_pre_action 20:40:08 INFO - Running main action method: read_buildbot_config 20:40:08 INFO - Using buildbot properties: 20:40:08 INFO - { 20:40:08 INFO - "project": "", 20:40:08 INFO - "product": "firefox", 20:40:08 INFO - "script_repo_revision": "production", 20:40:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:40:08 INFO - "repository": "", 20:40:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 20:40:08 INFO - "buildid": "20160815191423", 20:40:08 INFO - "pgo_build": "False", 20:40:08 INFO - "basedir": "/builds/slave/test", 20:40:08 INFO - "buildnumber": 1870, 20:40:08 INFO - "slavename": "talos-linux64-ix-025", 20:40:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:40:08 INFO - "platform": "ubuntu64_hw", 20:40:08 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 20:40:08 INFO - "branch": "fx-team", 20:40:08 INFO - "repo_path": "integration/fx-team", 20:40:08 INFO - "revision": "c9d9d817ae305b37464b7e5b222c1113c0646fd0", 20:40:08 INFO - "stage_platform": "linux64", 20:40:08 INFO - "builduid": "f5518cf516f8405db7bcf0d1907d64ff", 20:40:08 INFO - "slavebuilddir": "test" 20:40:08 INFO - } 20:40:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 20:40:08 INFO - Running post-action listener: _resource_record_post_action 20:40:08 INFO - [mozharness: 2016-08-16 03:40:08.119589Z] Finished read-buildbot-config step (success) 20:40:08 INFO - [mozharness: 2016-08-16 03:40:08.119678Z] Running download-and-extract step. 20:40:08 INFO - Running pre-action listener: _resource_record_pre_action 20:40:08 INFO - Running main action method: download_and_extract 20:40:08 INFO - mkdir: /builds/slave/test/build/tests 20:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:08 INFO - trying https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:40:08 INFO - Downloading https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/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 20:40:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/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 20:40:08 INFO - Downloaded 1361 bytes. 20:40:08 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:40:08 INFO - Using the following test package requirements: 20:40:08 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:40:08 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:40:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:40:08 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:40:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:40:08 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:40:08 INFO - u'jsshell-linux-x86_64.zip'], 20:40:08 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:40:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:40:08 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:40:08 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:40:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:40:08 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:40:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:40:08 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:40:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:40:08 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:40:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:40:08 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:08 INFO - trying https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:40:08 INFO - Downloading https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/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 20:40:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/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 20:40:09 INFO - Downloaded 20265717 bytes. 20:40:09 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 20:40:14 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 20:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:14 INFO - trying https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:40:14 INFO - Downloading https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/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 20:40:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/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 20:40:14 INFO - Downloaded 20265717 bytes. 20:40:14 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 20:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:19 INFO - trying https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:40:19 INFO - Downloading https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/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 20:40:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/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 20:40:20 INFO - Downloaded 14413719 bytes. 20:40:20 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 20:40:20 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')]} 20:40:20 INFO - trying https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:40:20 INFO - Downloading https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/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 20:40:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/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 20:40:22 INFO - Downloaded 55627151 bytes. 20:40:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:40:22 INFO - mkdir: /builds/slave/test/properties 20:40:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:40:22 INFO - Writing to file /builds/slave/test/properties/build_url 20:40:22 INFO - Contents: 20:40:22 INFO - build_url:https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:40:22 INFO - Running post-action listener: _resource_record_post_action 20:40:22 INFO - Running post-action listener: set_extra_try_arguments 20:40:22 INFO - [mozharness: 2016-08-16 03:40:22.714506Z] Finished download-and-extract step (success) 20:40:22 INFO - [mozharness: 2016-08-16 03:40:22.714736Z] Running populate-webroot step. 20:40:22 INFO - Running pre-action listener: _resource_record_pre_action 20:40:22 INFO - Running main action method: populate_webroot 20:40:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:40:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:40:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:40:22 INFO - '--tppagecycles', 20:40:22 INFO - '7'], 20:40:22 INFO - 'tests': ['tsvgm']}}, 20:40:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:40:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:40:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:40:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:40:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:40:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:40:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:22 INFO - 'talos_options': ['--disable-e10s'], 20:40:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:40:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:40:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:22 INFO - 'talos_options': ['--disable-e10s'], 20:40:22 INFO - 'tests': ['damp', 'tps']}, 20:40:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:22 INFO - 'tests': ['damp', 'tps']}, 20:40:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:40:22 INFO - 'tests': ['dromaeo_dom']}, 20:40:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:40:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:40:22 INFO - 'tests': ['basic_compositor_video']}, 20:40:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:40:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:40:22 INFO - 'tests': ['a11yr', 20:40:22 INFO - 'ts_paint', 20:40:22 INFO - 'tpaint', 20:40:22 INFO - 'sessionrestore', 20:40:22 INFO - 'sessionrestore_no_auto_restore', 20:40:22 INFO - 'tabpaint']}, 20:40:22 INFO - 'other-e10s': {'tests': ['a11yr', 20:40:22 INFO - 'ts_paint', 20:40:22 INFO - 'tpaint', 20:40:22 INFO - 'sessionrestore', 20:40:22 INFO - 'sessionrestore_no_auto_restore', 20:40:22 INFO - 'tabpaint']}, 20:40:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:40:22 INFO - 'ts_paint', 20:40:22 INFO - 'tpaint', 20:40:22 INFO - 'sessionrestore', 20:40:22 INFO - 'sessionrestore_no_auto_restore', 20:40:22 INFO - 'tabpaint']}, 20:40:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:40:22 INFO - 'ts_paint', 20:40:22 INFO - 'tpaint', 20:40:22 INFO - 'sessionrestore', 20:40:22 INFO - 'sessionrestore_no_auto_restore', 20:40:22 INFO - 'tabpaint']}, 20:40:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:40:22 INFO - 'tests': ['a11yr', 20:40:22 INFO - 'ts_paint', 20:40:22 INFO - 'tpaint', 20:40:22 INFO - 'sessionrestore', 20:40:22 INFO - 'sessionrestore_no_auto_restore', 20:40:22 INFO - 'tabpaint']}, 20:40:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:40:22 INFO - 'tests': ['a11yr', 20:40:22 INFO - 'ts_paint', 20:40:22 INFO - 'tpaint', 20:40:22 INFO - 'sessionrestore', 20:40:22 INFO - 'sessionrestore_no_auto_restore', 20:40:22 INFO - 'tabpaint']}, 20:40:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:40:22 INFO - 'tests': ['tsvgx', 20:40:22 INFO - 'tsvgr_opacity', 20:40:22 INFO - 'tart', 20:40:22 INFO - 'tscrollx', 20:40:22 INFO - 'cart']}, 20:40:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:40:22 INFO - 'tsvgr_opacity', 20:40:22 INFO - 'tart', 20:40:22 INFO - 'tscrollx', 20:40:22 INFO - 'cart']}, 20:40:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:22 INFO - 'talos_options': ['--disable-e10s'], 20:40:22 INFO - 'tests': ['tp5o']}, 20:40:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:22 INFO - 'tests': ['tp5o']}, 20:40:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:22 INFO - 'talos_options': ['--disable-e10s', 20:40:22 INFO - '--xperf_path', 20:40:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:40:22 INFO - 'tests': ['tp5n']}, 20:40:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:22 INFO - 'talos_options': ['--xperf_path', 20:40:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:40:22 INFO - 'tests': ['tp5n']}}, 20:40:22 INFO - 'talos.zip': {'path': '', 20:40:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:40:22 INFO - Running post-action listener: _resource_record_post_action 20:40:22 INFO - [mozharness: 2016-08-16 03:40:22.740707Z] Finished populate-webroot step (success) 20:40:22 INFO - [mozharness: 2016-08-16 03:40:22.740795Z] Running create-virtualenv step. 20:40:22 INFO - Running pre-action listener: _resource_record_pre_action 20:40:22 INFO - Running main action method: create_virtualenv 20:40:22 INFO - Creating virtualenv /builds/slave/test/build/venv 20:40:22 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 20:40:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:40:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:40:22 INFO - Using real prefix '/usr' 20:40:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:40:23 INFO - Installing distribute.............................................................................................................................................................................................done. 20:40:27 INFO - Installing pip.................done. 20:40:27 INFO - Return code: 0 20:40:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:27 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 0x7f9a099c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cf090>, '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 0x28d29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d2e40>, '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': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', '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 20:40:27 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 20:40:27 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 20:40:27 INFO - Using env: {'DISPLAY': ':0', 20:40:27 INFO - 'HOME': '/home/cltbld', 20:40:27 INFO - 'LANG': 'en_US.UTF-8', 20:40:27 INFO - 'LANGUAGE': 'en_US:en', 20:40:27 INFO - 'LOGNAME': 'cltbld', 20:40:27 INFO - 'MAIL': '/var/mail/cltbld', 20:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:27 INFO - 'MOZ_NO_REMOTE': '1', 20:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:27 INFO - 'NO_EM_RESTART': '1', 20:40:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:27 INFO - 'PWD': '/builds/slave/test', 20:40:27 INFO - 'SHELL': '/bin/bash', 20:40:27 INFO - 'SHLVL': '1', 20:40:27 INFO - 'TERM': 'linux', 20:40:27 INFO - 'TMOUT': '86400', 20:40:27 INFO - 'USER': 'cltbld', 20:40:27 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', 20:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:27 INFO - '_': '/tools/buildbot/bin/python'} 20:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:27 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 20:40:27 INFO - Cleaning up... 20:40:27 INFO - Return code: 0 20:40:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:27 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 0x7f9a099c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cf090>, '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 0x28d29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d2e40>, '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': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', '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 20:40:27 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 20:40:27 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 20:40:27 INFO - Using env: {'DISPLAY': ':0', 20:40:27 INFO - 'HOME': '/home/cltbld', 20:40:27 INFO - 'LANG': 'en_US.UTF-8', 20:40:27 INFO - 'LANGUAGE': 'en_US:en', 20:40:27 INFO - 'LOGNAME': 'cltbld', 20:40:27 INFO - 'MAIL': '/var/mail/cltbld', 20:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:27 INFO - 'MOZ_NO_REMOTE': '1', 20:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:27 INFO - 'NO_EM_RESTART': '1', 20:40:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:27 INFO - 'PWD': '/builds/slave/test', 20:40:27 INFO - 'SHELL': '/bin/bash', 20:40:27 INFO - 'SHLVL': '1', 20:40:27 INFO - 'TERM': 'linux', 20:40:27 INFO - 'TMOUT': '86400', 20:40:27 INFO - 'USER': 'cltbld', 20:40:27 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', 20:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:27 INFO - '_': '/tools/buildbot/bin/python'} 20:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:27 INFO - Downloading/unpacking psutil>=3.1.1 20:40:27 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 20:40:27 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 20:40:27 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 20:40:27 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 20:40:27 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 20:40:27 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 20:40:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:40:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:40:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:40:29 INFO - Installing collected packages: psutil 20:40:29 INFO - Running setup.py install for psutil 20:40:29 INFO - building 'psutil._psutil_linux' extension 20:40:29 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 20:40:30 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 20:40:31 INFO - building 'psutil._psutil_posix' extension 20:40:31 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 20:40:31 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 20:40:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:40:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:40:31 INFO - Successfully installed psutil 20:40:31 INFO - Cleaning up... 20:40:31 INFO - Return code: 0 20:40:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:40:31 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')]} 20:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:31 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')]} 20:40:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:31 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 0x7f9a099c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cf090>, '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 0x28d29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d2e40>, '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': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', '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 20:40:31 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 20:40:31 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 20:40:31 INFO - Using env: {'DISPLAY': ':0', 20:40:31 INFO - 'HOME': '/home/cltbld', 20:40:31 INFO - 'LANG': 'en_US.UTF-8', 20:40:31 INFO - 'LANGUAGE': 'en_US:en', 20:40:31 INFO - 'LOGNAME': 'cltbld', 20:40:31 INFO - 'MAIL': '/var/mail/cltbld', 20:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:31 INFO - 'MOZ_NO_REMOTE': '1', 20:40:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:31 INFO - 'NO_EM_RESTART': '1', 20:40:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:31 INFO - 'PWD': '/builds/slave/test', 20:40:31 INFO - 'SHELL': '/bin/bash', 20:40:31 INFO - 'SHLVL': '1', 20:40:31 INFO - 'TERM': 'linux', 20:40:31 INFO - 'TMOUT': '86400', 20:40:31 INFO - 'USER': 'cltbld', 20:40:31 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', 20:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:31 INFO - '_': '/tools/buildbot/bin/python'} 20:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:40:33 INFO - Installing collected packages: mozsystemmonitor 20:40:33 INFO - Running setup.py install for mozsystemmonitor 20:40:33 INFO - Successfully installed mozsystemmonitor 20:40:33 INFO - Cleaning up... 20:40:33 INFO - Return code: 0 20:40:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a099c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cf090>, '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 0x28d29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d2e40>, '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': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', '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 20:40:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:40:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:40:33 INFO - Using env: {'DISPLAY': ':0', 20:40:33 INFO - 'HOME': '/home/cltbld', 20:40:33 INFO - 'LANG': 'en_US.UTF-8', 20:40:33 INFO - 'LANGUAGE': 'en_US:en', 20:40:33 INFO - 'LOGNAME': 'cltbld', 20:40:33 INFO - 'MAIL': '/var/mail/cltbld', 20:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:33 INFO - 'MOZ_NO_REMOTE': '1', 20:40:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:33 INFO - 'NO_EM_RESTART': '1', 20:40:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:33 INFO - 'PWD': '/builds/slave/test', 20:40:33 INFO - 'SHELL': '/bin/bash', 20:40:33 INFO - 'SHLVL': '1', 20:40:33 INFO - 'TERM': 'linux', 20:40:33 INFO - 'TMOUT': '86400', 20:40:33 INFO - 'USER': 'cltbld', 20:40:33 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', 20:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:33 INFO - '_': '/tools/buildbot/bin/python'} 20:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:33 INFO - Downloading/unpacking jsonschema==2.5.1 20:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:40:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:40:35 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 20:40:35 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 20:40:35 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 20:40:35 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 20:40:35 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 20:40:35 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 20:40:36 INFO - Downloading functools32-3.2.3-2.tar.gz 20:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:40:36 INFO - warning: no files found matching '*.txt' 20:40:36 INFO - no previously-included directories found matching 'build' 20:40:36 INFO - no previously-included directories found matching 'dist' 20:40:36 INFO - no previously-included directories found matching '.git*' 20:40:36 INFO - Installing collected packages: jsonschema, functools32 20:40:36 INFO - Running setup.py install for functools32 20:40:36 INFO - warning: no files found matching '*.txt' 20:40:36 INFO - no previously-included directories found matching 'build' 20:40:36 INFO - no previously-included directories found matching 'dist' 20:40:36 INFO - no previously-included directories found matching '.git*' 20:40:36 INFO - Successfully installed jsonschema functools32 20:40:36 INFO - Cleaning up... 20:40:36 INFO - Return code: 0 20:40:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9a099c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cf090>, '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 0x28d29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d2e40>, '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': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', '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 20:40:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:40:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:40:36 INFO - Using env: {'DISPLAY': ':0', 20:40:36 INFO - 'HOME': '/home/cltbld', 20:40:36 INFO - 'LANG': 'en_US.UTF-8', 20:40:36 INFO - 'LANGUAGE': 'en_US:en', 20:40:36 INFO - 'LOGNAME': 'cltbld', 20:40:36 INFO - 'MAIL': '/var/mail/cltbld', 20:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:36 INFO - 'MOZ_NO_REMOTE': '1', 20:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:36 INFO - 'NO_EM_RESTART': '1', 20:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:36 INFO - 'PWD': '/builds/slave/test', 20:40:36 INFO - 'SHELL': '/bin/bash', 20:40:36 INFO - 'SHLVL': '1', 20:40:36 INFO - 'TERM': 'linux', 20:40:36 INFO - 'TMOUT': '86400', 20:40:36 INFO - 'USER': 'cltbld', 20:40:36 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', 20:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:36 INFO - '_': '/tools/buildbot/bin/python'} 20:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:40:36 INFO - Cleaning up... 20:40:36 INFO - Return code: 0 20:40:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9a099c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cf090>, '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 0x28d29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d2e40>, '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': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', '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 20:40:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:40:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:40:36 INFO - Using env: {'DISPLAY': ':0', 20:40:36 INFO - 'HOME': '/home/cltbld', 20:40:36 INFO - 'LANG': 'en_US.UTF-8', 20:40:36 INFO - 'LANGUAGE': 'en_US:en', 20:40:36 INFO - 'LOGNAME': 'cltbld', 20:40:36 INFO - 'MAIL': '/var/mail/cltbld', 20:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:36 INFO - 'MOZ_NO_REMOTE': '1', 20:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:36 INFO - 'NO_EM_RESTART': '1', 20:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:36 INFO - 'PWD': '/builds/slave/test', 20:40:36 INFO - 'SHELL': '/bin/bash', 20:40:36 INFO - 'SHLVL': '1', 20:40:36 INFO - 'TERM': 'linux', 20:40:36 INFO - 'TMOUT': '86400', 20:40:36 INFO - 'USER': 'cltbld', 20:40:36 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', 20:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:36 INFO - '_': '/tools/buildbot/bin/python'} 20:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:36 INFO - Downloading/unpacking blobuploader==1.2.4 20:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:38 INFO - Downloading blobuploader-1.2.4.tar.gz 20:40:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:40:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:40:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:39 INFO - Downloading docopt-0.6.1.tar.gz 20:40:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:40:39 INFO - Installing collected packages: blobuploader, requests, docopt 20:40:39 INFO - Running setup.py install for blobuploader 20:40:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:40:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:40:39 INFO - Running setup.py install for requests 20:40:39 INFO - Running setup.py install for docopt 20:40:39 INFO - Successfully installed blobuploader requests docopt 20:40:39 INFO - Cleaning up... 20:40:40 INFO - Return code: 0 20:40:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:40:40 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')]} 20:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:40 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')]} 20:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:40 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 0x7f9a099c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cf090>, '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 0x28d29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d2e40>, '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': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', '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 20:40:40 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 20:40:40 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 20:40:40 INFO - Using env: {'DISPLAY': ':0', 20:40:40 INFO - 'HOME': '/home/cltbld', 20:40:40 INFO - 'LANG': 'en_US.UTF-8', 20:40:40 INFO - 'LANGUAGE': 'en_US:en', 20:40:40 INFO - 'LOGNAME': 'cltbld', 20:40:40 INFO - 'MAIL': '/var/mail/cltbld', 20:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:40 INFO - 'MOZ_NO_REMOTE': '1', 20:40:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:40 INFO - 'NO_EM_RESTART': '1', 20:40:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:40 INFO - 'PWD': '/builds/slave/test', 20:40:40 INFO - 'SHELL': '/bin/bash', 20:40:40 INFO - 'SHLVL': '1', 20:40:40 INFO - 'TERM': 'linux', 20:40:40 INFO - 'TMOUT': '86400', 20:40:40 INFO - 'USER': 'cltbld', 20:40:40 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', 20:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:40 INFO - '_': '/tools/buildbot/bin/python'} 20:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:40:40 INFO - Running setup.py (path:/tmp/pip-BScvd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:40:40 INFO - Running setup.py (path:/tmp/pip-naRBzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:40:40 INFO - Running setup.py (path:/tmp/pip-EQdTTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:40:40 INFO - Running setup.py (path:/tmp/pip-jZ54aH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:40:40 INFO - Running setup.py (path:/tmp/pip-7j6c1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:40:40 INFO - Running setup.py (path:/tmp/pip-2ATNbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:40:40 INFO - Running setup.py (path:/tmp/pip-ZOmX_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:40:40 INFO - Running setup.py (path:/tmp/pip-wVZWyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:40:40 INFO - Running setup.py (path:/tmp/pip-QPkLl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:40:40 INFO - Running setup.py (path:/tmp/pip-hNSHDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:40:40 INFO - Running setup.py (path:/tmp/pip-0OXjnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:40:41 INFO - Running setup.py (path:/tmp/pip-9FzMkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:40:41 INFO - Running setup.py (path:/tmp/pip-IG5JLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:40:41 INFO - Running setup.py (path:/tmp/pip-akoY6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:40:41 INFO - Running setup.py (path:/tmp/pip-h6hWkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:40:41 INFO - Running setup.py (path:/tmp/pip-teu6jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:40:41 INFO - Running setup.py (path:/tmp/pip-U9FUaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:40:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:40:41 INFO - Running setup.py install for manifestparser 20:40:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:40:41 INFO - Running setup.py install for mozcrash 20:40:41 INFO - Running setup.py install for mozdebug 20:40:41 INFO - Running setup.py install for mozdevice 20:40:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:40:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:40:41 INFO - Running setup.py install for mozfile 20:40:41 INFO - Running setup.py install for mozhttpd 20:40:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:40:42 INFO - Running setup.py install for mozinfo 20:40:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:40:42 INFO - Running setup.py install for mozInstall 20:40:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:40:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:40:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:40:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:40:42 INFO - Running setup.py install for mozleak 20:40:42 INFO - Running setup.py install for mozlog 20:40:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:40:42 INFO - Running setup.py install for moznetwork 20:40:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:40:42 INFO - Running setup.py install for mozprocess 20:40:42 INFO - Running setup.py install for mozprofile 20:40:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:40:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:40:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:40:42 INFO - Running setup.py install for mozrunner 20:40:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:40:42 INFO - Running setup.py install for mozscreenshot 20:40:43 INFO - Running setup.py install for moztest 20:40:43 INFO - Running setup.py install for mozversion 20:40:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:40:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:40:43 INFO - Cleaning up... 20:40:43 INFO - Return code: 0 20:40:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:40:43 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')]} 20:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:43 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')]} 20:40:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:43 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 0x7f9a099c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cf090>, '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 0x28d29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d2e40>, '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': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', '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 20:40:43 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 20:40:43 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 20:40:43 INFO - Using env: {'DISPLAY': ':0', 20:40:43 INFO - 'HOME': '/home/cltbld', 20:40:43 INFO - 'LANG': 'en_US.UTF-8', 20:40:43 INFO - 'LANGUAGE': 'en_US:en', 20:40:43 INFO - 'LOGNAME': 'cltbld', 20:40:43 INFO - 'MAIL': '/var/mail/cltbld', 20:40:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:43 INFO - 'MOZ_NO_REMOTE': '1', 20:40:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:43 INFO - 'NO_EM_RESTART': '1', 20:40:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:43 INFO - 'PWD': '/builds/slave/test', 20:40:43 INFO - 'SHELL': '/bin/bash', 20:40:43 INFO - 'SHLVL': '1', 20:40:43 INFO - 'TERM': 'linux', 20:40:43 INFO - 'TMOUT': '86400', 20:40:43 INFO - 'USER': 'cltbld', 20:40:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', 20:40:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:43 INFO - '_': '/tools/buildbot/bin/python'} 20:40:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:40:43 INFO - Running setup.py (path:/tmp/pip-o8Mr0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:40:43 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)) 20:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:40:43 INFO - Running setup.py (path:/tmp/pip-VsqkoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:40:43 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)) 20:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:40:43 INFO - Running setup.py (path:/tmp/pip-NPKhxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:40:43 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)) 20:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:40:43 INFO - Running setup.py (path:/tmp/pip-6qxNgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:40:43 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)) 20:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:40:43 INFO - Running setup.py (path:/tmp/pip-j_u7tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:40:43 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)) 20:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:40:43 INFO - Running setup.py (path:/tmp/pip-Z1P3g0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:40:43 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)) 20:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:40:43 INFO - Running setup.py (path:/tmp/pip-UeP_oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:40:43 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)) 20:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:40:43 INFO - Running setup.py (path:/tmp/pip-bvFyTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:40:44 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)) 20:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:40:44 INFO - Running setup.py (path:/tmp/pip-LWW16v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:40:44 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)) 20:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:40:44 INFO - Running setup.py (path:/tmp/pip-GjO0ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:40:44 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)) 20:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:40:44 INFO - Running setup.py (path:/tmp/pip-VaxZuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:40:44 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)) 20:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:40:44 INFO - Running setup.py (path:/tmp/pip-xI2HK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:40:44 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)) 20:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:40:44 INFO - Running setup.py (path:/tmp/pip-yBezIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:40:44 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)) 20:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:40:44 INFO - Running setup.py (path:/tmp/pip-UHy6Fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:40:44 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)) 20:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:40:44 INFO - Running setup.py (path:/tmp/pip-Ef6sCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:40:44 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)) 20:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:40:44 INFO - Running setup.py (path:/tmp/pip-G0h4Lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:40:44 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)) 20:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:40:44 INFO - Running setup.py (path:/tmp/pip-Rs5Xta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:40:44 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)) 20:40:44 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)) 20:40:44 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)) 20:40:44 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)) 20:40:44 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)) 20:40:44 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)) 20:40:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:40:44 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 20:40:44 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 20:40:44 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 20:40:44 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 20:40:44 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 20:40:44 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 20:40:46 INFO - Downloading blessings-1.6.tar.gz 20:40:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:40:46 INFO - Installing collected packages: blessings 20:40:46 INFO - Running setup.py install for blessings 20:40:46 INFO - Successfully installed blessings 20:40:46 INFO - Cleaning up... 20:40:46 INFO - Return code: 0 20:40:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:40:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:40:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:40:47 INFO - Reading from file tmpfile_stdout 20:40:47 INFO - Current package versions: 20:40:47 INFO - argparse == 1.2.1 20:40:47 INFO - blessings == 1.6 20:40:47 INFO - blobuploader == 1.2.4 20:40:47 INFO - docopt == 0.6.1 20:40:47 INFO - functools32 == 3.2.3-2 20:40:47 INFO - jsonschema == 2.5.1 20:40:47 INFO - manifestparser == 1.1 20:40:47 INFO - mozInstall == 1.12 20:40:47 INFO - mozcrash == 0.17 20:40:47 INFO - mozdebug == 0.1 20:40:47 INFO - mozdevice == 0.48 20:40:47 INFO - mozfile == 1.2 20:40:47 INFO - mozhttpd == 0.7 20:40:47 INFO - mozinfo == 0.9 20:40:47 INFO - mozleak == 0.1 20:40:47 INFO - mozlog == 3.3 20:40:47 INFO - moznetwork == 0.27 20:40:47 INFO - mozprocess == 0.23 20:40:47 INFO - mozprofile == 0.28 20:40:47 INFO - mozrunner == 6.12 20:40:47 INFO - mozscreenshot == 0.1 20:40:47 INFO - mozsystemmonitor == 0.3 20:40:47 INFO - moztest == 0.7 20:40:47 INFO - mozversion == 1.4 20:40:47 INFO - psutil == 3.1.1 20:40:47 INFO - requests == 1.2.3 20:40:47 INFO - wsgiref == 0.1.2 20:40:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:40:47 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')]} 20:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:47 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')]} 20:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:47 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 0x7f9a099c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cf090>, '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 0x28d29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d2e40>, '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': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', '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 20:40:47 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 20:40:47 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 20:40:47 INFO - Using env: {'DISPLAY': ':0', 20:40:47 INFO - 'HOME': '/home/cltbld', 20:40:47 INFO - 'LANG': 'en_US.UTF-8', 20:40:47 INFO - 'LANGUAGE': 'en_US:en', 20:40:47 INFO - 'LOGNAME': 'cltbld', 20:40:47 INFO - 'MAIL': '/var/mail/cltbld', 20:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:47 INFO - 'MOZ_NO_REMOTE': '1', 20:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:47 INFO - 'NO_EM_RESTART': '1', 20:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:47 INFO - 'PWD': '/builds/slave/test', 20:40:47 INFO - 'SHELL': '/bin/bash', 20:40:47 INFO - 'SHLVL': '1', 20:40:47 INFO - 'TERM': 'linux', 20:40:47 INFO - 'TMOUT': '86400', 20:40:47 INFO - 'USER': 'cltbld', 20:40:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', 20:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:47 INFO - '_': '/tools/buildbot/bin/python'} 20:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:47 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)) 20:40:47 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)) 20:40:47 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)) 20:40:47 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)) 20:40:47 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)) 20:40:47 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)) 20:40:47 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)) 20:40:47 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)) 20:40:47 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)) 20:40:47 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)) 20:40:47 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)) 20:40:47 INFO - Cleaning up... 20:40:47 INFO - Return code: 0 20:40:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:40:47 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')]} 20:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:47 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')]} 20:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:47 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 0x7f9a099c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cf090>, '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 0x28d29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d2e40>, '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': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', '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 20:40:47 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 20:40:47 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 20:40:47 INFO - Using env: {'DISPLAY': ':0', 20:40:47 INFO - 'HOME': '/home/cltbld', 20:40:47 INFO - 'LANG': 'en_US.UTF-8', 20:40:47 INFO - 'LANGUAGE': 'en_US:en', 20:40:47 INFO - 'LOGNAME': 'cltbld', 20:40:47 INFO - 'MAIL': '/var/mail/cltbld', 20:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:47 INFO - 'MOZ_NO_REMOTE': '1', 20:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:47 INFO - 'NO_EM_RESTART': '1', 20:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:47 INFO - 'PWD': '/builds/slave/test', 20:40:47 INFO - 'SHELL': '/bin/bash', 20:40:47 INFO - 'SHLVL': '1', 20:40:47 INFO - 'TERM': 'linux', 20:40:47 INFO - 'TMOUT': '86400', 20:40:47 INFO - 'USER': 'cltbld', 20:40:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', 20:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:47 INFO - '_': '/tools/buildbot/bin/python'} 20:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:40:47 INFO - Cleaning up... 20:40:47 INFO - Return code: 0 20:40:47 INFO - Running post-action listener: _resource_record_post_action 20:40:47 INFO - Running post-action listener: _start_resource_monitoring 20:40:47 INFO - Starting resource monitoring. 20:40:47 INFO - [mozharness: 2016-08-16 03:40:47.578403Z] Finished create-virtualenv step (success) 20:40:47 INFO - [mozharness: 2016-08-16 03:40:47.579360Z] Running install step. 20:40:47 INFO - Running pre-action listener: _resource_record_pre_action 20:40:47 INFO - Running main action method: install 20:40:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:40:47 INFO - Reading from file tmpfile_stdout 20:40:47 INFO - Detecting whether we're running mozinstall >=1.0... 20:40:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:40:47 INFO - Reading from file tmpfile_stdout 20:40:47 INFO - Output received: 20:40:47 INFO - Usage: mozinstall [options] installer 20:40:47 INFO - Options: 20:40:47 INFO - -h, --help show this help message and exit 20:40:47 INFO - -d DEST, --destination=DEST 20:40:47 INFO - Directory to install application into. [default: 20:40:47 INFO - "/builds/slave/test"] 20:40:47 INFO - --app=APP Application being installed. [default: firefox] 20:40:47 INFO - mkdir: /builds/slave/test/build/application 20:40:47 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'] 20:40:47 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 20:41:03 INFO - Reading from file tmpfile_stdout 20:41:03 INFO - Output received: 20:41:03 INFO - /builds/slave/test/build/application/firefox/firefox 20:41:03 INFO - Running post-action listener: _resource_record_post_action 20:41:03 INFO - [mozharness: 2016-08-16 03:41:03.898335Z] Finished install step (success) 20:41:03 INFO - [mozharness: 2016-08-16 03:41:03.898581Z] Running run-tests step. 20:41:03 INFO - Running pre-action listener: _resource_record_pre_action 20:41:03 INFO - Running main action method: run_tests 20:41:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:41:03 INFO - Python 2.7.3 20:41:03 INFO - Return code: 0 20:41:03 INFO - grabbing minidump binary from tooltool 20:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:41:03 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 0x28cf090>, '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 0x28d29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d2e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:41:03 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 20:41:03 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 20:41:03 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 20:41:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:41:04 INFO - Return code: 0 20:41:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:41:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:41:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:41:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:41:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:41:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:41:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:41:04 INFO - Using env: {'DISPLAY': ':0', 20:41:04 INFO - 'HOME': '/home/cltbld', 20:41:04 INFO - 'LANG': 'en_US.UTF-8', 20:41:04 INFO - 'LANGUAGE': 'en_US:en', 20:41:04 INFO - 'LOGNAME': 'cltbld', 20:41:04 INFO - 'MAIL': '/var/mail/cltbld', 20:41:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:41:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:04 INFO - 'MOZ_NO_REMOTE': '1', 20:41:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:41:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:04 INFO - 'NO_EM_RESTART': '1', 20:41:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:04 INFO - 'PWD': '/builds/slave/test', 20:41:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:41:04 INFO - 'SHELL': '/bin/bash', 20:41:04 INFO - 'SHLVL': '1', 20:41:04 INFO - 'TERM': 'linux', 20:41:04 INFO - 'TMOUT': '86400', 20:41:04 INFO - 'USER': 'cltbld', 20:41:04 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471318805.403569-442925375', 20:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:04 INFO - '_': '/tools/buildbot/bin/python'} 20:41:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:41:04 INFO - mozversion application_buildid: 20160815191423 20:41:04 INFO - mozversion application_changeset: c9d9d817ae305b37464b7e5b222c1113c0646fd0 20:41:04 INFO - mozversion application_display_name: Nightly 20:41:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:41:04 INFO - mozversion application_name: Firefox 20:41:04 INFO - mozversion application_remotingname: firefox 20:41:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:41:04 INFO - mozversion application_vendor: Mozilla 20:41:04 INFO - mozversion application_version: 51.0a1 20:41:04 INFO - mozversion platform_buildid: 20160815191423 20:41:04 INFO - mozversion platform_changeset: c9d9d817ae305b37464b7e5b222c1113c0646fd0 20:41:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:41:04 INFO - mozversion platform_version: 51.0a1 20:41:04 INFO - using testdate: 1471318864 20:41:04 INFO - actual date: 1471318864 20:41:04 INFO - starting webserver on 'localhost:34214' 20:41:04 INFO - SUITE-START | Running 2 tests 20:41:04 INFO - TEST-START | dromaeo_css 20:41:04 INFO - operating with platform_type : linux_ 20:41:04 INFO - Initialising browser for dromaeo_css test... 20:41:04 INFO - TEST-INFO | started process 3307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphGw5dK/profile http://localhost:34214/getInfo.html) 20:41:09 INFO - PROCESS | 3307 | __metrics Screen width/height:1600/1200 20:41:09 INFO - PROCESS | 3307 | colorDepth:24 20:41:09 INFO - PROCESS | 3307 | Browser inner width/height: 1024/697 20:41:09 INFO - PROCESS | 3307 | __metrics 20:41:10 INFO - PROCESS | 3307 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:41:10 INFO - PROCESS | 3307 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:41:11 INFO - PROCESS | 3307 | console.error: PushService: 20:41:11 INFO - PROCESS | 3307 | stateChangeProcessEnqueue: Error transitioning state 20:41:11 INFO - PROCESS | 3307 | UnknownError 20:41:12 INFO - TEST-INFO | 3307: exit 0 20:41:12 INFO - Browser initialized. 20:41:12 INFO - Running cycle 1/1 for dromaeo_css test... 20:41:12 INFO - TEST-INFO | started process 3390 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphGw5dK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:41:23 INFO - PROCESS | 3390 | RSS: Main: 157429760 20:41:23 INFO - PROCESS | 3390 | 20:42:14 INFO - PROCESS | 3390 | 1471318934906 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] 20:44:28 INFO - PROCESS | 3390 | Cycle 1(1): loaded http://localhost:34214/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34214/tests/dromaeo/cssquery-ext.html) 20:44:29 INFO - PROCESS | 3390 | RSS: Main: 268800000 20:44:29 INFO - PROCESS | 3390 | 20:47:32 INFO - PROCESS | 3390 | Cycle 1(1): loaded http://localhost:34214/tests/dromaeo/cssquery-ext.html (next: http://localhost:34214/tests/dromaeo/cssquery-jquery.html) 20:47:33 INFO - PROCESS | 3390 | RSS: Main: 255873024 20:47:33 INFO - PROCESS | 3390 | 20:50:35 INFO - PROCESS | 3390 | Cycle 1(1): loaded http://localhost:34214/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34214/tests/dromaeo/cssquery-mootools.html) 20:50:35 INFO - PROCESS | 3390 | RSS: Main: 188252160 20:50:35 INFO - PROCESS | 3390 | 20:53:38 INFO - PROCESS | 3390 | Cycle 1(1): loaded http://localhost:34214/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34214/tests/dromaeo/cssquery-prototype.html) 20:53:38 INFO - PROCESS | 3390 | RSS: Main: 195702784 20:53:38 INFO - PROCESS | 3390 | 20:56:41 INFO - PROCESS | 3390 | Cycle 1(1): loaded http://localhost:34214/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34214/tests/dromaeo/cssquery-yui.html) 20:56:42 INFO - PROCESS | 3390 | RSS: Main: 191516672 20:56:42 INFO - PROCESS | 3390 | 20:59:45 INFO - PROCESS | 3390 | Cycle 1(1): loaded http://localhost:34214/tests/dromaeo/cssquery-yui.html (next: http://localhost:34214/tests/dromaeo/cssquery-dojo.html) 20:59:45 INFO - PROCESS | 3390 | RSS: Main: 279998464 20:59:45 INFO - PROCESS | 3390 | 20:59:45 INFO - PROCESS | 3390 | __start_tp_report 20:59:45 INFO - PROCESS | 3390 | _x_x_mozilla_page_load 20:59:45 INFO - PROCESS | 3390 | _x_x_mozilla_page_load_details 20:59:45 INFO - PROCESS | 3390 | |i|pagename|runs| 20:59:45 INFO - PROCESS | 3390 | |0;dojo.html;2628.592568151937;2640.590708440192;2648.827826191298;2672.9465410691787;2678.9866050669743;4708.152532544141;4788;4789.856304310876;4833.32333473314;4849.272609108635;4754.738489383082;4838.540338667821;4841.3222148899185;4858.4898585648525;4875.63432742544;4491.595756381925;4502.797374118156;4513.593776560109;4531.501534831166;4537.546245375453;4446.333050042504;4461.665375096864;4471.329300604919;4503.549645035503;4521.683482156251;4526.841560545382;4548.272276435771;4559.247724125516;4567.337736028274;4567.63458923287;4421.64626829856;4432.645388368923;4477.194105061088;4495.415595972503;4504.707194032378;4324.524302326773;4360.672949528766;4373.409589705381;4384.188925048876;4417.558244175589;4801.255805350176;4838.540338667821;4842.322074909515;4845.055214233226;4848.757562121915;5143.099957507421;5165.483451654842;5211.973940130313;5212.921806172911;5219.217117432378;5018.598512119058;5076.213186956028;5138.974305128488;5144.871378215537;5240.475952404767;4842.080004799077;4847.2729090636685;4848.10310092634;4854.368932038812;4857.319975203474;5329.360476742816;5336.573074154058;5338.6529875558745;5338.813141540105;5342.118550439134;4882.902341953212;5020.548150666457;5034.79860805571;5062.11413002723;5102.336696229467;5164.1995490699;5211.71335576547;5212.661177023481;5222.55608273301;5223.791048358099;5116.360454943132;5117.155669314521;5117.181250999896;5127.846164615067;5187.351581052369;4965.106280869478;5020.297158397827;5035.446100928895;5036.622253330942;5099.184130539096;4296.677749168824;4321.589449002403;4346.456692913386;4349.282368409177;4358.978205108954;3782.0355809268463;3794.354959656865;3814.122751767109;3842.9615703843165;3845.9230815383535;4320.675949303752;4337.327714204303;4356;4412.470503539532;4415.2935530315;5156.510131537498;5181.06740786662;5181.35233095863;5213.817516386908;5223.268742376071;4389.517153113155;4393.75834329115;4397.384366188736;4437.911241775147;4441.133978874089;4541.886452838706;4564.497905230422;4610.976945115253;4623;4649.767511624405;4908.7545622719435;4927.975360123177;4931.038447502702;4961.181405068123;4976.452590215146;5239.056969745482;5243.737813109406;5244.7902083916215;5248.186531087687;5292.576593872558;4772.188727916193;4820.469748327751;4835.468098509232;4915.066137433876;4929.038837426668;5086.3896332440345;5148.794048238028;5150.922736159036;5174.9482505174465;5189.455107213688;5129.8974020518635;5179.22311653255;5215.087359712111;5216.347956505437;5217.904240109619;4906.313116163668;4971.204607262821;5068.670536415121;5073.518015788494;5078.441371449211;4995.725235112103;5057.31726216956;5064.82273120439;5088.720120393414;5107.438181800073;4981.576565991932;4984.925226121683;5029.44676085623;5030.723310217827;5036.899262014813;4893.461719210813;4932.506749325039;4936.802527898987;5083.669561478492;5104.668196567211;4874.8050077997905;4885.609151267819;4888.6577939543895;4890;5001.399832020181 20:59:45 INFO - PROCESS | 3390 | |1;ext.html;552.6628756458559;560.6579986208412;563.850579596407;567.7643777832199;571.2858926342072;28581.285467863312;31476.527852082236;39562.40656390153;40748.79625601875;40990;40568.797156014254;40615.79692101535;40830.7958460208;40957.59042409575;41068.58931410685;7531.058617672791;7745.070591529025;7751.379889608846;7755.185705500926;7756.0304961879765;7623.352015078725;7690.2694244046725;7704.922950770505;7709.884351734729;7718.6912523498995;7703.1526532081425;7743.2256774322395;7745.380369570421;7758.185390533998;7776.339011184056;7717.575533345664;7739.38084953208;7743.070831500256;7748.573828439434;7754.495957762756;7665.655045522964;7731.072271327421;7734.2265773422205;7737.57443340616;7738.845223095563;37506;37868.43197352042;37893.43159852605;37938.8103059483;37951.620483795086;3196.216926852913;3257.9185520361943;3276.5904261967253;3432.742544309187;3513.7540372173958;29595.85202073976;29959.70040299591;30000.249993750112;30130.84934575313;31302.747890084596;3285.983570082134;3309.271960168759;3319.468884978392;3348.983255083709;3436.226848958989;248651;249261;249457;250186;250253;31424;32376.514352284736;53413.73293133587;53807;53809;32021.359572808415;32280;32335.191620209684;32337.191570210933;32360.35279294401;11997.160198786001;12138.271703697807;12144.210626309261;12144.817827732591;12167.209131406431;9869.309148359545;9960.80078398428;9966.451845148586;9970.152537034288;9971.002899710116;7911.129775724666;7912.28789408956;7940.602969851484;8044.235797599219;8046.275835174863;3082.6917308269444;3092.1805721483825;3106.409782141386;3127.405792899342;3131.890383836555;831.0069466986893;853.7652145659994;872.1322284327135;880.1242763450408;934.4393363981557;28126;28296.575551366746;28549;28581.99815032361;29250;927.3184209605935;971.3491960386417;974.1135566634329;975.5951280218629;984.5667906121283;14333;14700.55898323052;15166.620834479227;15392.538223853302;15505.9224703878;375359;382080;383212;386908;386951;48966.510334896906;49508;49539.99999999928;49657;49676.50323496791;1079.9730006749894;1131.1911982932243;1145.8223975283845;1158.195054437158;1161.4250945781723;25523.489530209663;28754.09901623637;29286.121416357542;29662.555061674524;29850.85074574613;41940.790296048326;42589.57410425856;42637.36043959405;42639;42640.360394594725;279960;281433.4494878008;281671;281732;282248;22554.323370298916;24808.25575232674;25365.239042828005;25398;25894.093706720174;41261.58738412698;41265.79367103145;41823.58176418197;42302.576974229865;42561.78719106385;34054;35066.824665876506;35607.64392356147;36818.815905920295;37610.6238937618;36123.819380902925;36580.26839463143;36687.26625467422;36923.815380922926;36940.81529592335;36079.00642534059;36099.45850812292;36228.63771362253;36367.27265454623;36985.81507092447;31526.527102093947;33028.1742956428;33493.33013339671;33611.15972100717;33924;24522.509549808547;24884.253472395856;25049;25426.618600721373;25700.228993130237 20:59:45 INFO - PROCESS | 3390 | |2;jquery.html;350.0810372771475;365.400742781838;372.1050872651274;373.6039797814318;387.41113507468646;12693.11148219625;16080.517584472469;16279.348826046944;17057.40299089532;18044.458666240032;15070.849291507082;15405.306761195745;16329.510114696548;16491.67016659666;16512.09183494907;4351.934720979188;4905.435874874382;4995.475475075119;5015.69905805651;5100.132977393852;4982.526659967315;5051.469595692454;5052.696838189702;5054.368203974504;5082.313887625179;4856.3201151838775;5000.274960130779;5035.672681275723;5059.696418214919;5065.366829146356;5004.049230646166;5048.596112311006;5052.418971818214;5053.317802096707;5055.064813009605;4364.41080454141;4496.4829044659955;4533;4537;4538.341940418653;20245.79754202454;20647.380578582666;20823.375298741063;21114.261000865048;21264.787352126434;2275.9089636414687;2504.8246622736415;2543.4023004593905;2546.847189168637;2579.87100644967;13364.398602062833;13891.166530008231;14037.45587985331;14087.859121408757;14412.855871441361;1707.4450803488917;1732.9220185091574;1755.5611097225694;1764.5676809181832;1782.0466050662833;65949.67025164844;67458.66270668615;67762;67772;67943.3205667942;9631.373960692672;9651.806963860823;9788.55951482185;9843.24493413506;9851.50742462874;13095.607131786062;13100.868991310155;13123.343832808321;13124.409401576951;13132.34338283082;6889.758858439931;6929.44564434844;7053.188883278386;7196.748113815991;7223.530470519399;6577.276499585042;6586.934130658632;6749.426298764562;6758.594484330956;6795.7961261162245;6108.450239478469;6167.938320616826;6208.875822483525;6242.250929888442;6329.556931014877;1649.653572749712;1688.3331084221663;1758.5515693498076;1781.100544225158;1793.1213705284576;783.5337973905517;855.9657613695507;920.6087412849646;956.5901195488791;967.2358836519212;16977.151142442828;17295.394661186798;17884.28462861471;17898;18425.447236582924;855.1747563601155;871.7471933139445;880.9559522023873;899.8335307968047;966.1690945786618;9623.903760962441;10019.895821877342;10107.848382274271;10267.229957753198;10558.841617375745;367066;370473;374675;377936;378275;78164.21835781683;81126;82737;83010;83297.16702833015;932.6036434515304;935.9064093590587;983.3165949664914;994.1202036197873;994.4480813148627;15108.471203508265;15895.68208635844;16055.759163612322;16068.43760468378;16959.491215263562;35345.82327088451;38320;38757.41863872101;39769.80115099406;41769;46283.76858115823;48572.757136214095;49329;50442.2433663488;52390.21414678707;6787.66061696923;7021.473389495911;7072.9841995031165;7382.5570465772225;7901.960490197513;11110.61112861046;11821.586244481401;12252.081093917814;12520.123591348518;12585.496580136693;10316.329438586468;10410.739731506774;10469.68590942273;10618.8938110621;10809.135269178603;9090.13643703847;9358.970513243674;9423.057694230522;9505.762355941157;9715.222782177267;5354;8008.679652813822;8299.626516806637;10773.599432073781;10819.680307224322;7063.57618542889;7112.786616401516;7194.100737407824;7290;7403;9773.85339219898;9963.452010139512;10212.948935255276;10261.28171028021;10282.280240383401 20:59:45 INFO - PROCESS | 3390 | |3;mootools.html;1174.5243176513513;1184.7275126720854;1256.5727652598114;1309.7576948264573;1664.7835781348424;6705.899411508825;7297.854042919138;7508.887366689491;7521.473496855222;7722.691092356313;7515.699372025112;7567.772966811004;7570.545767253969;7573.507721998067;7577.848443031136;2179.7602263750973;2208.4699672078746;2210.789974952385;2214.734231892175;2216;2158.3201291593177;2193.9451513712206;2203.713517242756;2206.117552978805;2206.8455208135438;2162.243214874789;2189.2228258968;2192.1231507397088;2195.7255343082115;2198.1756841184556;2162.643163877958;2166.4042388343173;2167.1331467413;2171.326888664519;2171.7285339332584;2052.5792212596384;2120.279105104272;2122.2678176029244;2123.9150433982777;2125.7024016637683;7488.090536913052;7605.391568674548;7616.428767842434;7653.770386888402;7666.118396384376;4430.734155950621;4548.749818759967;4553.795079221443;4562.840300589497;4564.064366804831;2968.1392396205074;3039.7720170987045;3088.536719492072;3089.6601373849085;3091.675374085711;931.5528546297747;936.6768464879606;937.1565590968115;949.9002604726473;951.4006176109076;10408.063274305274;10489.527971241312;10528.105111065568;10530.36817790935;10552.472376381227;3993.1414745829784;3999.8800035998383;4021.577734337911;4052.5339585947404;4208.789560522023;8452.197041281068;8465.915340846514;8468.830623387621;8473.915260847436;8491.405601607828;4325.4593175853015;4327.1345730853955;4327.415798867176;4328.675349348811;4332.415123958288;3508.649135086522;3901.726879118491;3924.823382947774;3927.3912543555793;4073.348264277701;3434.862605495802;3469.5142680024815;3573.7855728656364;3577.4276115821344;3582.5880023797595;1055.2138656700654;1063.744701271689;1064.882862885082;1074.6561100447939;1076.9730756730987;804.577596761693;813.6135335715607;834.3241974001079;846.8729690546468;854.3763052971242;5169.741512924414;5265.76304066318;5277.393099793496;5293.550048245942;5296.523312901781;833.8707500337457;901.9188273055456;909.4406939732017;909.8544232922701;913.0595486648763;3403.6766507182274;3489.7382696297877;3570.4108822044072;3621.27574485104;3631.291898079849;9091.409058411182;9554.140127388568;9582.137607615348;9590.616375344907;9602.423854568748;9493.715188544355;9515.57179926905;9525.52372381392;9528.190103841112;9552.808943821085;6987.89518157228;7220.386267167244;7267.491275610762;7422.665980030912;7440.73957411488;5196.662216955886;5208.270842082035;5251.448597897166;5411.78352865881;5506.697131657637;8817.955910220408;8831.425957312755;8888.24449921738;8940.15068568485;9060.54697265121;8619.741407757778;8854.778630534289;8912.153345432174;9148.451092934445;9178.128077832594;6217.253929528486;6515.674216289071;6637.4690024798865;6902.792916212522;6923.6192009439965;7383.852322953619;7716.8456630868195;7718.845623087394;7728.845423091394;7758.030246219223;6645.700943457653;6793.4565234782085;6874.381305682513;6880.931190688029;6980.336867997736;6572.375624315682;6627.602343859384;6699.832504187434;6739.764108256188;6766.357196066366;6411.198600174978;6474.4820414365795;6481.449076828522;6552.3447655234095;6591.472682185509;4496.505384407778;4546.727196368096;4557.430321209848;4637.907241855077;4710.764461776966;4437.7559234241135;4531.43357080365;4612.377329060534;4699.859004229878;4704.3649107370065 20:59:45 INFO - PROCESS | 3390 | |4;prototype.html;296.1707219784604;298.7445733897518;305.4989816700611;305.87459141751884;310.8570057773424;4674.836380726675;4793.640476964229;4813.085513752393;4853.369062021941;4861.683990540612;4636.374089497916;4730.4559975602815;4732.313814496896;4756.381670382845;4774.880627984302;3785.1483416231267;3799.6580307772297;3803.220339830342;3804.334241507739;3824.8087595620245;3574.267275208576;3612.6929211017095;3820.5606355269224;3830.731848770587;3838.712096592753;3776.848926042955;3783.205526839367;3795.3737633290475;3795.392737162055;3803.7527560708463;3782.35699931011;3783.8486460541544;3794.203217324365;3796.6013568575177;3802.5627052888995;3363.7813542119684;3366.9158271043175;3370.5112758650102;3373.96626033739;3376.2234686022352;4575.176468235716;4689.460712018094;4692.319613656001;4702.918328784364;4711.505291944331;4325.956740432587;4330.870073897788;4333.891652708676;4336.744892655801;4353.650368385811;5002.324686167357;5004.424491183524;5029.2958985742025;5038.79844806211;5039.72281524516;3555.928881422383;3632.473291372736;3655.122770535079;3669.3395188865993;3679.7056235501095;5208.583313334962;5218.530332270076;5229.921551176735;5230.515505135068;5232.529072383466;3738.794366309879;3749.418840079792;3749.7000239980734;3750.212455384345;3750.3249415104997;3743.3636281832155;3806.3148633246283;3808.638179372955;3823.674987626083;3840.9423858642144;4188.68584856137;4243.830246790156;4248.617624413818;4279.657627389802;4296.140771845643;4993.400791904922;4997.475265097185;5005.6996580205305;5006.674566153189;5010.4718060991745;1255.2092181925511;1281.4105511464645;1302.739452109563;1318.905308593865;1325.648703093681;883.9204471597587;906.3564868942992;913.2739472119681;915.2906497464518;922.326701507903;4325.178216138924;4380.751485826524;4387.232234358974;4402.5597440255715;4410.867673969786;5099.5410413063;5104.412992505835;5114.008305141534;5127.28236040923;5148.76830542619;4376.190404775127;4380.299152135643;4387.345655878148;4393.319035549495;4406.184855801687;2327.953440931172;2426.5389575980507;2432.0422060241676;2438.609822428403;2441.5971364724624;4296.722736949422;4301.806418711166;4331.7834108294455;4338.783060846945;4344.522102568715;4590.40324757786;4610.469795973506;4632.60622847055;4680.455449701591;4683.2038553446;4052.8986775330263;4316.676249281317;4320.546342633978;4322.783860806947;4331.653467722637;4544.7045942013665;4554.27131658933;4562.703424277412;4563.54364563541;4601.631869450503;4470.374147619271;4471.239889218776;4471.8434854779925;4527.547245275446;4537;4047.9677682190854;4304.203722311382;4311.48262208537;4328.749050493789;4337.804798783999;3444.5360721693683;3445.8807833182914;3450.2748625687154;3453.447448408343;3470.219200679827;4595.195840727926;4610.561996610317;4621.607163391015;4622.329762184531;5003.624728145476;4793.592544633745;5022.447530771686;5024.442422848929;5048.192289233705;5053;4987.982270726158;5013.824516141917;5022.308603176589;5022.623303252198;5039.672421292605;4794.113089078532;4926.802927882844;4966.726830024383;4973.925391119208;4981.352424184833;5027.622928280321;5061.670991385548;5074.898502030012;5075.822346217865;5081.314022607048;4948.208286674115;4956.975215123901;4959.553640172402;4999.225120106389;5000.7748101715315 20:59:45 INFO - PROCESS | 3390 | |5;yui.html;570.7460180219804;591.0100581525943;660.534323302072;707.5789905006523;726.1032624708484;12079.637610871678;13798.724025519483;13810.930945345259;13817.861821381783;13846.23845688488;13350.799738003914;13507.189568625865;13508.05443618947;13517.662058448544;13521.32393380332;619.294004834489;741.232824027132;752.6913965274239;765.7894079128229;773.736929443989;767.9347255483291;773.9419543534258;775.3603277296224;777.141258908906;777.5645638442462;818.7953011747063;820.151143566406;823.6375994562403;823.9752807415787;825.051191130202;659.3801826283278;794.8171920458327;820.7168526858254;821.7329367955379;822.0956947357919;604.1572007050185;604.2235727090712;604.6674329119011;604.7701873288122;605.1376788077017;13010.739785204338;13017.414216360286;13031.804522932163;13036.087473876833;13056.412461439259;12788.48846046157;13003;13072.869271307356;13669.17984920898;13669.391235830717;11471.885281147164;11497.482613282422;11567.537298508134;11651.825222621668;11919.821202681967;4129.236091323085;4146.813393397304;4162.875113746592;4166.812493437803;4209.726367786115;51988.74005629947;53628;53654.46345536534;60940.695296523234;62893.37106628921;9925.553350099262;10324.328918620266;10340.327878687862;10466.666666666666;10531.578736850593;18671.253149874126;18677.15952782128;18744.437666869744;18771.530711732044;18819.71770423445;6779.118714567075;6821.079154314104;6874.243833178446;6876.724931002804;7082.079329687108;3747.213085252073;3775.7356985011334;3837.788921609338;3853.556840963325;3962.782046987443;2901.202169403389;3019.818810871355;3028.1672540051222;3030.3787723517066;3033.5752994580776;513.4121430961528;515.5463192390747;515.9097157997336;516.6564234783901;524.1613418530321;553.195101127866;601.6841158391879;608.582807535684;609.3632154398664;615.5506480269429;7999.560024198725;8065.919340806517;8256.669733210725;8260.463069900557;8558.486490810572;555.8554775758251;566.4703502225433;570.3953808962513;583.0350769476523;596.3261514488601;3746.8875933722034;3807.3717836556657;3939.2515422069714;3941.7043721720984;4165.958340416618;57934.7103264481;58427.123593146134;58456.41543584595;78424;110577.44711276553;76326;80045.59977200077;82587;88850.11149888548;92800.53599732093;64201.07396778104;73724.26275737281;74418.62790686011;79604.60197698974;81915.5904220475;7172.892406614009;7609;7706.576138312223;7715.975385598914;7792.337651299703;46403.53596463992;46738.83152921068;47152.52847471481;47437;50334;37779.81110094432;56632;67959;68568;71298;11313.830292545454;11325;11462.254953428;11501.53993840237;11804.70488237801;11803.940980295043;11911.583094591648;12642.683932901384;12789.93605031969;13571.932140339235;11253.212275140662;11564.710882227675;11614.303141811519;11955.521779128738;11978.281303121841;11376.488058037243;11689.415529223676;11700.941495292469;12419.813702794285;12441.626751197478;10784.946075269574;11005.779884402427;11247.381394023407;11366.318020918772;12224.266544007389;9737.367071140354;10203.591856325664;10659.520321585702;10662.89337106619;10963.232573720083;9868;10039.548220330249;10081.647142349982;10234.181265498593;10293.794124117327 20:59:45 INFO - PROCESS | 3390 | __end_tp_report 20:59:45 INFO - PROCESS | 3390 | __start_cc_report 20:59:45 INFO - PROCESS | 3390 | _x_x_mozilla_cycle_collect,1137 20:59:45 INFO - PROCESS | 3390 | __end_cc_report 20:59:45 INFO - PROCESS | 3390 | __startTimestamp1471319985714__endTimestamp 20:59:45 INFO - PROCESS | 3390 | 20:59:45 INFO - PROCESS | 3390 | ------- Summary: start ------- 20:59:45 INFO - PROCESS | 3390 | Number of tests: 6 20:59:45 INFO - PROCESS | 3390 | 20:59:45 INFO - PROCESS | 3390 | [#0] dojo.html Cycles:165 Average:4772.82 Median:4890.00 stddev:510.00 (10.4%) stddev-sans-first:483.03 20:59:45 INFO - PROCESS | 3390 | Values: 2628.6 2640.6 2648.8 2672.9 2679.0 4708.2 4788.0 4789.9 4833.3 4849.3 4754.7 4838.5 4841.3 4858.5 4875.6 4491.6 4502.8 4513.6 4531.5 4537.5 4446.3 4461.7 4471.3 4503.5 4521.7 4526.8 4548.3 4559.2 4567.3 4567.6 4421.6 4432.6 4477.2 4495.4 4504.7 4324.5 4360.7 4373.4 4384.2 4417.6 4801.3 4838.5 4842.3 4845.1 4848.8 5143.1 5165.5 5212.0 5212.9 5219.2 5018.6 5076.2 5139.0 5144.9 5240.5 4842.1 4847.3 4848.1 4854.4 4857.3 5329.4 5336.6 5338.7 5338.8 5342.1 4882.9 5020.5 5034.8 5062.1 5102.3 5164.2 5211.7 5212.7 5222.6 5223.8 5116.4 5117.2 5117.2 5127.8 5187.4 4965.1 5020.3 5035.4 5036.6 5099.2 4296.7 4321.6 4346.5 4349.3 4359.0 3782.0 3794.4 3814.1 3843.0 3845.9 4320.7 4337.3 4356.0 4412.5 4415.3 5156.5 5181.1 5181.4 5213.8 5223.3 4389.5 4393.8 4397.4 4437.9 4441.1 4541.9 4564.5 4611.0 4623.0 4649.8 4908.8 4928.0 4931.0 4961.2 4976.5 5239.1 5243.7 5244.8 5248.2 5292.6 4772.2 4820.5 4835.5 4915.1 4929.0 5086.4 5148.8 5150.9 5174.9 5189.5 5129.9 5179.2 5215.1 5216.3 5217.9 4906.3 4971.2 5068.7 5073.5 5078.4 4995.7 5057.3 5064.8 5088.7 5107.4 4981.6 4984.9 5029.4 5030.7 5036.9 4893.5 4932.5 4936.8 5083.7 5104.7 4874.8 4885.6 4888.7 4890.0 5001.4 20:59:45 INFO - PROCESS | 3390 | 20:59:45 INFO - PROCESS | 3390 | [#1] ext.html Cycles:180 Average:44890.26 Median:36932.32 stddev:81688.48 (221.2%) stddev-sans-first:81849.81 20:59:45 INFO - PROCESS | 3390 | Values: 552.7 560.7 563.9 567.8 571.3 28581.3 31476.5 39562.4 40748.8 40990.0 40568.8 40615.8 40830.8 40957.6 41068.6 7531.1 7745.1 7751.4 7755.2 7756.0 7623.4 7690.3 7704.9 7709.9 7718.7 7703.2 7743.2 7745.4 7758.2 7776.3 7717.6 7739.4 7743.1 7748.6 7754.5 7665.7 7731.1 7734.2 7737.6 7738.8 37506.0 37868.4 37893.4 37938.8 37951.6 3196.2 3257.9 3276.6 3432.7 3513.8 29595.9 29959.7 30000.2 30130.8 31302.7 3286.0 3309.3 3319.5 3349.0 3436.2 248651.0 249261.0 249457.0 250186.0 250253.0 31424.0 32376.5 53413.7 53807.0 53809.0 32021.4 32280.0 32335.2 32337.2 32360.4 11997.2 12138.3 12144.2 12144.8 12167.2 9869.3 9960.8 9966.5 9970.2 9971.0 7911.1 7912.3 7940.6 8044.2 8046.3 3082.7 3092.2 3106.4 3127.4 3131.9 831.0 853.8 872.1 880.1 934.4 28126.0 28296.6 28549.0 28582.0 29250.0 927.3 971.3 974.1 975.6 984.6 14333.0 14700.6 15166.6 15392.5 15505.9 375359.0 382080.0 383212.0 386908.0 386951.0 48966.5 49508.0 49540.0 49657.0 49676.5 1080.0 1131.2 1145.8 1158.2 1161.4 25523.5 28754.1 29286.1 29662.6 29850.9 41940.8 42589.6 42637.4 42639.0 42640.4 279960.0 281433.4 281671.0 281732.0 282248.0 22554.3 24808.3 25365.2 25398.0 25894.1 41261.6 41265.8 41823.6 42302.6 42561.8 34054.0 35066.8 35607.6 36818.8 37610.6 36123.8 36580.3 36687.3 36923.8 36940.8 36079.0 36099.5 36228.6 36367.3 36985.8 31526.5 33028.2 33493.3 33611.2 33924.0 24522.5 24884.3 25049.0 25426.6 25700.2 20:59:45 INFO - PROCESS | 3390 | 20:59:45 INFO - PROCESS | 3390 | [#2] jquery.html Cycles:180 Average:23975.42 Median:25570.04 stddev:61887.41 (242.0%) stddev-sans-first:62035.60 20:59:45 INFO - PROCESS | 3390 | Values: 350.1 365.4 372.1 373.6 387.4 12693.1 16080.5 16279.3 17057.4 18044.5 15070.8 15405.3 16329.5 16491.7 16512.1 4351.9 4905.4 4995.5 5015.7 5100.1 4982.5 5051.5 5052.7 5054.4 5082.3 4856.3 5000.3 5035.7 5059.7 5065.4 5004.0 5048.6 5052.4 5053.3 5055.1 4364.4 4496.5 4533.0 4537.0 4538.3 20245.8 20647.4 20823.4 21114.3 21264.8 2275.9 2504.8 2543.4 2546.8 2579.9 13364.4 13891.2 14037.5 14087.9 14412.9 1707.4 1732.9 1755.6 1764.6 1782.0 65949.7 67458.7 67762.0 67772.0 67943.3 9631.4 9651.8 9788.6 9843.2 9851.5 13095.6 13100.9 13123.3 13124.4 13132.3 6889.8 6929.4 7053.2 7196.7 7223.5 6577.3 6586.9 6749.4 6758.6 6795.8 6108.5 6167.9 6208.9 6242.3 6329.6 1649.7 1688.3 1758.6 1781.1 1793.1 783.5 856.0 920.6 956.6 967.2 16977.2 17295.4 17884.3 17898.0 18425.4 855.2 871.7 881.0 899.8 966.2 9623.9 10019.9 10107.8 10267.2 10558.8 367066.0 370473.0 374675.0 377936.0 378275.0 78164.2 81126.0 82737.0 83010.0 83297.2 932.6 935.9 983.3 994.1 994.4 15108.5 15895.7 16055.8 16068.4 16959.5 35345.8 38320.0 38757.4 39769.8 41769.0 46283.8 48572.8 49329.0 50442.2 52390.2 6787.7 7021.5 7073.0 7382.6 7902.0 11110.6 11821.6 12252.1 12520.1 12585.5 10316.3 10410.7 10469.7 10618.9 10809.1 9090.1 9359.0 9423.1 9505.8 9715.2 5354.0 8008.7 8299.6 10773.6 10819.7 7063.6 7112.8 7194.1 7290.0 7403.0 9773.9 9963.5 10212.9 10261.3 10282.3 20:59:45 INFO - PROCESS | 3390 | 20:59:45 INFO - PROCESS | 3390 | [#3] mootools.html Cycles:180 Average:5070.04 Median:5285.47 stddev:2833.21 (53.6%) stddev-sans-first:2826.03 20:59:45 INFO - PROCESS | 3390 | Values: 1174.5 1184.7 1256.6 1309.8 1664.8 6705.9 7297.9 7508.9 7521.5 7722.7 7515.7 7567.8 7570.5 7573.5 7577.8 2179.8 2208.5 2210.8 2214.7 2216.0 2158.3 2193.9 2203.7 2206.1 2206.8 2162.2 2189.2 2192.1 2195.7 2198.2 2162.6 2166.4 2167.1 2171.3 2171.7 2052.6 2120.3 2122.3 2123.9 2125.7 7488.1 7605.4 7616.4 7653.8 7666.1 4430.7 4548.7 4553.8 4562.8 4564.1 2968.1 3039.8 3088.5 3089.7 3091.7 931.6 936.7 937.2 949.9 951.4 10408.1 10489.5 10528.1 10530.4 10552.5 3993.1 3999.9 4021.6 4052.5 4208.8 8452.2 8465.9 8468.8 8473.9 8491.4 4325.5 4327.1 4327.4 4328.7 4332.4 3508.6 3901.7 3924.8 3927.4 4073.3 3434.9 3469.5 3573.8 3577.4 3582.6 1055.2 1063.7 1064.9 1074.7 1077.0 804.6 813.6 834.3 846.9 854.4 5169.7 5265.8 5277.4 5293.6 5296.5 833.9 901.9 909.4 909.9 913.1 3403.7 3489.7 3570.4 3621.3 3631.3 9091.4 9554.1 9582.1 9590.6 9602.4 9493.7 9515.6 9525.5 9528.2 9552.8 6987.9 7220.4 7267.5 7422.7 7440.7 5196.7 5208.3 5251.4 5411.8 5506.7 8818.0 8831.4 8888.2 8940.2 9060.5 8619.7 8854.8 8912.2 9148.5 9178.1 6217.3 6515.7 6637.5 6902.8 6923.6 7383.9 7716.8 7718.8 7728.8 7758.0 6645.7 6793.5 6874.4 6880.9 6980.3 6572.4 6627.6 6699.8 6739.8 6766.4 6411.2 6474.5 6481.4 6552.3 6591.5 4496.5 4546.7 4557.4 4637.9 4710.8 4437.8 4531.4 4612.4 4699.9 4704.4 20:59:45 INFO - PROCESS | 3390 | 20:59:45 INFO - PROCESS | 3390 | [#4] prototype.html Cycles:180 Average:4061.20 Median:4390.33 stddev:1154.10 (26.3%) stddev-sans-first:1122.21 20:59:45 INFO - PROCESS | 3390 | Values: 296.2 298.7 305.5 305.9 310.9 4674.8 4793.6 4813.1 4853.4 4861.7 4636.4 4730.5 4732.3 4756.4 4774.9 3785.1 3799.7 3803.2 3804.3 3824.8 3574.3 3612.7 3820.6 3830.7 3838.7 3776.8 3783.2 3795.4 3795.4 3803.8 3782.4 3783.8 3794.2 3796.6 3802.6 3363.8 3366.9 3370.5 3374.0 3376.2 4575.2 4689.5 4692.3 4702.9 4711.5 4326.0 4330.9 4333.9 4336.7 4353.7 5002.3 5004.4 5029.3 5038.8 5039.7 3555.9 3632.5 3655.1 3669.3 3679.7 5208.6 5218.5 5229.9 5230.5 5232.5 3738.8 3749.4 3749.7 3750.2 3750.3 3743.4 3806.3 3808.6 3823.7 3840.9 4188.7 4243.8 4248.6 4279.7 4296.1 4993.4 4997.5 5005.7 5006.7 5010.5 1255.2 1281.4 1302.7 1318.9 1325.6 883.9 906.4 913.3 915.3 922.3 4325.2 4380.8 4387.2 4402.6 4410.9 5099.5 5104.4 5114.0 5127.3 5148.8 4376.2 4380.3 4387.3 4393.3 4406.2 2328.0 2426.5 2432.0 2438.6 2441.6 4296.7 4301.8 4331.8 4338.8 4344.5 4590.4 4610.5 4632.6 4680.5 4683.2 4052.9 4316.7 4320.5 4322.8 4331.7 4544.7 4554.3 4562.7 4563.5 4601.6 4470.4 4471.2 4471.8 4527.5 4537.0 4048.0 4304.2 4311.5 4328.7 4337.8 3444.5 3445.9 3450.3 3453.4 3470.2 4595.2 4610.6 4621.6 4622.3 5003.6 4793.6 5022.4 5024.4 5048.2 5053.0 4988.0 5013.8 5022.3 5022.6 5039.7 4794.1 4926.8 4966.7 4973.9 4981.4 5027.6 5061.7 5074.9 5075.8 5081.3 4948.2 4957.0 4959.6 4999.2 5000.8 20:59:45 INFO - PROCESS | 3390 | 20:59:45 INFO - PROCESS | 3390 | [#5] yui.html Cycles:180 Average:17039.71 Median:46945.68 stddev:23485.51 (50.0%) stddev-sans-first:23518.84 20:59:45 INFO - PROCESS | 3390 | Values: 570.7 591.0 660.5 707.6 726.1 12079.6 13798.7 13810.9 13817.9 13846.2 13350.8 13507.2 13508.1 13517.7 13521.3 619.3 741.2 752.7 765.8 773.7 767.9 773.9 775.4 777.1 777.6 818.8 820.2 823.6 824.0 825.1 659.4 794.8 820.7 821.7 822.1 604.2 604.2 604.7 604.8 605.1 13010.7 13017.4 13031.8 13036.1 13056.4 12788.5 13003.0 13072.9 13669.2 13669.4 11471.9 11497.5 11567.5 11651.8 11919.8 4129.2 4146.8 4162.9 4166.8 4209.7 51988.7 53628.0 53654.5 60940.7 62893.4 9925.6 10324.3 10340.3 10466.7 10531.6 18671.3 18677.2 18744.4 18771.5 18819.7 6779.1 6821.1 6874.2 6876.7 7082.1 3747.2 3775.7 3837.8 3853.6 3962.8 2901.2 3019.8 3028.2 3030.4 3033.6 513.4 515.5 515.9 516.7 524.2 553.2 601.7 608.6 609.4 615.6 7999.6 8065.9 8256.7 8260.5 8558.5 555.9 566.5 570.4 583.0 596.3 3746.9 3807.4 3939.3 3941.7 4166.0 57934.7 58427.1 58456.4 78424.0 110577.4 76326.0 80045.6 82587.0 88850.1 92800.5 64201.1 73724.3 74418.6 79604.6 81915.6 7172.9 7609.0 7706.6 7716.0 7792.3 46403.5 46738.8 47152.5 47437.0 50334.0 37779.8 56632.0 67959.0 68568.0 71298.0 11313.8 11325.0 11462.3 11501.5 11804.7 11803.9 11911.6 12642.7 12789.9 13571.9 11253.2 11564.7 11614.3 11955.5 11978.3 11376.5 11689.4 11700.9 12419.8 12441.6 10784.9 11005.8 11247.4 11366.3 12224.3 9737.4 10203.6 10659.5 10662.9 10963.2 9868.0 10039.5 10081.6 10234.2 10293.8 20:59:45 INFO - PROCESS | 3390 | -------- Summary: end -------- 20:59:45 INFO - PROCESS | 3390 | 20:59:46 INFO - TEST-INFO | 3390: exit 0 20:59:46 INFO - TEST-OK | dromaeo_css | took 1122111ms 20:59:46 INFO - TEST-START | kraken 20:59:46 INFO - operating with platform_type : linux_ 20:59:46 INFO - Initialising browser for kraken test... 20:59:46 INFO - TEST-INFO | started process 3690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZJxFGm/profile http://localhost:34214/getInfo.html) 20:59:51 INFO - PROCESS | 3690 | __metrics Screen width/height:1600/1200 20:59:51 INFO - PROCESS | 3690 | colorDepth:24 20:59:51 INFO - PROCESS | 3690 | Browser inner width/height: 1024/697 20:59:51 INFO - PROCESS | 3690 | __metrics 20:59:51 INFO - PROCESS | 3690 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:59:51 INFO - PROCESS | 3690 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:59:52 INFO - PROCESS | 3690 | console.error: PushService: 20:59:52 INFO - PROCESS | 3690 | stateChangeProcessEnqueue: Error transitioning state 20:59:52 INFO - PROCESS | 3690 | UnknownError 20:59:52 INFO - TEST-INFO | 3690: exit 0 20:59:52 INFO - Browser initialized. 20:59:52 INFO - Running cycle 1/1 for kraken test... 20:59:52 INFO - TEST-INFO | started process 3772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZJxFGm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:00:04 INFO - PROCESS | 3772 | RSS: Main: 157364224 21:00:04 INFO - PROCESS | 3772 | 21:00:07 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:34214/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34214/tests/kraken/driver.html?testName=audio-beat-detection) 21:00:08 INFO - PROCESS | 3772 | RSS: Main: 204812288 21:00:08 INFO - PROCESS | 3772 | 21:00:11 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:34214/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34214/tests/kraken/driver.html?testName=audio-dft) 21:00:11 INFO - PROCESS | 3772 | RSS: Main: 195596288 21:00:11 INFO - PROCESS | 3772 | 21:00:15 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:34214/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34214/tests/kraken/driver.html?testName=audio-fft) 21:00:15 INFO - PROCESS | 3772 | RSS: Main: 278421504 21:00:15 INFO - PROCESS | 3772 | 21:00:17 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:34214/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34214/tests/kraken/driver.html?testName=audio-oscillator) 21:00:18 INFO - PROCESS | 3772 | RSS: Main: 188030976 21:00:18 INFO - PROCESS | 3772 | 21:00:20 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:34214/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34214/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:00:21 INFO - PROCESS | 3772 | RSS: Main: 192135168 21:00:21 INFO - PROCESS | 3772 | 21:00:24 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:34214/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34214/tests/kraken/driver.html?testName=imaging-darkroom) 21:00:25 INFO - PROCESS | 3772 | RSS: Main: 228904960 21:00:25 INFO - PROCESS | 3772 | 21:00:28 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:34214/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34214/tests/kraken/driver.html?testName=imaging-desaturate) 21:00:29 INFO - PROCESS | 3772 | RSS: Main: 222142464 21:00:29 INFO - PROCESS | 3772 | 21:00:32 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:34214/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34214/tests/kraken/driver.html?testName=json-parse-financial) 21:00:32 INFO - PROCESS | 3772 | RSS: Main: 225329152 21:00:32 INFO - PROCESS | 3772 | 21:00:34 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:34214/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34214/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:00:35 INFO - PROCESS | 3772 | RSS: Main: 189014016 21:00:35 INFO - PROCESS | 3772 | 21:00:37 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:34214/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34214/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:00:37 INFO - PROCESS | 3772 | RSS: Main: 196681728 21:00:37 INFO - PROCESS | 3772 | 21:00:39 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:34214/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34214/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:00:40 INFO - PROCESS | 3772 | RSS: Main: 194732032 21:00:40 INFO - PROCESS | 3772 | 21:00:43 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:34214/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34214/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:00:44 INFO - PROCESS | 3772 | RSS: Main: 188776448 21:00:44 INFO - PROCESS | 3772 | 21:00:47 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:34214/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34214/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:00:47 INFO - PROCESS | 3772 | RSS: Main: 192462848 21:00:47 INFO - PROCESS | 3772 | 21:00:49 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:34214/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34214/tests/kraken/driver.html?testName=ai-astar) 21:00:49 INFO - PROCESS | 3772 | RSS: Main: 242917376 21:00:49 INFO - PROCESS | 3772 | 21:00:49 INFO - PROCESS | 3772 | __start_tp_report 21:00:49 INFO - PROCESS | 3772 | _x_x_mozilla_page_load 21:00:49 INFO - PROCESS | 3772 | _x_x_mozilla_page_load_details 21:00:49 INFO - PROCESS | 3772 | |i|pagename|runs| 21:00:49 INFO - PROCESS | 3772 | |0;ai-astar;106;116;114;114;108;115;114;114;114;113 21:00:49 INFO - PROCESS | 3772 | |1;audio-beat-detection;153;124;123;190;122;126;144;127;194;120 21:00:49 INFO - PROCESS | 3772 | |2;audio-dft;160;162;160;160;160;160;161;162;162;160 21:00:49 INFO - PROCESS | 3772 | |3;audio-fft;76;77;76;101;76;77;76;76;102;76 21:00:49 INFO - PROCESS | 3772 | |4;audio-oscillator;85;87;140;85;87;86;122;86;86;143 21:00:49 INFO - PROCESS | 3772 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;116;117;117 21:00:49 INFO - PROCESS | 3772 | |6;imaging-darkroom;146;147;146;146;147;146;145;146;146;146 21:00:49 INFO - PROCESS | 3772 | |7;imaging-desaturate;95;95;96;95;95;95;96;95;94;95 21:00:49 INFO - PROCESS | 3772 | |8;json-parse-financial;66;64;68;65;66;72;66;65;66;65 21:00:49 INFO - PROCESS | 3772 | |9;json-stringify-tinderbox;65;67;65;67;66;66;66;66;67;66 21:00:49 INFO - PROCESS | 3772 | |10;stanford-crypto-aes;82;82;81;81;81;81;81;82;81;81 21:00:49 INFO - PROCESS | 3772 | |11;stanford-crypto-ccm;138;133;131;138;132;131;132;146;152;135 21:00:49 INFO - PROCESS | 3772 | |12;stanford-crypto-pbkdf2;177;174;174;176;177;174;177;172;170;174 21:00:49 INFO - PROCESS | 3772 | |13;stanford-crypto-sha256-iterative;68;67;68;70;67;66;66;66;65;65 21:00:49 INFO - PROCESS | 3772 | __end_tp_report 21:00:49 INFO - PROCESS | 3772 | __start_cc_report 21:00:49 INFO - PROCESS | 3772 | _x_x_mozilla_cycle_collect,1951 21:00:49 INFO - PROCESS | 3772 | __end_cc_report 21:00:49 INFO - PROCESS | 3772 | __startTimestamp1471320049811__endTimestamp 21:00:49 INFO - PROCESS | 3772 | 21:00:49 INFO - PROCESS | 3772 | ------- Summary: start ------- 21:00:49 INFO - PROCESS | 3772 | Number of tests: 14 21:00:49 INFO - PROCESS | 3772 | 21:00:49 INFO - PROCESS | 3772 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:3.19 (2.8%) stddev-sans-first:2.24 21:00:49 INFO - PROCESS | 3772 | Values: 106.0 116.0 114.0 114.0 108.0 115.0 114.0 114.0 114.0 113.0 21:00:49 INFO - PROCESS | 3772 | 21:00:49 INFO - PROCESS | 3772 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:135.50 stddev:28.25 (20.8%) stddev-sans-first:29.70 21:00:49 INFO - PROCESS | 3772 | Values: 153.0 124.0 123.0 190.0 122.0 126.0 144.0 127.0 194.0 120.0 21:00:49 INFO - PROCESS | 3772 | 21:00:49 INFO - PROCESS | 3772 | [#2] audio-dft Cycles:10 Average:160.70 Median:160.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 21:00:49 INFO - PROCESS | 3772 | Values: 160.0 162.0 160.0 160.0 160.0 160.0 161.0 162.0 162.0 160.0 21:00:49 INFO - PROCESS | 3772 | 21:00:49 INFO - PROCESS | 3772 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:10.66 (14.0%) stddev-sans-first:11.13 21:00:49 INFO - PROCESS | 3772 | Values: 76.0 77.0 76.0 101.0 76.0 77.0 76.0 76.0 102.0 76.0 21:00:49 INFO - PROCESS | 3772 | 21:00:49 INFO - PROCESS | 3772 | [#4] audio-oscillator Cycles:10 Average:100.70 Median:86.00 stddev:24.28 (28.2%) stddev-sans-first:25.08 21:00:49 INFO - PROCESS | 3772 | Values: 85.0 87.0 140.0 85.0 87.0 86.0 122.0 86.0 86.0 143.0 21:00:49 INFO - PROCESS | 3772 | 21:00:49 INFO - PROCESS | 3772 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 21:00:49 INFO - PROCESS | 3772 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 116.0 117.0 117.0 21:00:49 INFO - PROCESS | 3772 | 21:00:49 INFO - PROCESS | 3772 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 21:00:49 INFO - PROCESS | 3772 | Values: 146.0 147.0 146.0 146.0 147.0 146.0 145.0 146.0 146.0 146.0 21:00:49 INFO - PROCESS | 3772 | 21:00:49 INFO - PROCESS | 3772 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 21:00:49 INFO - PROCESS | 3772 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 94.0 95.0 21:00:49 INFO - PROCESS | 3772 | 21:00:49 INFO - PROCESS | 3772 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.00 stddev:2.26 (3.4%) stddev-sans-first:2.40 21:00:49 INFO - PROCESS | 3772 | Values: 66.0 64.0 68.0 65.0 66.0 72.0 66.0 65.0 66.0 65.0 21:00:49 INFO - PROCESS | 3772 | 21:00:49 INFO - PROCESS | 3772 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 21:00:49 INFO - PROCESS | 3772 | Values: 65.0 67.0 65.0 67.0 66.0 66.0 66.0 66.0 67.0 66.0 21:00:49 INFO - PROCESS | 3772 | 21:00:49 INFO - PROCESS | 3772 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 21:00:49 INFO - PROCESS | 3772 | Values: 82.0 82.0 81.0 81.0 81.0 81.0 81.0 82.0 81.0 81.0 21:00:49 INFO - PROCESS | 3772 | 21:00:49 INFO - PROCESS | 3772 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:136.50 stddev:7.07 (5.2%) stddev-sans-first:7.48 21:00:49 INFO - PROCESS | 3772 | Values: 138.0 133.0 131.0 138.0 132.0 131.0 132.0 146.0 152.0 135.0 21:00:49 INFO - PROCESS | 3772 | 21:00:49 INFO - PROCESS | 3772 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:175.00 stddev:2.32 (1.3%) stddev-sans-first:2.28 21:00:49 INFO - PROCESS | 3772 | Values: 177.0 174.0 174.0 176.0 177.0 174.0 177.0 172.0 170.0 174.0 21:00:49 INFO - PROCESS | 3772 | 21:00:49 INFO - PROCESS | 3772 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.55 (2.3%) stddev-sans-first:1.58 21:00:49 INFO - PROCESS | 3772 | Values: 68.0 67.0 68.0 70.0 67.0 66.0 66.0 66.0 65.0 65.0 21:00:49 INFO - PROCESS | 3772 | -------- Summary: end -------- 21:00:49 INFO - PROCESS | 3772 | 21:00:50 INFO - TEST-INFO | 3772: exit 0 21:00:50 INFO - TEST-OK | kraken | took 64390ms 21:00:50 INFO - SUITE-END | took 1186s 21:00:51 INFO - Completed test suite (00:19:47) 21:00:51 INFO - javascript benchmark 21:00:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2628.592568151937, 2640.590708440192, 2648.827826191298, 2672.9465410691787, 2678.9866050669743, 4708.152532544141, 4788.0, 4789.856304310876, 4833.32333473314, 4849.272609108635, 4754.738489383082, 4838.540338667821, 4841.3222148899185, 4858.4898585648525, 4875.63432742544, 4491.595756381925, 4502.797374118156, 4513.593776560109, 4531.501534831166, 4537.546245375453, 4446.333050042504, 4461.665375096864, 4471.329300604919, 4503.549645035503, 4521.683482156251, 4526.841560545382, 4548.272276435771, 4559.247724125516, 4567.337736028274, 4567.63458923287, 4421.64626829856, 4432.645388368923, 4477.194105061088, 4495.415595972503, 4504.707194032378, 4324.524302326773, 4360.672949528766, 4373.409589705381, 4384.188925048876, 4417.558244175589, 4801.255805350176, 4838.540338667821, 4842.322074909515, 4845.055214233226, 4848.757562121915, 5143.099957507421, 5165.483451654842, 5211.973940130313, 5212.921806172911, 5219.217117432378, 5018.598512119058, 5076.213186956028, 5138.974305128488, 5144.871378215537, 5240.475952404767, 4842.080004799077, 4847.2729090636685, 4848.10310092634, 4854.368932038812, 4857.319975203474, 5329.360476742816, 5336.573074154058, 5338.6529875558745, 5338.813141540105, 5342.118550439134, 4882.902341953212, 5020.548150666457, 5034.79860805571, 5062.11413002723, 5102.336696229467, 5164.1995490699, 5211.71335576547, 5212.661177023481, 5222.55608273301, 5223.791048358099, 5116.360454943132, 5117.155669314521, 5117.181250999896, 5127.846164615067, 5187.351581052369, 4965.106280869478, 5020.297158397827, 5035.446100928895, 5036.622253330942, 5099.184130539096, 4296.677749168824, 4321.589449002403, 4346.456692913386, 4349.282368409177, 4358.978205108954, 3782.0355809268463, 3794.354959656865, 3814.122751767109, 3842.9615703843165, 3845.9230815383535, 4320.675949303752, 4337.327714204303, 4356.0, 4412.470503539532, 4415.2935530315, 5156.510131537498, 5181.06740786662, 5181.35233095863, 5213.817516386908, 5223.268742376071, 4389.517153113155, 4393.75834329115, 4397.384366188736, 4437.911241775147, 4441.133978874089, 4541.886452838706, 4564.497905230422, 4610.976945115253, 4623.0, 4649.767511624405, 4908.7545622719435, 4927.975360123177, 4931.038447502702, 4961.181405068123, 4976.452590215146, 5239.056969745482, 5243.737813109406, 5244.7902083916215, 5248.186531087687, 5292.576593872558, 4772.188727916193, 4820.469748327751, 4835.468098509232, 4915.066137433876, 4929.038837426668, 5086.3896332440345, 5148.794048238028, 5150.922736159036, 5174.9482505174465, 5189.455107213688, 5129.8974020518635, 5179.22311653255, 5215.087359712111, 5216.347956505437, 5217.904240109619, 4906.313116163668, 4971.204607262821, 5068.670536415121, 5073.518015788494, 5078.441371449211, 4995.725235112103, 5057.31726216956, 5064.82273120439, 5088.720120393414, 5107.438181800073, 4981.576565991932, 4984.925226121683, 5029.44676085623, 5030.723310217827, 5036.899262014813, 4893.461719210813, 4932.506749325039, 4936.802527898987, 5083.669561478492, 5104.668196567211, 4874.8050077997905, 4885.609151267819, 4888.6577939543895, 4890.0, 5001.399832020181], "value": 4739.333560674882, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.6628756458559, 560.6579986208412, 563.850579596407, 567.7643777832199, 571.2858926342072, 28581.285467863312, 31476.527852082236, 39562.40656390153, 40748.79625601875, 40990.0, 40568.797156014254, 40615.79692101535, 40830.7958460208, 40957.59042409575, 41068.58931410685, 7531.058617672791, 7745.070591529025, 7751.379889608846, 7755.185705500926, 7756.0304961879765, 7623.352015078725, 7690.2694244046725, 7704.922950770505, 7709.884351734729, 7718.6912523498995, 7703.1526532081425, 7743.2256774322395, 7745.380369570421, 7758.185390533998, 7776.339011184056, 7717.575533345664, 7739.38084953208, 7743.070831500256, 7748.573828439434, 7754.495957762756, 7665.655045522964, 7731.072271327421, 7734.2265773422205, 7737.57443340616, 7738.845223095563, 37506.0, 37868.43197352042, 37893.43159852605, 37938.8103059483, 37951.620483795086, 3196.216926852913, 3257.9185520361943, 3276.5904261967253, 3432.742544309187, 3513.7540372173958, 29595.85202073976, 29959.70040299591, 30000.249993750112, 30130.84934575313, 31302.747890084596, 3285.983570082134, 3309.271960168759, 3319.468884978392, 3348.983255083709, 3436.226848958989, 248651.0, 249261.0, 249457.0, 250186.0, 250253.0, 31424.0, 32376.514352284736, 53413.73293133587, 53807.0, 53809.0, 32021.359572808415, 32280.0, 32335.191620209684, 32337.191570210933, 32360.35279294401, 11997.160198786001, 12138.271703697807, 12144.210626309261, 12144.817827732591, 12167.209131406431, 9869.309148359545, 9960.80078398428, 9966.451845148586, 9970.152537034288, 9971.002899710116, 7911.129775724666, 7912.28789408956, 7940.602969851484, 8044.235797599219, 8046.275835174863, 3082.6917308269444, 3092.1805721483825, 3106.409782141386, 3127.405792899342, 3131.890383836555, 831.0069466986893, 853.7652145659994, 872.1322284327135, 880.1242763450408, 934.4393363981557, 28126.0, 28296.575551366746, 28549.0, 28581.99815032361, 29250.0, 927.3184209605935, 971.3491960386417, 974.1135566634329, 975.5951280218629, 984.5667906121283, 14333.0, 14700.55898323052, 15166.620834479227, 15392.538223853302, 15505.9224703878, 375359.0, 382080.0, 383212.0, 386908.0, 386951.0, 48966.510334896906, 49508.0, 49539.99999999928, 49657.0, 49676.50323496791, 1079.9730006749894, 1131.1911982932243, 1145.8223975283845, 1158.195054437158, 1161.4250945781723, 25523.489530209663, 28754.09901623637, 29286.121416357542, 29662.555061674524, 29850.85074574613, 41940.790296048326, 42589.57410425856, 42637.36043959405, 42639.0, 42640.360394594725, 279960.0, 281433.4494878008, 281671.0, 281732.0, 282248.0, 22554.323370298916, 24808.25575232674, 25365.239042828005, 25398.0, 25894.093706720174, 41261.58738412698, 41265.79367103145, 41823.58176418197, 42302.576974229865, 42561.78719106385, 34054.0, 35066.824665876506, 35607.64392356147, 36818.815905920295, 37610.6238937618, 36123.819380902925, 36580.26839463143, 36687.26625467422, 36923.815380922926, 36940.81529592335, 36079.00642534059, 36099.45850812292, 36228.63771362253, 36367.27265454623, 36985.81507092447, 31526.527102093947, 33028.1742956428, 33493.33013339671, 33611.15972100717, 33924.0, 24522.509549808547, 24884.253472395856, 25049.0, 25426.618600721373, 25700.228993130237], "value": 16198.80193133849, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.0810372771475, 365.400742781838, 372.1050872651274, 373.6039797814318, 387.41113507468646, 12693.11148219625, 16080.517584472469, 16279.348826046944, 17057.40299089532, 18044.458666240032, 15070.849291507082, 15405.306761195745, 16329.510114696548, 16491.67016659666, 16512.09183494907, 4351.934720979188, 4905.435874874382, 4995.475475075119, 5015.69905805651, 5100.132977393852, 4982.526659967315, 5051.469595692454, 5052.696838189702, 5054.368203974504, 5082.313887625179, 4856.3201151838775, 5000.274960130779, 5035.672681275723, 5059.696418214919, 5065.366829146356, 5004.049230646166, 5048.596112311006, 5052.418971818214, 5053.317802096707, 5055.064813009605, 4364.41080454141, 4496.4829044659955, 4533.0, 4537.0, 4538.341940418653, 20245.79754202454, 20647.380578582666, 20823.375298741063, 21114.261000865048, 21264.787352126434, 2275.9089636414687, 2504.8246622736415, 2543.4023004593905, 2546.847189168637, 2579.87100644967, 13364.398602062833, 13891.166530008231, 14037.45587985331, 14087.859121408757, 14412.855871441361, 1707.4450803488917, 1732.9220185091574, 1755.5611097225694, 1764.5676809181832, 1782.0466050662833, 65949.67025164844, 67458.66270668615, 67762.0, 67772.0, 67943.3205667942, 9631.373960692672, 9651.806963860823, 9788.55951482185, 9843.24493413506, 9851.50742462874, 13095.607131786062, 13100.868991310155, 13123.343832808321, 13124.409401576951, 13132.34338283082, 6889.758858439931, 6929.44564434844, 7053.188883278386, 7196.748113815991, 7223.530470519399, 6577.276499585042, 6586.934130658632, 6749.426298764562, 6758.594484330956, 6795.7961261162245, 6108.450239478469, 6167.938320616826, 6208.875822483525, 6242.250929888442, 6329.556931014877, 1649.653572749712, 1688.3331084221663, 1758.5515693498076, 1781.100544225158, 1793.1213705284576, 783.5337973905517, 855.9657613695507, 920.6087412849646, 956.5901195488791, 967.2358836519212, 16977.151142442828, 17295.394661186798, 17884.28462861471, 17898.0, 18425.447236582924, 855.1747563601155, 871.7471933139445, 880.9559522023873, 899.8335307968047, 966.1690945786618, 9623.903760962441, 10019.895821877342, 10107.848382274271, 10267.229957753198, 10558.841617375745, 367066.0, 370473.0, 374675.0, 377936.0, 378275.0, 78164.21835781683, 81126.0, 82737.0, 83010.0, 83297.16702833015, 932.6036434515304, 935.9064093590587, 983.3165949664914, 994.1202036197873, 994.4480813148627, 15108.471203508265, 15895.68208635844, 16055.759163612322, 16068.43760468378, 16959.491215263562, 35345.82327088451, 38320.0, 38757.41863872101, 39769.80115099406, 41769.0, 46283.76858115823, 48572.757136214095, 49329.0, 50442.2433663488, 52390.21414678707, 6787.66061696923, 7021.473389495911, 7072.9841995031165, 7382.5570465772225, 7901.960490197513, 11110.61112861046, 11821.586244481401, 12252.081093917814, 12520.123591348518, 12585.496580136693, 10316.329438586468, 10410.739731506774, 10469.68590942273, 10618.8938110621, 10809.135269178603, 9090.13643703847, 9358.970513243674, 9423.057694230522, 9505.762355941157, 9715.222782177267, 5354.0, 8008.679652813822, 8299.626516806637, 10773.599432073781, 10819.680307224322, 7063.57618542889, 7112.786616401516, 7194.100737407824, 7290.0, 7403.0, 9773.85339219898, 9963.452010139512, 10212.948935255276, 10261.28171028021, 10282.280240383401], "value": 8264.193963503647, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1174.5243176513513, 1184.7275126720854, 1256.5727652598114, 1309.7576948264573, 1664.7835781348424, 6705.899411508825, 7297.854042919138, 7508.887366689491, 7521.473496855222, 7722.691092356313, 7515.699372025112, 7567.772966811004, 7570.545767253969, 7573.507721998067, 7577.848443031136, 2179.7602263750973, 2208.4699672078746, 2210.789974952385, 2214.734231892175, 2216.0, 2158.3201291593177, 2193.9451513712206, 2203.713517242756, 2206.117552978805, 2206.8455208135438, 2162.243214874789, 2189.2228258968, 2192.1231507397088, 2195.7255343082115, 2198.1756841184556, 2162.643163877958, 2166.4042388343173, 2167.1331467413, 2171.326888664519, 2171.7285339332584, 2052.5792212596384, 2120.279105104272, 2122.2678176029244, 2123.9150433982777, 2125.7024016637683, 7488.090536913052, 7605.391568674548, 7616.428767842434, 7653.770386888402, 7666.118396384376, 4430.734155950621, 4548.749818759967, 4553.795079221443, 4562.840300589497, 4564.064366804831, 2968.1392396205074, 3039.7720170987045, 3088.536719492072, 3089.6601373849085, 3091.675374085711, 931.5528546297747, 936.6768464879606, 937.1565590968115, 949.9002604726473, 951.4006176109076, 10408.063274305274, 10489.527971241312, 10528.105111065568, 10530.36817790935, 10552.472376381227, 3993.1414745829784, 3999.8800035998383, 4021.577734337911, 4052.5339585947404, 4208.789560522023, 8452.197041281068, 8465.915340846514, 8468.830623387621, 8473.915260847436, 8491.405601607828, 4325.4593175853015, 4327.1345730853955, 4327.415798867176, 4328.675349348811, 4332.415123958288, 3508.649135086522, 3901.726879118491, 3924.823382947774, 3927.3912543555793, 4073.348264277701, 3434.862605495802, 3469.5142680024815, 3573.7855728656364, 3577.4276115821344, 3582.5880023797595, 1055.2138656700654, 1063.744701271689, 1064.882862885082, 1074.6561100447939, 1076.9730756730987, 804.577596761693, 813.6135335715607, 834.3241974001079, 846.8729690546468, 854.3763052971242, 5169.741512924414, 5265.76304066318, 5277.393099793496, 5293.550048245942, 5296.523312901781, 833.8707500337457, 901.9188273055456, 909.4406939732017, 909.8544232922701, 913.0595486648763, 3403.6766507182274, 3489.7382696297877, 3570.4108822044072, 3621.27574485104, 3631.291898079849, 9091.409058411182, 9554.140127388568, 9582.137607615348, 9590.616375344907, 9602.423854568748, 9493.715188544355, 9515.57179926905, 9525.52372381392, 9528.190103841112, 9552.808943821085, 6987.89518157228, 7220.386267167244, 7267.491275610762, 7422.665980030912, 7440.73957411488, 5196.662216955886, 5208.270842082035, 5251.448597897166, 5411.78352865881, 5506.697131657637, 8817.955910220408, 8831.425957312755, 8888.24449921738, 8940.15068568485, 9060.54697265121, 8619.741407757778, 8854.778630534289, 8912.153345432174, 9148.451092934445, 9178.128077832594, 6217.253929528486, 6515.674216289071, 6637.4690024798865, 6902.792916212522, 6923.6192009439965, 7383.852322953619, 7716.8456630868195, 7718.845623087394, 7728.845423091394, 7758.030246219223, 6645.700943457653, 6793.4565234782085, 6874.381305682513, 6880.931190688029, 6980.336867997736, 6572.375624315682, 6627.602343859384, 6699.832504187434, 6739.764108256188, 6766.357196066366, 6411.198600174978, 6474.4820414365795, 6481.449076828522, 6552.3447655234095, 6591.472682185509, 4496.505384407778, 4546.727196368096, 4557.430321209848, 4637.907241855077, 4710.764461776966, 4437.7559234241135, 4531.43357080365, 4612.377329060534, 4699.859004229878, 4704.3649107370065], "value": 4082.225231714845, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.1707219784604, 298.7445733897518, 305.4989816700611, 305.87459141751884, 310.8570057773424, 4674.836380726675, 4793.640476964229, 4813.085513752393, 4853.369062021941, 4861.683990540612, 4636.374089497916, 4730.4559975602815, 4732.313814496896, 4756.381670382845, 4774.880627984302, 3785.1483416231267, 3799.6580307772297, 3803.220339830342, 3804.334241507739, 3824.8087595620245, 3574.267275208576, 3612.6929211017095, 3820.5606355269224, 3830.731848770587, 3838.712096592753, 3776.848926042955, 3783.205526839367, 3795.3737633290475, 3795.392737162055, 3803.7527560708463, 3782.35699931011, 3783.8486460541544, 3794.203217324365, 3796.6013568575177, 3802.5627052888995, 3363.7813542119684, 3366.9158271043175, 3370.5112758650102, 3373.96626033739, 3376.2234686022352, 4575.176468235716, 4689.460712018094, 4692.319613656001, 4702.918328784364, 4711.505291944331, 4325.956740432587, 4330.870073897788, 4333.891652708676, 4336.744892655801, 4353.650368385811, 5002.324686167357, 5004.424491183524, 5029.2958985742025, 5038.79844806211, 5039.72281524516, 3555.928881422383, 3632.473291372736, 3655.122770535079, 3669.3395188865993, 3679.7056235501095, 5208.583313334962, 5218.530332270076, 5229.921551176735, 5230.515505135068, 5232.529072383466, 3738.794366309879, 3749.418840079792, 3749.7000239980734, 3750.212455384345, 3750.3249415104997, 3743.3636281832155, 3806.3148633246283, 3808.638179372955, 3823.674987626083, 3840.9423858642144, 4188.68584856137, 4243.830246790156, 4248.617624413818, 4279.657627389802, 4296.140771845643, 4993.400791904922, 4997.475265097185, 5005.6996580205305, 5006.674566153189, 5010.4718060991745, 1255.2092181925511, 1281.4105511464645, 1302.739452109563, 1318.905308593865, 1325.648703093681, 883.9204471597587, 906.3564868942992, 913.2739472119681, 915.2906497464518, 922.326701507903, 4325.178216138924, 4380.751485826524, 4387.232234358974, 4402.5597440255715, 4410.867673969786, 5099.5410413063, 5104.412992505835, 5114.008305141534, 5127.28236040923, 5148.76830542619, 4376.190404775127, 4380.299152135643, 4387.345655878148, 4393.319035549495, 4406.184855801687, 2327.953440931172, 2426.5389575980507, 2432.0422060241676, 2438.609822428403, 2441.5971364724624, 4296.722736949422, 4301.806418711166, 4331.7834108294455, 4338.783060846945, 4344.522102568715, 4590.40324757786, 4610.469795973506, 4632.60622847055, 4680.455449701591, 4683.2038553446, 4052.8986775330263, 4316.676249281317, 4320.546342633978, 4322.783860806947, 4331.653467722637, 4544.7045942013665, 4554.27131658933, 4562.703424277412, 4563.54364563541, 4601.631869450503, 4470.374147619271, 4471.239889218776, 4471.8434854779925, 4527.547245275446, 4537.0, 4047.9677682190854, 4304.203722311382, 4311.48262208537, 4328.749050493789, 4337.804798783999, 3444.5360721693683, 3445.8807833182914, 3450.2748625687154, 3453.447448408343, 3470.219200679827, 4595.195840727926, 4610.561996610317, 4621.607163391015, 4622.329762184531, 5003.624728145476, 4793.592544633745, 5022.447530771686, 5024.442422848929, 5048.192289233705, 5053.0, 4987.982270726158, 5013.824516141917, 5022.308603176589, 5022.623303252198, 5039.672421292605, 4794.113089078532, 4926.802927882844, 4966.726830024383, 4973.925391119208, 4981.352424184833, 5027.622928280321, 5061.670991385548, 5074.898502030012, 5075.822346217865, 5081.314022607048, 4948.208286674115, 4956.975215123901, 4959.553640172402, 4999.225120106389, 5000.7748101715315], "value": 3703.1925344412316, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.7460180219804, 591.0100581525943, 660.534323302072, 707.5789905006523, 726.1032624708484, 12079.637610871678, 13798.724025519483, 13810.930945345259, 13817.861821381783, 13846.23845688488, 13350.799738003914, 13507.189568625865, 13508.05443618947, 13517.662058448544, 13521.32393380332, 619.294004834489, 741.232824027132, 752.6913965274239, 765.7894079128229, 773.736929443989, 767.9347255483291, 773.9419543534258, 775.3603277296224, 777.141258908906, 777.5645638442462, 818.7953011747063, 820.151143566406, 823.6375994562403, 823.9752807415787, 825.051191130202, 659.3801826283278, 794.8171920458327, 820.7168526858254, 821.7329367955379, 822.0956947357919, 604.1572007050185, 604.2235727090712, 604.6674329119011, 604.7701873288122, 605.1376788077017, 13010.739785204338, 13017.414216360286, 13031.804522932163, 13036.087473876833, 13056.412461439259, 12788.48846046157, 13003.0, 13072.869271307356, 13669.17984920898, 13669.391235830717, 11471.885281147164, 11497.482613282422, 11567.537298508134, 11651.825222621668, 11919.821202681967, 4129.236091323085, 4146.813393397304, 4162.875113746592, 4166.812493437803, 4209.726367786115, 51988.74005629947, 53628.0, 53654.46345536534, 60940.695296523234, 62893.37106628921, 9925.553350099262, 10324.328918620266, 10340.327878687862, 10466.666666666666, 10531.578736850593, 18671.253149874126, 18677.15952782128, 18744.437666869744, 18771.530711732044, 18819.71770423445, 6779.118714567075, 6821.079154314104, 6874.243833178446, 6876.724931002804, 7082.079329687108, 3747.213085252073, 3775.7356985011334, 3837.788921609338, 3853.556840963325, 3962.782046987443, 2901.202169403389, 3019.818810871355, 3028.1672540051222, 3030.3787723517066, 3033.5752994580776, 513.4121430961528, 515.5463192390747, 515.9097157997336, 516.6564234783901, 524.1613418530321, 553.195101127866, 601.6841158391879, 608.582807535684, 609.3632154398664, 615.5506480269429, 7999.560024198725, 8065.919340806517, 8256.669733210725, 8260.463069900557, 8558.486490810572, 555.8554775758251, 566.4703502225433, 570.3953808962513, 583.0350769476523, 596.3261514488601, 3746.8875933722034, 3807.3717836556657, 3939.2515422069714, 3941.7043721720984, 4165.958340416618, 57934.7103264481, 58427.123593146134, 58456.41543584595, 78424.0, 110577.44711276553, 76326.0, 80045.59977200077, 82587.0, 88850.11149888548, 92800.53599732093, 64201.07396778104, 73724.26275737281, 74418.62790686011, 79604.60197698974, 81915.5904220475, 7172.892406614009, 7609.0, 7706.576138312223, 7715.975385598914, 7792.337651299703, 46403.53596463992, 46738.83152921068, 47152.52847471481, 47437.0, 50334.0, 37779.81110094432, 56632.0, 67959.0, 68568.0, 71298.0, 11313.830292545454, 11325.0, 11462.254953428, 11501.53993840237, 11804.70488237801, 11803.940980295043, 11911.583094591648, 12642.683932901384, 12789.93605031969, 13571.932140339235, 11253.212275140662, 11564.710882227675, 11614.303141811519, 11955.521779128738, 11978.281303121841, 11376.488058037243, 11689.415529223676, 11700.941495292469, 12419.813702794285, 12441.626751197478, 10784.946075269574, 11005.779884402427, 11247.381394023407, 11366.318020918772, 12224.266544007389, 9737.367071140354, 10203.591856325664, 10659.520321585702, 10662.89337106619, 10963.232573720083, 9868.0, 10039.548220330249, 10081.647142349982, 10234.181265498593, 10293.794124117327], "value": 6564.358126024996, "unit": "score"}], "name": "dromaeo_css", "value": 6307.4281506707175, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 114.0, 114.0, 108.0, 115.0, 114.0, 114.0, 114.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 123.0, 190.0, 122.0, 126.0, 144.0, 127.0, 194.0, 120.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 160.0, 160.0, 160.0, 161.0, 162.0, 162.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 101.0, 76.0, 77.0, 76.0, 76.0, 102.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 140.0, 85.0, 87.0, 86.0, 122.0, 86.0, 86.0, 143.0], "value": 100.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 68.0, 65.0, 66.0, 72.0, 66.0, 65.0, 66.0, 65.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 67.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 81.0, 81.0, 81.0, 81.0, 82.0, 81.0, 81.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 133.0, 131.0, 138.0, 132.0, 131.0, 132.0, 146.0, 152.0, 135.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 174.0, 174.0, 176.0, 177.0, 174.0, 177.0, 172.0, 170.0, 174.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 70.0, 67.0, 66.0, 66.0, 66.0, 65.0, 65.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1547.8, "alertThreshold": 2.0}]} 21:00:51 INFO - Return code: 0 21:00:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:00:51 INFO - # TBPL SUCCESS # 21:00:51 INFO - Running post-action listener: _resource_record_post_action 21:00:51 INFO - [mozharness: 2016-08-16 04:00:51.644653Z] Finished run-tests step (success) 21:00:51 INFO - Running post-run listener: _resource_record_post_run 21:00:51 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 7766016; Write bytes: 441692160; Read time: 1888; Write time: 374564 21:00:51 INFO - TinderboxPrint: CPU usage
13.0% 21:00:51 INFO - TinderboxPrint: I/O read bytes / time
7,766,016 / 1,888 21:00:51 INFO - TinderboxPrint: I/O write bytes / time
441,692,160 / 374,564 21:00:51 INFO - TinderboxPrint: CPU idle
8,355.9 (86.9%) 21:00:51 INFO - TinderboxPrint: CPU user
1,205.5 (12.5%) 21:00:51 INFO - TinderboxPrint: Swap in / out
0 / 0 21:00:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 8806400; Read time: 0; Write time: 2276 21:00:51 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 5570560; Write bytes: 371552256; Read time: 1376; Write time: 291424 21:00:52 INFO - Running post-run listener: _upload_blobber_files 21:00:52 INFO - Blob upload gear active. 21:00:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:00:52 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 21:00:52 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:00:52 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:00:52 INFO - (blobuploader) - INFO - Open directory for files ... 21:00:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:00:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:00:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:00:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:00:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:00:53 INFO - (blobuploader) - INFO - Done attempting. 21:00:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:00:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:00:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:00:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:00:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:00:59 INFO - (blobuploader) - INFO - Done attempting. 21:00:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:00:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:00:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:01:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:01:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:01:00 INFO - (blobuploader) - INFO - Done attempting. 21:01:00 INFO - (blobuploader) - INFO - Iteration through files over. 21:01:00 INFO - Return code: 0 21:01:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:01:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:01:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9468a6302fa294e815beb72a8dcf33349a8b1c0912fd99746f8ea59374d8c2ccb95ca60b7f59da6114a4763ffe78539ee8d6673cf68fbeafc802c8c246618eec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4103e6226a00013a0571173819c457ee25fa3461534d0abfed9db944a0aca323a1d51ee3088b36cc776066b85cc79a1105af8a2be59e16d24b3699224bad3bd6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9c8d59a22efd9321ffce323be793c5c0d2205ba2e06674683a022b1ec35a4c0335cfa5c9370601b602e7194d507781169c3314f39e70c24ab7bf65f1b873f369"} 21:01:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:01:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:01:00 INFO - Contents: 21:01:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9468a6302fa294e815beb72a8dcf33349a8b1c0912fd99746f8ea59374d8c2ccb95ca60b7f59da6114a4763ffe78539ee8d6673cf68fbeafc802c8c246618eec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4103e6226a00013a0571173819c457ee25fa3461534d0abfed9db944a0aca323a1d51ee3088b36cc776066b85cc79a1105af8a2be59e16d24b3699224bad3bd6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9c8d59a22efd9321ffce323be793c5c0d2205ba2e06674683a022b1ec35a4c0335cfa5c9370601b602e7194d507781169c3314f39e70c24ab7bf65f1b873f369"} 21:01:00 INFO - Running post-run listener: copy_logs_to_upload_dir 21:01:00 INFO - Copying logs to upload dir... 21:01:00 INFO - mkdir: /builds/slave/test/build/upload/logs 21:01:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.085777 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-08-15 21:01:00.580342) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 21:01:00.585575) ========= 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=232498196343f89f466a4a9a000001c8-1471318805.403569-442925375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9468a6302fa294e815beb72a8dcf33349a8b1c0912fd99746f8ea59374d8c2ccb95ca60b7f59da6114a4763ffe78539ee8d6673cf68fbeafc802c8c246618eec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4103e6226a00013a0571173819c457ee25fa3461534d0abfed9db944a0aca323a1d51ee3088b36cc776066b85cc79a1105af8a2be59e16d24b3699224bad3bd6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9c8d59a22efd9321ffce323be793c5c0d2205ba2e06674683a022b1ec35a4c0335cfa5c9370601b602e7194d507781169c3314f39e70c24ab7bf65f1b873f369"} build_url:https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011139 build_url: 'https://queue.taskcluster.net/v1/task/KDI50iMrT1eteYHGuIh4tQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9468a6302fa294e815beb72a8dcf33349a8b1c0912fd99746f8ea59374d8c2ccb95ca60b7f59da6114a4763ffe78539ee8d6673cf68fbeafc802c8c246618eec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4103e6226a00013a0571173819c457ee25fa3461534d0abfed9db944a0aca323a1d51ee3088b36cc776066b85cc79a1105af8a2be59e16d24b3699224bad3bd6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9c8d59a22efd9321ffce323be793c5c0d2205ba2e06674683a022b1ec35a4c0335cfa5c9370601b602e7194d507781169c3314f39e70c24ab7bf65f1b873f369"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 21:01:00.610537) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 21:01:00.610847) ========= 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=232498196343f89f466a4a9a000001c8-1471318805.403569-442925375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 21:01:00.693792) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 21:01:00.694097) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 21:01:00.694384) ========= ========= Total master_lag: 0.17 =========