builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1470604524.31 results: success (0) buildid: 20160807113002 builduid: bade3b5237eb4c3baaaf8db33ee890b7 revision: 204b39c31233c082553493f52bfe8c3ebcc404ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 14:15:24.312777) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 14:15:24.313349) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 14:15:24.313661) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 14:15:24.348303) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 14:15:24.348635) ========= 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=745a4373a2a16df560f216e000000264-1470595898.412628-430910497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-07 14:15:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.9M=0s 2016-08-07 14:15:25 (37.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135612 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 14:15:24.506065) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 14:15:24.506729) ========= 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=745a4373a2a16df560f216e000000264-1470595898.412628-430910497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019619 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 14:15:24.577801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 14:15:24.578157) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 204b39c31233c082553493f52bfe8c3ebcc404ff --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 204b39c31233c082553493f52bfe8c3ebcc404ff --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=745a4373a2a16df560f216e000000264-1470595898.412628-430910497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-07 14:15:25,319 truncating revision to first 12 chars 2016-08-07 14:15:25,319 Setting DEBUG logging. 2016-08-07 14:15:25,319 attempt 1/10 2016-08-07 14:15:25,319 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/204b39c31233?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 14:15:26,062 unpacking tar archive at: fx-team-204b39c31233/testing/mozharness/ program finished with exit code 0 elapsedTime=1.078370 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 14:15:25.717065) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 14:15:25.717384) ========= script_repo_revision: 204b39c31233c082553493f52bfe8c3ebcc404ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 14:15:25.717778) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 14:15:25.718070) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 14:15:25.782867) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-08-07 14:15:25.783148) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1470595898.412628-430910497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:15:26 INFO - MultiFileLogger online at 20160807 14:15:26 in /builds/slave/test 14:15:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:15:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:15:26 INFO - {'append_to_log': False, 14:15:26 INFO - 'base_work_dir': '/builds/slave/test', 14:15:26 INFO - 'blob_upload_branch': 'Fx-Team', 14:15:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:15:26 INFO - 'branch': 'Fx-Team', 14:15:26 INFO - 'buildbot_json_path': 'buildprops.json', 14:15:26 INFO - 'config_files': ('talos/linux_config.py',), 14:15:26 INFO - 'default_actions': ('clobber', 14:15:26 INFO - 'read-buildbot-config', 14:15:26 INFO - 'download-and-extract', 14:15:26 INFO - 'populate-webroot', 14:15:26 INFO - 'create-virtualenv', 14:15:26 INFO - 'install', 14:15:26 INFO - 'run-tests'), 14:15:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:15:26 INFO - 'download_minidump_stackwalk': True, 14:15:26 INFO - 'download_symbols': 'ondemand', 14:15:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:15:26 INFO - 'tooltool.py': '/tools/tooltool.py', 14:15:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:15:26 INFO - '/tools/misc-python/virtualenv.py')}, 14:15:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:15:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:15:26 INFO - 'installer_path': 'installer.exe', 14:15:26 INFO - 'log_level': 'info', 14:15:26 INFO - 'log_name': 'talos', 14:15:26 INFO - 'log_to_console': True, 14:15:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:15:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:15:26 INFO - 'opt_config_files': (), 14:15:26 INFO - 'pip_index': False, 14:15:26 INFO - 'sps_profile': False, 14:15:26 INFO - 'sps_profile_interval': 0, 14:15:26 INFO - 'suite': 'dromaeojs', 14:15:26 INFO - 'system_bits': '32', 14:15:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:15:26 INFO - 'title': 'talos-linux64-ix-032', 14:15:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:15:26 INFO - 'use_talos_json': True, 14:15:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:15:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:15:26 INFO - 'work_dir': 'build'} 14:15:26 INFO - [mozharness: 2016-08-07 21:15:26.617770Z] Running clobber step. 14:15:26 INFO - Running pre-action listener: _resource_record_pre_action 14:15:26 INFO - Running main action method: clobber 14:15:26 INFO - rmtree: /builds/slave/test/build 14:15:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:15:27 INFO - Running post-action listener: _resource_record_post_action 14:15:27 INFO - [mozharness: 2016-08-07 21:15:27.604068Z] Finished clobber step (success) 14:15:27 INFO - [mozharness: 2016-08-07 21:15:27.604168Z] Running read-buildbot-config step. 14:15:27 INFO - Running pre-action listener: _resource_record_pre_action 14:15:27 INFO - Running main action method: read_buildbot_config 14:15:27 INFO - Using buildbot properties: 14:15:27 INFO - { 14:15:27 INFO - "project": "", 14:15:27 INFO - "product": "firefox", 14:15:27 INFO - "script_repo_revision": "production", 14:15:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:15:27 INFO - "repository": "", 14:15:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:15:27 INFO - "buildid": "20160807113002", 14:15:27 INFO - "pgo_build": "True", 14:15:27 INFO - "basedir": "/builds/slave/test", 14:15:27 INFO - "buildnumber": 341, 14:15:27 INFO - "slavename": "talos-linux64-ix-032", 14:15:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:15:27 INFO - "platform": "ubuntu64_hw", 14:15:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:15:27 INFO - "branch": "fx-team", 14:15:27 INFO - "repo_path": "integration/fx-team", 14:15:27 INFO - "revision": "204b39c31233c082553493f52bfe8c3ebcc404ff", 14:15:27 INFO - "stage_platform": "linux64-pgo", 14:15:27 INFO - "builduid": "bade3b5237eb4c3baaaf8db33ee890b7", 14:15:27 INFO - "slavebuilddir": "test" 14:15:27 INFO - } 14:15:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 14:15:27 INFO - Running post-action listener: _resource_record_post_action 14:15:27 INFO - [mozharness: 2016-08-07 21:15:27.606642Z] Finished read-buildbot-config step (success) 14:15:27 INFO - [mozharness: 2016-08-07 21:15:27.606731Z] Running download-and-extract step. 14:15:27 INFO - Running pre-action listener: _resource_record_pre_action 14:15:27 INFO - Running main action method: download_and_extract 14:15:27 INFO - mkdir: /builds/slave/test/build/tests 14:15: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')]} 14:15:27 INFO - trying https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:15:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/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 14:15:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/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 14:15:28 INFO - Downloaded 1361 bytes. 14:15:28 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:15:28 INFO - Using the following test package requirements: 14:15:28 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:15:28 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:15:28 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:15:28 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:28 INFO - u'jsshell-linux-x86_64.zip'], 14:15:28 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:15:28 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:15:28 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:15:28 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:15:28 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:15:28 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:15:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:28 INFO - trying https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:15:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/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 14:15:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/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 14:15:29 INFO - Downloaded 21829510 bytes. 14:15:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:15:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:15:30 INFO - Return code: 0 14:15:30 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 14:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:30 INFO - trying https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:15:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/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 14:15:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/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 14:15:31 INFO - Downloaded 21829510 bytes. 14:15:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:15:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:15:33 INFO - Return code: 0 14:15: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')]} 14:15:33 INFO - trying https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:15:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/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 14:15:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/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 14:15:33 INFO - Downloaded 14413723 bytes. 14:15:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:15:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:15:34 INFO - Return code: 0 14:15:34 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')]} 14:15:34 INFO - trying https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:15:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/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 14:15:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/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 14:15:35 INFO - Downloaded 59962435 bytes. 14:15:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:15:35 INFO - mkdir: /builds/slave/test/properties 14:15:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:15:35 INFO - Writing to file /builds/slave/test/properties/build_url 14:15:35 INFO - Contents: 14:15:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:15:36 INFO - Running post-action listener: _resource_record_post_action 14:15:36 INFO - Running post-action listener: set_extra_try_arguments 14:15:36 INFO - [mozharness: 2016-08-07 21:15:36.314035Z] Finished download-and-extract step (success) 14:15:36 INFO - [mozharness: 2016-08-07 21:15:36.314268Z] Running populate-webroot step. 14:15:36 INFO - Running pre-action listener: _resource_record_pre_action 14:15:36 INFO - Running main action method: populate_webroot 14:15:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:15:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:15:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:15:36 INFO - '--tppagecycles', 14:15:36 INFO - '7'], 14:15:36 INFO - 'tests': ['tsvgm']}}, 14:15:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:15:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:15:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:15:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:15:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:15:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:15:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:36 INFO - 'talos_options': ['--disable-e10s'], 14:15:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:15:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:15:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:36 INFO - 'talos_options': ['--disable-e10s'], 14:15:36 INFO - 'tests': ['damp', 'tps']}, 14:15:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:36 INFO - 'tests': ['damp', 'tps']}, 14:15:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:15:36 INFO - 'tests': ['dromaeo_dom']}, 14:15:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:15:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:15:36 INFO - 'tests': ['basic_compositor_video']}, 14:15:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:15:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:15:36 INFO - 'tests': ['a11yr', 14:15:36 INFO - 'ts_paint', 14:15:36 INFO - 'tpaint', 14:15:36 INFO - 'sessionrestore', 14:15:36 INFO - 'sessionrestore_no_auto_restore', 14:15:36 INFO - 'tabpaint']}, 14:15:36 INFO - 'other-e10s': {'tests': ['a11yr', 14:15:36 INFO - 'ts_paint', 14:15:36 INFO - 'tpaint', 14:15:36 INFO - 'sessionrestore', 14:15:36 INFO - 'sessionrestore_no_auto_restore', 14:15:36 INFO - 'tabpaint']}, 14:15:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:15:36 INFO - 'ts_paint', 14:15:36 INFO - 'tpaint', 14:15:36 INFO - 'sessionrestore', 14:15:36 INFO - 'sessionrestore_no_auto_restore', 14:15:36 INFO - 'tabpaint']}, 14:15:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:15:36 INFO - 'ts_paint', 14:15:36 INFO - 'tpaint', 14:15:36 INFO - 'sessionrestore', 14:15:36 INFO - 'sessionrestore_no_auto_restore', 14:15:36 INFO - 'tabpaint']}, 14:15:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:15:36 INFO - 'tests': ['a11yr', 14:15:36 INFO - 'ts_paint', 14:15:36 INFO - 'tpaint', 14:15:36 INFO - 'sessionrestore', 14:15:36 INFO - 'sessionrestore_no_auto_restore', 14:15:36 INFO - 'tabpaint']}, 14:15:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:15:36 INFO - 'tests': ['a11yr', 14:15:36 INFO - 'ts_paint', 14:15:36 INFO - 'tpaint', 14:15:36 INFO - 'sessionrestore', 14:15:36 INFO - 'sessionrestore_no_auto_restore', 14:15:36 INFO - 'tabpaint']}, 14:15:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:15:36 INFO - 'tests': ['tsvgx', 14:15:36 INFO - 'tsvgr_opacity', 14:15:36 INFO - 'tart', 14:15:36 INFO - 'tscrollx', 14:15:36 INFO - 'cart']}, 14:15:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:15:36 INFO - 'tsvgr_opacity', 14:15:36 INFO - 'tart', 14:15:36 INFO - 'tscrollx', 14:15:36 INFO - 'cart']}, 14:15:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:36 INFO - 'talos_options': ['--disable-e10s'], 14:15:36 INFO - 'tests': ['tp5o']}, 14:15:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:36 INFO - 'tests': ['tp5o']}, 14:15:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:36 INFO - 'talos_options': ['--disable-e10s', 14:15:36 INFO - '--xperf_path', 14:15:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:15:36 INFO - 'tests': ['tp5n']}, 14:15:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:36 INFO - 'talos_options': ['--xperf_path', 14:15:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:15:36 INFO - 'tests': ['tp5n']}}, 14:15:36 INFO - 'talos.zip': {'path': '', 14:15:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:15:36 INFO - Running post-action listener: _resource_record_post_action 14:15:36 INFO - [mozharness: 2016-08-07 21:15:36.334273Z] Finished populate-webroot step (success) 14:15:36 INFO - [mozharness: 2016-08-07 21:15:36.334362Z] Running create-virtualenv step. 14:15:36 INFO - Running pre-action listener: _resource_record_pre_action 14:15:36 INFO - Running main action method: create_virtualenv 14:15:36 INFO - Creating virtualenv /builds/slave/test/build/venv 14:15:36 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 14:15:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:15:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:15:36 INFO - Using real prefix '/usr' 14:15:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:15:36 INFO - Installing distribute.............................................................................................................................................................................................done. 14:15:38 INFO - Installing pip.................done. 14:15:38 INFO - Return code: 0 14:15:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf05030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c43b0>, '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 0x11c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5740>, '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': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', '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 14:15:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:15:38 INFO - Using env: {'DISPLAY': ':0', 14:15:38 INFO - 'HOME': '/home/cltbld', 14:15:38 INFO - 'LANG': 'en_US.UTF-8', 14:15:38 INFO - 'LANGUAGE': 'en_US:en', 14:15:38 INFO - 'LOGNAME': 'cltbld', 14:15:38 INFO - 'MAIL': '/var/mail/cltbld', 14:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:38 INFO - 'MOZ_NO_REMOTE': '1', 14:15:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:38 INFO - 'NO_EM_RESTART': '1', 14:15:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:38 INFO - 'PWD': '/builds/slave/test', 14:15:38 INFO - 'SHELL': '/bin/bash', 14:15:38 INFO - 'SHLVL': '1', 14:15:38 INFO - 'TERM': 'linux', 14:15:38 INFO - 'TMOUT': '86400', 14:15:38 INFO - 'USER': 'cltbld', 14:15:38 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', 14:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:38 INFO - '_': '/tools/buildbot/bin/python'} 14:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:39 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 14:15:39 INFO - Cleaning up... 14:15:39 INFO - Return code: 0 14:15:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:15:39 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')]} 14:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:39 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')]} 14:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:39 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 0xf05030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c43b0>, '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 0x11c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5740>, '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': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', '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 14:15:39 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 14:15:39 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 14:15:39 INFO - Using env: {'DISPLAY': ':0', 14:15:39 INFO - 'HOME': '/home/cltbld', 14:15:39 INFO - 'LANG': 'en_US.UTF-8', 14:15:39 INFO - 'LANGUAGE': 'en_US:en', 14:15:39 INFO - 'LOGNAME': 'cltbld', 14:15:39 INFO - 'MAIL': '/var/mail/cltbld', 14:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:39 INFO - 'MOZ_NO_REMOTE': '1', 14:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:39 INFO - 'NO_EM_RESTART': '1', 14:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:39 INFO - 'PWD': '/builds/slave/test', 14:15:39 INFO - 'SHELL': '/bin/bash', 14:15:39 INFO - 'SHLVL': '1', 14:15:39 INFO - 'TERM': 'linux', 14:15:39 INFO - 'TMOUT': '86400', 14:15:39 INFO - 'USER': 'cltbld', 14:15:39 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', 14:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:39 INFO - '_': '/tools/buildbot/bin/python'} 14:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:39 INFO - Downloading/unpacking psutil>=3.1.1 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:15:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:15:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:15:41 INFO - Installing collected packages: psutil 14:15:41 INFO - Running setup.py install for psutil 14:15:41 INFO - building 'psutil._psutil_linux' extension 14:15:41 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 14:15:41 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 14:15:41 INFO - building 'psutil._psutil_posix' extension 14:15:41 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 14:15:41 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 14:15:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:15:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:15:41 INFO - Successfully installed psutil 14:15:41 INFO - Cleaning up... 14:15:41 INFO - Return code: 0 14:15:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:15:41 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')]} 14:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:41 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')]} 14:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:41 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 0xf05030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c43b0>, '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 0x11c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5740>, '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': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', '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 14:15:41 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 14:15:41 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 14:15:41 INFO - Using env: {'DISPLAY': ':0', 14:15:41 INFO - 'HOME': '/home/cltbld', 14:15:41 INFO - 'LANG': 'en_US.UTF-8', 14:15:41 INFO - 'LANGUAGE': 'en_US:en', 14:15:41 INFO - 'LOGNAME': 'cltbld', 14:15:41 INFO - 'MAIL': '/var/mail/cltbld', 14:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:41 INFO - 'MOZ_NO_REMOTE': '1', 14:15:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:41 INFO - 'NO_EM_RESTART': '1', 14:15:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:41 INFO - 'PWD': '/builds/slave/test', 14:15:41 INFO - 'SHELL': '/bin/bash', 14:15:41 INFO - 'SHLVL': '1', 14:15:41 INFO - 'TERM': 'linux', 14:15:41 INFO - 'TMOUT': '86400', 14:15:41 INFO - 'USER': 'cltbld', 14:15:41 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', 14:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:41 INFO - '_': '/tools/buildbot/bin/python'} 14:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:15:42 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 14:15:42 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 14:15:42 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 14:15:42 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 14:15:42 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 14:15:42 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 14:15:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:15:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:15:44 INFO - Installing collected packages: mozsystemmonitor 14:15:44 INFO - Running setup.py install for mozsystemmonitor 14:15:44 INFO - Successfully installed mozsystemmonitor 14:15:44 INFO - Cleaning up... 14:15:44 INFO - Return code: 0 14:15:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:15:44 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')]} 14:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:44 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')]} 14:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:44 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 0xf05030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c43b0>, '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 0x11c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5740>, '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': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', '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 14:15:44 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 14:15:44 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 14:15:44 INFO - Using env: {'DISPLAY': ':0', 14:15:44 INFO - 'HOME': '/home/cltbld', 14:15:44 INFO - 'LANG': 'en_US.UTF-8', 14:15:44 INFO - 'LANGUAGE': 'en_US:en', 14:15:44 INFO - 'LOGNAME': 'cltbld', 14:15:44 INFO - 'MAIL': '/var/mail/cltbld', 14:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:44 INFO - 'MOZ_NO_REMOTE': '1', 14:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:44 INFO - 'NO_EM_RESTART': '1', 14:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:44 INFO - 'PWD': '/builds/slave/test', 14:15:44 INFO - 'SHELL': '/bin/bash', 14:15:44 INFO - 'SHLVL': '1', 14:15:44 INFO - 'TERM': 'linux', 14:15:44 INFO - 'TMOUT': '86400', 14:15:44 INFO - 'USER': 'cltbld', 14:15:44 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', 14:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:44 INFO - '_': '/tools/buildbot/bin/python'} 14:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:44 INFO - Downloading/unpacking jsonschema==2.5.1 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:15:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:15:46 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 14:15:46 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 14:15:46 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 14:15:46 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 14:15:46 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 14:15:46 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 14:15:46 INFO - Downloading functools32-3.2.3-2.tar.gz 14:15:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:15:46 INFO - warning: no files found matching '*.txt' 14:15:46 INFO - no previously-included directories found matching 'build' 14:15:46 INFO - no previously-included directories found matching 'dist' 14:15:46 INFO - no previously-included directories found matching '.git*' 14:15:46 INFO - Installing collected packages: jsonschema, functools32 14:15:46 INFO - Running setup.py install for functools32 14:15:46 INFO - warning: no files found matching '*.txt' 14:15:46 INFO - no previously-included directories found matching 'build' 14:15:46 INFO - no previously-included directories found matching 'dist' 14:15:46 INFO - no previously-included directories found matching '.git*' 14:15:46 INFO - Successfully installed jsonschema functools32 14:15:46 INFO - Cleaning up... 14:15:46 INFO - Return code: 0 14:15:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:46 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 0xf05030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c43b0>, '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 0x11c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5740>, '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': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', '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 14:15:46 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 14:15:46 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 14:15:46 INFO - Using env: {'DISPLAY': ':0', 14:15:46 INFO - 'HOME': '/home/cltbld', 14:15:46 INFO - 'LANG': 'en_US.UTF-8', 14:15:46 INFO - 'LANGUAGE': 'en_US:en', 14:15:46 INFO - 'LOGNAME': 'cltbld', 14:15:46 INFO - 'MAIL': '/var/mail/cltbld', 14:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:46 INFO - 'MOZ_NO_REMOTE': '1', 14:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:46 INFO - 'NO_EM_RESTART': '1', 14:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:46 INFO - 'PWD': '/builds/slave/test', 14:15:46 INFO - 'SHELL': '/bin/bash', 14:15:46 INFO - 'SHLVL': '1', 14:15:46 INFO - 'TERM': 'linux', 14:15:46 INFO - 'TMOUT': '86400', 14:15:46 INFO - 'USER': 'cltbld', 14:15:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', 14:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:46 INFO - '_': '/tools/buildbot/bin/python'} 14:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:15:47 INFO - Cleaning up... 14:15:47 INFO - Return code: 0 14:15:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:15: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')]} 14:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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')]} 14:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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', '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 0xf05030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c43b0>, '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 0x11c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5740>, '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': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', '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 14:15: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:15: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 blobuploader==1.2.4 14:15:47 INFO - Using env: {'DISPLAY': ':0', 14:15:47 INFO - 'HOME': '/home/cltbld', 14:15:47 INFO - 'LANG': 'en_US.UTF-8', 14:15:47 INFO - 'LANGUAGE': 'en_US:en', 14:15:47 INFO - 'LOGNAME': 'cltbld', 14:15:47 INFO - 'MAIL': '/var/mail/cltbld', 14:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:47 INFO - 'MOZ_NO_REMOTE': '1', 14:15:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:47 INFO - 'NO_EM_RESTART': '1', 14:15:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:47 INFO - 'PWD': '/builds/slave/test', 14:15:47 INFO - 'SHELL': '/bin/bash', 14:15:47 INFO - 'SHLVL': '1', 14:15:47 INFO - 'TERM': 'linux', 14:15:47 INFO - 'TMOUT': '86400', 14:15:47 INFO - 'USER': 'cltbld', 14:15:47 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', 14:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:47 INFO - '_': '/tools/buildbot/bin/python'} 14:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:47 INFO - Downloading/unpacking blobuploader==1.2.4 14:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:49 INFO - Downloading blobuploader-1.2.4.tar.gz 14:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:15:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:15:49 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 14:15:49 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 14:15:49 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 14:15:49 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 14:15:49 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 14:15:49 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 14:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:15:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:15:49 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 14:15:49 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 14:15:49 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 14:15:49 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 14:15:49 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 14:15:49 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 14:15:50 INFO - Downloading docopt-0.6.1.tar.gz 14:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:15:50 INFO - Installing collected packages: blobuploader, requests, docopt 14:15:50 INFO - Running setup.py install for blobuploader 14:15:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:15:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:15:50 INFO - Running setup.py install for requests 14:15:50 INFO - Running setup.py install for docopt 14:15:50 INFO - Successfully installed blobuploader requests docopt 14:15:50 INFO - Cleaning up... 14:15:50 INFO - Return code: 0 14:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:50 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 0xf05030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c43b0>, '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 0x11c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5740>, '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': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', '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 14:15:50 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 14:15:50 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 14:15:50 INFO - Using env: {'DISPLAY': ':0', 14:15:50 INFO - 'HOME': '/home/cltbld', 14:15:50 INFO - 'LANG': 'en_US.UTF-8', 14:15:50 INFO - 'LANGUAGE': 'en_US:en', 14:15:50 INFO - 'LOGNAME': 'cltbld', 14:15:50 INFO - 'MAIL': '/var/mail/cltbld', 14:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:50 INFO - 'MOZ_NO_REMOTE': '1', 14:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:50 INFO - 'NO_EM_RESTART': '1', 14:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:50 INFO - 'PWD': '/builds/slave/test', 14:15:50 INFO - 'SHELL': '/bin/bash', 14:15:50 INFO - 'SHLVL': '1', 14:15:50 INFO - 'TERM': 'linux', 14:15:50 INFO - 'TMOUT': '86400', 14:15:50 INFO - 'USER': 'cltbld', 14:15:50 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', 14:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:50 INFO - '_': '/tools/buildbot/bin/python'} 14:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:50 INFO - Running setup.py (path:/tmp/pip-DJy97x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:51 INFO - Running setup.py (path:/tmp/pip-lZM1EO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:51 INFO - Running setup.py (path:/tmp/pip-by8_sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:51 INFO - Running setup.py (path:/tmp/pip-kzCLkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:51 INFO - Running setup.py (path:/tmp/pip-h3Ob01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:51 INFO - Running setup.py (path:/tmp/pip-fC_cO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:51 INFO - Running setup.py (path:/tmp/pip-DZpHuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:51 INFO - Running setup.py (path:/tmp/pip-SsI3Ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:51 INFO - Running setup.py (path:/tmp/pip-fvsRha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:51 INFO - Running setup.py (path:/tmp/pip-_YYVgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:51 INFO - Running setup.py (path:/tmp/pip-xqy0Pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:51 INFO - Running setup.py (path:/tmp/pip-s2LOXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:51 INFO - Running setup.py (path:/tmp/pip-BvMXuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:51 INFO - Running setup.py (path:/tmp/pip-xlBpAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:51 INFO - Running setup.py (path:/tmp/pip-gUcV0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:52 INFO - Running setup.py (path:/tmp/pip-BwIL9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:52 INFO - Running setup.py (path:/tmp/pip-bpAIy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:15:52 INFO - Running setup.py install for manifestparser 14:15:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:15:52 INFO - Running setup.py install for mozcrash 14:15:52 INFO - Running setup.py install for mozdebug 14:15:52 INFO - Running setup.py install for mozdevice 14:15:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:15:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:15:52 INFO - Running setup.py install for mozfile 14:15:52 INFO - Running setup.py install for mozhttpd 14:15:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:15:52 INFO - Running setup.py install for mozinfo 14:15:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:15:52 INFO - Running setup.py install for mozInstall 14:15:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:15:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:15:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:15:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:15:52 INFO - Running setup.py install for mozleak 14:15:53 INFO - Running setup.py install for mozlog 14:15:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:15:53 INFO - Running setup.py install for moznetwork 14:15:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:15:53 INFO - Running setup.py install for mozprocess 14:15:53 INFO - Running setup.py install for mozprofile 14:15:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:15:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:15:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:15:53 INFO - Running setup.py install for mozrunner 14:15:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:15:53 INFO - Running setup.py install for mozscreenshot 14:15:53 INFO - Running setup.py install for moztest 14:15:53 INFO - Running setup.py install for mozversion 14:15:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:15:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:15:53 INFO - Cleaning up... 14:15:53 INFO - Return code: 0 14:15:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:53 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 0xf05030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c43b0>, '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 0x11c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5740>, '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': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', '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 14:15:53 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 14:15:53 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 14:15:53 INFO - Using env: {'DISPLAY': ':0', 14:15:53 INFO - 'HOME': '/home/cltbld', 14:15:53 INFO - 'LANG': 'en_US.UTF-8', 14:15:53 INFO - 'LANGUAGE': 'en_US:en', 14:15:53 INFO - 'LOGNAME': 'cltbld', 14:15:53 INFO - 'MAIL': '/var/mail/cltbld', 14:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:53 INFO - 'MOZ_NO_REMOTE': '1', 14:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:53 INFO - 'NO_EM_RESTART': '1', 14:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:53 INFO - 'PWD': '/builds/slave/test', 14:15:53 INFO - 'SHELL': '/bin/bash', 14:15:53 INFO - 'SHLVL': '1', 14:15:53 INFO - 'TERM': 'linux', 14:15:53 INFO - 'TMOUT': '86400', 14:15:53 INFO - 'USER': 'cltbld', 14:15:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', 14:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:53 INFO - '_': '/tools/buildbot/bin/python'} 14:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:54 INFO - Running setup.py (path:/tmp/pip-qdrhFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:54 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)) 14:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:54 INFO - Running setup.py (path:/tmp/pip-JsGtKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:54 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)) 14:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:54 INFO - Running setup.py (path:/tmp/pip-DN4mzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:54 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)) 14:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:54 INFO - Running setup.py (path:/tmp/pip-sua7HU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:54 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)) 14:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:54 INFO - Running setup.py (path:/tmp/pip-YkOjX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:54 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)) 14:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:54 INFO - Running setup.py (path:/tmp/pip-jZpCQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:54 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)) 14:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:54 INFO - Running setup.py (path:/tmp/pip-L7xY7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:54 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)) 14:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:54 INFO - Running setup.py (path:/tmp/pip-B8WFDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:54 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)) 14:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:54 INFO - Running setup.py (path:/tmp/pip-9UdVrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:54 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)) 14:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:54 INFO - Running setup.py (path:/tmp/pip-fPAWuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:54 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)) 14:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:54 INFO - Running setup.py (path:/tmp/pip-dSpLEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:54 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)) 14:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:54 INFO - Running setup.py (path:/tmp/pip-DEI7IU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:55 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)) 14:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:55 INFO - Running setup.py (path:/tmp/pip-oFoA9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:55 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)) 14:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:55 INFO - Running setup.py (path:/tmp/pip-k2Tfv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:55 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)) 14:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:55 INFO - Running setup.py (path:/tmp/pip-ZXSejm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:55 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)) 14:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:55 INFO - Running setup.py (path:/tmp/pip-uVcOJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:55 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)) 14:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:55 INFO - Running setup.py (path:/tmp/pip-Gl0JQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:55 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)) 14:15:55 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)) 14:15:55 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)) 14:15:55 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)) 14:15:55 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)) 14:15:55 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)) 14:15:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:15:55 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 14:15:55 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 14:15:55 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 14:15:55 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 14:15:55 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 14:15:55 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 14:15:57 INFO - Downloading blessings-1.6.tar.gz 14:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:15:57 INFO - Installing collected packages: blessings 14:15:57 INFO - Running setup.py install for blessings 14:15:57 INFO - Successfully installed blessings 14:15:57 INFO - Cleaning up... 14:15:57 INFO - Return code: 0 14:15:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:15:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:15:57 INFO - Reading from file tmpfile_stdout 14:15:57 INFO - Current package versions: 14:15:57 INFO - argparse == 1.2.1 14:15:57 INFO - blessings == 1.6 14:15:57 INFO - blobuploader == 1.2.4 14:15:57 INFO - docopt == 0.6.1 14:15:57 INFO - functools32 == 3.2.3-2 14:15:57 INFO - jsonschema == 2.5.1 14:15:57 INFO - manifestparser == 1.1 14:15:57 INFO - mozInstall == 1.12 14:15:57 INFO - mozcrash == 0.17 14:15:57 INFO - mozdebug == 0.1 14:15:57 INFO - mozdevice == 0.48 14:15:57 INFO - mozfile == 1.2 14:15:57 INFO - mozhttpd == 0.7 14:15:57 INFO - mozinfo == 0.9 14:15:57 INFO - mozleak == 0.1 14:15:57 INFO - mozlog == 3.3 14:15:57 INFO - moznetwork == 0.27 14:15:57 INFO - mozprocess == 0.23 14:15:57 INFO - mozprofile == 0.28 14:15:57 INFO - mozrunner == 6.12 14:15:57 INFO - mozscreenshot == 0.1 14:15:57 INFO - mozsystemmonitor == 0.3 14:15:57 INFO - moztest == 0.7 14:15:57 INFO - mozversion == 1.4 14:15:57 INFO - psutil == 3.1.1 14:15:57 INFO - requests == 1.2.3 14:15:57 INFO - wsgiref == 0.1.2 14:15:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:57 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')]} 14:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:57 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')]} 14:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:57 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 0xf05030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c43b0>, '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 0x11c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5740>, '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': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', '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 14:15:57 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 14:15:57 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 14:15:57 INFO - Using env: {'DISPLAY': ':0', 14:15:57 INFO - 'HOME': '/home/cltbld', 14:15:57 INFO - 'LANG': 'en_US.UTF-8', 14:15:57 INFO - 'LANGUAGE': 'en_US:en', 14:15:57 INFO - 'LOGNAME': 'cltbld', 14:15:57 INFO - 'MAIL': '/var/mail/cltbld', 14:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:57 INFO - 'MOZ_NO_REMOTE': '1', 14:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:57 INFO - 'NO_EM_RESTART': '1', 14:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:57 INFO - 'PWD': '/builds/slave/test', 14:15:57 INFO - 'SHELL': '/bin/bash', 14:15:57 INFO - 'SHLVL': '1', 14:15:57 INFO - 'TERM': 'linux', 14:15:57 INFO - 'TMOUT': '86400', 14:15:57 INFO - 'USER': 'cltbld', 14:15:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', 14:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:57 INFO - '_': '/tools/buildbot/bin/python'} 14:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 INFO - Cleaning up... 14:15:57 INFO - Return code: 0 14:15:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:15:57 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')]} 14:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:57 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')]} 14:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:57 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 0xf05030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c43b0>, '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 0x11c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5740>, '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': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', '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 14:15:57 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 14:15:57 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 14:15:57 INFO - Using env: {'DISPLAY': ':0', 14:15:57 INFO - 'HOME': '/home/cltbld', 14:15:57 INFO - 'LANG': 'en_US.UTF-8', 14:15:57 INFO - 'LANGUAGE': 'en_US:en', 14:15:57 INFO - 'LOGNAME': 'cltbld', 14:15:57 INFO - 'MAIL': '/var/mail/cltbld', 14:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:57 INFO - 'MOZ_NO_REMOTE': '1', 14:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:57 INFO - 'NO_EM_RESTART': '1', 14:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:57 INFO - 'PWD': '/builds/slave/test', 14:15:57 INFO - 'SHELL': '/bin/bash', 14:15:57 INFO - 'SHLVL': '1', 14:15:57 INFO - 'TERM': 'linux', 14:15:57 INFO - 'TMOUT': '86400', 14:15:57 INFO - 'USER': 'cltbld', 14:15:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', 14:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:57 INFO - '_': '/tools/buildbot/bin/python'} 14:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:15:58 INFO - Cleaning up... 14:15:58 INFO - Return code: 0 14:15:58 INFO - Running post-action listener: _resource_record_post_action 14:15:58 INFO - Running post-action listener: _start_resource_monitoring 14:15:58 INFO - Starting resource monitoring. 14:15:58 INFO - [mozharness: 2016-08-07 21:15:58.231029Z] Finished create-virtualenv step (success) 14:15:58 INFO - [mozharness: 2016-08-07 21:15:58.231508Z] Running install step. 14:15:58 INFO - Running pre-action listener: _resource_record_pre_action 14:15:58 INFO - Running main action method: install 14:15:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:15:58 INFO - Reading from file tmpfile_stdout 14:15:58 INFO - Detecting whether we're running mozinstall >=1.0... 14:15:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:15:58 INFO - Reading from file tmpfile_stdout 14:15:58 INFO - Output received: 14:15:58 INFO - Usage: mozinstall [options] installer 14:15:58 INFO - Options: 14:15:58 INFO - -h, --help show this help message and exit 14:15:58 INFO - -d DEST, --destination=DEST 14:15:58 INFO - Directory to install application into. [default: 14:15:58 INFO - "/builds/slave/test"] 14:15:58 INFO - --app=APP Application being installed. [default: firefox] 14:15:58 INFO - mkdir: /builds/slave/test/build/application 14:15:58 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'] 14:15:58 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 14:16:17 INFO - Reading from file tmpfile_stdout 14:16:17 INFO - Output received: 14:16:17 INFO - /builds/slave/test/build/application/firefox/firefox 14:16:17 INFO - Running post-action listener: _resource_record_post_action 14:16:17 INFO - [mozharness: 2016-08-07 21:16:17.218212Z] Finished install step (success) 14:16:17 INFO - [mozharness: 2016-08-07 21:16:17.218459Z] Running run-tests step. 14:16:17 INFO - Running pre-action listener: _resource_record_pre_action 14:16:17 INFO - Running main action method: run_tests 14:16:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:16:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:16:17 INFO - Python 2.7.3 14:16:17 INFO - Return code: 0 14:16:17 INFO - grabbing minidump binary from tooltool 14:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:17 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 0x11c43b0>, '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 0x11c52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c5740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:16:17 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 14:16:17 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 14:16:17 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 14:16:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:16:17 INFO - Return code: 0 14:16:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:16:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:16:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:16:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:16:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:16:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 14:16:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 14:16:17 INFO - Using env: {'DISPLAY': ':0', 14:16:17 INFO - 'HOME': '/home/cltbld', 14:16:17 INFO - 'LANG': 'en_US.UTF-8', 14:16:17 INFO - 'LANGUAGE': 'en_US:en', 14:16:17 INFO - 'LOGNAME': 'cltbld', 14:16:17 INFO - 'MAIL': '/var/mail/cltbld', 14:16:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:16:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:17 INFO - 'MOZ_NO_REMOTE': '1', 14:16:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:17 INFO - 'NO_EM_RESTART': '1', 14:16:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:17 INFO - 'PWD': '/builds/slave/test', 14:16:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:16:17 INFO - 'SHELL': '/bin/bash', 14:16:17 INFO - 'SHLVL': '1', 14:16:17 INFO - 'TERM': 'linux', 14:16:17 INFO - 'TMOUT': '86400', 14:16:17 INFO - 'USER': 'cltbld', 14:16:17 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470595898.412628-430910497', 14:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:17 INFO - '_': '/tools/buildbot/bin/python'} 14:16:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 14:16:17 INFO - mozversion application_buildid: 20160807113002 14:16:17 INFO - mozversion application_changeset: 204b39c31233c082553493f52bfe8c3ebcc404ff 14:16:17 INFO - mozversion application_display_name: Nightly 14:16:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:16:17 INFO - mozversion application_name: Firefox 14:16:17 INFO - mozversion application_remotingname: firefox 14:16:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:16:17 INFO - mozversion application_vendor: Mozilla 14:16:17 INFO - mozversion application_version: 51.0a1 14:16:17 INFO - mozversion platform_buildid: 20160807113002 14:16:17 INFO - mozversion platform_changeset: 204b39c31233c082553493f52bfe8c3ebcc404ff 14:16:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:16:17 INFO - mozversion platform_version: 51.0a1 14:16:17 INFO - using testdate: 1470604577 14:16:17 INFO - actual date: 1470604577 14:16:17 INFO - starting webserver on 'localhost:51753' 14:16:17 INFO - SUITE-START | Running 2 tests 14:16:17 INFO - TEST-START | dromaeo_css 14:16:17 INFO - operating with platform_type : linux_ 14:16:17 INFO - Initialising browser for dromaeo_css test... 14:16:17 INFO - TEST-INFO | started process 25710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr3UZMw/profile http://localhost:51753/getInfo.html) 14:16:22 INFO - PROCESS | 25710 | __metrics Screen width/height:1600/1200 14:16:22 INFO - PROCESS | 25710 | colorDepth:24 14:16:22 INFO - PROCESS | 25710 | Browser inner width/height: 1024/697 14:16:22 INFO - PROCESS | 25710 | __metrics 14:16:23 INFO - PROCESS | 25710 | 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" 14:16:23 INFO - PROCESS | 25710 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:16:23 INFO - PROCESS | 25710 | console.error: PushService: 14:16:23 INFO - PROCESS | 25710 | stateChangeProcessEnqueue: Error transitioning state 14:16:23 INFO - PROCESS | 25710 | UnknownError 14:16:24 INFO - TEST-INFO | 25710: exit 0 14:16:24 INFO - Browser initialized. 14:16:24 INFO - Running cycle 1/1 for dromaeo_css test... 14:16:24 INFO - TEST-INFO | started process 25795 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr3UZMw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:16:35 INFO - PROCESS | 25795 | RSS: Main: 156639232 14:16:35 INFO - PROCESS | 25795 | 14:17:27 INFO - PROCESS | 25795 | 1470604647381 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] 14:19:36 INFO - PROCESS | 25795 | Cycle 1(1): loaded http://localhost:51753/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51753/tests/dromaeo/cssquery-ext.html) 14:19:37 INFO - PROCESS | 25795 | RSS: Main: 246419456 14:19:37 INFO - PROCESS | 25795 | 14:22:39 INFO - PROCESS | 25795 | Cycle 1(1): loaded http://localhost:51753/tests/dromaeo/cssquery-ext.html (next: http://localhost:51753/tests/dromaeo/cssquery-jquery.html) 14:22:40 INFO - PROCESS | 25795 | RSS: Main: 246759424 14:22:40 INFO - PROCESS | 25795 | 14:25:42 INFO - PROCESS | 25795 | Cycle 1(1): loaded http://localhost:51753/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51753/tests/dromaeo/cssquery-mootools.html) 14:25:43 INFO - PROCESS | 25795 | RSS: Main: 190222336 14:25:43 INFO - PROCESS | 25795 | 14:28:45 INFO - PROCESS | 25795 | Cycle 1(1): loaded http://localhost:51753/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51753/tests/dromaeo/cssquery-prototype.html) 14:28:45 INFO - PROCESS | 25795 | RSS: Main: 231370752 14:28:45 INFO - PROCESS | 25795 | 14:31:48 INFO - PROCESS | 25795 | Cycle 1(1): loaded http://localhost:51753/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51753/tests/dromaeo/cssquery-yui.html) 14:31:49 INFO - PROCESS | 25795 | RSS: Main: 191799296 14:31:49 INFO - PROCESS | 25795 | 14:34:51 INFO - PROCESS | 25795 | Cycle 1(1): loaded http://localhost:51753/tests/dromaeo/cssquery-yui.html (next: http://localhost:51753/tests/dromaeo/cssquery-dojo.html) 14:34:52 INFO - PROCESS | 25795 | RSS: Main: 283713536 14:34:52 INFO - PROCESS | 25795 | 14:34:52 INFO - PROCESS | 25795 | __start_tp_report 14:34:52 INFO - PROCESS | 25795 | _x_x_mozilla_page_load 14:34:52 INFO - PROCESS | 25795 | _x_x_mozilla_page_load_details 14:34:52 INFO - PROCESS | 25795 | |i|pagename|runs| 14:34:52 INFO - PROCESS | 25795 | |0;dojo.html;3050.4356694011594;3059.174023013786;3107.875684972601;3109.9533506997386;3124.390743804959;5161.612879034078;5193.558547523456;5211.2704221408985;5284.022455845671;5296.973515132424;5263.526282634562;5302.257683924254;5323.574114070875;5336.30628018357;5389;4769.213079841822;4839.637027222955;4844.07962487128;4855.611551075923;4958.6281028922795;4879.926801097987;4898.4366797818175;4907.165781817082;4909.3126962225315;4925.039617274633;4771.141194584973;4814.75926203692;4856.1016212000895;4860.076585448789;4861.270809378586;4812.807487700487;4815.036992601494;4826.396700412449;4836.347093142416;4947.158982972867;4842.346283251786;4860.975695121501;4878.341423907763;4886.780094895738;4917.188663870457;5184;5202.661826981234;5249.186376111708;5263.789448422059;5332.386775520826;5628.774849006035;5683.744231509592;5697.77208911643;5703.7148142592705;5710.600257981943;5734.913976290359;5735.684537350486;5752;5759.452851979097;5767.480926716574;5155.53600175986;5214.687118772886;5262.500062494057;5266.657667251617;5360.3299587551555;5785.739641716133;5846.269216347957;5846.532277417881;5849.853753656193;5850.034744267148;5586.776528938797;5589.664620122806;5622.887542249132;5629;5643.294588176478;5452.509274165344;5605.271314729059;5644.8306550803545;5650.265465489542;5732.226149469769;5655.3779084300695;5657.2928383952;5657.971710141423;5659.745311460912;5663.348714897757;5640.633358831663;5673.00722373583;5686.118651608925;5688.8862222755315;5690.174924635905;4250.511191212988;4316.460442444694;4317.892052698645;4376.387305777193;4379.1022840317655;3870.6903447724117;3899.3566061599518;3931.5085614298214;3948.6643635290748;3950.861719839792;5414.3232095988005;5418.160185171305;5422.349318081855;5437.864053398617;5465.262189604432;5657.4908258256955;5657.886842263214;5658.519025882763;5660.320761508646;5701.629394089371;5191.091558977164;5366.758495867695;5408.215808707715;5427.511523962862;5444.91832622511;4978.303037574742;4983.8006479741125;4988.102141614471;5014.398272207359;5031.723255220998;5882.49998750111;5895.675737834375;5898.616589921641;5901.232839730807;5903.173555702205;5345.091334473227;5604.439556044363;5694.288213973254;5702.714864256687;5726.570507211893;5810.854728631818;5871.500922421471;5875.882482350244;5925.140854576149;5932.525397968238;5634.352049514358;5635.577331700221;5640.097584386478;5642.040853054908;5645.435456454322;5486.61593688438;5614.07367784311;5720.456556627114;5729.054705973468;5730.968425683417;5490.670559766427;5584.4136365681015;5587.106063029895;5622.184783206494;5640.125780504029;5514.117741161395;5557;5557.138643510262;5558;5558.221848941233;5274.97362513185;5419;5483.945160548344;5502.889942201214;5551.306086739158;5544.889102218014;5584.106542953108;5585.944140558542;5628.127640215773;5639.097744360883;5433.755481003285;5438.728063596725;5441.102218134122;5445.972770136124;5451.318585176853 14:34:52 INFO - PROCESS | 25795 | |1;ext.html;595.7438301530342;600.8287638023162;610.435347303744;618.8669436071247;643.1863692429075;44224.33663495046;45954.851128721755;45968.770156149214;50170.49829501704;50197;47983;48568.2714759278;48598;48617.54147375576;48638.51361486384;9031.819363612723;9178.403403778766;9181.58682859273;9182.816343673123;9183.678571250008;8983.19151276385;8989.820203595924;9054.77363065922;9076.31927605429;9078.591463384164;9103.36276460648;9135.95432022839;9139.68011119611;9147.268218542535;9153;8994.820103597924;9012.053734357929;9016.819663606724;9043.276537876955;9114.225290850285;9003.864942025875;9081.45511269326;9087.454752714859;9091;9093.181613654737;44425.77787111044;44770.55229447696;44820.10359792786;44837.327440088426;44937.775311123565;3570.1967057412135;3585.3367127081574;3628.183658676803;3673.045008297835;3870.2066076454257;33701.83149084263;34943;34974.65025349739;35017;35232.471512927325;4349.534653514625;4511.684182107254;4512.751798651073;4649.070185962787;4666.043461090502;361326;364205;364548.1772591147;364590;365895;62133.68933155396;62489.37510624927;62699.37300627027;62728.37271627317;62782.68608656927;64476;64577.67711161414;64668.35331646623;64683;64733;16998.660026799396;17204.483865484057;17219.741703874453;17233.741493877602;17239.310427582757;11999.400029998465;12008.699782505333;12017.819732704016;12028.15802893789;12059.457324420422;14209.573712788633;17889.552761181076;18193.45419637413;18350.265989360276;18396.63206735858;5636.661800291996;6583.769568065095;6761.594304341756;6795;6845.452363810983;930.9767255818658;957.9760505987267;1035.7255327338262;1121.5527362617195;1201.9158658893793;32552.348953020806;33029;33217.3356532868;33275.66724332774;33605.643711017445;1123.7471568896933;1127.9774404512027;1153.2676750263643;1196.3719047499958;1209.564556759566;16827.242774075195;17505.824941750674;17642.735358969625;17929.72120562963;19220.903895480435;529998;534705;534910;535564;535847;61827;62155.68922155451;62268.37731622716;62358.688206558676;62375.376246236956;1254.4417734108233;1318.5516924245803;1319.9934000329936;1388.7986241995056;1429.1496559547054;26860.59709104326;35535.46696799498;35720.82139589285;35963.64036359603;36088.4586731194;59416;59785;59929;60084;60186.097208542786;498959;500069;501511;502704;504889;29234;30159;30420.543691845083;30595;30608.387832243676;49869.50130498649;50465.74767126141;51768.48231517787;52191;52671.209931851816;40220.39669404903;43360.349594756735;43848.123037539706;44090;44636.33045504255;42081.78959105185;42886.78556607197;43076.78461607797;44736.328955066354;44990;42396.57603423926;42663.5733642672;42869.14261714811;43061.78469107635;43193;35965.82017090003;37852;38613.80693096516;38628;38992;28095.157145285673;28616.855325786735;29187.270318242216;29646;29661.25846853846 14:34:52 INFO - PROCESS | 25795 | |2;jquery.html;362.99455508167364;370.57939238963786;387.8138493523109;396.8055652730163;420.82115101082053;17054.317827286908;19617.215311387547;19730.112144953477;20494.692579611317;20500.794992050076;19438.125284362202;19705.113269902853;19925.103370348334;19932.90033549834;20123.29568465104;5420.864478388052;5620.522255608268;5821.6507009579345;5851.268591426072;5867.677277749722;5783.913241301384;5799.18811366409;5839.737211825478;5840.06558950568;5843.737031833578;5588.133839254922;5767.567432442563;5827.242458480391;5831.446012628815;5831.912521312183;5727.828165155052;5754.482096611304;5792.913106303409;5799.159121927318;5803.564732645069;4898.314236006961;4995.275685025687;5021.49785021495;5025.271335656346;5025.296458495814;24388.512229755484;24502.754972450224;24756.876215618806;24916.626250606256;24979.375515612253;2427.5023620157826;2482.1064416809936;2545.325488745484;2968.257935516121;3174.9841250793597;10010.749731256705;10557.630482933137;10679.092277156451;10705.46472676363;10821;1824.5803465202946;1915.530694979725;1934.951626209356;1958.2362878477404;2052.7639321478073;81146;84876;86607.56696216541;87888;89573;10033.397996120257;10505.107065899485;10562.788744225227;10667.199960002876;11336.829947550794;15198;15200.08799472013;15200.239988000556;15258.847411525743;15277.236138193046;8140.389470789596;8376.916230837614;8473.661053557911;8566.78583035429;8691.739247822576;7287.562746235243;7376.889346659805;7609.277118673828;8087.150849160871;8382.664693412316;4721.811127554859;4764.76176191196;4780.689255198401;4915.926261106087;5040.546350828443;1835.2934120363757;1890.4706682129026;1893.5644801695687;1907.437305994735;1931.4688460673426;929.0848514213494;980.7155924781877;1027.984580231297;1056.5932116135343;1081.8039380058494;19413.4175974721;20102.798972010387;20200;20244.89877550603;20541.48646283825;940.9576569054409;950.4012472142645;1005.8893521712606;1014.9594016239267;1021.9335743176819;10743.677689669323;11125.276857004268;11167.72080697989;11236.438178091063;11240.943795280971;418001;431360;455296.7235163803;456189;458121;76138.61930690311;76756;99087.00912990922;101548;103258.96741032644;984.7291994701515;998.4558415663481;1000.5347513406301;1003.3127307794184;1012.9341592796445;17481.737773933655;17999.66004419417;18446.35437759672;18501.44495665132;18804.435866924014;45740;46718.76640616911;46943.530564695284;47393.76303118462;47416.52583474259;62896;62946.37053629405;64163;64613.35386646073;65345.673271633335;8502.404831661725;8574.142585741376;8686.91313086861;8697.52163630981;8803.207711306013;8668.913310867063;9832.950835245778;13108.279044652636;13523.188608683511;13793;11840.822387664364;11857.52569897229;11906.642800715992;12067.155299128977;12324.876751232372;11121.443927803739;11616.477258523219;11830.526778928746;11968.16222864391;12165.69585760363;11705.356205408785;11717.88282117168;11846.585369512026;11925.701857453287;12102.092343074128;8418.242358187792;8587.785305367415;8627.352948529011;8805.471671699719;8813.823723525365;10659.520321585393;11558.826617600575;11831.940840295743;11914.642560723192;12067.09496787762 14:34:52 INFO - PROCESS | 25795 | |3;mootools.html;1456.519348614957;1496.289262600265;1586.5478338673481;1736.6613510365485;1791.185010820077;8644.956775216124;9381.202597779196;9387.249020078403;9392.530373481315;9403.529823508823;7847.92152078479;8532.232099111094;8848.601812918418;8855.335849811258;9215.308851836106;2411.457422080031;2435.476372579895;2435.8782060896974;2445.2419749877595;2446.7920226780657;2407.1334319644916;2423.0307876849224;2438.780509754122;2440.5728997425467;2450.803935685141;2330.9184178553755;2340.4265954841003;2415.5893498105274;2450.3996520852415;2454.312792418126;2350.318407661776;2351.235848349285;2353.976460235393;2355.564220619191;2394.0902457066377;2340.3447034830274;2364.054378248697;2374.03851440167;2375.7386687464364;2375.9881200593886;9113.362064655477;9127.406718563272;9232.30757693169;9235.907640923571;9237.676681316188;5229.712365819878;5351.973240133774;5353.652012619167;5357.249985002103;5367.43641917597;3475.061733331986;3501.7373696972827;3541.274038822061;3549.219171782204;3593.784372937606;1144.067584918289;1144.2791041643795;1178.9410529473491;1182.2020136407891;1198.4726720243152;12842.550510732173;12879.356032198446;12970.87029129706;12980.870191298061;13006.34968251593;4417.889552761207;4674.5325467452985;4768.594669453066;4889.608831293559;4893.437254715682;10749.570017199381;10778.407187604756;10780.407077610807;10782.46087695612;10793;5367.1412573988755;5384.461553844584;5400.675959442446;5401.621886467988;5404.756785944642;4062.939055914164;4313.374560688745;4459.331100334975;4844.467108618049;4992.201247800407;4174.373843923436;4188.4136220928485;4194.098268872146;4284.592963668447;4289.356596510486;1305.3538498443331;1309.59402585197;1317.743040107189;1319.6766792135795;1342.838859336886;916.4180745226829;942.4345392764286;947.9383840050513;952.6713283917038;1003.4380746781826;6131.344536975081;6132.6627035513475;6285.96857015712;6338.112664227012;6352.650604216812;474.7270319566263;475.43185892858395;478.5095277340684;487.2958574859365;489.55695095938233;4261;4265.594768496988;4289.978550107292;4290.957090429119;4303.806328715215;10770.353778773298;11346.319220846775;11349.148813838996;11351.205415620992;11395.145364097725;10604.469776511143;11144.052755515871;11265.831012534818;11278.774424511465;11296.717582060513;8383.664653413794;8572.571371431404;8604.35467339952;8607.483550986835;8609.741707748777;6017.729202185999;6183.350748171377;6275.592086514362;6382.5532212744665;6485.9946708260295;10004.749881253027;10132.949335253277;10324.122449591869;10515.263931525025;10517.579296828042;8856.822863542564;10505.9474702626;10567.418791966209;10756.784864302514;10817.945910270399;7484.513506622052;7963.761087167394;8047.798805029921;8310.418270720991;8315.667373305;8468.068512463748;8754.21212090915;8773.341999349946;8845.115488451362;8924.375293729376;7955.761327160194;7962;7989.161138080418;8116.350691944748;8121.431499794958;7669.539827610138;7834.882476762739;7850.685972561034;7862.803429914298;7994.5602991836;7244.927550724636;7246.746363877239;7252.166000909963;7309.049823522908;7310.122785265802;5051.3433253676785;5200.869978250574;5235.973820130875;5302.443243459381;5356.732163391737;5192.143296356059;5195.75265459088;5216.452272511332;5258.553022992935;5437.4018857926385 14:34:52 INFO - PROCESS | 25795 | |4;prototype.html;283.57746957034027;298.28858173256776;302.6942787784337;317.993550412943;321.4182329982731;5114.28400023997;5125.615578831584;5145.922811157836;5151.76817043233;5152.737579293069;4894.583960363365;4939.431965323989;5046.747662616864;5069.340985671857;5141.588672906168;4059.6955228357842;4076;4078.8164532595956;4081.9183616327655;4101.6308532232015;4079.9796001019954;4083.9387409188885;4085.7957102144924;4111.321631930728;4134.421181034658;3869.593692662258;3873.4577159197734;4045.312296909518;4069.837206511736;4112.300908845488;4022.617851304151;4027.0939038716347;4036.2129384769983;4046.372812214097;4080.6123418275365;3604.4232922732235;3627.8548858045647;3628.2743451309843;3629.4374371972385;3630.473581330719;4776.641751868624;4990.575801056914;5009.599232061463;5015.3730783652045;5040.193569028975;4554.294084416921;4558.749268790215;4571.702839315467;4574.820499752674;4597.678162528624;5343.171808369709;5344.038073146832;5351.598630102758;5372.516473517363;5378.381486129106;3755.661990420848;3836.2327534492933;3846.442265871461;3846.942295865564;3864.7294689371756;5400.513953744143;5516.7517461714315;5521.1442226454965;5521.972390138064;5525.309336332958;3918.921621567553;3939.3697008478507;3944.487216661873;3948.262764383662;3977.54258260298;3970.305196590585;3970.9205815884097;3971.483707118114;3973.1259122992897;3973.7417067890497;4352.934705979413;4499.437570303712;4520.796564154555;4526.434195725535;4541.3188021797;5372.5970552207955;5379.462053794589;5395.433479484597;5400.567954563626;5409.540189083972;1360.3062438156612;1373.8007988841562;1374.5601407549489;1375.1817668487233;1376.898481215024;866.6879923227633;901.2249465459699;917.8026724254318;920.7928216151446;931.7856892914532;5132.28148059272;5135.204043373283;5139.768710407966;5151.536361727388;5165.612579056586;5351.224072509543;5351.919721204107;5366.651167674167;5388.225064091996;5435.266239057755;4919.508049195052;5144.202648589475;5151.304573882553;5154.788624673199;5197.324347834758;2826.816256943292;2834.7888646855486;2843.824474277138;2846.644169478815;2858.285428642839;5498.206237695977;5524.447555244524;5550.361708403585;5586.86032849182;5597.608167428322;5336.546393556591;5429.484199001088;5436.075867102523;5444.428335024844;5479;5484.39491241657;5506.889862202734;5511.972440137773;5523.226748255248;5543.501084902378;5179.45615710345;5354.625176237626;5381.165919282361;5389.568834493152;5396.676199428047;5327.893442131213;5334.266363431822;5364.490373414519;5368.557306425645;5380.784768609368;5505.338949598472;5521.199426083276;5524.447555244444;5538.587660146637;5573.498385145356;3861.362875125573;3899.883003509899;3912.5696173420333;3939.625735555118;3950.1309711863346;5195.402528709095;5277.788888444419;5336.946630533645;5395.298611180521;5396.64921780083;5276.788928442819;5285.810692594136;5298.523132918056;5312.362516498045;5318.9628022535235;5311.840644780663;5336.918601745245;5342.6260161788305;5350.438203988525;5353.491418315254;5154.201098829687;5162.664426812245;5204.2974198484235;5220.321358223407;5234.712090835041;5248.343957005374;5254.710990895537;5285.656432331886;5288.629795914403;5341.5459685927135;5033.144365457808;5234.319538459976;5253.9211911820585;5263.552598029058;5283.498067683564 14:34:52 INFO - PROCESS | 25795 | |5;yui.html;680.2347359220877;701.0395757811801;722.9674664640094;732.1397358104226;764.4495962906706;16237.188140592967;17110.657786844273;17335.13324333783;17841.553961150945;17895.91052044741;16869.83130168701;17216.483505494823;17221.82778172218;17237.655246895054;17240.82759172408;786.5949036246324;810.5582457560644;814.2793627639522;814.4380377539479;815.0504662068682;656.2125449460642;769.3537428560008;792.5363662257586;798.1858504325585;800.5836964778312;853.1298075962515;854.5855260198798;854.8845905802731;855.4012191465968;855.820277741675;845.247729520727;845.6828689241535;846.5047946951041;846.8687353460255;846.8856704344896;502.7260143221953;584.1733946465788;596.6986671730748;599.3497055694532;600.627610881252;15364.615884602974;15369.154696491689;15412.922935385364;16034.438794642248;16074.035557866566;13912.30438478072;14123.929380353135;14328.211948342838;14698.118112913153;14778.778318325234;13594.38825252866;13603.387847546785;13653.522126725517;13771;14130.929345353208;4608.33179189019;4611.654125940534;4654.325122857167;4659.32439796231;4717.622590192776;88157;88577;88954.11045889523;90038;90968;11968.341741204144;12099.516019359127;12149.210301330386;12205.20666156697;12246.755064898653;22191.66712499314;22229.666555001688;22256.666150007764;22291.55416891653;22448.775512244996;8758;8806.427582207136;8853.955730221307;9018.008019117891;9117.361784675142;4833.32333473314;5026.974865125724;5107.514786095315;5271.262023316739;5276.657017293864;3589.210373717778;3653.397189463762;3679.9080022999105;3690.7785532868115;3702.092987218095;601.590918175636;605.0470508948424;617.4165413684116;619.6096459230656;624.2976651267325;617.8795134948732;644.0371644391664;700.0863872646246;704.3344039882262;719.022129903331;9000.819983600422;9262.72211833646;9379.437233765995;9452.763680907894;9782.51087445625;567.5629765080947;597.9581429299994;599.5143933413949;622.4211483320555;636.1888592045179;4623.838165664186;4682.531746825291;4718.363020992122;4725.125851717443;4814.807407703653;130760.3461982703;130951.34524327317;131166;131953;132971;68808.6559567199;82732.17267827244;111287;113153;117884;96724;96766.51616741871;96784.51607741916;98611.50694246627;100617;8717.694880679146;8764;8802.38383313162;8814.294856411343;9095.954520227357;55175.17237241525;56352;56732.71633641805;56783.71608142098;57015;74111.51776964539;83755.5812220935;83924;85335.57332213299;86689.56655216936;12118.636440906786;12238.204516706743;12281.385930703607;12289;12809.167404118702;12691.492340306284;13296.202227866359;13433.462661493431;13523.526676566273;13997.230152341719;12889.291088990196;13034.250694606717;13110;13293;13876.791848122488;12615.425792925202;12934;13060.80408793888;13176.143550669176;13254.337283135612;12760.361981900682;13009.609711708665;13140.277284749049;13140.408681609159;13577.11748736329;10716.142708583138;10778.407187604756;10963.397013164353;11024.448777560929;11379.658610241706;10791.298565593212;10855.84347434962;10933.781324373627;11049.392283424168;11178.161637877354 14:34:52 INFO - PROCESS | 25795 | __end_tp_report 14:34:52 INFO - PROCESS | 25795 | __start_cc_report 14:34:52 INFO - PROCESS | 25795 | _x_x_mozilla_cycle_collect,894 14:34:52 INFO - PROCESS | 25795 | __end_cc_report 14:34:52 INFO - PROCESS | 25795 | __startTimestamp1470605692235__endTimestamp 14:34:52 INFO - PROCESS | 25795 | 14:34:52 INFO - PROCESS | 25795 | ------- Summary: start ------- 14:34:52 INFO - PROCESS | 25795 | Number of tests: 6 14:34:52 INFO - PROCESS | 25795 | 14:34:52 INFO - PROCESS | 25795 | [#0] dojo.html Cycles:165 Average:5282.27 Median:5452.51 stddev:590.62 (10.8%) stddev-sans-first:565.88 14:34:52 INFO - PROCESS | 25795 | Values: 3050.4 3059.2 3107.9 3110.0 3124.4 5161.6 5193.6 5211.3 5284.0 5297.0 5263.5 5302.3 5323.6 5336.3 5389.0 4769.2 4839.6 4844.1 4855.6 4958.6 4879.9 4898.4 4907.2 4909.3 4925.0 4771.1 4814.8 4856.1 4860.1 4861.3 4812.8 4815.0 4826.4 4836.3 4947.2 4842.3 4861.0 4878.3 4886.8 4917.2 5184.0 5202.7 5249.2 5263.8 5332.4 5628.8 5683.7 5697.8 5703.7 5710.6 5734.9 5735.7 5752.0 5759.5 5767.5 5155.5 5214.7 5262.5 5266.7 5360.3 5785.7 5846.3 5846.5 5849.9 5850.0 5586.8 5589.7 5622.9 5629.0 5643.3 5452.5 5605.3 5644.8 5650.3 5732.2 5655.4 5657.3 5658.0 5659.7 5663.3 5640.6 5673.0 5686.1 5688.9 5690.2 4250.5 4316.5 4317.9 4376.4 4379.1 3870.7 3899.4 3931.5 3948.7 3950.9 5414.3 5418.2 5422.3 5437.9 5465.3 5657.5 5657.9 5658.5 5660.3 5701.6 5191.1 5366.8 5408.2 5427.5 5444.9 4978.3 4983.8 4988.1 5014.4 5031.7 5882.5 5895.7 5898.6 5901.2 5903.2 5345.1 5604.4 5694.3 5702.7 5726.6 5810.9 5871.5 5875.9 5925.1 5932.5 5634.4 5635.6 5640.1 5642.0 5645.4 5486.6 5614.1 5720.5 5729.1 5731.0 5490.7 5584.4 5587.1 5622.2 5640.1 5514.1 5557.0 5557.1 5558.0 5558.2 5275.0 5419.0 5483.9 5502.9 5551.3 5544.9 5584.1 5585.9 5628.1 5639.1 5433.8 5438.7 5441.1 5446.0 5451.3 14:34:52 INFO - PROCESS | 25795 | 14:34:52 INFO - PROCESS | 25795 | [#1] ext.html Cycles:180 Average:63853.73 Median:44795.33 stddev:125230.44 (279.6%) stddev-sans-first:125491.68 14:34:52 INFO - PROCESS | 25795 | Values: 595.7 600.8 610.4 618.9 643.2 44224.3 45954.9 45968.8 50170.5 50197.0 47983.0 48568.3 48598.0 48617.5 48638.5 9031.8 9178.4 9181.6 9182.8 9183.7 8983.2 8989.8 9054.8 9076.3 9078.6 9103.4 9136.0 9139.7 9147.3 9153.0 8994.8 9012.1 9016.8 9043.3 9114.2 9003.9 9081.5 9087.5 9091.0 9093.2 44425.8 44770.6 44820.1 44837.3 44937.8 3570.2 3585.3 3628.2 3673.0 3870.2 33701.8 34943.0 34974.7 35017.0 35232.5 4349.5 4511.7 4512.8 4649.1 4666.0 361326.0 364205.0 364548.2 364590.0 365895.0 62133.7 62489.4 62699.4 62728.4 62782.7 64476.0 64577.7 64668.4 64683.0 64733.0 16998.7 17204.5 17219.7 17233.7 17239.3 11999.4 12008.7 12017.8 12028.2 12059.5 14209.6 17889.6 18193.5 18350.3 18396.6 5636.7 6583.8 6761.6 6795.0 6845.5 931.0 958.0 1035.7 1121.6 1201.9 32552.3 33029.0 33217.3 33275.7 33605.6 1123.7 1128.0 1153.3 1196.4 1209.6 16827.2 17505.8 17642.7 17929.7 19220.9 529998.0 534705.0 534910.0 535564.0 535847.0 61827.0 62155.7 62268.4 62358.7 62375.4 1254.4 1318.6 1320.0 1388.8 1429.1 26860.6 35535.5 35720.8 35963.6 36088.5 59416.0 59785.0 59929.0 60084.0 60186.1 498959.0 500069.0 501511.0 502704.0 504889.0 29234.0 30159.0 30420.5 30595.0 30608.4 49869.5 50465.7 51768.5 52191.0 52671.2 40220.4 43360.3 43848.1 44090.0 44636.3 42081.8 42886.8 43076.8 44736.3 44990.0 42396.6 42663.6 42869.1 43061.8 43193.0 35965.8 37852.0 38613.8 38628.0 38992.0 28095.2 28616.9 29187.3 29646.0 29661.3 14:34:52 INFO - PROCESS | 25795 | 14:34:52 INFO - PROCESS | 25795 | [#2] jquery.html Cycles:180 Average:28256.18 Median:13762.35 stddev:73718.10 (535.7%) stddev-sans-first:73895.15 14:34:52 INFO - PROCESS | 25795 | Values: 363.0 370.6 387.8 396.8 420.8 17054.3 19617.2 19730.1 20494.7 20500.8 19438.1 19705.1 19925.1 19932.9 20123.3 5420.9 5620.5 5821.7 5851.3 5867.7 5783.9 5799.2 5839.7 5840.1 5843.7 5588.1 5767.6 5827.2 5831.4 5831.9 5727.8 5754.5 5792.9 5799.2 5803.6 4898.3 4995.3 5021.5 5025.3 5025.3 24388.5 24502.8 24756.9 24916.6 24979.4 2427.5 2482.1 2545.3 2968.3 3175.0 10010.7 10557.6 10679.1 10705.5 10821.0 1824.6 1915.5 1935.0 1958.2 2052.8 81146.0 84876.0 86607.6 87888.0 89573.0 10033.4 10505.1 10562.8 10667.2 11336.8 15198.0 15200.1 15200.2 15258.8 15277.2 8140.4 8376.9 8473.7 8566.8 8691.7 7287.6 7376.9 7609.3 8087.2 8382.7 4721.8 4764.8 4780.7 4915.9 5040.5 1835.3 1890.5 1893.6 1907.4 1931.5 929.1 980.7 1028.0 1056.6 1081.8 19413.4 20102.8 20200.0 20244.9 20541.5 941.0 950.4 1005.9 1015.0 1021.9 10743.7 11125.3 11167.7 11236.4 11240.9 418001.0 431360.0 455296.7 456189.0 458121.0 76138.6 76756.0 99087.0 101548.0 103259.0 984.7 998.5 1000.5 1003.3 1012.9 17481.7 17999.7 18446.4 18501.4 18804.4 45740.0 46718.8 46943.5 47393.8 47416.5 62896.0 62946.4 64163.0 64613.4 65345.7 8502.4 8574.1 8686.9 8697.5 8803.2 8668.9 9833.0 13108.3 13523.2 13793.0 11840.8 11857.5 11906.6 12067.2 12324.9 11121.4 11616.5 11830.5 11968.2 12165.7 11705.4 11717.9 11846.6 11925.7 12102.1 8418.2 8587.8 8627.4 8805.5 8813.8 10659.5 11558.8 11831.9 11914.6 12067.1 14:34:52 INFO - PROCESS | 25795 | 14:34:52 INFO - PROCESS | 25795 | [#3] mootools.html Cycles:180 Average:5966.77 Median:475.08 stddev:3430.65 (722.1%) stddev-sans-first:3423.53 14:34:52 INFO - PROCESS | 25795 | Values: 1456.5 1496.3 1586.5 1736.7 1791.2 8645.0 9381.2 9387.2 9392.5 9403.5 7847.9 8532.2 8848.6 8855.3 9215.3 2411.5 2435.5 2435.9 2445.2 2446.8 2407.1 2423.0 2438.8 2440.6 2450.8 2330.9 2340.4 2415.6 2450.4 2454.3 2350.3 2351.2 2354.0 2355.6 2394.1 2340.3 2364.1 2374.0 2375.7 2376.0 9113.4 9127.4 9232.3 9235.9 9237.7 5229.7 5352.0 5353.7 5357.2 5367.4 3475.1 3501.7 3541.3 3549.2 3593.8 1144.1 1144.3 1178.9 1182.2 1198.5 12842.6 12879.4 12970.9 12980.9 13006.3 4417.9 4674.5 4768.6 4889.6 4893.4 10749.6 10778.4 10780.4 10782.5 10793.0 5367.1 5384.5 5400.7 5401.6 5404.8 4062.9 4313.4 4459.3 4844.5 4992.2 4174.4 4188.4 4194.1 4284.6 4289.4 1305.4 1309.6 1317.7 1319.7 1342.8 916.4 942.4 947.9 952.7 1003.4 6131.3 6132.7 6286.0 6338.1 6352.7 474.7 475.4 478.5 487.3 489.6 4261.0 4265.6 4290.0 4291.0 4303.8 10770.4 11346.3 11349.1 11351.2 11395.1 10604.5 11144.1 11265.8 11278.8 11296.7 8383.7 8572.6 8604.4 8607.5 8609.7 6017.7 6183.4 6275.6 6382.6 6486.0 10004.7 10132.9 10324.1 10515.3 10517.6 8856.8 10505.9 10567.4 10756.8 10817.9 7484.5 7963.8 8047.8 8310.4 8315.7 8468.1 8754.2 8773.3 8845.1 8924.4 7955.8 7962.0 7989.2 8116.4 8121.4 7669.5 7834.9 7850.7 7862.8 7994.6 7244.9 7246.7 7252.2 7309.0 7310.1 5051.3 5200.9 5236.0 5302.4 5356.7 5192.1 5195.8 5216.5 5258.6 5437.4 14:34:52 INFO - PROCESS | 25795 | 14:34:52 INFO - PROCESS | 25795 | [#4] prototype.html Cycles:180 Average:4482.28 Median:5151.65 stddev:1296.30 (25.2%) stddev-sans-first:1261.05 14:34:52 INFO - PROCESS | 25795 | Values: 283.6 298.3 302.7 318.0 321.4 5114.3 5125.6 5145.9 5151.8 5152.7 4894.6 4939.4 5046.7 5069.3 5141.6 4059.7 4076.0 4078.8 4081.9 4101.6 4080.0 4083.9 4085.8 4111.3 4134.4 3869.6 3873.5 4045.3 4069.8 4112.3 4022.6 4027.1 4036.2 4046.4 4080.6 3604.4 3627.9 3628.3 3629.4 3630.5 4776.6 4990.6 5009.6 5015.4 5040.2 4554.3 4558.7 4571.7 4574.8 4597.7 5343.2 5344.0 5351.6 5372.5 5378.4 3755.7 3836.2 3846.4 3846.9 3864.7 5400.5 5516.8 5521.1 5522.0 5525.3 3918.9 3939.4 3944.5 3948.3 3977.5 3970.3 3970.9 3971.5 3973.1 3973.7 4352.9 4499.4 4520.8 4526.4 4541.3 5372.6 5379.5 5395.4 5400.6 5409.5 1360.3 1373.8 1374.6 1375.2 1376.9 866.7 901.2 917.8 920.8 931.8 5132.3 5135.2 5139.8 5151.5 5165.6 5351.2 5351.9 5366.7 5388.2 5435.3 4919.5 5144.2 5151.3 5154.8 5197.3 2826.8 2834.8 2843.8 2846.6 2858.3 5498.2 5524.4 5550.4 5586.9 5597.6 5336.5 5429.5 5436.1 5444.4 5479.0 5484.4 5506.9 5512.0 5523.2 5543.5 5179.5 5354.6 5381.2 5389.6 5396.7 5327.9 5334.3 5364.5 5368.6 5380.8 5505.3 5521.2 5524.4 5538.6 5573.5 3861.4 3899.9 3912.6 3939.6 3950.1 5195.4 5277.8 5336.9 5395.3 5396.6 5276.8 5285.8 5298.5 5312.4 5319.0 5311.8 5336.9 5342.6 5350.4 5353.5 5154.2 5162.7 5204.3 5220.3 5234.7 5248.3 5254.7 5285.7 5288.6 5341.5 5033.1 5234.3 5253.9 5263.6 5283.5 14:34:52 INFO - PROCESS | 25795 | 14:34:52 INFO - PROCESS | 25795 | [#5] yui.html Cycles:180 Average:22448.34 Median:4717.99 stddev:33519.44 (710.5%) stddev-sans-first:33573.62 14:34:52 INFO - PROCESS | 25795 | Values: 680.2 701.0 723.0 732.1 764.4 16237.2 17110.7 17335.1 17841.6 17895.9 16869.8 17216.5 17221.8 17237.7 17240.8 786.6 810.6 814.3 814.4 815.1 656.2 769.4 792.5 798.2 800.6 853.1 854.6 854.9 855.4 855.8 845.2 845.7 846.5 846.9 846.9 502.7 584.2 596.7 599.3 600.6 15364.6 15369.2 15412.9 16034.4 16074.0 13912.3 14123.9 14328.2 14698.1 14778.8 13594.4 13603.4 13653.5 13771.0 14130.9 4608.3 4611.7 4654.3 4659.3 4717.6 88157.0 88577.0 88954.1 90038.0 90968.0 11968.3 12099.5 12149.2 12205.2 12246.8 22191.7 22229.7 22256.7 22291.6 22448.8 8758.0 8806.4 8854.0 9018.0 9117.4 4833.3 5027.0 5107.5 5271.3 5276.7 3589.2 3653.4 3679.9 3690.8 3702.1 601.6 605.0 617.4 619.6 624.3 617.9 644.0 700.1 704.3 719.0 9000.8 9262.7 9379.4 9452.8 9782.5 567.6 598.0 599.5 622.4 636.2 4623.8 4682.5 4718.4 4725.1 4814.8 130760.3 130951.3 131166.0 131953.0 132971.0 68808.7 82732.2 111287.0 113153.0 117884.0 96724.0 96766.5 96784.5 98611.5 100617.0 8717.7 8764.0 8802.4 8814.3 9096.0 55175.2 56352.0 56732.7 56783.7 57015.0 74111.5 83755.6 83924.0 85335.6 86689.6 12118.6 12238.2 12281.4 12289.0 12809.2 12691.5 13296.2 13433.5 13523.5 13997.2 12889.3 13034.3 13110.0 13293.0 13876.8 12615.4 12934.0 13060.8 13176.1 13254.3 12760.4 13009.6 13140.3 13140.4 13577.1 10716.1 10778.4 10963.4 11024.4 11379.7 10791.3 10855.8 10933.8 11049.4 11178.2 14:34:52 INFO - PROCESS | 25795 | -------- Summary: end -------- 14:34:52 INFO - PROCESS | 25795 | 14:34:53 INFO - TEST-INFO | 25795: exit 0 14:34:53 INFO - TEST-OK | dromaeo_css | took 1115555ms 14:34:53 INFO - TEST-START | kraken 14:34:53 INFO - operating with platform_type : linux_ 14:34:53 INFO - Initialising browser for kraken test... 14:34:53 INFO - TEST-INFO | started process 25996 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo31321/profile http://localhost:51753/getInfo.html) 14:34:57 INFO - PROCESS | 25996 | __metrics Screen width/height:1600/1200 14:34:57 INFO - PROCESS | 25996 | colorDepth:24 14:34:57 INFO - PROCESS | 25996 | Browser inner width/height: 1024/697 14:34:57 INFO - PROCESS | 25996 | __metrics 14:34:58 INFO - PROCESS | 25996 | 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" 14:34:58 INFO - PROCESS | 25996 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:34:59 INFO - PROCESS | 25996 | console.error: PushService: 14:34:59 INFO - PROCESS | 25996 | stateChangeProcessEnqueue: Error transitioning state 14:34:59 INFO - PROCESS | 25996 | UnknownError 14:34:59 INFO - TEST-INFO | 25996: exit 0 14:34:59 INFO - Browser initialized. 14:34:59 INFO - Running cycle 1/1 for kraken test... 14:34:59 INFO - TEST-INFO | started process 26081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo31321/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:35:11 INFO - PROCESS | 26081 | RSS: Main: 156651520 14:35:11 INFO - PROCESS | 26081 | 14:35:13 INFO - PROCESS | 26081 | Cycle 1(1): loaded http://localhost:51753/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51753/tests/kraken/driver.html?testName=audio-beat-detection) 14:35:14 INFO - PROCESS | 26081 | RSS: Main: 213303296 14:35:14 INFO - PROCESS | 26081 | 14:35:17 INFO - PROCESS | 26081 | Cycle 1(1): loaded http://localhost:51753/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51753/tests/kraken/driver.html?testName=audio-dft) 14:35:17 INFO - PROCESS | 26081 | RSS: Main: 192831488 14:35:17 INFO - PROCESS | 26081 | 14:35:21 INFO - PROCESS | 26081 | Cycle 1(1): loaded http://localhost:51753/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51753/tests/kraken/driver.html?testName=audio-fft) 14:35:21 INFO - PROCESS | 26081 | RSS: Main: 269447168 14:35:21 INFO - PROCESS | 26081 | 14:35:23 INFO - PROCESS | 26081 | Cycle 1(1): loaded http://localhost:51753/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51753/tests/kraken/driver.html?testName=audio-oscillator) 14:35:24 INFO - PROCESS | 26081 | RSS: Main: 179662848 14:35:24 INFO - PROCESS | 26081 | 14:35:26 INFO - PROCESS | 26081 | Cycle 1(1): loaded http://localhost:51753/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51753/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:35:27 INFO - PROCESS | 26081 | RSS: Main: 184684544 14:35:27 INFO - PROCESS | 26081 | 14:35:30 INFO - PROCESS | 26081 | Cycle 1(1): loaded http://localhost:51753/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51753/tests/kraken/driver.html?testName=imaging-darkroom) 14:35:30 INFO - PROCESS | 26081 | RSS: Main: 219578368 14:35:30 INFO - PROCESS | 26081 | 14:35:34 INFO - PROCESS | 26081 | Cycle 1(1): loaded http://localhost:51753/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51753/tests/kraken/driver.html?testName=imaging-desaturate) 14:35:34 INFO - PROCESS | 26081 | RSS: Main: 219787264 14:35:34 INFO - PROCESS | 26081 | 14:35:37 INFO - PROCESS | 26081 | Cycle 1(1): loaded http://localhost:51753/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51753/tests/kraken/driver.html?testName=json-parse-financial) 14:35:38 INFO - PROCESS | 26081 | RSS: Main: 219541504 14:35:38 INFO - PROCESS | 26081 | 14:35:39 INFO - PROCESS | 26081 | Cycle 1(1): loaded http://localhost:51753/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51753/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:35:40 INFO - PROCESS | 26081 | RSS: Main: 183992320 14:35:40 INFO - PROCESS | 26081 | 14:35:41 INFO - PROCESS | 26081 | Cycle 1(1): loaded http://localhost:51753/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51753/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:35:42 INFO - PROCESS | 26081 | RSS: Main: 189517824 14:35:42 INFO - PROCESS | 26081 | 14:35:44 INFO - PROCESS | 26081 | Cycle 1(1): loaded http://localhost:51753/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51753/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:35:45 INFO - PROCESS | 26081 | RSS: Main: 194101248 14:35:45 INFO - PROCESS | 26081 | 14:35:47 INFO - PROCESS | 26081 | Cycle 1(1): loaded http://localhost:51753/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51753/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:35:48 INFO - PROCESS | 26081 | RSS: Main: 189337600 14:35:48 INFO - PROCESS | 26081 | 14:35:51 INFO - PROCESS | 26081 | Cycle 1(1): loaded http://localhost:51753/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51753/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:35:51 INFO - PROCESS | 26081 | RSS: Main: 192835584 14:35:51 INFO - PROCESS | 26081 | 14:35:53 INFO - PROCESS | 26081 | Cycle 1(1): loaded http://localhost:51753/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51753/tests/kraken/driver.html?testName=ai-astar) 14:35:53 INFO - PROCESS | 26081 | RSS: Main: 243007488 14:35:53 INFO - PROCESS | 26081 | 14:35:53 INFO - PROCESS | 26081 | __start_tp_report 14:35:53 INFO - PROCESS | 26081 | _x_x_mozilla_page_load 14:35:53 INFO - PROCESS | 26081 | _x_x_mozilla_page_load_details 14:35:53 INFO - PROCESS | 26081 | |i|pagename|runs| 14:35:53 INFO - PROCESS | 26081 | |0;ai-astar;102;111;110;111;111;110;111;109;111;109 14:35:53 INFO - PROCESS | 26081 | |1;audio-beat-detection;141;116;119;179;125;126;156;116;152;116 14:35:53 INFO - PROCESS | 26081 | |2;audio-dft;161;161;162;162;162;160;160;162;161;161 14:35:53 INFO - PROCESS | 26081 | |3;audio-fft;74;75;75;108;76;75;75;75;104;75 14:35:53 INFO - PROCESS | 26081 | |4;audio-oscillator;83;84;122;85;85;84;122;84;84;135 14:35:53 INFO - PROCESS | 26081 | |5;imaging-gaussian-blur;117;116;116;116;117;117;116;117;117;116 14:35:53 INFO - PROCESS | 26081 | |6;imaging-darkroom;146;145;146;146;147;145;147;145;145;145 14:35:53 INFO - PROCESS | 26081 | |7;imaging-desaturate;96;95;96;96;95;96;95;97;95;95 14:35:53 INFO - PROCESS | 26081 | |8;json-parse-financial;51;50;51;50;49;50;50;50;49;49 14:35:53 INFO - PROCESS | 26081 | |9;json-stringify-tinderbox;62;62;60;62;63;61;61;63;61;61 14:35:53 INFO - PROCESS | 26081 | |10;stanford-crypto-aes;83;76;84;78;75;84;76;76;79;77 14:35:53 INFO - PROCESS | 26081 | |11;stanford-crypto-ccm;123;120;122;128;120;122;119;130;153;129 14:35:53 INFO - PROCESS | 26081 | |12;stanford-crypto-pbkdf2;164;161;156;156;157;156;156;157;158;156 14:35:53 INFO - PROCESS | 26081 | |13;stanford-crypto-sha256-iterative;66;64;64;63;63;63;63;63;61;62 14:35:53 INFO - PROCESS | 26081 | __end_tp_report 14:35:53 INFO - PROCESS | 26081 | __start_cc_report 14:35:53 INFO - PROCESS | 26081 | _x_x_mozilla_cycle_collect,1655 14:35:53 INFO - PROCESS | 26081 | __end_cc_report 14:35:53 INFO - PROCESS | 26081 | __startTimestamp1470605753539__endTimestamp 14:35:53 INFO - PROCESS | 26081 | 14:35:53 INFO - PROCESS | 26081 | ------- Summary: start ------- 14:35:53 INFO - PROCESS | 26081 | Number of tests: 14 14:35:53 INFO - PROCESS | 26081 | 14:35:53 INFO - PROCESS | 26081 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:2.76 (2.5%) stddev-sans-first:0.87 14:35:53 INFO - PROCESS | 26081 | Values: 102.0 111.0 110.0 111.0 111.0 110.0 111.0 109.0 111.0 109.0 14:35:53 INFO - PROCESS | 26081 | 14:35:53 INFO - PROCESS | 26081 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:133.50 stddev:21.65 (16.2%) stddev-sans-first:22.84 14:35:53 INFO - PROCESS | 26081 | Values: 141.0 116.0 119.0 179.0 125.0 126.0 156.0 116.0 152.0 116.0 14:35:53 INFO - PROCESS | 26081 | 14:35:53 INFO - PROCESS | 26081 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 14:35:53 INFO - PROCESS | 26081 | Values: 161.0 161.0 162.0 162.0 162.0 160.0 160.0 162.0 161.0 161.0 14:35:53 INFO - PROCESS | 26081 | 14:35:53 INFO - PROCESS | 26081 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.00 stddev:13.11 (17.5%) stddev-sans-first:13.65 14:35:53 INFO - PROCESS | 26081 | Values: 74.0 75.0 75.0 108.0 76.0 75.0 75.0 75.0 104.0 75.0 14:35:53 INFO - PROCESS | 26081 | 14:35:53 INFO - PROCESS | 26081 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:84.00 stddev:20.69 (24.6%) stddev-sans-first:21.34 14:35:53 INFO - PROCESS | 26081 | Values: 83.0 84.0 122.0 85.0 85.0 84.0 122.0 84.0 84.0 135.0 14:35:53 INFO - PROCESS | 26081 | 14:35:53 INFO - PROCESS | 26081 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 14:35:53 INFO - PROCESS | 26081 | Values: 117.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 14:35:53 INFO - PROCESS | 26081 | 14:35:53 INFO - PROCESS | 26081 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 14:35:53 INFO - PROCESS | 26081 | Values: 146.0 145.0 146.0 146.0 147.0 145.0 147.0 145.0 145.0 145.0 14:35:53 INFO - PROCESS | 26081 | 14:35:53 INFO - PROCESS | 26081 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 14:35:53 INFO - PROCESS | 26081 | Values: 96.0 95.0 96.0 96.0 95.0 96.0 95.0 97.0 95.0 95.0 14:35:53 INFO - PROCESS | 26081 | 14:35:53 INFO - PROCESS | 26081 | [#8] json-parse-financial Cycles:10 Average:49.90 Median:50.00 stddev:0.74 (1.5%) stddev-sans-first:0.67 14:35:53 INFO - PROCESS | 26081 | Values: 51.0 50.0 51.0 50.0 49.0 50.0 50.0 50.0 49.0 49.0 14:35:53 INFO - PROCESS | 26081 | 14:35:53 INFO - PROCESS | 26081 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.97 (1.6%) stddev-sans-first:1.01 14:35:53 INFO - PROCESS | 26081 | Values: 62.0 62.0 60.0 62.0 63.0 61.0 61.0 63.0 61.0 61.0 14:35:53 INFO - PROCESS | 26081 | 14:35:53 INFO - PROCESS | 26081 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.50 stddev:3.55 (4.5%) stddev-sans-first:3.43 14:35:53 INFO - PROCESS | 26081 | Values: 83.0 76.0 84.0 78.0 75.0 84.0 76.0 76.0 79.0 77.0 14:35:53 INFO - PROCESS | 26081 | 14:35:53 INFO - PROCESS | 26081 | [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:125.50 stddev:10.09 (8.0%) stddev-sans-first:10.62 14:35:53 INFO - PROCESS | 26081 | Values: 123.0 120.0 122.0 128.0 120.0 122.0 119.0 130.0 153.0 129.0 14:35:53 INFO - PROCESS | 26081 | 14:35:53 INFO - PROCESS | 26081 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.70 Median:157.00 stddev:2.71 (1.7%) stddev-sans-first:1.66 14:35:53 INFO - PROCESS | 26081 | Values: 164.0 161.0 156.0 156.0 157.0 156.0 156.0 157.0 158.0 156.0 14:35:53 INFO - PROCESS | 26081 | 14:35:53 INFO - PROCESS | 26081 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.32 (2.1%) stddev-sans-first:0.93 14:35:53 INFO - PROCESS | 26081 | Values: 66.0 64.0 64.0 63.0 63.0 63.0 63.0 63.0 61.0 62.0 14:35:53 INFO - PROCESS | 26081 | -------- Summary: end -------- 14:35:53 INFO - PROCESS | 26081 | 14:35:54 INFO - TEST-INFO | 26081: exit 0 14:35:54 INFO - TEST-OK | kraken | took 61556ms 14:35:54 INFO - SUITE-END | took 1177s 14:35:54 INFO - Completed test suite (00:19:37) 14:35:54 INFO - javascript benchmark 14:35:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3050.4356694011594, 3059.174023013786, 3107.875684972601, 3109.9533506997386, 3124.390743804959, 5161.612879034078, 5193.558547523456, 5211.2704221408985, 5284.022455845671, 5296.973515132424, 5263.526282634562, 5302.257683924254, 5323.574114070875, 5336.30628018357, 5389.0, 4769.213079841822, 4839.637027222955, 4844.07962487128, 4855.611551075923, 4958.6281028922795, 4879.926801097987, 4898.4366797818175, 4907.165781817082, 4909.3126962225315, 4925.039617274633, 4771.141194584973, 4814.75926203692, 4856.1016212000895, 4860.076585448789, 4861.270809378586, 4812.807487700487, 4815.036992601494, 4826.396700412449, 4836.347093142416, 4947.158982972867, 4842.346283251786, 4860.975695121501, 4878.341423907763, 4886.780094895738, 4917.188663870457, 5184.0, 5202.661826981234, 5249.186376111708, 5263.789448422059, 5332.386775520826, 5628.774849006035, 5683.744231509592, 5697.77208911643, 5703.7148142592705, 5710.600257981943, 5734.913976290359, 5735.684537350486, 5752.0, 5759.452851979097, 5767.480926716574, 5155.53600175986, 5214.687118772886, 5262.500062494057, 5266.657667251617, 5360.3299587551555, 5785.739641716133, 5846.269216347957, 5846.532277417881, 5849.853753656193, 5850.034744267148, 5586.776528938797, 5589.664620122806, 5622.887542249132, 5629.0, 5643.294588176478, 5452.509274165344, 5605.271314729059, 5644.8306550803545, 5650.265465489542, 5732.226149469769, 5655.3779084300695, 5657.2928383952, 5657.971710141423, 5659.745311460912, 5663.348714897757, 5640.633358831663, 5673.00722373583, 5686.118651608925, 5688.8862222755315, 5690.174924635905, 4250.511191212988, 4316.460442444694, 4317.892052698645, 4376.387305777193, 4379.1022840317655, 3870.6903447724117, 3899.3566061599518, 3931.5085614298214, 3948.6643635290748, 3950.861719839792, 5414.3232095988005, 5418.160185171305, 5422.349318081855, 5437.864053398617, 5465.262189604432, 5657.4908258256955, 5657.886842263214, 5658.519025882763, 5660.320761508646, 5701.629394089371, 5191.091558977164, 5366.758495867695, 5408.215808707715, 5427.511523962862, 5444.91832622511, 4978.303037574742, 4983.8006479741125, 4988.102141614471, 5014.398272207359, 5031.723255220998, 5882.49998750111, 5895.675737834375, 5898.616589921641, 5901.232839730807, 5903.173555702205, 5345.091334473227, 5604.439556044363, 5694.288213973254, 5702.714864256687, 5726.570507211893, 5810.854728631818, 5871.500922421471, 5875.882482350244, 5925.140854576149, 5932.525397968238, 5634.352049514358, 5635.577331700221, 5640.097584386478, 5642.040853054908, 5645.435456454322, 5486.61593688438, 5614.07367784311, 5720.456556627114, 5729.054705973468, 5730.968425683417, 5490.670559766427, 5584.4136365681015, 5587.106063029895, 5622.184783206494, 5640.125780504029, 5514.117741161395, 5557.0, 5557.138643510262, 5558.0, 5558.221848941233, 5274.97362513185, 5419.0, 5483.945160548344, 5502.889942201214, 5551.306086739158, 5544.889102218014, 5584.106542953108, 5585.944140558542, 5628.127640215773, 5639.097744360883, 5433.755481003285, 5438.728063596725, 5441.102218134122, 5445.972770136124, 5451.318585176853], "value": 5243.026681110571, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.7438301530342, 600.8287638023162, 610.435347303744, 618.8669436071247, 643.1863692429075, 44224.33663495046, 45954.851128721755, 45968.770156149214, 50170.49829501704, 50197.0, 47983.0, 48568.2714759278, 48598.0, 48617.54147375576, 48638.51361486384, 9031.819363612723, 9178.403403778766, 9181.58682859273, 9182.816343673123, 9183.678571250008, 8983.19151276385, 8989.820203595924, 9054.77363065922, 9076.31927605429, 9078.591463384164, 9103.36276460648, 9135.95432022839, 9139.68011119611, 9147.268218542535, 9153.0, 8994.820103597924, 9012.053734357929, 9016.819663606724, 9043.276537876955, 9114.225290850285, 9003.864942025875, 9081.45511269326, 9087.454752714859, 9091.0, 9093.181613654737, 44425.77787111044, 44770.55229447696, 44820.10359792786, 44837.327440088426, 44937.775311123565, 3570.1967057412135, 3585.3367127081574, 3628.183658676803, 3673.045008297835, 3870.2066076454257, 33701.83149084263, 34943.0, 34974.65025349739, 35017.0, 35232.471512927325, 4349.534653514625, 4511.684182107254, 4512.751798651073, 4649.070185962787, 4666.043461090502, 361326.0, 364205.0, 364548.1772591147, 364590.0, 365895.0, 62133.68933155396, 62489.37510624927, 62699.37300627027, 62728.37271627317, 62782.68608656927, 64476.0, 64577.67711161414, 64668.35331646623, 64683.0, 64733.0, 16998.660026799396, 17204.483865484057, 17219.741703874453, 17233.741493877602, 17239.310427582757, 11999.400029998465, 12008.699782505333, 12017.819732704016, 12028.15802893789, 12059.457324420422, 14209.573712788633, 17889.552761181076, 18193.45419637413, 18350.265989360276, 18396.63206735858, 5636.661800291996, 6583.769568065095, 6761.594304341756, 6795.0, 6845.452363810983, 930.9767255818658, 957.9760505987267, 1035.7255327338262, 1121.5527362617195, 1201.9158658893793, 32552.348953020806, 33029.0, 33217.3356532868, 33275.66724332774, 33605.643711017445, 1123.7471568896933, 1127.9774404512027, 1153.2676750263643, 1196.3719047499958, 1209.564556759566, 16827.242774075195, 17505.824941750674, 17642.735358969625, 17929.72120562963, 19220.903895480435, 529998.0, 534705.0, 534910.0, 535564.0, 535847.0, 61827.0, 62155.68922155451, 62268.37731622716, 62358.688206558676, 62375.376246236956, 1254.4417734108233, 1318.5516924245803, 1319.9934000329936, 1388.7986241995056, 1429.1496559547054, 26860.59709104326, 35535.46696799498, 35720.82139589285, 35963.64036359603, 36088.4586731194, 59416.0, 59785.0, 59929.0, 60084.0, 60186.097208542786, 498959.0, 500069.0, 501511.0, 502704.0, 504889.0, 29234.0, 30159.0, 30420.543691845083, 30595.0, 30608.387832243676, 49869.50130498649, 50465.74767126141, 51768.48231517787, 52191.0, 52671.209931851816, 40220.39669404903, 43360.349594756735, 43848.123037539706, 44090.0, 44636.33045504255, 42081.78959105185, 42886.78556607197, 43076.78461607797, 44736.328955066354, 44990.0, 42396.57603423926, 42663.5733642672, 42869.14261714811, 43061.78469107635, 43193.0, 35965.82017090003, 37852.0, 38613.80693096516, 38628.0, 38992.0, 28095.157145285673, 28616.855325786735, 29187.270318242216, 29646.0, 29661.25846853846], "value": 20934.04108467536, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.99455508167364, 370.57939238963786, 387.8138493523109, 396.8055652730163, 420.82115101082053, 17054.317827286908, 19617.215311387547, 19730.112144953477, 20494.692579611317, 20500.794992050076, 19438.125284362202, 19705.113269902853, 19925.103370348334, 19932.90033549834, 20123.29568465104, 5420.864478388052, 5620.522255608268, 5821.6507009579345, 5851.268591426072, 5867.677277749722, 5783.913241301384, 5799.18811366409, 5839.737211825478, 5840.06558950568, 5843.737031833578, 5588.133839254922, 5767.567432442563, 5827.242458480391, 5831.446012628815, 5831.912521312183, 5727.828165155052, 5754.482096611304, 5792.913106303409, 5799.159121927318, 5803.564732645069, 4898.314236006961, 4995.275685025687, 5021.49785021495, 5025.271335656346, 5025.296458495814, 24388.512229755484, 24502.754972450224, 24756.876215618806, 24916.626250606256, 24979.375515612253, 2427.5023620157826, 2482.1064416809936, 2545.325488745484, 2968.257935516121, 3174.9841250793597, 10010.749731256705, 10557.630482933137, 10679.092277156451, 10705.46472676363, 10821.0, 1824.5803465202946, 1915.530694979725, 1934.951626209356, 1958.2362878477404, 2052.7639321478073, 81146.0, 84876.0, 86607.56696216541, 87888.0, 89573.0, 10033.397996120257, 10505.107065899485, 10562.788744225227, 10667.199960002876, 11336.829947550794, 15198.0, 15200.08799472013, 15200.239988000556, 15258.847411525743, 15277.236138193046, 8140.389470789596, 8376.916230837614, 8473.661053557911, 8566.78583035429, 8691.739247822576, 7287.562746235243, 7376.889346659805, 7609.277118673828, 8087.150849160871, 8382.664693412316, 4721.811127554859, 4764.76176191196, 4780.689255198401, 4915.926261106087, 5040.546350828443, 1835.2934120363757, 1890.4706682129026, 1893.5644801695687, 1907.437305994735, 1931.4688460673426, 929.0848514213494, 980.7155924781877, 1027.984580231297, 1056.5932116135343, 1081.8039380058494, 19413.4175974721, 20102.798972010387, 20200.0, 20244.89877550603, 20541.48646283825, 940.9576569054409, 950.4012472142645, 1005.8893521712606, 1014.9594016239267, 1021.9335743176819, 10743.677689669323, 11125.276857004268, 11167.72080697989, 11236.438178091063, 11240.943795280971, 418001.0, 431360.0, 455296.7235163803, 456189.0, 458121.0, 76138.61930690311, 76756.0, 99087.00912990922, 101548.0, 103258.96741032644, 984.7291994701515, 998.4558415663481, 1000.5347513406301, 1003.3127307794184, 1012.9341592796445, 17481.737773933655, 17999.66004419417, 18446.35437759672, 18501.44495665132, 18804.435866924014, 45740.0, 46718.76640616911, 46943.530564695284, 47393.76303118462, 47416.52583474259, 62896.0, 62946.37053629405, 64163.0, 64613.35386646073, 65345.673271633335, 8502.404831661725, 8574.142585741376, 8686.91313086861, 8697.52163630981, 8803.207711306013, 8668.913310867063, 9832.950835245778, 13108.279044652636, 13523.188608683511, 13793.0, 11840.822387664364, 11857.52569897229, 11906.642800715992, 12067.155299128977, 12324.876751232372, 11121.443927803739, 11616.477258523219, 11830.526778928746, 11968.16222864391, 12165.69585760363, 11705.356205408785, 11717.88282117168, 11846.585369512026, 11925.701857453287, 12102.092343074128, 8418.242358187792, 8587.785305367415, 8627.352948529011, 8805.471671699719, 8813.823723525365, 10659.520321585393, 11558.826617600575, 11831.940840295743, 11914.642560723192, 12067.09496787762], "value": 9326.082414331982, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.519348614957, 1496.289262600265, 1586.5478338673481, 1736.6613510365485, 1791.185010820077, 8644.956775216124, 9381.202597779196, 9387.249020078403, 9392.530373481315, 9403.529823508823, 7847.92152078479, 8532.232099111094, 8848.601812918418, 8855.335849811258, 9215.308851836106, 2411.457422080031, 2435.476372579895, 2435.8782060896974, 2445.2419749877595, 2446.7920226780657, 2407.1334319644916, 2423.0307876849224, 2438.780509754122, 2440.5728997425467, 2450.803935685141, 2330.9184178553755, 2340.4265954841003, 2415.5893498105274, 2450.3996520852415, 2454.312792418126, 2350.318407661776, 2351.235848349285, 2353.976460235393, 2355.564220619191, 2394.0902457066377, 2340.3447034830274, 2364.054378248697, 2374.03851440167, 2375.7386687464364, 2375.9881200593886, 9113.362064655477, 9127.406718563272, 9232.30757693169, 9235.907640923571, 9237.676681316188, 5229.712365819878, 5351.973240133774, 5353.652012619167, 5357.249985002103, 5367.43641917597, 3475.061733331986, 3501.7373696972827, 3541.274038822061, 3549.219171782204, 3593.784372937606, 1144.067584918289, 1144.2791041643795, 1178.9410529473491, 1182.2020136407891, 1198.4726720243152, 12842.550510732173, 12879.356032198446, 12970.87029129706, 12980.870191298061, 13006.34968251593, 4417.889552761207, 4674.5325467452985, 4768.594669453066, 4889.608831293559, 4893.437254715682, 10749.570017199381, 10778.407187604756, 10780.407077610807, 10782.46087695612, 10793.0, 5367.1412573988755, 5384.461553844584, 5400.675959442446, 5401.621886467988, 5404.756785944642, 4062.939055914164, 4313.374560688745, 4459.331100334975, 4844.467108618049, 4992.201247800407, 4174.373843923436, 4188.4136220928485, 4194.098268872146, 4284.592963668447, 4289.356596510486, 1305.3538498443331, 1309.59402585197, 1317.743040107189, 1319.6766792135795, 1342.838859336886, 916.4180745226829, 942.4345392764286, 947.9383840050513, 952.6713283917038, 1003.4380746781826, 6131.344536975081, 6132.6627035513475, 6285.96857015712, 6338.112664227012, 6352.650604216812, 474.7270319566263, 475.43185892858395, 478.5095277340684, 487.2958574859365, 489.55695095938233, 4261.0, 4265.594768496988, 4289.978550107292, 4290.957090429119, 4303.806328715215, 10770.353778773298, 11346.319220846775, 11349.148813838996, 11351.205415620992, 11395.145364097725, 10604.469776511143, 11144.052755515871, 11265.831012534818, 11278.774424511465, 11296.717582060513, 8383.664653413794, 8572.571371431404, 8604.35467339952, 8607.483550986835, 8609.741707748777, 6017.729202185999, 6183.350748171377, 6275.592086514362, 6382.5532212744665, 6485.9946708260295, 10004.749881253027, 10132.949335253277, 10324.122449591869, 10515.263931525025, 10517.579296828042, 8856.822863542564, 10505.9474702626, 10567.418791966209, 10756.784864302514, 10817.945910270399, 7484.513506622052, 7963.761087167394, 8047.798805029921, 8310.418270720991, 8315.667373305, 8468.068512463748, 8754.21212090915, 8773.341999349946, 8845.115488451362, 8924.375293729376, 7955.761327160194, 7962.0, 7989.161138080418, 8116.350691944748, 8121.431499794958, 7669.539827610138, 7834.882476762739, 7850.685972561034, 7862.803429914298, 7994.5602991836, 7244.927550724636, 7246.746363877239, 7252.166000909963, 7309.049823522908, 7310.122785265802, 5051.3433253676785, 5200.869978250574, 5235.973820130875, 5302.443243459381, 5356.732163391737, 5192.143296356059, 5195.75265459088, 5216.452272511332, 5258.553022992935, 5437.4018857926385], "value": 4689.111982010777, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.57746957034027, 298.28858173256776, 302.6942787784337, 317.993550412943, 321.4182329982731, 5114.28400023997, 5125.615578831584, 5145.922811157836, 5151.76817043233, 5152.737579293069, 4894.583960363365, 4939.431965323989, 5046.747662616864, 5069.340985671857, 5141.588672906168, 4059.6955228357842, 4076.0, 4078.8164532595956, 4081.9183616327655, 4101.6308532232015, 4079.9796001019954, 4083.9387409188885, 4085.7957102144924, 4111.321631930728, 4134.421181034658, 3869.593692662258, 3873.4577159197734, 4045.312296909518, 4069.837206511736, 4112.300908845488, 4022.617851304151, 4027.0939038716347, 4036.2129384769983, 4046.372812214097, 4080.6123418275365, 3604.4232922732235, 3627.8548858045647, 3628.2743451309843, 3629.4374371972385, 3630.473581330719, 4776.641751868624, 4990.575801056914, 5009.599232061463, 5015.3730783652045, 5040.193569028975, 4554.294084416921, 4558.749268790215, 4571.702839315467, 4574.820499752674, 4597.678162528624, 5343.171808369709, 5344.038073146832, 5351.598630102758, 5372.516473517363, 5378.381486129106, 3755.661990420848, 3836.2327534492933, 3846.442265871461, 3846.942295865564, 3864.7294689371756, 5400.513953744143, 5516.7517461714315, 5521.1442226454965, 5521.972390138064, 5525.309336332958, 3918.921621567553, 3939.3697008478507, 3944.487216661873, 3948.262764383662, 3977.54258260298, 3970.305196590585, 3970.9205815884097, 3971.483707118114, 3973.1259122992897, 3973.7417067890497, 4352.934705979413, 4499.437570303712, 4520.796564154555, 4526.434195725535, 4541.3188021797, 5372.5970552207955, 5379.462053794589, 5395.433479484597, 5400.567954563626, 5409.540189083972, 1360.3062438156612, 1373.8007988841562, 1374.5601407549489, 1375.1817668487233, 1376.898481215024, 866.6879923227633, 901.2249465459699, 917.8026724254318, 920.7928216151446, 931.7856892914532, 5132.28148059272, 5135.204043373283, 5139.768710407966, 5151.536361727388, 5165.612579056586, 5351.224072509543, 5351.919721204107, 5366.651167674167, 5388.225064091996, 5435.266239057755, 4919.508049195052, 5144.202648589475, 5151.304573882553, 5154.788624673199, 5197.324347834758, 2826.816256943292, 2834.7888646855486, 2843.824474277138, 2846.644169478815, 2858.285428642839, 5498.206237695977, 5524.447555244524, 5550.361708403585, 5586.86032849182, 5597.608167428322, 5336.546393556591, 5429.484199001088, 5436.075867102523, 5444.428335024844, 5479.0, 5484.39491241657, 5506.889862202734, 5511.972440137773, 5523.226748255248, 5543.501084902378, 5179.45615710345, 5354.625176237626, 5381.165919282361, 5389.568834493152, 5396.676199428047, 5327.893442131213, 5334.266363431822, 5364.490373414519, 5368.557306425645, 5380.784768609368, 5505.338949598472, 5521.199426083276, 5524.447555244444, 5538.587660146637, 5573.498385145356, 3861.362875125573, 3899.883003509899, 3912.5696173420333, 3939.625735555118, 3950.1309711863346, 5195.402528709095, 5277.788888444419, 5336.946630533645, 5395.298611180521, 5396.64921780083, 5276.788928442819, 5285.810692594136, 5298.523132918056, 5312.362516498045, 5318.9628022535235, 5311.840644780663, 5336.918601745245, 5342.6260161788305, 5350.438203988525, 5353.491418315254, 5154.201098829687, 5162.664426812245, 5204.2974198484235, 5220.321358223407, 5234.712090835041, 5248.343957005374, 5254.710990895537, 5285.656432331886, 5288.629795914403, 5341.5459685927135, 5033.144365457808, 5234.319538459976, 5253.9211911820585, 5263.552598029058, 5283.498067683564], "value": 4063.3244629629994, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.2347359220877, 701.0395757811801, 722.9674664640094, 732.1397358104226, 764.4495962906706, 16237.188140592967, 17110.657786844273, 17335.13324333783, 17841.553961150945, 17895.91052044741, 16869.83130168701, 17216.483505494823, 17221.82778172218, 17237.655246895054, 17240.82759172408, 786.5949036246324, 810.5582457560644, 814.2793627639522, 814.4380377539479, 815.0504662068682, 656.2125449460642, 769.3537428560008, 792.5363662257586, 798.1858504325585, 800.5836964778312, 853.1298075962515, 854.5855260198798, 854.8845905802731, 855.4012191465968, 855.820277741675, 845.247729520727, 845.6828689241535, 846.5047946951041, 846.8687353460255, 846.8856704344896, 502.7260143221953, 584.1733946465788, 596.6986671730748, 599.3497055694532, 600.627610881252, 15364.615884602974, 15369.154696491689, 15412.922935385364, 16034.438794642248, 16074.035557866566, 13912.30438478072, 14123.929380353135, 14328.211948342838, 14698.118112913153, 14778.778318325234, 13594.38825252866, 13603.387847546785, 13653.522126725517, 13771.0, 14130.929345353208, 4608.33179189019, 4611.654125940534, 4654.325122857167, 4659.32439796231, 4717.622590192776, 88157.0, 88577.0, 88954.11045889523, 90038.0, 90968.0, 11968.341741204144, 12099.516019359127, 12149.210301330386, 12205.20666156697, 12246.755064898653, 22191.66712499314, 22229.666555001688, 22256.666150007764, 22291.55416891653, 22448.775512244996, 8758.0, 8806.427582207136, 8853.955730221307, 9018.008019117891, 9117.361784675142, 4833.32333473314, 5026.974865125724, 5107.514786095315, 5271.262023316739, 5276.657017293864, 3589.210373717778, 3653.397189463762, 3679.9080022999105, 3690.7785532868115, 3702.092987218095, 601.590918175636, 605.0470508948424, 617.4165413684116, 619.6096459230656, 624.2976651267325, 617.8795134948732, 644.0371644391664, 700.0863872646246, 704.3344039882262, 719.022129903331, 9000.819983600422, 9262.72211833646, 9379.437233765995, 9452.763680907894, 9782.51087445625, 567.5629765080947, 597.9581429299994, 599.5143933413949, 622.4211483320555, 636.1888592045179, 4623.838165664186, 4682.531746825291, 4718.363020992122, 4725.125851717443, 4814.807407703653, 130760.3461982703, 130951.34524327317, 131166.0, 131953.0, 132971.0, 68808.6559567199, 82732.17267827244, 111287.0, 113153.0, 117884.0, 96724.0, 96766.51616741871, 96784.51607741916, 98611.50694246627, 100617.0, 8717.694880679146, 8764.0, 8802.38383313162, 8814.294856411343, 9095.954520227357, 55175.17237241525, 56352.0, 56732.71633641805, 56783.71608142098, 57015.0, 74111.51776964539, 83755.5812220935, 83924.0, 85335.57332213299, 86689.56655216936, 12118.636440906786, 12238.204516706743, 12281.385930703607, 12289.0, 12809.167404118702, 12691.492340306284, 13296.202227866359, 13433.462661493431, 13523.526676566273, 13997.230152341719, 12889.291088990196, 13034.250694606717, 13110.0, 13293.0, 13876.791848122488, 12615.425792925202, 12934.0, 13060.80408793888, 13176.143550669176, 13254.337283135612, 12760.361981900682, 13009.609711708665, 13140.277284749049, 13140.408681609159, 13577.11748736329, 10716.142708583138, 10778.407187604756, 10963.397013164353, 11024.448777560929, 11379.658610241706, 10791.298565593212, 10855.84347434962, 10933.781324373627, 11049.392283424168, 11178.161637877354], "value": 7705.688292612653, "unit": "score"}], "name": "dromaeo_css", "value": 7291.682680196662, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 110.0, 111.0, 111.0, 110.0, 111.0, 109.0, 111.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 116.0, 119.0, 179.0, 125.0, 126.0, 156.0, 116.0, 152.0, 116.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 162.0, 160.0, 160.0, 162.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 108.0, 76.0, 75.0, 75.0, 75.0, 104.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 122.0, 85.0, 85.0, 84.0, 122.0, 84.0, 84.0, 135.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 147.0, 145.0, 147.0, 145.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 97.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 50.0, 49.0, 50.0, 50.0, 50.0, 49.0, 49.0], "value": 49.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 60.0, 62.0, 63.0, 61.0, 61.0, 63.0, 61.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 76.0, 84.0, 78.0, 75.0, 84.0, 76.0, 76.0, 79.0, 77.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 120.0, 122.0, 128.0, 120.0, 122.0, 119.0, 130.0, 153.0, 129.0], "value": 126.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 156.0, 156.0, 157.0, 156.0, 156.0, 157.0, 158.0, 156.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 61.0, 62.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1478.8999999999999, "alertThreshold": 2.0}]} 14:35:54 INFO - Return code: 0 14:35:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:35:54 INFO - # TBPL SUCCESS # 14:35:54 INFO - Running post-action listener: _resource_record_post_action 14:35:54 INFO - [mozharness: 2016-08-07 21:35:54.854309Z] Finished run-tests step (success) 14:35:54 INFO - Running post-run listener: _resource_record_post_run 14:35:54 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 557387776; Read time: 12; Write time: 1417952 14:35:54 INFO - TinderboxPrint: CPU usage
13.1% 14:35:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:35:54 INFO - TinderboxPrint: I/O write bytes / time
557,387,776 / 1,417,952 14:35:54 INFO - TinderboxPrint: CPU idle
8,293.3 (86.9%) 14:35:54 INFO - TinderboxPrint: CPU user
1,193.5 (12.5%) 14:35:54 INFO - TinderboxPrint: Swap in / out
0 / 0 14:35:54 INFO - install - Wall time: 19s; CPU: 18.0%; Read bytes: 0; Write bytes: 264462336; Read time: 0; Write time: 932664 14:35:54 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292925440; Read time: 12; Write time: 485288 14:35:55 INFO - Running post-run listener: _upload_blobber_files 14:35:55 INFO - Blob upload gear active. 14:35:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:35:55 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 14:35:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:35:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:35:55 INFO - (blobuploader) - INFO - Open directory for files ... 14:35:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:35:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:35:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:59 INFO - (blobuploader) - INFO - Done attempting. 14:35:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:35:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:35:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:59 INFO - (blobuploader) - INFO - Done attempting. 14:35:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:35:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:36:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:36:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:36:00 INFO - (blobuploader) - INFO - Done attempting. 14:36:00 INFO - (blobuploader) - INFO - Iteration through files over. 14:36:00 INFO - Return code: 0 14:36:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:36:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:36:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a326cafe6797644d3d15ee571538d775fe51f8b89e47aa4bdd0085645bfaec61dba74ab1b6a3b31b5257a77787883e2dc7871139766b56135b73dc2cad008963", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b17016a7b603170c4d5d1e97502ed15993c6325ed29d0130d2027c1b5a580e492fb1cf42c05ef9885342614cf06b10098fb29504a144152ab5a9d6eaac1558a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08ac4d5fda53e669035c4e37e333dc89f36057f730001edf21e314f3c7aeddbba5ee44e8b9f76c8166c6ab16a1650ab18320bd43acf28be1af9b965b847b3a3f"} 14:36:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:36:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:36:00 INFO - Contents: 14:36:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a326cafe6797644d3d15ee571538d775fe51f8b89e47aa4bdd0085645bfaec61dba74ab1b6a3b31b5257a77787883e2dc7871139766b56135b73dc2cad008963", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b17016a7b603170c4d5d1e97502ed15993c6325ed29d0130d2027c1b5a580e492fb1cf42c05ef9885342614cf06b10098fb29504a144152ab5a9d6eaac1558a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08ac4d5fda53e669035c4e37e333dc89f36057f730001edf21e314f3c7aeddbba5ee44e8b9f76c8166c6ab16a1650ab18320bd43acf28be1af9b965b847b3a3f"} 14:36:00 INFO - Running post-run listener: copy_logs_to_upload_dir 14:36:00 INFO - Copying logs to upload dir... 14:36:00 INFO - mkdir: /builds/slave/test/build/upload/logs 14:36:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.250313 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-08-07 14:36:00.062982) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 14:36:00.066716) ========= 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=745a4373a2a16df560f216e000000264-1470595898.412628-430910497 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/sha512/a326cafe6797644d3d15ee571538d775fe51f8b89e47aa4bdd0085645bfaec61dba74ab1b6a3b31b5257a77787883e2dc7871139766b56135b73dc2cad008963", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b17016a7b603170c4d5d1e97502ed15993c6325ed29d0130d2027c1b5a580e492fb1cf42c05ef9885342614cf06b10098fb29504a144152ab5a9d6eaac1558a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08ac4d5fda53e669035c4e37e333dc89f36057f730001edf21e314f3c7aeddbba5ee44e8b9f76c8166c6ab16a1650ab18320bd43acf28be1af9b965b847b3a3f"} build_url:https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/Oo09Ur-KQsu6J56rjVT2TA/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/sha512/a326cafe6797644d3d15ee571538d775fe51f8b89e47aa4bdd0085645bfaec61dba74ab1b6a3b31b5257a77787883e2dc7871139766b56135b73dc2cad008963", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b17016a7b603170c4d5d1e97502ed15993c6325ed29d0130d2027c1b5a580e492fb1cf42c05ef9885342614cf06b10098fb29504a144152ab5a9d6eaac1558a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08ac4d5fda53e669035c4e37e333dc89f36057f730001edf21e314f3c7aeddbba5ee44e8b9f76c8166c6ab16a1650ab18320bd43acf28be1af9b965b847b3a3f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 14:36:00.092350) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 14:36:00.094688) ========= 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=745a4373a2a16df560f216e000000264-1470595898.412628-430910497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 14:36:00.177557) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 14:36:00.177922) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 14:36:00.178257) ========= ========= Total master_lag: 0.26 =========