builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1471667270.8 results: success (0) buildid: 20160819200714 builduid: eb93eef6a3f84eed883de48b0f7ff1c7 revision: fb9dbacb7f8b52dd47b1ff87f8678179bcf68f4e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 21:27:50.800238) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 21:27:50.800704) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 21:27:50.801179) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 21:27:50.816402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 21:27:50.816697) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 21:27:51-- 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% 224M=0s 2016-08-19 21:27:51 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148704 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 21:27:50.988352) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 21:27:50.988820) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015005 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 21:27:51.042070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 21:27:51.042416) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev fb9dbacb7f8b52dd47b1ff87f8678179bcf68f4e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev fb9dbacb7f8b52dd47b1ff87f8678179bcf68f4e --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=6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 21:27:51,421 truncating revision to first 12 chars 2016-08-19 21:27:51,421 Setting DEBUG logging. 2016-08-19 21:27:51,421 attempt 1/10 2016-08-19 21:27:51,421 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/fb9dbacb7f8b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 21:27:51,733 unpacking tar archive at: autoland-fb9dbacb7f8b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641460 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 21:27:51.699664) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 21:27:51.700034) ========= script_repo_revision: fb9dbacb7f8b52dd47b1ff87f8678179bcf68f4e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 21:27:51.700545) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 21:27:51.700853) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 21:27:51.710365) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-19 21:27:51.710670) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:27:52 INFO - MultiFileLogger online at 20160819 21:27:52 in /builds/slave/test 21:27:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 21:27:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:27:52 INFO - {'append_to_log': False, 21:27:52 INFO - 'base_work_dir': '/builds/slave/test', 21:27:52 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 21:27:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:27:52 INFO - 'branch': 'Autoland-Non-PGO', 21:27:52 INFO - 'buildbot_json_path': 'buildprops.json', 21:27:52 INFO - 'config_files': ('talos/linux_config.py',), 21:27:52 INFO - 'default_actions': ('clobber', 21:27:52 INFO - 'read-buildbot-config', 21:27:52 INFO - 'download-and-extract', 21:27:52 INFO - 'populate-webroot', 21:27:52 INFO - 'create-virtualenv', 21:27:52 INFO - 'install', 21:27:52 INFO - 'run-tests'), 21:27:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:27:52 INFO - 'download_minidump_stackwalk': True, 21:27:52 INFO - 'download_symbols': 'ondemand', 21:27:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:27:52 INFO - 'tooltool.py': '/tools/tooltool.py', 21:27:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:27:52 INFO - '/tools/misc-python/virtualenv.py')}, 21:27:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:27:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:27:52 INFO - 'installer_path': 'installer.exe', 21:27:52 INFO - 'log_level': 'info', 21:27:52 INFO - 'log_name': 'talos', 21:27:52 INFO - 'log_to_console': True, 21:27:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:27:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:27:52 INFO - 'opt_config_files': (), 21:27:52 INFO - 'pip_index': False, 21:27:52 INFO - 'sps_profile': False, 21:27:52 INFO - 'sps_profile_interval': 0, 21:27:52 INFO - 'suite': 'dromaeojs', 21:27:52 INFO - 'system_bits': '32', 21:27:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:27:52 INFO - 'title': 'talos-linux64-ix-023', 21:27:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:27:52 INFO - 'use_talos_json': True, 21:27:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:27:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:27:52 INFO - 'work_dir': 'build'} 21:27:52 INFO - [mozharness: 2016-08-20 04:27:52.181085Z] Running clobber step. 21:27:52 INFO - Running pre-action listener: _resource_record_pre_action 21:27:52 INFO - Running main action method: clobber 21:27:52 INFO - rmtree: /builds/slave/test/build 21:27:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:27:52 INFO - Running post-action listener: _resource_record_post_action 21:27:52 INFO - [mozharness: 2016-08-20 04:27:52.640549Z] Finished clobber step (success) 21:27:52 INFO - [mozharness: 2016-08-20 04:27:52.640650Z] Running read-buildbot-config step. 21:27:52 INFO - Running pre-action listener: _resource_record_pre_action 21:27:52 INFO - Running main action method: read_buildbot_config 21:27:52 INFO - Using buildbot properties: 21:27:52 INFO - { 21:27:52 INFO - "project": "", 21:27:52 INFO - "product": "firefox", 21:27:52 INFO - "script_repo_revision": "production", 21:27:52 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 21:27:52 INFO - "repository": "", 21:27:52 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 21:27:52 INFO - "buildid": "20160819200714", 21:27:52 INFO - "pgo_build": "False", 21:27:52 INFO - "basedir": "/builds/slave/test", 21:27:52 INFO - "buildnumber": 432, 21:27:52 INFO - "slavename": "talos-linux64-ix-023", 21:27:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:27:52 INFO - "platform": "ubuntu64_hw", 21:27:52 INFO - "scheduler": "tests-autoland-linux64-talos", 21:27:52 INFO - "branch": "autoland", 21:27:52 INFO - "repo_path": "integration/autoland", 21:27:52 INFO - "revision": "fb9dbacb7f8b52dd47b1ff87f8678179bcf68f4e", 21:27:52 INFO - "stage_platform": "linux64", 21:27:52 INFO - "builduid": "eb93eef6a3f84eed883de48b0f7ff1c7", 21:27:52 INFO - "slavebuilddir": "test" 21:27:52 INFO - } 21:27:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 21:27:52 INFO - Running post-action listener: _resource_record_post_action 21:27:52 INFO - [mozharness: 2016-08-20 04:27:52.643080Z] Finished read-buildbot-config step (success) 21:27:52 INFO - [mozharness: 2016-08-20 04:27:52.643167Z] Running download-and-extract step. 21:27:52 INFO - Running pre-action listener: _resource_record_pre_action 21:27:52 INFO - Running main action method: download_and_extract 21:27:52 INFO - mkdir: /builds/slave/test/build/tests 21:27:52 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')]} 21:27:52 INFO - trying https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:27:52 INFO - Downloading https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/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 21:27:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/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 21:27:53 INFO - Downloaded 1361 bytes. 21:27:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:27:53 INFO - Using the following test package requirements: 21:27:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 21:27:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:27:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:27:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:27:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:27:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:27:53 INFO - u'jsshell-linux-x86_64.zip'], 21:27:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:27:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:27:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 21:27:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:27:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:27:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:27:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:27:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:27:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:27:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:27:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:27:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:27: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')]} 21:27:53 INFO - trying https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:27:53 INFO - Downloading https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/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 21:27:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/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 21:27:54 INFO - Downloaded 20330229 bytes. 21:27:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 21:27:58 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 21:27:58 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')]} 21:27:58 INFO - trying https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:27:58 INFO - Downloading https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/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 21:27:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/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 21:27:59 INFO - Downloaded 20330229 bytes. 21:27:59 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 21:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:03 INFO - trying https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 21:28:03 INFO - Downloading https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/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 21:28:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/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 21:28:05 INFO - Downloaded 14413981 bytes. 21:28:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 21:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:05 INFO - trying https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:28:05 INFO - Downloading https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/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 21:28:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/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 21:28:06 INFO - Downloaded 55792865 bytes. 21:28:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:28:06 INFO - mkdir: /builds/slave/test/properties 21:28:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:28:06 INFO - Writing to file /builds/slave/test/properties/build_url 21:28:06 INFO - Contents: 21:28:06 INFO - build_url:https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:28:07 INFO - Running post-action listener: _resource_record_post_action 21:28:07 INFO - Running post-action listener: set_extra_try_arguments 21:28:07 INFO - [mozharness: 2016-08-20 04:28:07.243098Z] Finished download-and-extract step (success) 21:28:07 INFO - [mozharness: 2016-08-20 04:28:07.243322Z] Running populate-webroot step. 21:28:07 INFO - Running pre-action listener: _resource_record_pre_action 21:28:07 INFO - Running main action method: populate_webroot 21:28:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:28:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:28:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:28:07 INFO - '--tppagecycles', 21:28:07 INFO - '7'], 21:28:07 INFO - 'tests': ['tsvgm']}}, 21:28:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:28:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:28:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:28:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:28:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:28:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:28:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:07 INFO - 'talos_options': ['--disable-e10s'], 21:28:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:28:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:28:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:07 INFO - 'talos_options': ['--disable-e10s'], 21:28:07 INFO - 'tests': ['damp', 'tps']}, 21:28:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:07 INFO - 'tests': ['damp', 'tps']}, 21:28:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:28:07 INFO - 'tests': ['dromaeo_dom']}, 21:28:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:28:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:28:07 INFO - 'tests': ['basic_compositor_video']}, 21:28:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:28:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:28:07 INFO - 'tests': ['a11yr', 21:28:07 INFO - 'ts_paint', 21:28:07 INFO - 'tpaint', 21:28:07 INFO - 'sessionrestore', 21:28:07 INFO - 'sessionrestore_no_auto_restore', 21:28:07 INFO - 'tabpaint']}, 21:28:07 INFO - 'other-e10s': {'tests': ['a11yr', 21:28:07 INFO - 'ts_paint', 21:28:07 INFO - 'tpaint', 21:28:07 INFO - 'sessionrestore', 21:28:07 INFO - 'sessionrestore_no_auto_restore', 21:28:07 INFO - 'tabpaint']}, 21:28:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:28:07 INFO - 'ts_paint', 21:28:07 INFO - 'tpaint', 21:28:07 INFO - 'sessionrestore', 21:28:07 INFO - 'sessionrestore_no_auto_restore', 21:28:07 INFO - 'tabpaint']}, 21:28:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:28:07 INFO - 'ts_paint', 21:28:07 INFO - 'tpaint', 21:28:07 INFO - 'sessionrestore', 21:28:07 INFO - 'sessionrestore_no_auto_restore', 21:28:07 INFO - 'tabpaint']}, 21:28:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:28:07 INFO - 'tests': ['a11yr', 21:28:07 INFO - 'ts_paint', 21:28:07 INFO - 'tpaint', 21:28:07 INFO - 'sessionrestore', 21:28:07 INFO - 'sessionrestore_no_auto_restore', 21:28:07 INFO - 'tabpaint']}, 21:28:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:28:07 INFO - 'tests': ['a11yr', 21:28:07 INFO - 'ts_paint', 21:28:07 INFO - 'tpaint', 21:28:07 INFO - 'sessionrestore', 21:28:07 INFO - 'sessionrestore_no_auto_restore', 21:28:07 INFO - 'tabpaint']}, 21:28:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:28:07 INFO - 'tests': ['tsvgx', 21:28:07 INFO - 'tsvgr_opacity', 21:28:07 INFO - 'tart', 21:28:07 INFO - 'tscrollx', 21:28:07 INFO - 'cart']}, 21:28:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:28:07 INFO - 'tsvgr_opacity', 21:28:07 INFO - 'tart', 21:28:07 INFO - 'tscrollx', 21:28:07 INFO - 'cart']}, 21:28:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:07 INFO - 'talos_options': ['--disable-e10s'], 21:28:07 INFO - 'tests': ['tp5o']}, 21:28:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:07 INFO - 'tests': ['tp5o']}, 21:28:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:07 INFO - 'talos_options': ['--disable-e10s', 21:28:07 INFO - '--xperf_path', 21:28:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:28:07 INFO - 'tests': ['tp5n']}, 21:28:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:07 INFO - 'talos_options': ['--xperf_path', 21:28:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:28:07 INFO - 'tests': ['tp5n']}}, 21:28:07 INFO - 'talos.zip': {'path': '', 21:28:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:28:07 INFO - Running post-action listener: _resource_record_post_action 21:28:07 INFO - [mozharness: 2016-08-20 04:28:07.260988Z] Finished populate-webroot step (success) 21:28:07 INFO - [mozharness: 2016-08-20 04:28:07.261076Z] Running create-virtualenv step. 21:28:07 INFO - Running pre-action listener: _resource_record_pre_action 21:28:07 INFO - Running main action method: create_virtualenv 21:28:07 INFO - Creating virtualenv /builds/slave/test/build/venv 21:28:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:28:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:28:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:28:07 INFO - Using real prefix '/usr' 21:28:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:28:07 INFO - Installing distribute.............................................................................................................................................................................................done. 21:28:09 INFO - Installing pip.................done. 21:28:09 INFO - Return code: 0 21:28:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:28:09 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')]} 21:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:09 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')]} 21:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:09 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 0x7f603c534f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc1090>, '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 0xfc49b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc4e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', '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 21:28:09 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 21:28:09 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 21:28:09 INFO - Using env: {'DISPLAY': ':0', 21:28:09 INFO - 'HOME': '/home/cltbld', 21:28:09 INFO - 'LANG': 'en_US.UTF-8', 21:28:09 INFO - 'LANGUAGE': 'en_US:en', 21:28:09 INFO - 'LOGNAME': 'cltbld', 21:28:09 INFO - 'MAIL': '/var/mail/cltbld', 21:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:09 INFO - 'MOZ_NO_REMOTE': '1', 21:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:09 INFO - 'NO_EM_RESTART': '1', 21:28:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:09 INFO - 'PWD': '/builds/slave/test', 21:28:09 INFO - 'SHELL': '/bin/bash', 21:28:09 INFO - 'SHLVL': '1', 21:28:09 INFO - 'TERM': 'linux', 21:28:09 INFO - 'TMOUT': '86400', 21:28:09 INFO - 'USER': 'cltbld', 21:28:09 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', 21:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:09 INFO - '_': '/tools/buildbot/bin/python'} 21:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:28:10 INFO - Cleaning up... 21:28:10 INFO - Return code: 0 21:28:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f603c534f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc1090>, '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 0xfc49b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc4e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', '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 21:28:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:28:10 INFO - Using env: {'DISPLAY': ':0', 21:28:10 INFO - 'HOME': '/home/cltbld', 21:28:10 INFO - 'LANG': 'en_US.UTF-8', 21:28:10 INFO - 'LANGUAGE': 'en_US:en', 21:28:10 INFO - 'LOGNAME': 'cltbld', 21:28:10 INFO - 'MAIL': '/var/mail/cltbld', 21:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:10 INFO - 'MOZ_NO_REMOTE': '1', 21:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:10 INFO - 'NO_EM_RESTART': '1', 21:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:10 INFO - 'PWD': '/builds/slave/test', 21:28:10 INFO - 'SHELL': '/bin/bash', 21:28:10 INFO - 'SHLVL': '1', 21:28:10 INFO - 'TERM': 'linux', 21:28:10 INFO - 'TMOUT': '86400', 21:28:10 INFO - 'USER': 'cltbld', 21:28:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', 21:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:10 INFO - '_': '/tools/buildbot/bin/python'} 21:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:10 INFO - Downloading/unpacking psutil>=3.1.1 21:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:28:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:28:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:28:12 INFO - Installing collected packages: psutil 21:28:12 INFO - Running setup.py install for psutil 21:28:12 INFO - building 'psutil._psutil_linux' extension 21:28:12 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 21:28:12 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 21:28:12 INFO - building 'psutil._psutil_posix' extension 21:28:12 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 21:28:12 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 21:28:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:28:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:28:12 INFO - Successfully installed psutil 21:28:12 INFO - Cleaning up... 21:28:12 INFO - Return code: 0 21:28:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:28:12 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')]} 21:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:12 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')]} 21:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:12 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 0x7f603c534f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc1090>, '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 0xfc49b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc4e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', '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 21:28:12 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 21:28:12 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 21:28:12 INFO - Using env: {'DISPLAY': ':0', 21:28:12 INFO - 'HOME': '/home/cltbld', 21:28:12 INFO - 'LANG': 'en_US.UTF-8', 21:28:12 INFO - 'LANGUAGE': 'en_US:en', 21:28:12 INFO - 'LOGNAME': 'cltbld', 21:28:12 INFO - 'MAIL': '/var/mail/cltbld', 21:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:12 INFO - 'MOZ_NO_REMOTE': '1', 21:28:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:12 INFO - 'NO_EM_RESTART': '1', 21:28:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:12 INFO - 'PWD': '/builds/slave/test', 21:28:12 INFO - 'SHELL': '/bin/bash', 21:28:12 INFO - 'SHLVL': '1', 21:28:12 INFO - 'TERM': 'linux', 21:28:12 INFO - 'TMOUT': '86400', 21:28:12 INFO - 'USER': 'cltbld', 21:28:12 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', 21:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:12 INFO - '_': '/tools/buildbot/bin/python'} 21:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:28:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:28:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:28:14 INFO - Installing collected packages: mozsystemmonitor 21:28:14 INFO - Running setup.py install for mozsystemmonitor 21:28:15 INFO - Successfully installed mozsystemmonitor 21:28:15 INFO - Cleaning up... 21:28:15 INFO - Return code: 0 21:28:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f603c534f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc1090>, '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 0xfc49b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc4e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', '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 21:28:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:28:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:28:15 INFO - Using env: {'DISPLAY': ':0', 21:28:15 INFO - 'HOME': '/home/cltbld', 21:28:15 INFO - 'LANG': 'en_US.UTF-8', 21:28:15 INFO - 'LANGUAGE': 'en_US:en', 21:28:15 INFO - 'LOGNAME': 'cltbld', 21:28:15 INFO - 'MAIL': '/var/mail/cltbld', 21:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:15 INFO - 'MOZ_NO_REMOTE': '1', 21:28:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:15 INFO - 'NO_EM_RESTART': '1', 21:28:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:15 INFO - 'PWD': '/builds/slave/test', 21:28:15 INFO - 'SHELL': '/bin/bash', 21:28:15 INFO - 'SHLVL': '1', 21:28:15 INFO - 'TERM': 'linux', 21:28:15 INFO - 'TMOUT': '86400', 21:28:15 INFO - 'USER': 'cltbld', 21:28:15 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', 21:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:15 INFO - '_': '/tools/buildbot/bin/python'} 21:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:15 INFO - Downloading/unpacking jsonschema==2.5.1 21:28:15 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 21:28:15 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 21:28:15 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 21:28:15 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 21:28:15 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 21:28:15 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 21:28:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:28:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:17 INFO - Downloading functools32-3.2.3-2.tar.gz 21:28:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:28:17 INFO - warning: no files found matching '*.txt' 21:28:17 INFO - no previously-included directories found matching 'build' 21:28:17 INFO - no previously-included directories found matching 'dist' 21:28:17 INFO - no previously-included directories found matching '.git*' 21:28:17 INFO - Installing collected packages: jsonschema, functools32 21:28:17 INFO - Running setup.py install for functools32 21:28:17 INFO - warning: no files found matching '*.txt' 21:28:17 INFO - no previously-included directories found matching 'build' 21:28:17 INFO - no previously-included directories found matching 'dist' 21:28:17 INFO - no previously-included directories found matching '.git*' 21:28:17 INFO - Successfully installed jsonschema functools32 21:28:17 INFO - Cleaning up... 21:28:17 INFO - Return code: 0 21:28:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:28: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')]} 21:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28: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')]} 21:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f603c534f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc1090>, '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 0xfc49b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc4e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', '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 21:28:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:28:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:28:17 INFO - Using env: {'DISPLAY': ':0', 21:28:17 INFO - 'HOME': '/home/cltbld', 21:28:17 INFO - 'LANG': 'en_US.UTF-8', 21:28:17 INFO - 'LANGUAGE': 'en_US:en', 21:28:17 INFO - 'LOGNAME': 'cltbld', 21:28:17 INFO - 'MAIL': '/var/mail/cltbld', 21:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:17 INFO - 'MOZ_NO_REMOTE': '1', 21:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:17 INFO - 'NO_EM_RESTART': '1', 21:28:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:17 INFO - 'PWD': '/builds/slave/test', 21:28:17 INFO - 'SHELL': '/bin/bash', 21:28:17 INFO - 'SHLVL': '1', 21:28:17 INFO - 'TERM': 'linux', 21:28:17 INFO - 'TMOUT': '86400', 21:28:17 INFO - 'USER': 'cltbld', 21:28:17 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', 21:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:17 INFO - '_': '/tools/buildbot/bin/python'} 21:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:28:17 INFO - Cleaning up... 21:28:17 INFO - Return code: 0 21:28:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:28: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')]} 21:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28: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')]} 21:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f603c534f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc1090>, '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 0xfc49b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc4e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', '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 21:28:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:28:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:28:17 INFO - Using env: {'DISPLAY': ':0', 21:28:17 INFO - 'HOME': '/home/cltbld', 21:28:17 INFO - 'LANG': 'en_US.UTF-8', 21:28:17 INFO - 'LANGUAGE': 'en_US:en', 21:28:17 INFO - 'LOGNAME': 'cltbld', 21:28:17 INFO - 'MAIL': '/var/mail/cltbld', 21:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:17 INFO - 'MOZ_NO_REMOTE': '1', 21:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:17 INFO - 'NO_EM_RESTART': '1', 21:28:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:17 INFO - 'PWD': '/builds/slave/test', 21:28:17 INFO - 'SHELL': '/bin/bash', 21:28:17 INFO - 'SHLVL': '1', 21:28:17 INFO - 'TERM': 'linux', 21:28:17 INFO - 'TMOUT': '86400', 21:28:17 INFO - 'USER': 'cltbld', 21:28:17 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', 21:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:17 INFO - '_': '/tools/buildbot/bin/python'} 21:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:18 INFO - Downloading/unpacking blobuploader==1.2.4 21:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:19 INFO - Downloading blobuploader-1.2.4.tar.gz 21:28:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:28:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:28:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:20 INFO - Downloading docopt-0.6.1.tar.gz 21:28:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:28:20 INFO - Installing collected packages: blobuploader, requests, docopt 21:28:20 INFO - Running setup.py install for blobuploader 21:28:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:28:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:28:20 INFO - Running setup.py install for requests 21:28:21 INFO - Running setup.py install for docopt 21:28:21 INFO - Successfully installed blobuploader requests docopt 21:28:21 INFO - Cleaning up... 21:28:21 INFO - Return code: 0 21:28:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:28:21 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')]} 21:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:21 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')]} 21:28:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:21 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 0x7f603c534f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc1090>, '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 0xfc49b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc4e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', '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 21:28:21 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 21:28:21 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 21:28:21 INFO - Using env: {'DISPLAY': ':0', 21:28:21 INFO - 'HOME': '/home/cltbld', 21:28:21 INFO - 'LANG': 'en_US.UTF-8', 21:28:21 INFO - 'LANGUAGE': 'en_US:en', 21:28:21 INFO - 'LOGNAME': 'cltbld', 21:28:21 INFO - 'MAIL': '/var/mail/cltbld', 21:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:21 INFO - 'MOZ_NO_REMOTE': '1', 21:28:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:21 INFO - 'NO_EM_RESTART': '1', 21:28:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:21 INFO - 'PWD': '/builds/slave/test', 21:28:21 INFO - 'SHELL': '/bin/bash', 21:28:21 INFO - 'SHLVL': '1', 21:28:21 INFO - 'TERM': 'linux', 21:28:21 INFO - 'TMOUT': '86400', 21:28:21 INFO - 'USER': 'cltbld', 21:28:21 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', 21:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:21 INFO - '_': '/tools/buildbot/bin/python'} 21:28:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:28:21 INFO - Running setup.py (path:/tmp/pip-1QU9Bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:28:21 INFO - Running setup.py (path:/tmp/pip-fLeMLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:28:21 INFO - Running setup.py (path:/tmp/pip-ddTtPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:28:21 INFO - Running setup.py (path:/tmp/pip-JFjRR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:28:21 INFO - Running setup.py (path:/tmp/pip-ArJrDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:28:21 INFO - Running setup.py (path:/tmp/pip-RnM2sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:28:21 INFO - Running setup.py (path:/tmp/pip-fkF1YC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:28:22 INFO - Running setup.py (path:/tmp/pip-KESvSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:28:22 INFO - Running setup.py (path:/tmp/pip-JV_Dup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:28:22 INFO - Running setup.py (path:/tmp/pip-166Op5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:28:22 INFO - Running setup.py (path:/tmp/pip-G4jx0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:28:22 INFO - Running setup.py (path:/tmp/pip-beUZeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:28:22 INFO - Running setup.py (path:/tmp/pip-95ARAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:28:22 INFO - Running setup.py (path:/tmp/pip-ONTYPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:28:22 INFO - Running setup.py (path:/tmp/pip-C6qz0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:28:22 INFO - Running setup.py (path:/tmp/pip-skEcF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:28:22 INFO - Running setup.py (path:/tmp/pip-c0gS2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:28:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:28:22 INFO - Running setup.py install for manifestparser 21:28:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:28:22 INFO - Running setup.py install for mozcrash 21:28:22 INFO - Running setup.py install for mozdebug 21:28:23 INFO - Running setup.py install for mozdevice 21:28:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:28:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:28:23 INFO - Running setup.py install for mozfile 21:28:23 INFO - Running setup.py install for mozhttpd 21:28:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:28:23 INFO - Running setup.py install for mozinfo 21:28:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:28:23 INFO - Running setup.py install for mozInstall 21:28:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:28:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:28:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:28:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:28:23 INFO - Running setup.py install for mozleak 21:28:23 INFO - Running setup.py install for mozlog 21:28:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:28:23 INFO - Running setup.py install for moznetwork 21:28:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:28:23 INFO - Running setup.py install for mozprocess 21:28:23 INFO - Running setup.py install for mozprofile 21:28:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:28:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:28:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:28:24 INFO - Running setup.py install for mozrunner 21:28:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:28:24 INFO - Running setup.py install for mozscreenshot 21:28:24 INFO - Running setup.py install for moztest 21:28:24 INFO - Running setup.py install for mozversion 21:28:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:28:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:28:24 INFO - Cleaning up... 21:28:24 INFO - Return code: 0 21:28:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:24 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 0x7f603c534f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc1090>, '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 0xfc49b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc4e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', '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 21:28:24 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 21:28:24 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 21:28:24 INFO - Using env: {'DISPLAY': ':0', 21:28:24 INFO - 'HOME': '/home/cltbld', 21:28:24 INFO - 'LANG': 'en_US.UTF-8', 21:28:24 INFO - 'LANGUAGE': 'en_US:en', 21:28:24 INFO - 'LOGNAME': 'cltbld', 21:28:24 INFO - 'MAIL': '/var/mail/cltbld', 21:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:24 INFO - 'MOZ_NO_REMOTE': '1', 21:28:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:24 INFO - 'NO_EM_RESTART': '1', 21:28:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:24 INFO - 'PWD': '/builds/slave/test', 21:28:24 INFO - 'SHELL': '/bin/bash', 21:28:24 INFO - 'SHLVL': '1', 21:28:24 INFO - 'TERM': 'linux', 21:28:24 INFO - 'TMOUT': '86400', 21:28:24 INFO - 'USER': 'cltbld', 21:28:24 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', 21:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:24 INFO - '_': '/tools/buildbot/bin/python'} 21:28:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:28:24 INFO - Running setup.py (path:/tmp/pip-wV_oPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:28:24 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)) 21:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:28:24 INFO - Running setup.py (path:/tmp/pip-_C6h39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:28:24 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)) 21:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:28:24 INFO - Running setup.py (path:/tmp/pip-AcLs63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:28:24 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)) 21:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:28:24 INFO - Running setup.py (path:/tmp/pip-PARMHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:28:24 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)) 21:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:28:25 INFO - Running setup.py (path:/tmp/pip-dQufWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:28:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:28:25 INFO - Running setup.py (path:/tmp/pip-ZeZazp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:28:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:28:25 INFO - Running setup.py (path:/tmp/pip-d1EQJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:28:25 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)) 21:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:28:25 INFO - Running setup.py (path:/tmp/pip-Xo9TtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:28:25 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)) 21:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:28:25 INFO - Running setup.py (path:/tmp/pip-KTFpBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:28:25 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)) 21:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:28:25 INFO - Running setup.py (path:/tmp/pip-P2fQQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:28:25 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)) 21:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:28:25 INFO - Running setup.py (path:/tmp/pip-obbaeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:28:25 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)) 21:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:28:25 INFO - Running setup.py (path:/tmp/pip-Tcd689-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:28:25 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)) 21:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:28:25 INFO - Running setup.py (path:/tmp/pip-GOBLSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:28:25 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)) 21:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:28:25 INFO - Running setup.py (path:/tmp/pip-6qpun3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:28:25 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)) 21:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:28:25 INFO - Running setup.py (path:/tmp/pip-7My9_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:28:25 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)) 21:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:28:25 INFO - Running setup.py (path:/tmp/pip-igAoVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:28:25 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)) 21:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:28:25 INFO - Running setup.py (path:/tmp/pip-5pxahZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:28:25 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)) 21:28:25 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)) 21:28:25 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)) 21:28:25 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)) 21:28:25 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)) 21:28:25 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)) 21:28:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:28:25 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 21:28:25 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 21:28:25 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 21:28:25 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 21:28:25 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 21:28:25 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 21:28:27 INFO - Downloading blessings-1.6.tar.gz 21:28:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:28:27 INFO - Installing collected packages: blessings 21:28:27 INFO - Running setup.py install for blessings 21:28:28 INFO - Successfully installed blessings 21:28:28 INFO - Cleaning up... 21:28:28 INFO - Return code: 0 21:28:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:28:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:28:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:28:28 INFO - Reading from file tmpfile_stdout 21:28:28 INFO - Current package versions: 21:28:28 INFO - argparse == 1.2.1 21:28:28 INFO - blessings == 1.6 21:28:28 INFO - blobuploader == 1.2.4 21:28:28 INFO - docopt == 0.6.1 21:28:28 INFO - functools32 == 3.2.3-2 21:28:28 INFO - jsonschema == 2.5.1 21:28:28 INFO - manifestparser == 1.1 21:28:28 INFO - mozInstall == 1.12 21:28:28 INFO - mozcrash == 0.17 21:28:28 INFO - mozdebug == 0.1 21:28:28 INFO - mozdevice == 0.48 21:28:28 INFO - mozfile == 1.2 21:28:28 INFO - mozhttpd == 0.7 21:28:28 INFO - mozinfo == 0.9 21:28:28 INFO - mozleak == 0.1 21:28:28 INFO - mozlog == 3.3 21:28:28 INFO - moznetwork == 0.27 21:28:28 INFO - mozprocess == 0.23 21:28:28 INFO - mozprofile == 0.28 21:28:28 INFO - mozrunner == 6.12 21:28:28 INFO - mozscreenshot == 0.1 21:28:28 INFO - mozsystemmonitor == 0.3 21:28:28 INFO - moztest == 0.7 21:28:28 INFO - mozversion == 1.4 21:28:28 INFO - psutil == 3.1.1 21:28:28 INFO - requests == 1.2.3 21:28:28 INFO - wsgiref == 0.1.2 21:28:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:28: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')]} 21:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28: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')]} 21:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:28 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 0x7f603c534f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc1090>, '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 0xfc49b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc4e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', '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 21:28:28 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 21:28:28 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 21:28:28 INFO - Using env: {'DISPLAY': ':0', 21:28:28 INFO - 'HOME': '/home/cltbld', 21:28:28 INFO - 'LANG': 'en_US.UTF-8', 21:28:28 INFO - 'LANGUAGE': 'en_US:en', 21:28:28 INFO - 'LOGNAME': 'cltbld', 21:28:28 INFO - 'MAIL': '/var/mail/cltbld', 21:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:28 INFO - 'MOZ_NO_REMOTE': '1', 21:28:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:28 INFO - 'NO_EM_RESTART': '1', 21:28:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:28 INFO - 'PWD': '/builds/slave/test', 21:28:28 INFO - 'SHELL': '/bin/bash', 21:28:28 INFO - 'SHLVL': '1', 21:28:28 INFO - 'TERM': 'linux', 21:28:28 INFO - 'TMOUT': '86400', 21:28:28 INFO - 'USER': 'cltbld', 21:28:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', 21:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:28 INFO - '_': '/tools/buildbot/bin/python'} 21:28:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:28 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)) 21:28:28 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)) 21:28:28 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)) 21:28:28 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)) 21:28:28 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)) 21:28:28 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)) 21:28:28 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)) 21:28:28 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)) 21:28:28 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)) 21:28:28 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)) 21:28:28 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)) 21:28:28 INFO - Cleaning up... 21:28:28 INFO - Return code: 0 21:28:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:28: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')]} 21:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28: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')]} 21:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:28 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 0x7f603c534f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc1090>, '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 0xfc49b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc4e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', '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 21:28:28 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 21:28:28 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 21:28:28 INFO - Using env: {'DISPLAY': ':0', 21:28:28 INFO - 'HOME': '/home/cltbld', 21:28:28 INFO - 'LANG': 'en_US.UTF-8', 21:28:28 INFO - 'LANGUAGE': 'en_US:en', 21:28:28 INFO - 'LOGNAME': 'cltbld', 21:28:28 INFO - 'MAIL': '/var/mail/cltbld', 21:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:28 INFO - 'MOZ_NO_REMOTE': '1', 21:28:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:28 INFO - 'NO_EM_RESTART': '1', 21:28:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:28 INFO - 'PWD': '/builds/slave/test', 21:28:28 INFO - 'SHELL': '/bin/bash', 21:28:28 INFO - 'SHLVL': '1', 21:28:28 INFO - 'TERM': 'linux', 21:28:28 INFO - 'TMOUT': '86400', 21:28:28 INFO - 'USER': 'cltbld', 21:28:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', 21:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:28 INFO - '_': '/tools/buildbot/bin/python'} 21:28:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:28:28 INFO - Cleaning up... 21:28:28 INFO - Return code: 0 21:28:28 INFO - Running post-action listener: _resource_record_post_action 21:28:28 INFO - Running post-action listener: _start_resource_monitoring 21:28:28 INFO - Starting resource monitoring. 21:28:28 INFO - [mozharness: 2016-08-20 04:28:28.760161Z] Finished create-virtualenv step (success) 21:28:28 INFO - [mozharness: 2016-08-20 04:28:28.760618Z] Running install step. 21:28:28 INFO - Running pre-action listener: _resource_record_pre_action 21:28:28 INFO - Running main action method: install 21:28:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:28:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:28:28 INFO - Reading from file tmpfile_stdout 21:28:28 INFO - Detecting whether we're running mozinstall >=1.0... 21:28:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:28:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:28:29 INFO - Reading from file tmpfile_stdout 21:28:29 INFO - Output received: 21:28:29 INFO - Usage: mozinstall [options] installer 21:28:29 INFO - Options: 21:28:29 INFO - -h, --help show this help message and exit 21:28:29 INFO - -d DEST, --destination=DEST 21:28:29 INFO - Directory to install application into. [default: 21:28:29 INFO - "/builds/slave/test"] 21:28:29 INFO - --app=APP Application being installed. [default: firefox] 21:28:29 INFO - mkdir: /builds/slave/test/build/application 21:28:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:28:45 INFO - Reading from file tmpfile_stdout 21:28:45 INFO - Output received: 21:28:45 INFO - /builds/slave/test/build/application/firefox/firefox 21:28:45 INFO - Running post-action listener: _resource_record_post_action 21:28:45 INFO - [mozharness: 2016-08-20 04:28:45.181616Z] Finished install step (success) 21:28:45 INFO - [mozharness: 2016-08-20 04:28:45.181864Z] Running run-tests step. 21:28:45 INFO - Running pre-action listener: _resource_record_pre_action 21:28:45 INFO - Running main action method: run_tests 21:28:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:28:45 INFO - Python 2.7.3 21:28:45 INFO - Return code: 0 21:28:45 INFO - grabbing minidump binary from tooltool 21:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:45 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 0xfc1090>, '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 0xfc49b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc4e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:28:45 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 21:28:45 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 21:28:45 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 21:28:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:28:45 INFO - Return code: 0 21:28:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:28:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:28:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:28:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:28:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:28:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 21:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 21:28:45 INFO - Using env: {'DISPLAY': ':0', 21:28:45 INFO - 'HOME': '/home/cltbld', 21:28:45 INFO - 'LANG': 'en_US.UTF-8', 21:28:45 INFO - 'LANGUAGE': 'en_US:en', 21:28:45 INFO - 'LOGNAME': 'cltbld', 21:28:45 INFO - 'MAIL': '/var/mail/cltbld', 21:28:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:28:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:45 INFO - 'MOZ_NO_REMOTE': '1', 21:28:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:45 INFO - 'NO_EM_RESTART': '1', 21:28:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:45 INFO - 'PWD': '/builds/slave/test', 21:28:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:28:45 INFO - 'SHELL': '/bin/bash', 21:28:45 INFO - 'SHLVL': '1', 21:28:45 INFO - 'TERM': 'linux', 21:28:45 INFO - 'TMOUT': '86400', 21:28:45 INFO - 'USER': 'cltbld', 21:28:45 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530', 21:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:45 INFO - '_': '/tools/buildbot/bin/python'} 21:28:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 21:28:45 INFO - mozversion application_buildid: 20160819200714 21:28:45 INFO - mozversion application_changeset: fb9dbacb7f8b52dd47b1ff87f8678179bcf68f4e 21:28:45 INFO - mozversion application_display_name: Nightly 21:28:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:28:45 INFO - mozversion application_name: Firefox 21:28:45 INFO - mozversion application_remotingname: firefox 21:28:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:28:45 INFO - mozversion application_vendor: Mozilla 21:28:45 INFO - mozversion application_version: 51.0a1 21:28:45 INFO - mozversion platform_buildid: 20160819200714 21:28:45 INFO - mozversion platform_changeset: fb9dbacb7f8b52dd47b1ff87f8678179bcf68f4e 21:28:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:28:45 INFO - mozversion platform_version: 51.0a1 21:28:45 INFO - using testdate: 1471667325 21:28:45 INFO - actual date: 1471667325 21:28:45 INFO - starting webserver on 'localhost:44304' 21:28:45 INFO - SUITE-START | Running 2 tests 21:28:45 INFO - TEST-START | dromaeo_css 21:28:45 INFO - operating with platform_type : linux_ 21:28:45 INFO - Initialising browser for dromaeo_css test... 21:28:45 INFO - TEST-INFO | started process 15974 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0NapAe/profile http://localhost:44304/getInfo.html) 21:28:50 INFO - PROCESS | 15974 | __metrics Screen width/height:1600/1200 21:28:50 INFO - PROCESS | 15974 | colorDepth:24 21:28:50 INFO - PROCESS | 15974 | Browser inner width/height: 1024/697 21:28:50 INFO - PROCESS | 15974 | __metrics 21:28:50 INFO - PROCESS | 15974 | 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" 21:28:50 INFO - PROCESS | 15974 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:28:51 INFO - TEST-INFO | 15974: exit 0 21:28:51 INFO - Browser initialized. 21:28:51 INFO - Running cycle 1/1 for dromaeo_css test... 21:28:51 INFO - TEST-INFO | started process 16053 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0NapAe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:29:03 INFO - PROCESS | 16053 | RSS: Main: 175910912 21:29:03 INFO - PROCESS | 16053 | 21:29:55 INFO - PROCESS | 16053 | 1471667395656 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] 21:32:07 INFO - PROCESS | 16053 | Cycle 1(1): loaded http://localhost:44304/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44304/tests/dromaeo/cssquery-ext.html) 21:32:08 INFO - PROCESS | 16053 | RSS: Main: 267530240 21:32:08 INFO - PROCESS | 16053 | 21:35:11 INFO - PROCESS | 16053 | Cycle 1(1): loaded http://localhost:44304/tests/dromaeo/cssquery-ext.html (next: http://localhost:44304/tests/dromaeo/cssquery-jquery.html) 21:35:12 INFO - PROCESS | 16053 | RSS: Main: 274731008 21:35:12 INFO - PROCESS | 16053 | 21:38:14 INFO - PROCESS | 16053 | Cycle 1(1): loaded http://localhost:44304/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44304/tests/dromaeo/cssquery-mootools.html) 21:38:15 INFO - PROCESS | 16053 | RSS: Main: 219586560 21:38:15 INFO - PROCESS | 16053 | 21:41:17 INFO - PROCESS | 16053 | Cycle 1(1): loaded http://localhost:44304/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44304/tests/dromaeo/cssquery-prototype.html) 21:41:18 INFO - PROCESS | 16053 | RSS: Main: 219324416 21:41:18 INFO - PROCESS | 16053 | 21:44:21 INFO - PROCESS | 16053 | Cycle 1(1): loaded http://localhost:44304/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44304/tests/dromaeo/cssquery-yui.html) 21:44:22 INFO - PROCESS | 16053 | RSS: Main: 223260672 21:44:22 INFO - PROCESS | 16053 | 21:47:25 INFO - PROCESS | 16053 | Cycle 1(1): loaded http://localhost:44304/tests/dromaeo/cssquery-yui.html (next: http://localhost:44304/tests/dromaeo/cssquery-dojo.html) 21:47:25 INFO - PROCESS | 16053 | RSS: Main: 309874688 21:47:25 INFO - PROCESS | 16053 | 21:47:25 INFO - PROCESS | 16053 | __start_tp_report 21:47:25 INFO - PROCESS | 16053 | _x_x_mozilla_page_load 21:47:25 INFO - PROCESS | 16053 | _x_x_mozilla_page_load_details 21:47:25 INFO - PROCESS | 16053 | |i|pagename|runs| 21:47:25 INFO - PROCESS | 16053 | |0;dojo.html;2576.0339872547793;2597.792176625868;2603.7396260373957;2607.4785042991393;2626.3434141464636;4470;4633.884152896179;4666.673332866701;4667.953320466794;4670.299455081739;4641.883952901179;4657.138429390557;4708.105459962605;4784.473707892129;4798.688085274463;4087.509498860126;4278.122984788127;4391.692581519295;4413.889652758675;4431.202383570956;4391.231534481469;4402.955970440286;4421.778911054451;4421.955780442187;4426;4196.223698615766;4233.301505251629;4243.236217480852;4359.455068116486;4373.540778218305;4256.9574304257185;4259.637930775857;4261.190373828963;4270.829166833323;4327.935080973756;4287.421198138242;4326.459192600925;4344.326629372453;4344.413504176959;4346.956530434687;4735.715857048588;4736.739479328636;4740.928886066712;4752.857414277542;4761.928571071437;4915.459299477055;4979.45226025137;5027.421846487664;5049.545540901337;5107.387113546361;5087.033463641933;5100.642954993152;5101.362329708786;5103.795848166069;5124.0776660201145;4582.473015603182;4734.313524538922;4757.35775670287;4761.785719642625;4770.045990801854;5123.103456895028;5173.637845350864;5178.249153872667;5209.322788037607;5252.422233554306;4983.177775666974;4988.102141614544;4991.875203119951;4993.151164302078;4993.151164302078;4892.926606100911;5094.235864620263;5118.078745825787;5119.795208191705;5120.48795120485;4929.802807887716;4932.21084626458;4963.081829861487;5025.773840177201;5043.293938848564;5000.424951130593;5003.5997120230295;5005.399352077774;5012.824551140692;5013.39839219296;4129.793510324472;4258.382534532476;4261.850835220753;4264.744115353026;4288.421063156434;3658.70730341572;3677.3748462761396;3695.427208782643;3700.648438398348;3761.8683346083303;4333.804978775963;4368.410264614236;4373.387725718402;4377.058932329564;4377.387165796791;4915.311856340115;5044.873878153076;5045.217991211368;5048;5049.772760225798;4281.957180428218;4306.698531102793;4307.892302692458;4362.411074504901;4367.672424568106;4499.280115181556;4515.848458643025;4517.706349087299;4518.209313370213;4526.23054080807;4633.2818413146015;4745.762711864393;4760.309755085563;4763.380760501182;4763.809447622057;4992;5004.84985450437;5023.045621332081;5076.908464680111;5089.821856235014;4761.4762376137905;4784.856454306377;4786.138495070921;4789.473157952552;4802.423709154924;4962.627802914868;5002.099622068063;5023.120953833138;5023.547880690755;5028.974855125847;4890.731009794353;4913.3121363008495;4959.652824302409;4971.130052240916;5022.995400919757;4890.462049174659;4894.608431325557;4902.828401005948;4904.94543673112;4905.1416002200185;4881.096997055556;4892.8532144035735;4893.412790465167;4900.607951363953;4901.460839307602;4682.789274482589;4788.688735232199;4835.419749630067;4840.951590484191;4911.975440122919;4964.081644895706;4976.751162441791;4977.527134922177;5026.924596130988;5027.547520723152;4668.626509879269;4865.245886887538;4879.56083952446;4918.286848407032;4920.21276595743 21:47:25 INFO - PROCESS | 16053 | |1;ext.html;550.4742970463208;551.8261747549524;562.4881357964254;563.5913962377277;568.2186992884783;28200;31351.372972540565;39159.60840391599;40423.19153616933;40600.79699601505;40485.595144048624;40859.38710919338;40879.386809197815;40907.59092409075;40943;7519.924800752005;7662.233776622321;7668.38652907766;7668.4248681348845;7669.8082547936465;7453.888191677129;9552.140307372336;9783.945371472;9820.558074886647;10151.289409741321;9822.312438129335;9914.504274786268;9917.752056198617;9926.602935882556;9931.652392166276;9855.704328870146;9917.851232231522;9928.354656947311;9929.106380425725;9937.90062099377;9950.203983681287;10025.899741002642;10033.448160351178;10039.648612298535;10040.196784257316;38065.80967095175;38344.23311533782;38385.80807095975;38395.42406863899;38410.615893840986;2760.8205466644604;2785.373291009527;2796.1192224449233;2850.2589326774983;3067.9539806902912;28589.38139790322;29070.854645726846;29271.85364073166;29321.853390733122;29874.70125298741;3434.862605495777;3526.5944416392185;3564.108972756811;3567.2687099144873;3568.107973006748;252521;252951;253901;253986;254222;50712.23931641028;50895;50918.490815091376;50963.23555146676;51045.23432148521;32003.67996320007;32648.510272345935;32881.177970550925;53997.46002539925;54041.729791350794;12973.286469244282;13077.346132693327;13182.472701092041;13185.53850615224;13192.934035329761;9267.629294828266;9373.62505499786;9918.80162396748;10010.249231307682;10031.29780915329;17100.144992750313;17618.2071806769;17763.378281760077;17777.911110444365;17896.821031789776;6781.694823732944;6882.562775407372;6925.792226233221;7180;7207.603581802946;789.2226157235234;879.9868001979976;907.9409838360485;917.4220241248105;923.8152369526122;27922.16233512998;27965;28165.71834281672;28194;28302.575461368095;940.7554035950702;968.2979839616222;968.5012218707371;979.3242662562809;992.8957459466797;14071.507497237548;14842.628934276729;14855.851441485664;15173.544793656209;15383.230838458032;395556;397630;398509;398676;400954;44207.55792442099;48955.26567101496;49542;49559.256611150864;49615.75192124016;1069.4492336446735;1145.4788071427313;1176.129664048598;1188.037689471531;1201.5554244929083;27009.45981080328;28436.43127137487;28531.857340713163;29401.85299073491;29610.703892960795;41127.58872411238;46046.309305361116;47809;47819.28271076006;52175.73912130415;268971;271879;272033;272049;272229.6388518045;24918.252452426455;25362.365940851625;25482.490350193264;26246.73753262443;32562.837185814868;41213.58786412098;41240.793796030826;41249.79375103225;41523;41704.58295417128;35331.29337413289;35431.291374172884;35918.640813591526;35982.28035439329;36330.27339453249;34995.47506787451;35174.296514069065;35674.643253567134;35750.8212458936;35795.284094317445;34533.30933381268;34989.30021399507;35003;35647.64352356547;35712;30814.537781932842;33316;33316.500252495745;33665.326693465504;33857.49213761845;24649.87675061613;25371;25585.744142558335;25775.484490309715;26236 21:47:25 INFO - PROCESS | 16053 | |2;jquery.html;340.17846899737134;355.2132027558956;360.9133807886107;368.2947156195885;376.26064782701985;12541.749165016694;13672.589822305323;14077.718445631093;14795;15250.94981003801;15588.532344029669;15855.84144158558;15954.84045159548;16106.194690265498;16227.107509086996;4340.609345158935;4861.246506791453;5004.924926126111;5112.258722485238;5115.079285728568;5003.12445322069;5077.060743762398;5084.186530155157;5085.338905942241;5087.414947281054;4766.142094423002;4945.505449455061;5054.317667114948;5062.240663900426;5063.088644044071;4856.5629093381585;4925.75371231437;4930.482299358588;4936.531029552187;4937.185364414867;4414.845480408202;4417.977910110429;4419.049904270597;4421.115776844644;4663.673542852001;18811.905940470348;20050.398488045383;20484.487887802774;20550.38348849522;20610.175592976262;1678.639092595098;1678.7985441746946;1778.8043315235313;1810.1582764014665;2003.1987205117923;8724.258438032775;9126.680566180152;9300.581473833694;9438.244940404751;9632.711018669452;1467.9192644404554;1525.4203402707012;1665.6835201311712;1717.3130747700895;1733.081466822586;66408.66795666039;67236.66381668061;67595;69325.30674693239;70157.64921175361;9925.751856203653;10015.098641122187;10031.347962382422;10236.48817559119;10250.58997640086;13840.584782456543;13840.792388114187;13852.792208116887;13863.930680346533;13872.861271387359;6603.339666033455;6739;6850.691718872663;7016.859662806715;7096.53872498286;6314.305426403092;6356.173697419306;6521.543491955613;6540.836479087966;6547.345265473415;4271;4305.225059489259;4309.6767742418815;4345.521992580813;4430.82276708928;1726.6374061446986;1759.3930094117509;1797.1194114883613;1817.581956150093;1822.5170329862597;763.4655740981335;775.9224077592309;801.8997625296838;909.3452714045876;910.7859652981545;15232.543023709306;15845.603859903595;15944.202789860461;15976.680466390839;16567.834321656628;742.7177672484421;793.6626933553217;795.9243871832167;830.323286521483;831.9750407487785;8781.34139939507;8963;9061.13919177677;9738.220942324597;10557.524911379007;281689;282068;283433;382242;408271;78324;81140.59429702813;82182;82986;85274.99999999876;885.8051228729669;919.1865199298669;920.5719340506696;926.0878035135386;926.7590426489162;15742.291596878396;15800.841991579937;16114.194290285204;16336;16472.83527164713;37526.81236593799;37674.246515070095;38137.23725525529;38399.99999999888;38855.6114438852;52787.73606131945;53219.4763445096;54773.1784023232;54786;55709;7341.486095973444;7365.410767138723;7389.113306403266;7542.773716788505;7965.561894095648;7847.764567062997;10936.781264374828;11530.365829879438;11572.363520006144;12064.215825971634;9917.752056198653;10102.595896164365;10329.741756455847;10362.451212329845;10393.58425662965;9618.807623847624;9978.251631127549;10023.498825058572;10089.545970431202;10151.340162889388;9595.23238140961;10042.69871903844;10302.690919272434;10389.740256493647;10479;7252.456065795192;7313.23211062852;7472.402207823252;7585.886211706939;7593.392528597588;8416.957915210385;10331.793364132525;10533.9473302633;10700.41147736882;10823.729406764895 21:47:25 INFO - PROCESS | 16053 | |3;mootools.html;1256.484841215102;1369.1579678497721;1394.5119208277101;1466.8899832512564;1671.0892563552864;6662.500312476565;7121.145462544496;7440.96279518603;7456.105267367923;7458.701651933923;7232.493725439222;7354.889676654854;7359.227281135471;7524.84950300995;7535.811604709885;2166.1660260799586;2208.1608988584394;2212.0930418528405;2219.2454565447742;2219.933401997943;2134.210342173398;2160.48148444373;2171.5114099327684;2196.967045494319;2211.9557608847813;2178.2049551913597;2205.7683943185975;2210.4363387336207;2212.889355532217;2214.402111429913;2139.7860213978556;2143.07847625521;2146.73165854269;2148.0655914677163;2148.4521447030907;2133.925312614051;2195.8243340532717;2197.626403511407;2198.483356411242;2199.5820794049077;7405.518641288353;7538.3215510604305;7577.81055473612;7618.162002179756;7624;4323.567643235683;4445.799939002753;4472.418585583886;4473.865784026452;4474.328850672393;2892.204643722972;2988.491956367423;3028.712272334125;3036.817790932529;3048.1465189746905;939.304914363373;957.861110139026;971.3346357744897;972.2707969023232;983.1643103362156;10253.897461025368;10311.381317120922;10435.530401131968;10439.164866810714;10458.215633827493;4149.543550209474;4192.140611174702;4330.935035974463;4353.934690979638;4382.386465894777;8240.793980150424;8336.374771892011;8337.708180213664;8338.708145214889;8342.83314333722;4394.318880573516;4395.670324725658;4396.4284642996845;4400.229959757094;4402.537733537996;3597.712183025352;3601.8408142135495;3698.574663913684;4062.2484840304637;4062.939055914164;3309.7517686173633;3397.813120278359;3471.479278108304;3479.7912125272564;3503.737219708532;1072.694282129605;1096.5230124895695;1098.0776148035688;1111.6387174168428;1115.6485707002269;663.3598577372859;755.1165136789969;786.8662327404355;807.6365635463948;813.3371302388534;4918.778654960463;4975.676581022222;5035.723035233024;5139.922901156486;5306.867328316745;408.27938688215323;417.09906601740096;421.26279011729474;423.35861170326365;425.55529471702147;3336.3327334532705;3391.542141810824;3417.2652879631;3486.599041110254;3514.367413865478;8980.775480613036;9224.446533208029;9296.07039296065;9299.907000929905;9306.906930930603;9259.444433334022;9264.953675231716;9269.768255793659;9281.39670921388;9284.535773211312;7058.894116588255;7095.858082838315;7108.3602475777425;7131.144262688407;7150.892736608955;4813.7593120344545;4932.654714169974;4991.925121123259;5003.624728145476;5174.301469301596;8396.32829373661;8676.826463470821;8707.172818582225;8765.737027889174;8836.072212417861;7722.806929826575;8641.265492433213;8863.734087977371;8940.910590894007;8953.836001319787;6292.874142517033;6474.514411419068;6503.44720698727;6688.598684078776;6692.531522793358;7144.4641651877355;7199.208087110309;7199.604021778852;7252.057232559733;7278.454115941219;6528.640924748995;6619.702113404812;6633.369829866155;6666.699998500176;6688.130543029375;6191.907121393273;6401.423871851555;6442.387973142544;6445.6454894981225;6487.124238227968;6125.111858780541;6151.446369826737;6153.600015998945;6214.067889816383;6218.906716399167;4406.933895991627;4453.421055262795;4513.54864513546;4559.430071241095;4627.49097599257;4579.542045795394;4647.953520464887;4649.465311489087;4664.113818374498;4697.859064228079 21:47:25 INFO - PROCESS | 16053 | |4;prototype.html;295.39444139513995;302.2398667351611;304.7942638718864;304.85367023828576;308.84249032993165;4705.764711764411;4707.882302942428;4726;4729.527047295273;4765.666403351766;4639.492165046365;4682.578567928886;4692.944087580293;4696.201645720227;4704.012157446931;3535.2222511047594;3619.348517266891;3629.3467175908327;3638.181409182926;3649.41250556009;3690.15126520899;3695.778253304797;3715.4984077149643;3717;3721.1627383838554;3668.578113516953;3674.8346324415465;3688.8604609326662;3697.907552311187;3714.8699795507164;3492.725155318303;3514.297140571896;3655.5613326400735;3656.11709969366;3679.3193259247123;3282.179455136216;3291;3291.522729204276;3291.9177020574675;3295.1762059485127;4571.679982401233;4573.679842411033;4579.702319349265;4584.381108550337;4606.262997920317;4147.212029714345;4165.189299925148;4204.2432362174795;4215.367694845767;4216.2832318505625;4827;4859.975700121512;4860.7326597037145;4864.197407427806;4882.194437917739;3576.7317451191007;3585.229175727205;3591.2458383739445;3600.135967367839;3601.2617413430185;5128.461411601281;5136.306598609177;5156.742162891878;5171.327727395452;5185.118529849935;3602.1354874830377;3681.631836816297;3704.2776658551325;3705.184859330943;3705.370087085202;3729.254149170177;3730.309892669865;3731.3097077040834;3751.9609116615084;3760.4735337052834;4188.162367526507;4197.454330936958;4200.411942328076;4201.621854033152;4221.02916329246;4715.905681886343;4876.122297986326;4887.3890763654545;4888.364512613338;4930.802767889316;1252.874712528758;1281.3080936294482;1285.3573213393304;1294.6698591859015;1297.3902265934996;817.9918200818034;832.9458585192065;848.728406909783;852.6996330595767;857.4555157474923;4263.232618128704;4334.913301733947;4354.912901741947;4371.519132895379;4371.803268852909;5011.924821127686;5019.619604608689;5025.949740502621;5041.495850415003;5049.848504544796;4355.607995280377;4359.302511598193;4361.498427680794;4396.802143903468;4406.933895991563;2525.8002448837024;2642.8371516532666;2665.800064995133;2666.6400035994893;2667.3598336399123;4751.904961900812;4758.904821903542;4767.880802979953;4768.809247630125;4795.832145874878;4998.277292777751;5153.871153221199;5154.458781827929;5180.9740951295;5186;4682.367880336179;4718.678769944421;4761.357216775691;4762.357081794052;4764.71293778988;4986.626003049858;5016.924746128738;5017.9498205018945;5031.320771695774;5056.898862022813;4754;4943.530364615356;4968.180250258667;4973.9253911190635;4980.576650984562;4718.0983695026625;4730.645201609824;4733.7396443194575;4761.761941895063;4767.856964291077;3646.796557136192;3648.8540458381367;3662.3957047086933;3672.2288319453214;3679.1905780729267;5052.949470505395;5057.140286151437;5062;5069.721165335942;5087.898242035212;4771.6898401603785;4871.610271178368;4874.7562621868055;4882.8281212509455;4913.213885778258;4850.757462126809;4865.367502224688;4874.4150701916;4875.634327425528;4875.780589873393;4828.696252012008;4830.855074347775;4840.975795121002;4841.346418233635;4843.321934929042;4764.521899013808;4877.097736918681;4901.607871370211;4906.55840974314;4917.901641967069;4788.63523895688;4806.375171227718;4811.422629284508;4824.228123500223;4825.806967721252 21:47:25 INFO - PROCESS | 16053 | |5;yui.html;593.6883136353414;605.1407002057078;653.2487639214902;677.1062197898775;679.3817625960377;11627.941860290697;12795.552155674564;12899.419526121324;12900.870991290085;12935.029872759533;13072.477100915976;13224.6693832654;13295.268760218185;13316.600501984933;13317;625.5371025441186;753.8529986652592;775.25962705616;778.4395235430482;778.7663700889739;630;759.8480303939207;771.6026246483066;783.8197214640636;785.5561607691636;812.4515951732586;814.1085511365076;814.9266566009057;815.2377527012262;815.5881279953616;647.4076220258457;811.5739236900615;812.9065157506903;813.4996976859248;813.6826637611337;580.1384943359109;590.3270271890049;592.9851753706149;596.8507873031742;597.3190562758415;11751.236169649032;11862.940685296604;11956.222845515014;11959.40202989847;11987.58043468483;12702.301373424458;13231.669208269774;13328.533501327503;13347;13512.189268643815;10910.345379277189;11222.887771122267;11405.714857128554;11798.764024719543;11909.940450297692;4125;4153.273177193979;4183.790810459464;4299.935500967488;4337.110892267077;52743;56325;56353.71823140858;63603.681981590256;64362;9851.96554361796;9946.850797238047;10092.394456332644;10158.441285729356;10211.7447063824;18281.725774113398;18592.721109183374;18612.534686632673;18625.7206141908;18630.44108676742;6244.906326405107;6366.522510811707;6369.363063693593;6381.840453988688;6568.540202185896;3180.9840950795096;3262;3269.324379364796;3337.666233376643;3421.26442814796;2745.9725402746117;2822.223888430657;2845.601615773793;2850.08797184903;2854.6574411070806;490.49724032866595;493.53854146373254;494.82433736023916;498.4666406944607;498.7157320327451;473.7796924430157;507.2070231730814;507.6066048812126;508.72274610337456;532.5047705633798;7545;7587.938951717129;7894.565798881116;8044.517328960164;8053;461.93301971213987;484.9791189545955;518.0571360124537;520.5393226994138;536.0538649284017;3474;3695.6119607440833;3705.350230023425;3734.3651579231596;3757.511523501927;91163;92975;95925;96215.51892240494;96340;85005.87485312916;88637;88889;89249;89459;45606.77196614062;59293;70527.64736176287;72424;75916.62041689757;6971.163460384786;7229.819254518468;7263.891041634274;7266.600336981517;7346.449016323904;45259.773701131286;46092.46890373043;46411.30383044325;46453.53546464627;46930.84848454655;59653.10520342285;59973.70013150081;65397.90138824333;67587.66206168938;68158.65920670365;8894.644214231359;8924.910750892668;8935.776605584912;9024.59389327495;9300.860487092563;9997.400155990665;10055;10091;10158.339707918962;10314.638987635397;8910.86633700482;9003.504807235666;9121.133492318218;9572.282078843975;9698.36960597559;9315.161635452841;9325.580348884181;9467.763305917131;9681;10039.19686425099;9065.546722663972;9093;9186.632534698538;9463.432194068102;9832.410055396698;7419.5548267101985;7611.543307401574;7759.2240775921955;7796.610169491616;7889.4082943780595;8146.9185308148535;8208.343332533503;8336.416450848625;8452.408331416987;8519.190676885686 21:47:25 INFO - PROCESS | 16053 | __end_tp_report 21:47:25 INFO - PROCESS | 16053 | __start_cc_report 21:47:25 INFO - PROCESS | 16053 | _x_x_mozilla_cycle_collect,963 21:47:25 INFO - PROCESS | 16053 | __end_cc_report 21:47:25 INFO - PROCESS | 16053 | __startTimestamp1471668445654__endTimestamp 21:47:25 INFO - PROCESS | 16053 | 21:47:25 INFO - PROCESS | 16053 | ------- Summary: start ------- 21:47:25 INFO - PROCESS | 16053 | Number of tests: 6 21:47:25 INFO - PROCESS | 16053 | 21:47:25 INFO - PROCESS | 16053 | [#0] dojo.html Cycles:165 Average:4651.89 Median:4784.86 stddev:497.31 (10.4%) stddev-sans-first:471.42 21:47:25 INFO - PROCESS | 16053 | Values: 2576.0 2597.8 2603.7 2607.5 2626.3 4470.0 4633.9 4666.7 4668.0 4670.3 4641.9 4657.1 4708.1 4784.5 4798.7 4087.5 4278.1 4391.7 4413.9 4431.2 4391.2 4403.0 4421.8 4422.0 4426.0 4196.2 4233.3 4243.2 4359.5 4373.5 4257.0 4259.6 4261.2 4270.8 4327.9 4287.4 4326.5 4344.3 4344.4 4347.0 4735.7 4736.7 4740.9 4752.9 4761.9 4915.5 4979.5 5027.4 5049.5 5107.4 5087.0 5100.6 5101.4 5103.8 5124.1 4582.5 4734.3 4757.4 4761.8 4770.0 5123.1 5173.6 5178.2 5209.3 5252.4 4983.2 4988.1 4991.9 4993.2 4993.2 4892.9 5094.2 5118.1 5119.8 5120.5 4929.8 4932.2 4963.1 5025.8 5043.3 5000.4 5003.6 5005.4 5012.8 5013.4 4129.8 4258.4 4261.9 4264.7 4288.4 3658.7 3677.4 3695.4 3700.6 3761.9 4333.8 4368.4 4373.4 4377.1 4377.4 4915.3 5044.9 5045.2 5048.0 5049.8 4282.0 4306.7 4307.9 4362.4 4367.7 4499.3 4515.8 4517.7 4518.2 4526.2 4633.3 4745.8 4760.3 4763.4 4763.8 4992.0 5004.8 5023.0 5076.9 5089.8 4761.5 4784.9 4786.1 4789.5 4802.4 4962.6 5002.1 5023.1 5023.5 5029.0 4890.7 4913.3 4959.7 4971.1 5023.0 4890.5 4894.6 4902.8 4904.9 4905.1 4881.1 4892.9 4893.4 4900.6 4901.5 4682.8 4788.7 4835.4 4841.0 4912.0 4964.1 4976.8 4977.5 5026.9 5027.5 4668.6 4865.2 4879.6 4918.3 4920.2 21:47:25 INFO - PROCESS | 16053 | 21:47:25 INFO - PROCESS | 16053 | [#1] ext.html Cycles:180 Average:46222.43 Median:19640.05 stddev:82693.36 (421.0%) stddev-sans-first:82854.24 21:47:25 INFO - PROCESS | 16053 | Values: 550.5 551.8 562.5 563.6 568.2 28200.0 31351.4 39159.6 40423.2 40600.8 40485.6 40859.4 40879.4 40907.6 40943.0 7519.9 7662.2 7668.4 7668.4 7669.8 7453.9 9552.1 9783.9 9820.6 10151.3 9822.3 9914.5 9917.8 9926.6 9931.7 9855.7 9917.9 9928.4 9929.1 9937.9 9950.2 10025.9 10033.4 10039.6 10040.2 38065.8 38344.2 38385.8 38395.4 38410.6 2760.8 2785.4 2796.1 2850.3 3068.0 28589.4 29070.9 29271.9 29321.9 29874.7 3434.9 3526.6 3564.1 3567.3 3568.1 252521.0 252951.0 253901.0 253986.0 254222.0 50712.2 50895.0 50918.5 50963.2 51045.2 32003.7 32648.5 32881.2 53997.5 54041.7 12973.3 13077.3 13182.5 13185.5 13192.9 9267.6 9373.6 9918.8 10010.2 10031.3 17100.1 17618.2 17763.4 17777.9 17896.8 6781.7 6882.6 6925.8 7180.0 7207.6 789.2 880.0 907.9 917.4 923.8 27922.2 27965.0 28165.7 28194.0 28302.6 940.8 968.3 968.5 979.3 992.9 14071.5 14842.6 14855.9 15173.5 15383.2 395556.0 397630.0 398509.0 398676.0 400954.0 44207.6 48955.3 49542.0 49559.3 49615.8 1069.4 1145.5 1176.1 1188.0 1201.6 27009.5 28436.4 28531.9 29401.9 29610.7 41127.6 46046.3 47809.0 47819.3 52175.7 268971.0 271879.0 272033.0 272049.0 272229.6 24918.3 25362.4 25482.5 26246.7 32562.8 41213.6 41240.8 41249.8 41523.0 41704.6 35331.3 35431.3 35918.6 35982.3 36330.3 34995.5 35174.3 35674.6 35750.8 35795.3 34533.3 34989.3 35003.0 35647.6 35712.0 30814.5 33316.0 33316.5 33665.3 33857.5 24649.9 25371.0 25585.7 25775.5 26236.0 21:47:25 INFO - PROCESS | 16053 | 21:47:25 INFO - PROCESS | 16053 | [#2] jquery.html Cycles:180 Average:22530.98 Median:4418.51 stddev:55587.48 (1258.1%) stddev-sans-first:55718.44 21:47:25 INFO - PROCESS | 16053 | Values: 340.2 355.2 360.9 368.3 376.3 12541.7 13672.6 14077.7 14795.0 15250.9 15588.5 15855.8 15954.8 16106.2 16227.1 4340.6 4861.2 5004.9 5112.3 5115.1 5003.1 5077.1 5084.2 5085.3 5087.4 4766.1 4945.5 5054.3 5062.2 5063.1 4856.6 4925.8 4930.5 4936.5 4937.2 4414.8 4418.0 4419.0 4421.1 4663.7 18811.9 20050.4 20484.5 20550.4 20610.2 1678.6 1678.8 1778.8 1810.2 2003.2 8724.3 9126.7 9300.6 9438.2 9632.7 1467.9 1525.4 1665.7 1717.3 1733.1 66408.7 67236.7 67595.0 69325.3 70157.6 9925.8 10015.1 10031.3 10236.5 10250.6 13840.6 13840.8 13852.8 13863.9 13872.9 6603.3 6739.0 6850.7 7016.9 7096.5 6314.3 6356.2 6521.5 6540.8 6547.3 4271.0 4305.2 4309.7 4345.5 4430.8 1726.6 1759.4 1797.1 1817.6 1822.5 763.5 775.9 801.9 909.3 910.8 15232.5 15845.6 15944.2 15976.7 16567.8 742.7 793.7 795.9 830.3 832.0 8781.3 8963.0 9061.1 9738.2 10557.5 281689.0 282068.0 283433.0 382242.0 408271.0 78324.0 81140.6 82182.0 82986.0 85275.0 885.8 919.2 920.6 926.1 926.8 15742.3 15800.8 16114.2 16336.0 16472.8 37526.8 37674.2 38137.2 38400.0 38855.6 52787.7 53219.5 54773.2 54786.0 55709.0 7341.5 7365.4 7389.1 7542.8 7965.6 7847.8 10936.8 11530.4 11572.4 12064.2 9917.8 10102.6 10329.7 10362.5 10393.6 9618.8 9978.3 10023.5 10089.5 10151.3 9595.2 10042.7 10302.7 10389.7 10479.0 7252.5 7313.2 7472.4 7585.9 7593.4 8417.0 10331.8 10533.9 10700.4 10823.7 21:47:25 INFO - PROCESS | 16053 | 21:47:25 INFO - PROCESS | 16053 | [#3] mootools.html Cycles:180 Average:4953.32 Median:4866.27 stddev:2760.55 (56.7%) stddev-sans-first:2754.32 21:47:25 INFO - PROCESS | 16053 | Values: 1256.5 1369.2 1394.5 1466.9 1671.1 6662.5 7121.1 7441.0 7456.1 7458.7 7232.5 7354.9 7359.2 7524.8 7535.8 2166.2 2208.2 2212.1 2219.2 2219.9 2134.2 2160.5 2171.5 2197.0 2212.0 2178.2 2205.8 2210.4 2212.9 2214.4 2139.8 2143.1 2146.7 2148.1 2148.5 2133.9 2195.8 2197.6 2198.5 2199.6 7405.5 7538.3 7577.8 7618.2 7624.0 4323.6 4445.8 4472.4 4473.9 4474.3 2892.2 2988.5 3028.7 3036.8 3048.1 939.3 957.9 971.3 972.3 983.2 10253.9 10311.4 10435.5 10439.2 10458.2 4149.5 4192.1 4330.9 4353.9 4382.4 8240.8 8336.4 8337.7 8338.7 8342.8 4394.3 4395.7 4396.4 4400.2 4402.5 3597.7 3601.8 3698.6 4062.2 4062.9 3309.8 3397.8 3471.5 3479.8 3503.7 1072.7 1096.5 1098.1 1111.6 1115.6 663.4 755.1 786.9 807.6 813.3 4918.8 4975.7 5035.7 5139.9 5306.9 408.3 417.1 421.3 423.4 425.6 3336.3 3391.5 3417.3 3486.6 3514.4 8980.8 9224.4 9296.1 9299.9 9306.9 9259.4 9265.0 9269.8 9281.4 9284.5 7058.9 7095.9 7108.4 7131.1 7150.9 4813.8 4932.7 4991.9 5003.6 5174.3 8396.3 8676.8 8707.2 8765.7 8836.1 7722.8 8641.3 8863.7 8940.9 8953.8 6292.9 6474.5 6503.4 6688.6 6692.5 7144.5 7199.2 7199.6 7252.1 7278.5 6528.6 6619.7 6633.4 6666.7 6688.1 6191.9 6401.4 6442.4 6445.6 6487.1 6125.1 6151.4 6153.6 6214.1 6218.9 4406.9 4453.4 4513.5 4559.4 4627.5 4579.5 4648.0 4649.5 4664.1 4697.9 21:47:25 INFO - PROCESS | 16053 | 21:47:25 INFO - PROCESS | 16053 | [#4] prototype.html Cycles:180 Average:4091.33 Median:4704.89 stddev:1172.93 (24.9%) stddev-sans-first:1141.09 21:47:25 INFO - PROCESS | 16053 | Values: 295.4 302.2 304.8 304.9 308.8 4705.8 4707.9 4726.0 4729.5 4765.7 4639.5 4682.6 4692.9 4696.2 4704.0 3535.2 3619.3 3629.3 3638.2 3649.4 3690.2 3695.8 3715.5 3717.0 3721.2 3668.6 3674.8 3688.9 3697.9 3714.9 3492.7 3514.3 3655.6 3656.1 3679.3 3282.2 3291.0 3291.5 3291.9 3295.2 4571.7 4573.7 4579.7 4584.4 4606.3 4147.2 4165.2 4204.2 4215.4 4216.3 4827.0 4860.0 4860.7 4864.2 4882.2 3576.7 3585.2 3591.2 3600.1 3601.3 5128.5 5136.3 5156.7 5171.3 5185.1 3602.1 3681.6 3704.3 3705.2 3705.4 3729.3 3730.3 3731.3 3752.0 3760.5 4188.2 4197.5 4200.4 4201.6 4221.0 4715.9 4876.1 4887.4 4888.4 4930.8 1252.9 1281.3 1285.4 1294.7 1297.4 818.0 832.9 848.7 852.7 857.5 4263.2 4334.9 4354.9 4371.5 4371.8 5011.9 5019.6 5025.9 5041.5 5049.8 4355.6 4359.3 4361.5 4396.8 4406.9 2525.8 2642.8 2665.8 2666.6 2667.4 4751.9 4758.9 4767.9 4768.8 4795.8 4998.3 5153.9 5154.5 5181.0 5186.0 4682.4 4718.7 4761.4 4762.4 4764.7 4986.6 5016.9 5017.9 5031.3 5056.9 4754.0 4943.5 4968.2 4973.9 4980.6 4718.1 4730.6 4733.7 4761.8 4767.9 3646.8 3648.9 3662.4 3672.2 3679.2 5052.9 5057.1 5062.0 5069.7 5087.9 4771.7 4871.6 4874.8 4882.8 4913.2 4850.8 4865.4 4874.4 4875.6 4875.8 4828.7 4830.9 4841.0 4841.3 4843.3 4764.5 4877.1 4901.6 4906.6 4917.9 4788.6 4806.4 4811.4 4824.2 4825.8 21:47:25 INFO - PROCESS | 16053 | 21:47:25 INFO - PROCESS | 16053 | [#5] yui.html Cycles:180 Average:17006.22 Median:30289.42 stddev:25001.33 (82.5%) stddev-sans-first:25041.09 21:47:25 INFO - PROCESS | 16053 | Values: 593.7 605.1 653.2 677.1 679.4 11627.9 12795.6 12899.4 12900.9 12935.0 13072.5 13224.7 13295.3 13316.6 13317.0 625.5 753.9 775.3 778.4 778.8 630.0 759.8 771.6 783.8 785.6 812.5 814.1 814.9 815.2 815.6 647.4 811.6 812.9 813.5 813.7 580.1 590.3 593.0 596.9 597.3 11751.2 11862.9 11956.2 11959.4 11987.6 12702.3 13231.7 13328.5 13347.0 13512.2 10910.3 11222.9 11405.7 11798.8 11909.9 4125.0 4153.3 4183.8 4299.9 4337.1 52743.0 56325.0 56353.7 63603.7 64362.0 9852.0 9946.9 10092.4 10158.4 10211.7 18281.7 18592.7 18612.5 18625.7 18630.4 6244.9 6366.5 6369.4 6381.8 6568.5 3181.0 3262.0 3269.3 3337.7 3421.3 2746.0 2822.2 2845.6 2850.1 2854.7 490.5 493.5 494.8 498.5 498.7 473.8 507.2 507.6 508.7 532.5 7545.0 7587.9 7894.6 8044.5 8053.0 461.9 485.0 518.1 520.5 536.1 3474.0 3695.6 3705.4 3734.4 3757.5 91163.0 92975.0 95925.0 96215.5 96340.0 85005.9 88637.0 88889.0 89249.0 89459.0 45606.8 59293.0 70527.6 72424.0 75916.6 6971.2 7229.8 7263.9 7266.6 7346.4 45259.8 46092.5 46411.3 46453.5 46930.8 59653.1 59973.7 65397.9 67587.7 68158.7 8894.6 8924.9 8935.8 9024.6 9300.9 9997.4 10055.0 10091.0 10158.3 10314.6 8910.9 9003.5 9121.1 9572.3 9698.4 9315.2 9325.6 9467.8 9681.0 10039.2 9065.5 9093.0 9186.6 9463.4 9832.4 7419.6 7611.5 7759.2 7796.6 7889.4 8146.9 8208.3 8336.4 8452.4 8519.2 21:47:25 INFO - PROCESS | 16053 | -------- Summary: end -------- 21:47:25 INFO - PROCESS | 16053 | 21:47:26 INFO - TEST-INFO | 16053: exit 0 21:47:26 INFO - TEST-OK | dromaeo_css | took 1121188ms 21:47:26 INFO - TEST-START | kraken 21:47:26 INFO - operating with platform_type : linux_ 21:47:26 INFO - Initialising browser for kraken test... 21:47:26 INFO - TEST-INFO | started process 16358 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjVmIXG/profile http://localhost:44304/getInfo.html) 21:47:31 INFO - PROCESS | 16358 | __metrics Screen width/height:1600/1200 21:47:31 INFO - PROCESS | 16358 | colorDepth:24 21:47:31 INFO - PROCESS | 16358 | Browser inner width/height: 1024/697 21:47:31 INFO - PROCESS | 16358 | __metrics 21:47:31 INFO - PROCESS | 16358 | 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" 21:47:31 INFO - PROCESS | 16358 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:47:32 INFO - TEST-INFO | 16358: exit 0 21:47:32 INFO - Browser initialized. 21:47:32 INFO - Running cycle 1/1 for kraken test... 21:47:32 INFO - TEST-INFO | started process 16440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjVmIXG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:47:45 INFO - PROCESS | 16440 | RSS: Main: 175398912 21:47:45 INFO - PROCESS | 16440 | 21:47:47 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44304/tests/kraken/driver.html?testName=audio-beat-detection) 21:47:48 INFO - PROCESS | 16440 | RSS: Main: 235544576 21:47:48 INFO - PROCESS | 16440 | 21:47:51 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44304/tests/kraken/driver.html?testName=audio-dft) 21:47:52 INFO - PROCESS | 16440 | RSS: Main: 226603008 21:47:52 INFO - PROCESS | 16440 | 21:47:55 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44304/tests/kraken/driver.html?testName=audio-fft) 21:47:56 INFO - PROCESS | 16440 | RSS: Main: 302092288 21:47:56 INFO - PROCESS | 16440 | 21:47:58 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44304/tests/kraken/driver.html?testName=audio-oscillator) 21:47:58 INFO - PROCESS | 16440 | RSS: Main: 210690048 21:47:58 INFO - PROCESS | 16440 | 21:48:01 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44304/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:48:01 INFO - PROCESS | 16440 | RSS: Main: 214286336 21:48:01 INFO - PROCESS | 16440 | 21:48:05 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44304/tests/kraken/driver.html?testName=imaging-darkroom) 21:48:05 INFO - PROCESS | 16440 | RSS: Main: 250576896 21:48:05 INFO - PROCESS | 16440 | 21:48:09 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44304/tests/kraken/driver.html?testName=imaging-desaturate) 21:48:09 INFO - PROCESS | 16440 | RSS: Main: 245383168 21:48:09 INFO - PROCESS | 16440 | 21:48:12 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44304/tests/kraken/driver.html?testName=json-parse-financial) 21:48:13 INFO - PROCESS | 16440 | RSS: Main: 249544704 21:48:13 INFO - PROCESS | 16440 | 21:48:15 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44304/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:48:15 INFO - PROCESS | 16440 | RSS: Main: 211963904 21:48:15 INFO - PROCESS | 16440 | 21:48:17 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44304/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:48:18 INFO - PROCESS | 16440 | RSS: Main: 219578368 21:48:18 INFO - PROCESS | 16440 | 21:48:20 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44304/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:48:21 INFO - PROCESS | 16440 | RSS: Main: 223858688 21:48:21 INFO - PROCESS | 16440 | 21:48:24 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:48:24 INFO - PROCESS | 16440 | RSS: Main: 218501120 21:48:24 INFO - PROCESS | 16440 | 21:48:27 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:48:28 INFO - PROCESS | 16440 | RSS: Main: 221401088 21:48:28 INFO - PROCESS | 16440 | 21:48:30 INFO - PROCESS | 16440 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44304/tests/kraken/driver.html?testName=ai-astar) 21:48:30 INFO - PROCESS | 16440 | RSS: Main: 272994304 21:48:30 INFO - PROCESS | 16440 | 21:48:30 INFO - PROCESS | 16440 | __start_tp_report 21:48:30 INFO - PROCESS | 16440 | _x_x_mozilla_page_load 21:48:30 INFO - PROCESS | 16440 | _x_x_mozilla_page_load_details 21:48:30 INFO - PROCESS | 16440 | |i|pagename|runs| 21:48:30 INFO - PROCESS | 16440 | |0;ai-astar;102;114;113;117;118;115;123;116;116;115 21:48:30 INFO - PROCESS | 16440 | |1;audio-beat-detection;156;126;147;183;128;145;146;123;192;123 21:48:30 INFO - PROCESS | 16440 | |2;audio-dft;161;160;161;162;162;161;161;162;161;159 21:48:30 INFO - PROCESS | 16440 | |3;audio-fft;77;77;75;178;78;76;77;122;117;77 21:48:30 INFO - PROCESS | 16440 | |4;audio-oscillator;85;86;143;87;86;86;142;87;87;156 21:48:30 INFO - PROCESS | 16440 | |5;imaging-gaussian-blur;118;118;117;118;118;119;117;116;117;117 21:48:30 INFO - PROCESS | 16440 | |6;imaging-darkroom;148;148;148;147;147;147;146;147;146;146 21:48:30 INFO - PROCESS | 16440 | |7;imaging-desaturate;95;96;94;95;95;95;95;95;95;94 21:48:30 INFO - PROCESS | 16440 | |8;json-parse-financial;64;66;66;66;66;67;73;68;69;69 21:48:30 INFO - PROCESS | 16440 | |9;json-stringify-tinderbox;64;66;66;65;66;65;64;67;75;65 21:48:30 INFO - PROCESS | 16440 | |10;stanford-crypto-aes;82;82;85;82;86;83;83;91;82;88 21:48:30 INFO - PROCESS | 16440 | |11;stanford-crypto-ccm;134;131;132;131;130;131;132;132;168;142 21:48:30 INFO - PROCESS | 16440 | |12;stanford-crypto-pbkdf2;177;173;177;175;176;178;186;174;185;176 21:48:30 INFO - PROCESS | 16440 | |13;stanford-crypto-sha256-iterative;68;69;70;70;68;69;69;70;76;69 21:48:30 INFO - PROCESS | 16440 | __end_tp_report 21:48:30 INFO - PROCESS | 16440 | __start_cc_report 21:48:30 INFO - PROCESS | 16440 | _x_x_mozilla_cycle_collect,1978 21:48:30 INFO - PROCESS | 16440 | __end_cc_report 21:48:30 INFO - PROCESS | 16440 | __startTimestamp1471668510389__endTimestamp 21:48:30 INFO - PROCESS | 16440 | 21:48:30 INFO - PROCESS | 16440 | ------- Summary: start ------- 21:48:30 INFO - PROCESS | 16440 | Number of tests: 14 21:48:30 INFO - PROCESS | 16440 | 21:48:30 INFO - PROCESS | 16440 | [#0] ai-astar Cycles:10 Average:114.90 Median:116.00 stddev:5.30 (4.6%) stddev-sans-first:2.92 21:48:30 INFO - PROCESS | 16440 | Values: 102.0 114.0 113.0 117.0 118.0 115.0 123.0 116.0 116.0 115.0 21:48:30 INFO - PROCESS | 16440 | 21:48:30 INFO - PROCESS | 16440 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:146.50 stddev:24.41 (16.7%) stddev-sans-first:25.66 21:48:30 INFO - PROCESS | 16440 | Values: 156.0 126.0 147.0 183.0 128.0 145.0 146.0 123.0 192.0 123.0 21:48:30 INFO - PROCESS | 16440 | 21:48:30 INFO - PROCESS | 16440 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 21:48:30 INFO - PROCESS | 16440 | Values: 161.0 160.0 161.0 162.0 162.0 161.0 161.0 162.0 161.0 159.0 21:48:30 INFO - PROCESS | 16440 | 21:48:30 INFO - PROCESS | 16440 | [#3] audio-fft Cycles:10 Average:95.40 Median:77.00 stddev:34.07 (44.2%) stddev-sans-first:35.48 21:48:30 INFO - PROCESS | 16440 | Values: 77.0 77.0 75.0 178.0 78.0 76.0 77.0 122.0 117.0 77.0 21:48:30 INFO - PROCESS | 16440 | 21:48:30 INFO - PROCESS | 16440 | [#4] audio-oscillator Cycles:10 Average:104.50 Median:86.00 stddev:29.56 (34.4%) stddev-sans-first:30.50 21:48:30 INFO - PROCESS | 16440 | Values: 85.0 86.0 143.0 87.0 86.0 86.0 142.0 87.0 87.0 156.0 21:48:30 INFO - PROCESS | 16440 | 21:48:30 INFO - PROCESS | 16440 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 21:48:30 INFO - PROCESS | 16440 | Values: 118.0 118.0 117.0 118.0 118.0 119.0 117.0 116.0 117.0 117.0 21:48:30 INFO - PROCESS | 16440 | 21:48:30 INFO - PROCESS | 16440 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 21:48:30 INFO - PROCESS | 16440 | Values: 148.0 148.0 148.0 147.0 147.0 147.0 146.0 147.0 146.0 146.0 21:48:30 INFO - PROCESS | 16440 | 21:48:30 INFO - PROCESS | 16440 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 21:48:30 INFO - PROCESS | 16440 | Values: 95.0 96.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 21:48:30 INFO - PROCESS | 16440 | 21:48:30 INFO - PROCESS | 16440 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:67.50 stddev:2.50 (3.7%) stddev-sans-first:2.33 21:48:30 INFO - PROCESS | 16440 | Values: 64.0 66.0 66.0 66.0 66.0 67.0 73.0 68.0 69.0 69.0 21:48:30 INFO - PROCESS | 16440 | 21:48:30 INFO - PROCESS | 16440 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:3.20 (4.8%) stddev-sans-first:3.28 21:48:30 INFO - PROCESS | 16440 | Values: 64.0 66.0 66.0 65.0 66.0 65.0 64.0 67.0 75.0 65.0 21:48:30 INFO - PROCESS | 16440 | 21:48:30 INFO - PROCESS | 16440 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:3.10 (3.7%) stddev-sans-first:3.16 21:48:30 INFO - PROCESS | 16440 | Values: 82.0 82.0 85.0 82.0 86.0 83.0 83.0 91.0 82.0 88.0 21:48:30 INFO - PROCESS | 16440 | 21:48:30 INFO - PROCESS | 16440 | [#11] stanford-crypto-ccm Cycles:10 Average:136.30 Median:132.00 stddev:11.65 (8.8%) stddev-sans-first:12.33 21:48:30 INFO - PROCESS | 16440 | Values: 134.0 131.0 132.0 131.0 130.0 131.0 132.0 132.0 168.0 142.0 21:48:30 INFO - PROCESS | 16440 | 21:48:30 INFO - PROCESS | 16440 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.70 Median:177.00 stddev:4.37 (2.5%) stddev-sans-first:4.63 21:48:30 INFO - PROCESS | 16440 | Values: 177.0 173.0 177.0 175.0 176.0 178.0 186.0 174.0 185.0 176.0 21:48:30 INFO - PROCESS | 16440 | 21:48:30 INFO - PROCESS | 16440 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:69.50 stddev:2.30 (3.3%) stddev-sans-first:2.35 21:48:30 INFO - PROCESS | 16440 | Values: 68.0 69.0 70.0 70.0 68.0 69.0 69.0 70.0 76.0 69.0 21:48:30 INFO - PROCESS | 16440 | -------- Summary: end -------- 21:48:30 INFO - PROCESS | 16440 | 21:48:31 INFO - TEST-INFO | 16440: exit 0 21:48:31 INFO - TEST-OK | kraken | took 65026ms 21:48:31 INFO - SUITE-END | took 1186s 21:48:32 INFO - Completed test suite (00:19:46) 21:48:32 INFO - javascript benchmark 21:48:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2576.0339872547793, 2597.792176625868, 2603.7396260373957, 2607.4785042991393, 2626.3434141464636, 4470.0, 4633.884152896179, 4666.673332866701, 4667.953320466794, 4670.299455081739, 4641.883952901179, 4657.138429390557, 4708.105459962605, 4784.473707892129, 4798.688085274463, 4087.509498860126, 4278.122984788127, 4391.692581519295, 4413.889652758675, 4431.202383570956, 4391.231534481469, 4402.955970440286, 4421.778911054451, 4421.955780442187, 4426.0, 4196.223698615766, 4233.301505251629, 4243.236217480852, 4359.455068116486, 4373.540778218305, 4256.9574304257185, 4259.637930775857, 4261.190373828963, 4270.829166833323, 4327.935080973756, 4287.421198138242, 4326.459192600925, 4344.326629372453, 4344.413504176959, 4346.956530434687, 4735.715857048588, 4736.739479328636, 4740.928886066712, 4752.857414277542, 4761.928571071437, 4915.459299477055, 4979.45226025137, 5027.421846487664, 5049.545540901337, 5107.387113546361, 5087.033463641933, 5100.642954993152, 5101.362329708786, 5103.795848166069, 5124.0776660201145, 4582.473015603182, 4734.313524538922, 4757.35775670287, 4761.785719642625, 4770.045990801854, 5123.103456895028, 5173.637845350864, 5178.249153872667, 5209.322788037607, 5252.422233554306, 4983.177775666974, 4988.102141614544, 4991.875203119951, 4993.151164302078, 4993.151164302078, 4892.926606100911, 5094.235864620263, 5118.078745825787, 5119.795208191705, 5120.48795120485, 4929.802807887716, 4932.21084626458, 4963.081829861487, 5025.773840177201, 5043.293938848564, 5000.424951130593, 5003.5997120230295, 5005.399352077774, 5012.824551140692, 5013.39839219296, 4129.793510324472, 4258.382534532476, 4261.850835220753, 4264.744115353026, 4288.421063156434, 3658.70730341572, 3677.3748462761396, 3695.427208782643, 3700.648438398348, 3761.8683346083303, 4333.804978775963, 4368.410264614236, 4373.387725718402, 4377.058932329564, 4377.387165796791, 4915.311856340115, 5044.873878153076, 5045.217991211368, 5048.0, 5049.772760225798, 4281.957180428218, 4306.698531102793, 4307.892302692458, 4362.411074504901, 4367.672424568106, 4499.280115181556, 4515.848458643025, 4517.706349087299, 4518.209313370213, 4526.23054080807, 4633.2818413146015, 4745.762711864393, 4760.309755085563, 4763.380760501182, 4763.809447622057, 4992.0, 5004.84985450437, 5023.045621332081, 5076.908464680111, 5089.821856235014, 4761.4762376137905, 4784.856454306377, 4786.138495070921, 4789.473157952552, 4802.423709154924, 4962.627802914868, 5002.099622068063, 5023.120953833138, 5023.547880690755, 5028.974855125847, 4890.731009794353, 4913.3121363008495, 4959.652824302409, 4971.130052240916, 5022.995400919757, 4890.462049174659, 4894.608431325557, 4902.828401005948, 4904.94543673112, 4905.1416002200185, 4881.096997055556, 4892.8532144035735, 4893.412790465167, 4900.607951363953, 4901.460839307602, 4682.789274482589, 4788.688735232199, 4835.419749630067, 4840.951590484191, 4911.975440122919, 4964.081644895706, 4976.751162441791, 4977.527134922177, 5026.924596130988, 5027.547520723152, 4668.626509879269, 4865.245886887538, 4879.56083952446, 4918.286848407032, 4920.21276595743], "value": 4619.474219304808, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.4742970463208, 551.8261747549524, 562.4881357964254, 563.5913962377277, 568.2186992884783, 28200.0, 31351.372972540565, 39159.60840391599, 40423.19153616933, 40600.79699601505, 40485.595144048624, 40859.38710919338, 40879.386809197815, 40907.59092409075, 40943.0, 7519.924800752005, 7662.233776622321, 7668.38652907766, 7668.4248681348845, 7669.8082547936465, 7453.888191677129, 9552.140307372336, 9783.945371472, 9820.558074886647, 10151.289409741321, 9822.312438129335, 9914.504274786268, 9917.752056198617, 9926.602935882556, 9931.652392166276, 9855.704328870146, 9917.851232231522, 9928.354656947311, 9929.106380425725, 9937.90062099377, 9950.203983681287, 10025.899741002642, 10033.448160351178, 10039.648612298535, 10040.196784257316, 38065.80967095175, 38344.23311533782, 38385.80807095975, 38395.42406863899, 38410.615893840986, 2760.8205466644604, 2785.373291009527, 2796.1192224449233, 2850.2589326774983, 3067.9539806902912, 28589.38139790322, 29070.854645726846, 29271.85364073166, 29321.853390733122, 29874.70125298741, 3434.862605495777, 3526.5944416392185, 3564.108972756811, 3567.2687099144873, 3568.107973006748, 252521.0, 252951.0, 253901.0, 253986.0, 254222.0, 50712.23931641028, 50895.0, 50918.490815091376, 50963.23555146676, 51045.23432148521, 32003.67996320007, 32648.510272345935, 32881.177970550925, 53997.46002539925, 54041.729791350794, 12973.286469244282, 13077.346132693327, 13182.472701092041, 13185.53850615224, 13192.934035329761, 9267.629294828266, 9373.62505499786, 9918.80162396748, 10010.249231307682, 10031.29780915329, 17100.144992750313, 17618.2071806769, 17763.378281760077, 17777.911110444365, 17896.821031789776, 6781.694823732944, 6882.562775407372, 6925.792226233221, 7180.0, 7207.603581802946, 789.2226157235234, 879.9868001979976, 907.9409838360485, 917.4220241248105, 923.8152369526122, 27922.16233512998, 27965.0, 28165.71834281672, 28194.0, 28302.575461368095, 940.7554035950702, 968.2979839616222, 968.5012218707371, 979.3242662562809, 992.8957459466797, 14071.507497237548, 14842.628934276729, 14855.851441485664, 15173.544793656209, 15383.230838458032, 395556.0, 397630.0, 398509.0, 398676.0, 400954.0, 44207.55792442099, 48955.26567101496, 49542.0, 49559.256611150864, 49615.75192124016, 1069.4492336446735, 1145.4788071427313, 1176.129664048598, 1188.037689471531, 1201.5554244929083, 27009.45981080328, 28436.43127137487, 28531.857340713163, 29401.85299073491, 29610.703892960795, 41127.58872411238, 46046.309305361116, 47809.0, 47819.28271076006, 52175.73912130415, 268971.0, 271879.0, 272033.0, 272049.0, 272229.6388518045, 24918.252452426455, 25362.365940851625, 25482.490350193264, 26246.73753262443, 32562.837185814868, 41213.58786412098, 41240.793796030826, 41249.79375103225, 41523.0, 41704.58295417128, 35331.29337413289, 35431.291374172884, 35918.640813591526, 35982.28035439329, 36330.27339453249, 34995.47506787451, 35174.296514069065, 35674.643253567134, 35750.8212458936, 35795.284094317445, 34533.30933381268, 34989.30021399507, 35003.0, 35647.64352356547, 35712.0, 30814.537781932842, 33316.0, 33316.500252495745, 33665.326693465504, 33857.49213761845, 24649.87675061613, 25371.0, 25585.744142558335, 25775.484490309715, 26236.0], "value": 17582.76806271245, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.17846899737134, 355.2132027558956, 360.9133807886107, 368.2947156195885, 376.26064782701985, 12541.749165016694, 13672.589822305323, 14077.718445631093, 14795.0, 15250.94981003801, 15588.532344029669, 15855.84144158558, 15954.84045159548, 16106.194690265498, 16227.107509086996, 4340.609345158935, 4861.246506791453, 5004.924926126111, 5112.258722485238, 5115.079285728568, 5003.12445322069, 5077.060743762398, 5084.186530155157, 5085.338905942241, 5087.414947281054, 4766.142094423002, 4945.505449455061, 5054.317667114948, 5062.240663900426, 5063.088644044071, 4856.5629093381585, 4925.75371231437, 4930.482299358588, 4936.531029552187, 4937.185364414867, 4414.845480408202, 4417.977910110429, 4419.049904270597, 4421.115776844644, 4663.673542852001, 18811.905940470348, 20050.398488045383, 20484.487887802774, 20550.38348849522, 20610.175592976262, 1678.639092595098, 1678.7985441746946, 1778.8043315235313, 1810.1582764014665, 2003.1987205117923, 8724.258438032775, 9126.680566180152, 9300.581473833694, 9438.244940404751, 9632.711018669452, 1467.9192644404554, 1525.4203402707012, 1665.6835201311712, 1717.3130747700895, 1733.081466822586, 66408.66795666039, 67236.66381668061, 67595.0, 69325.30674693239, 70157.64921175361, 9925.751856203653, 10015.098641122187, 10031.347962382422, 10236.48817559119, 10250.58997640086, 13840.584782456543, 13840.792388114187, 13852.792208116887, 13863.930680346533, 13872.861271387359, 6603.339666033455, 6739.0, 6850.691718872663, 7016.859662806715, 7096.53872498286, 6314.305426403092, 6356.173697419306, 6521.543491955613, 6540.836479087966, 6547.345265473415, 4271.0, 4305.225059489259, 4309.6767742418815, 4345.521992580813, 4430.82276708928, 1726.6374061446986, 1759.3930094117509, 1797.1194114883613, 1817.581956150093, 1822.5170329862597, 763.4655740981335, 775.9224077592309, 801.8997625296838, 909.3452714045876, 910.7859652981545, 15232.543023709306, 15845.603859903595, 15944.202789860461, 15976.680466390839, 16567.834321656628, 742.7177672484421, 793.6626933553217, 795.9243871832167, 830.323286521483, 831.9750407487785, 8781.34139939507, 8963.0, 9061.13919177677, 9738.220942324597, 10557.524911379007, 281689.0, 282068.0, 283433.0, 382242.0, 408271.0, 78324.0, 81140.59429702813, 82182.0, 82986.0, 85274.99999999876, 885.8051228729669, 919.1865199298669, 920.5719340506696, 926.0878035135386, 926.7590426489162, 15742.291596878396, 15800.841991579937, 16114.194290285204, 16336.0, 16472.83527164713, 37526.81236593799, 37674.246515070095, 38137.23725525529, 38399.99999999888, 38855.6114438852, 52787.73606131945, 53219.4763445096, 54773.1784023232, 54786.0, 55709.0, 7341.486095973444, 7365.410767138723, 7389.113306403266, 7542.773716788505, 7965.561894095648, 7847.764567062997, 10936.781264374828, 11530.365829879438, 11572.363520006144, 12064.215825971634, 9917.752056198653, 10102.595896164365, 10329.741756455847, 10362.451212329845, 10393.58425662965, 9618.807623847624, 9978.251631127549, 10023.498825058572, 10089.545970431202, 10151.340162889388, 9595.23238140961, 10042.69871903844, 10302.690919272434, 10389.740256493647, 10479.0, 7252.456065795192, 7313.23211062852, 7472.402207823252, 7585.886211706939, 7593.392528597588, 8416.957915210385, 10331.793364132525, 10533.9473302633, 10700.41147736882, 10823.729406764895], "value": 7894.34196083228, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1256.484841215102, 1369.1579678497721, 1394.5119208277101, 1466.8899832512564, 1671.0892563552864, 6662.500312476565, 7121.145462544496, 7440.96279518603, 7456.105267367923, 7458.701651933923, 7232.493725439222, 7354.889676654854, 7359.227281135471, 7524.84950300995, 7535.811604709885, 2166.1660260799586, 2208.1608988584394, 2212.0930418528405, 2219.2454565447742, 2219.933401997943, 2134.210342173398, 2160.48148444373, 2171.5114099327684, 2196.967045494319, 2211.9557608847813, 2178.2049551913597, 2205.7683943185975, 2210.4363387336207, 2212.889355532217, 2214.402111429913, 2139.7860213978556, 2143.07847625521, 2146.73165854269, 2148.0655914677163, 2148.4521447030907, 2133.925312614051, 2195.8243340532717, 2197.626403511407, 2198.483356411242, 2199.5820794049077, 7405.518641288353, 7538.3215510604305, 7577.81055473612, 7618.162002179756, 7624.0, 4323.567643235683, 4445.799939002753, 4472.418585583886, 4473.865784026452, 4474.328850672393, 2892.204643722972, 2988.491956367423, 3028.712272334125, 3036.817790932529, 3048.1465189746905, 939.304914363373, 957.861110139026, 971.3346357744897, 972.2707969023232, 983.1643103362156, 10253.897461025368, 10311.381317120922, 10435.530401131968, 10439.164866810714, 10458.215633827493, 4149.543550209474, 4192.140611174702, 4330.935035974463, 4353.934690979638, 4382.386465894777, 8240.793980150424, 8336.374771892011, 8337.708180213664, 8338.708145214889, 8342.83314333722, 4394.318880573516, 4395.670324725658, 4396.4284642996845, 4400.229959757094, 4402.537733537996, 3597.712183025352, 3601.8408142135495, 3698.574663913684, 4062.2484840304637, 4062.939055914164, 3309.7517686173633, 3397.813120278359, 3471.479278108304, 3479.7912125272564, 3503.737219708532, 1072.694282129605, 1096.5230124895695, 1098.0776148035688, 1111.6387174168428, 1115.6485707002269, 663.3598577372859, 755.1165136789969, 786.8662327404355, 807.6365635463948, 813.3371302388534, 4918.778654960463, 4975.676581022222, 5035.723035233024, 5139.922901156486, 5306.867328316745, 408.27938688215323, 417.09906601740096, 421.26279011729474, 423.35861170326365, 425.55529471702147, 3336.3327334532705, 3391.542141810824, 3417.2652879631, 3486.599041110254, 3514.367413865478, 8980.775480613036, 9224.446533208029, 9296.07039296065, 9299.907000929905, 9306.906930930603, 9259.444433334022, 9264.953675231716, 9269.768255793659, 9281.39670921388, 9284.535773211312, 7058.894116588255, 7095.858082838315, 7108.3602475777425, 7131.144262688407, 7150.892736608955, 4813.7593120344545, 4932.654714169974, 4991.925121123259, 5003.624728145476, 5174.301469301596, 8396.32829373661, 8676.826463470821, 8707.172818582225, 8765.737027889174, 8836.072212417861, 7722.806929826575, 8641.265492433213, 8863.734087977371, 8940.910590894007, 8953.836001319787, 6292.874142517033, 6474.514411419068, 6503.44720698727, 6688.598684078776, 6692.531522793358, 7144.4641651877355, 7199.208087110309, 7199.604021778852, 7252.057232559733, 7278.454115941219, 6528.640924748995, 6619.702113404812, 6633.369829866155, 6666.699998500176, 6688.130543029375, 6191.907121393273, 6401.423871851555, 6442.387973142544, 6445.6454894981225, 6487.124238227968, 6125.111858780541, 6151.446369826737, 6153.600015998945, 6214.067889816383, 6218.906716399167, 4406.933895991627, 4453.421055262795, 4513.54864513546, 4559.430071241095, 4627.49097599257, 4579.542045795394, 4647.953520464887, 4649.465311489087, 4664.113818374498, 4697.859064228079], "value": 3943.14246966283, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.39444139513995, 302.2398667351611, 304.7942638718864, 304.85367023828576, 308.84249032993165, 4705.764711764411, 4707.882302942428, 4726.0, 4729.527047295273, 4765.666403351766, 4639.492165046365, 4682.578567928886, 4692.944087580293, 4696.201645720227, 4704.012157446931, 3535.2222511047594, 3619.348517266891, 3629.3467175908327, 3638.181409182926, 3649.41250556009, 3690.15126520899, 3695.778253304797, 3715.4984077149643, 3717.0, 3721.1627383838554, 3668.578113516953, 3674.8346324415465, 3688.8604609326662, 3697.907552311187, 3714.8699795507164, 3492.725155318303, 3514.297140571896, 3655.5613326400735, 3656.11709969366, 3679.3193259247123, 3282.179455136216, 3291.0, 3291.522729204276, 3291.9177020574675, 3295.1762059485127, 4571.679982401233, 4573.679842411033, 4579.702319349265, 4584.381108550337, 4606.262997920317, 4147.212029714345, 4165.189299925148, 4204.2432362174795, 4215.367694845767, 4216.2832318505625, 4827.0, 4859.975700121512, 4860.7326597037145, 4864.197407427806, 4882.194437917739, 3576.7317451191007, 3585.229175727205, 3591.2458383739445, 3600.135967367839, 3601.2617413430185, 5128.461411601281, 5136.306598609177, 5156.742162891878, 5171.327727395452, 5185.118529849935, 3602.1354874830377, 3681.631836816297, 3704.2776658551325, 3705.184859330943, 3705.370087085202, 3729.254149170177, 3730.309892669865, 3731.3097077040834, 3751.9609116615084, 3760.4735337052834, 4188.162367526507, 4197.454330936958, 4200.411942328076, 4201.621854033152, 4221.02916329246, 4715.905681886343, 4876.122297986326, 4887.3890763654545, 4888.364512613338, 4930.802767889316, 1252.874712528758, 1281.3080936294482, 1285.3573213393304, 1294.6698591859015, 1297.3902265934996, 817.9918200818034, 832.9458585192065, 848.728406909783, 852.6996330595767, 857.4555157474923, 4263.232618128704, 4334.913301733947, 4354.912901741947, 4371.519132895379, 4371.803268852909, 5011.924821127686, 5019.619604608689, 5025.949740502621, 5041.495850415003, 5049.848504544796, 4355.607995280377, 4359.302511598193, 4361.498427680794, 4396.802143903468, 4406.933895991563, 2525.8002448837024, 2642.8371516532666, 2665.800064995133, 2666.6400035994893, 2667.3598336399123, 4751.904961900812, 4758.904821903542, 4767.880802979953, 4768.809247630125, 4795.832145874878, 4998.277292777751, 5153.871153221199, 5154.458781827929, 5180.9740951295, 5186.0, 4682.367880336179, 4718.678769944421, 4761.357216775691, 4762.357081794052, 4764.71293778988, 4986.626003049858, 5016.924746128738, 5017.9498205018945, 5031.320771695774, 5056.898862022813, 4754.0, 4943.530364615356, 4968.180250258667, 4973.9253911190635, 4980.576650984562, 4718.0983695026625, 4730.645201609824, 4733.7396443194575, 4761.761941895063, 4767.856964291077, 3646.796557136192, 3648.8540458381367, 3662.3957047086933, 3672.2288319453214, 3679.1905780729267, 5052.949470505395, 5057.140286151437, 5062.0, 5069.721165335942, 5087.898242035212, 4771.6898401603785, 4871.610271178368, 4874.7562621868055, 4882.8281212509455, 4913.213885778258, 4850.757462126809, 4865.367502224688, 4874.4150701916, 4875.634327425528, 4875.780589873393, 4828.696252012008, 4830.855074347775, 4840.975795121002, 4841.346418233635, 4843.321934929042, 4764.521899013808, 4877.097736918681, 4901.607871370211, 4906.55840974314, 4917.901641967069, 4788.63523895688, 4806.375171227718, 4811.422629284508, 4824.228123500223, 4825.806967721252], "value": 3721.761519184102, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.6883136353414, 605.1407002057078, 653.2487639214902, 677.1062197898775, 679.3817625960377, 11627.941860290697, 12795.552155674564, 12899.419526121324, 12900.870991290085, 12935.029872759533, 13072.477100915976, 13224.6693832654, 13295.268760218185, 13316.600501984933, 13317.0, 625.5371025441186, 753.8529986652592, 775.25962705616, 778.4395235430482, 778.7663700889739, 630.0, 759.8480303939207, 771.6026246483066, 783.8197214640636, 785.5561607691636, 812.4515951732586, 814.1085511365076, 814.9266566009057, 815.2377527012262, 815.5881279953616, 647.4076220258457, 811.5739236900615, 812.9065157506903, 813.4996976859248, 813.6826637611337, 580.1384943359109, 590.3270271890049, 592.9851753706149, 596.8507873031742, 597.3190562758415, 11751.236169649032, 11862.940685296604, 11956.222845515014, 11959.40202989847, 11987.58043468483, 12702.301373424458, 13231.669208269774, 13328.533501327503, 13347.0, 13512.189268643815, 10910.345379277189, 11222.887771122267, 11405.714857128554, 11798.764024719543, 11909.940450297692, 4125.0, 4153.273177193979, 4183.790810459464, 4299.935500967488, 4337.110892267077, 52743.0, 56325.0, 56353.71823140858, 63603.681981590256, 64362.0, 9851.96554361796, 9946.850797238047, 10092.394456332644, 10158.441285729356, 10211.7447063824, 18281.725774113398, 18592.721109183374, 18612.534686632673, 18625.7206141908, 18630.44108676742, 6244.906326405107, 6366.522510811707, 6369.363063693593, 6381.840453988688, 6568.540202185896, 3180.9840950795096, 3262.0, 3269.324379364796, 3337.666233376643, 3421.26442814796, 2745.9725402746117, 2822.223888430657, 2845.601615773793, 2850.08797184903, 2854.6574411070806, 490.49724032866595, 493.53854146373254, 494.82433736023916, 498.4666406944607, 498.7157320327451, 473.7796924430157, 507.2070231730814, 507.6066048812126, 508.72274610337456, 532.5047705633798, 7545.0, 7587.938951717129, 7894.565798881116, 8044.517328960164, 8053.0, 461.93301971213987, 484.9791189545955, 518.0571360124537, 520.5393226994138, 536.0538649284017, 3474.0, 3695.6119607440833, 3705.350230023425, 3734.3651579231596, 3757.511523501927, 91163.0, 92975.0, 95925.0, 96215.51892240494, 96340.0, 85005.87485312916, 88637.0, 88889.0, 89249.0, 89459.0, 45606.77196614062, 59293.0, 70527.64736176287, 72424.0, 75916.62041689757, 6971.163460384786, 7229.819254518468, 7263.891041634274, 7266.600336981517, 7346.449016323904, 45259.773701131286, 46092.46890373043, 46411.30383044325, 46453.53546464627, 46930.84848454655, 59653.10520342285, 59973.70013150081, 65397.90138824333, 67587.66206168938, 68158.65920670365, 8894.644214231359, 8924.910750892668, 8935.776605584912, 9024.59389327495, 9300.860487092563, 9997.400155990665, 10055.0, 10091.0, 10158.339707918962, 10314.638987635397, 8910.86633700482, 9003.504807235666, 9121.133492318218, 9572.282078843975, 9698.36960597559, 9315.161635452841, 9325.580348884181, 9467.763305917131, 9681.0, 10039.19686425099, 9065.546722663972, 9093.0, 9186.632534698538, 9463.432194068102, 9832.410055396698, 7419.5548267101985, 7611.543307401574, 7759.2240775921955, 7796.610169491616, 7889.4082943780595, 8146.9185308148535, 8208.343332533503, 8336.416450848625, 8452.408331416987, 8519.190676885686], "value": 6132.828890689161, "unit": "score"}], "name": "dromaeo_css", "value": 6216.557613978074, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 113.0, 117.0, 118.0, 115.0, 123.0, 116.0, 116.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 147.0, 183.0, 128.0, 145.0, 146.0, 123.0, 192.0, 123.0], "value": 146.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 162.0, 162.0, 161.0, 161.0, 162.0, 161.0, 159.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 75.0, 178.0, 78.0, 76.0, 77.0, 122.0, 117.0, 77.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 143.0, 87.0, 86.0, 86.0, 142.0, 87.0, 87.0, 156.0], "value": 104.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 119.0, 117.0, 116.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 66.0, 66.0, 67.0, 73.0, 68.0, 69.0, 69.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 65.0, 66.0, 65.0, 64.0, 67.0, 75.0, 65.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 85.0, 82.0, 86.0, 83.0, 83.0, 91.0, 82.0, 88.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 131.0, 132.0, 131.0, 130.0, 131.0, 132.0, 132.0, 168.0, 142.0], "value": 136.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 173.0, 177.0, 175.0, 176.0, 178.0, 186.0, 174.0, 185.0, 176.0], "value": 177.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 70.0, 68.0, 69.0, 69.0, 70.0, 76.0, 69.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1584.0, "alertThreshold": 2.0}]} 21:48:32 INFO - Return code: 0 21:48:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:48:32 INFO - # TBPL SUCCESS # 21:48:32 INFO - Running post-action listener: _resource_record_post_action 21:48:32 INFO - [mozharness: 2016-08-20 04:48:32.175695Z] Finished run-tests step (success) 21:48:32 INFO - Running post-run listener: _resource_record_post_run 21:48:32 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 417574912; Read time: 16; Write time: 419092 21:48:32 INFO - TinderboxPrint: CPU usage
13.2% 21:48:32 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 21:48:32 INFO - TinderboxPrint: I/O write bytes / time
417,574,912 / 419,092 21:48:32 INFO - TinderboxPrint: CPU idle
8,326.3 (86.7%) 21:48:32 INFO - TinderboxPrint: CPU user
1,206.1 (12.6%) 21:48:32 INFO - TinderboxPrint: Swap in / out
0 / 0 21:48:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124874752; Read time: 0; Write time: 113228 21:48:32 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 292700160; Read time: 0; Write time: 305864 21:48:32 INFO - Running post-run listener: _upload_blobber_files 21:48:32 INFO - Blob upload gear active. 21:48:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:48:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:48:32 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:48:32 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:48:33 INFO - (blobuploader) - INFO - Open directory for files ... 21:48:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:48:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:48:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:48:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:48:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:48:34 INFO - (blobuploader) - INFO - Done attempting. 21:48:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:48:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:48:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:48:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:48:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:48:34 INFO - (blobuploader) - INFO - Done attempting. 21:48:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:48:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:48:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:48:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:48:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:48:38 INFO - (blobuploader) - INFO - Done attempting. 21:48:38 INFO - (blobuploader) - INFO - Iteration through files over. 21:48:38 INFO - Return code: 0 21:48:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:48:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:48:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1bfe5d1b2ab5c568e06351218828898db35447295449db992fd5f5f42bbc3514fb3f73c37e8a204f9dc6620df349731b6f8032a08d198755477f2becc6a71860", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cb145242f4cf2bcd253ed1ad475682681d22e3c5bbb24054b4c591434ddc23826156d78b6619f056873685d4d2fba8522f5ae19838eabf2235524d4d52cc8461", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/04ce99e4254d650fcd40198e7f6512ad9bb93ff31d1147ee4adae3a875ab2884832535624dfced511ee3271ab59e05a5603524aac446d9f8d08fad24e3648bf4"} 21:48:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:48:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:48:38 INFO - Contents: 21:48:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1bfe5d1b2ab5c568e06351218828898db35447295449db992fd5f5f42bbc3514fb3f73c37e8a204f9dc6620df349731b6f8032a08d198755477f2becc6a71860", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cb145242f4cf2bcd253ed1ad475682681d22e3c5bbb24054b4c591434ddc23826156d78b6619f056873685d4d2fba8522f5ae19838eabf2235524d4d52cc8461", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/04ce99e4254d650fcd40198e7f6512ad9bb93ff31d1147ee4adae3a875ab2884832535624dfced511ee3271ab59e05a5603524aac446d9f8d08fad24e3648bf4"} 21:48:38 INFO - Running post-run listener: copy_logs_to_upload_dir 21:48:38 INFO - Copying logs to upload dir... 21:48:38 INFO - mkdir: /builds/slave/test/build/upload/logs 21:48:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.020900 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-19 21:48:37.737704) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 21:48:37.741448) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1bfe5d1b2ab5c568e06351218828898db35447295449db992fd5f5f42bbc3514fb3f73c37e8a204f9dc6620df349731b6f8032a08d198755477f2becc6a71860", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cb145242f4cf2bcd253ed1ad475682681d22e3c5bbb24054b4c591434ddc23826156d78b6619f056873685d4d2fba8522f5ae19838eabf2235524d4d52cc8461", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/04ce99e4254d650fcd40198e7f6512ad9bb93ff31d1147ee4adae3a875ab2884832535624dfced511ee3271ab59e05a5603524aac446d9f8d08fad24e3648bf4"} build_url:https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011367 build_url: 'https://queue.taskcluster.net/v1/task/RV6GS4zJTwqO6UFdm063UQ/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/Autoland-Non-PGO/sha512/1bfe5d1b2ab5c568e06351218828898db35447295449db992fd5f5f42bbc3514fb3f73c37e8a204f9dc6620df349731b6f8032a08d198755477f2becc6a71860", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cb145242f4cf2bcd253ed1ad475682681d22e3c5bbb24054b4c591434ddc23826156d78b6619f056873685d4d2fba8522f5ae19838eabf2235524d4d52cc8461", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/04ce99e4254d650fcd40198e7f6512ad9bb93ff31d1147ee4adae3a875ab2884832535624dfced511ee3271ab59e05a5603524aac446d9f8d08fad24e3648bf4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 21:48:37.770283) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 21:48:37.771034) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471666045.875051-496288530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 21:48:37.856534) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 21:48:37.857282) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 21:48:37.857910) ========= ========= Total master_lag: 0.18 =========