builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1472290234.11 results: success (0) buildid: 20160827003612 builduid: 36947f374e77471b9c763217f2194b6e revision: 7daaea2c6f3f112da09efcf679a19687d653033a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 02:30:34.109500) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 02:30:34.110192) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 02:30:34.110555) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 02:30:34.126554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 02:30:34.127145) ========= 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=8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-27 02:30:34-- 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% 113M=0s 2016-08-27 02:30:34 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093946 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 02:30:34.237185) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 02:30:34.237560) ========= 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=8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018124 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 02:30:34.289635) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 02:30:34.290213) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 7daaea2c6f3f112da09efcf679a19687d653033a --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 7daaea2c6f3f112da09efcf679a19687d653033a --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=8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-27 02:30:34,380 truncating revision to first 12 chars 2016-08-27 02:30:34,380 Setting DEBUG logging. 2016-08-27 02:30:34,380 attempt 1/10 2016-08-27 02:30:34,380 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/7daaea2c6f3f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-27 02:30:34,634 unpacking tar archive at: autoland-7daaea2c6f3f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.593872 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 02:30:34.902637) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 02:30:34.903370) ========= script_repo_revision: 7daaea2c6f3f112da09efcf679a19687d653033a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 02:30:34.904227) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 02:30:34.904888) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 02:30:34.916197) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-27 02:30:34.916564) ========= /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=8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:30:35 INFO - MultiFileLogger online at 20160827 02:30:35 in /builds/slave/test 02:30:35 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 02:30:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:30:35 INFO - {'append_to_log': False, 02:30:35 INFO - 'base_work_dir': '/builds/slave/test', 02:30:35 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 02:30:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:30:35 INFO - 'branch': 'Autoland-Non-PGO', 02:30:35 INFO - 'buildbot_json_path': 'buildprops.json', 02:30:35 INFO - 'config_files': ('talos/linux_config.py',), 02:30:35 INFO - 'default_actions': ('clobber', 02:30:35 INFO - 'read-buildbot-config', 02:30:35 INFO - 'download-and-extract', 02:30:35 INFO - 'populate-webroot', 02:30:35 INFO - 'create-virtualenv', 02:30:35 INFO - 'install', 02:30:35 INFO - 'run-tests'), 02:30:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:30:35 INFO - 'download_minidump_stackwalk': True, 02:30:35 INFO - 'download_symbols': 'ondemand', 02:30:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:30:35 INFO - 'tooltool.py': '/tools/tooltool.py', 02:30:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:30:35 INFO - '/tools/misc-python/virtualenv.py')}, 02:30:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:30:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:30:35 INFO - 'installer_path': 'installer.exe', 02:30:35 INFO - 'log_level': 'info', 02:30:35 INFO - 'log_name': 'talos', 02:30:35 INFO - 'log_to_console': True, 02:30:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:30:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:30:35 INFO - 'opt_config_files': (), 02:30:35 INFO - 'pip_index': False, 02:30:35 INFO - 'sps_profile': False, 02:30:35 INFO - 'sps_profile_interval': 0, 02:30:35 INFO - 'suite': 'dromaeojs', 02:30:35 INFO - 'system_bits': '32', 02:30:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:30:35 INFO - 'title': 'talos-linux64-ix-038', 02:30:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:30:35 INFO - 'use_talos_json': True, 02:30:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:30:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:30:35 INFO - 'work_dir': 'build'} 02:30:35 INFO - [mozharness: 2016-08-27 09:30:35.097500Z] Running clobber step. 02:30:35 INFO - Running pre-action listener: _resource_record_pre_action 02:30:35 INFO - Running main action method: clobber 02:30:35 INFO - rmtree: /builds/slave/test/build 02:30:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:30:35 INFO - Running post-action listener: _resource_record_post_action 02:30:35 INFO - [mozharness: 2016-08-27 09:30:35.579349Z] Finished clobber step (success) 02:30:35 INFO - [mozharness: 2016-08-27 09:30:35.579452Z] Running read-buildbot-config step. 02:30:35 INFO - Running pre-action listener: _resource_record_pre_action 02:30:35 INFO - Running main action method: read_buildbot_config 02:30:35 INFO - Using buildbot properties: 02:30:35 INFO - { 02:30:35 INFO - "project": "", 02:30:35 INFO - "product": "firefox", 02:30:35 INFO - "script_repo_revision": "production", 02:30:35 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 02:30:35 INFO - "repository": "", 02:30:35 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 02:30:35 INFO - "buildid": "20160827003612", 02:30:35 INFO - "pgo_build": "False", 02:30:35 INFO - "basedir": "/builds/slave/test", 02:30:35 INFO - "buildnumber": 334, 02:30:35 INFO - "slavename": "talos-linux64-ix-038", 02:30:35 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:30:35 INFO - "platform": "ubuntu64_hw", 02:30:35 INFO - "scheduler": "tests-autoland-linux64-talos", 02:30:35 INFO - "branch": "autoland", 02:30:35 INFO - "repo_path": "integration/autoland", 02:30:35 INFO - "revision": "7daaea2c6f3f112da09efcf679a19687d653033a", 02:30:35 INFO - "stage_platform": "linux64", 02:30:35 INFO - "builduid": "36947f374e77471b9c763217f2194b6e", 02:30:35 INFO - "slavebuilddir": "test" 02:30:35 INFO - } 02:30:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/IK8Ja1j0RhiZNXQqXixoPA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 02:30:35 INFO - Running post-action listener: _resource_record_post_action 02:30:35 INFO - [mozharness: 2016-08-27 09:30:35.581893Z] Finished read-buildbot-config step (success) 02:30:35 INFO - [mozharness: 2016-08-27 09:30:35.581984Z] Running download-and-extract step. 02:30:35 INFO - Running pre-action listener: _resource_record_pre_action 02:30:35 INFO - Running main action method: download_and_extract 02:30:35 INFO - mkdir: /builds/slave/test/build/tests 02:30:35 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')]} 02:30:35 INFO - trying https://queue.taskcluster.net/v1/task/IK8Ja1j0RhiZNXQqXixoPA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:30:35 INFO - Downloading https://queue.taskcluster.net/v1/task/IK8Ja1j0RhiZNXQqXixoPA/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 02:30:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IK8Ja1j0RhiZNXQqXixoPA/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 02:30:36 INFO - Downloaded 1361 bytes. 02:30:36 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:30:36 INFO - Using the following test package requirements: 02:30:36 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:30:36 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:30:36 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:30:36 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:36 INFO - u'jsshell-linux-x86_64.zip'], 02:30:36 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:30:36 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:30:36 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:30:36 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:30:36 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:30:36 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:36 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:30:36 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:30:36 INFO - trying https://queue.taskcluster.net/v1/task/IK8Ja1j0RhiZNXQqXixoPA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:30:36 INFO - Downloading https://queue.taskcluster.net/v1/task/IK8Ja1j0RhiZNXQqXixoPA/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 02:30:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IK8Ja1j0RhiZNXQqXixoPA/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 02:30:36 INFO - Downloaded 20305438 bytes. 02:30:36 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 02:30:41 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 02:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:30:41 INFO - trying https://queue.taskcluster.net/v1/task/IK8Ja1j0RhiZNXQqXixoPA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:30:41 INFO - Downloading https://queue.taskcluster.net/v1/task/IK8Ja1j0RhiZNXQqXixoPA/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 02:30:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IK8Ja1j0RhiZNXQqXixoPA/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 02:30:42 INFO - Downloaded 20305438 bytes. 02:30:42 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 02:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:30:46 INFO - trying https://queue.taskcluster.net/v1/task/IK8Ja1j0RhiZNXQqXixoPA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:30:46 INFO - Downloading https://queue.taskcluster.net/v1/task/IK8Ja1j0RhiZNXQqXixoPA/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 02:30:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IK8Ja1j0RhiZNXQqXixoPA/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 02:30:47 INFO - Downloaded 14413998 bytes. 02:30:47 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 02:30:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:30:47 INFO - trying https://queue.taskcluster.net/v1/task/IK8Ja1j0RhiZNXQqXixoPA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:30:47 INFO - Downloading https://queue.taskcluster.net/v1/task/IK8Ja1j0RhiZNXQqXixoPA/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 02:30:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IK8Ja1j0RhiZNXQqXixoPA/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 02:30:48 INFO - Downloaded 55865009 bytes. 02:30:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IK8Ja1j0RhiZNXQqXixoPA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:30:48 INFO - mkdir: /builds/slave/test/properties 02:30:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:30:48 INFO - Writing to file /builds/slave/test/properties/build_url 02:30:48 INFO - Contents: 02:30:48 INFO - build_url:https://queue.taskcluster.net/v1/task/IK8Ja1j0RhiZNXQqXixoPA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:30:49 INFO - Running post-action listener: _resource_record_post_action 02:30:49 INFO - Running post-action listener: set_extra_try_arguments 02:30:49 INFO - [mozharness: 2016-08-27 09:30:49.333358Z] Finished download-and-extract step (success) 02:30:49 INFO - [mozharness: 2016-08-27 09:30:49.333587Z] Running populate-webroot step. 02:30:49 INFO - Running pre-action listener: _resource_record_pre_action 02:30:49 INFO - Running main action method: populate_webroot 02:30:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:30:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:30:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:30:49 INFO - '--tppagecycles', 02:30:49 INFO - '7'], 02:30:49 INFO - 'tests': ['tsvgm']}}, 02:30:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:30:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:30:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:30:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:30:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:30:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:30:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:49 INFO - 'talos_options': ['--disable-e10s'], 02:30:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:30:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:30:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:49 INFO - 'talos_options': ['--disable-e10s'], 02:30:49 INFO - 'tests': ['damp', 'tps']}, 02:30:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:49 INFO - 'tests': ['damp', 'tps']}, 02:30:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:30:49 INFO - 'tests': ['dromaeo_dom']}, 02:30:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:30:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:30:49 INFO - 'tests': ['basic_compositor_video']}, 02:30:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:30:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:30:49 INFO - 'tests': ['a11yr', 02:30:49 INFO - 'ts_paint', 02:30:49 INFO - 'tpaint', 02:30:49 INFO - 'sessionrestore', 02:30:49 INFO - 'sessionrestore_no_auto_restore', 02:30:49 INFO - 'tabpaint']}, 02:30:49 INFO - 'other-e10s': {'tests': ['a11yr', 02:30:49 INFO - 'ts_paint', 02:30:49 INFO - 'tpaint', 02:30:49 INFO - 'sessionrestore', 02:30:49 INFO - 'sessionrestore_no_auto_restore', 02:30:49 INFO - 'tabpaint']}, 02:30:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:30:49 INFO - 'ts_paint', 02:30:49 INFO - 'tpaint', 02:30:49 INFO - 'sessionrestore', 02:30:49 INFO - 'sessionrestore_no_auto_restore', 02:30:49 INFO - 'tabpaint']}, 02:30:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:30:49 INFO - 'ts_paint', 02:30:49 INFO - 'tpaint', 02:30:49 INFO - 'sessionrestore', 02:30:49 INFO - 'sessionrestore_no_auto_restore', 02:30:49 INFO - 'tabpaint']}, 02:30:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:30:49 INFO - 'tests': ['a11yr', 02:30:49 INFO - 'ts_paint', 02:30:49 INFO - 'tpaint', 02:30:49 INFO - 'sessionrestore', 02:30:49 INFO - 'sessionrestore_no_auto_restore', 02:30:49 INFO - 'tabpaint']}, 02:30:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:30:49 INFO - 'tests': ['a11yr', 02:30:49 INFO - 'ts_paint', 02:30:49 INFO - 'tpaint', 02:30:49 INFO - 'sessionrestore', 02:30:49 INFO - 'sessionrestore_no_auto_restore', 02:30:49 INFO - 'tabpaint']}, 02:30:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:30:49 INFO - 'tests': ['tsvgx', 02:30:49 INFO - 'tsvgr_opacity', 02:30:49 INFO - 'tart', 02:30:49 INFO - 'tscrollx', 02:30:49 INFO - 'cart']}, 02:30:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:30:49 INFO - 'tsvgr_opacity', 02:30:49 INFO - 'tart', 02:30:49 INFO - 'tscrollx', 02:30:49 INFO - 'cart']}, 02:30:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:49 INFO - 'talos_options': ['--disable-e10s'], 02:30:49 INFO - 'tests': ['tp5o']}, 02:30:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:49 INFO - 'tests': ['tp5o']}, 02:30:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:49 INFO - 'talos_options': ['--disable-e10s', 02:30:49 INFO - '--xperf_path', 02:30:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:30:49 INFO - 'tests': ['tp5n']}, 02:30:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:49 INFO - 'talos_options': ['--xperf_path', 02:30:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:30:49 INFO - 'tests': ['tp5n']}}, 02:30:49 INFO - 'talos.zip': {'path': '', 02:30:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:30:49 INFO - Running post-action listener: _resource_record_post_action 02:30:49 INFO - [mozharness: 2016-08-27 09:30:49.351586Z] Finished populate-webroot step (success) 02:30:49 INFO - [mozharness: 2016-08-27 09:30:49.351676Z] Running create-virtualenv step. 02:30:49 INFO - Running pre-action listener: _resource_record_pre_action 02:30:49 INFO - Running main action method: create_virtualenv 02:30:49 INFO - Creating virtualenv /builds/slave/test/build/venv 02:30:49 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 02:30:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:30:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:30:49 INFO - Using real prefix '/usr' 02:30:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:30:49 INFO - Installing distribute.............................................................................................................................................................................................done. 02:30:51 INFO - Installing pip.................done. 02:30:51 INFO - Return code: 0 02:30:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:30:51 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')]} 02:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:51 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')]} 02:30:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:51 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 0x7fcbc76f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2009090>, '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 0x200c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200ce40>, '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': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', '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 02:30:51 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 02:30:51 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 02:30:51 INFO - Using env: {'DISPLAY': ':0', 02:30:51 INFO - 'HOME': '/home/cltbld', 02:30:51 INFO - 'LANG': 'en_US.UTF-8', 02:30:51 INFO - 'LANGUAGE': 'en_US:en', 02:30:51 INFO - 'LOGNAME': 'cltbld', 02:30:51 INFO - 'MAIL': '/var/mail/cltbld', 02:30:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:51 INFO - 'MOZ_NO_REMOTE': '1', 02:30:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:51 INFO - 'NO_EM_RESTART': '1', 02:30:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:51 INFO - 'PWD': '/builds/slave/test', 02:30:51 INFO - 'SHELL': '/bin/bash', 02:30:51 INFO - 'SHLVL': '1', 02:30:51 INFO - 'TERM': 'linux', 02:30:51 INFO - 'TMOUT': '86400', 02:30:51 INFO - 'USER': 'cltbld', 02:30:51 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', 02:30:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:51 INFO - '_': '/tools/buildbot/bin/python'} 02:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:52 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 02:30:52 INFO - Cleaning up... 02:30:52 INFO - Return code: 0 02:30:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:30: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')]} 02:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30: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')]} 02:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:52 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 0x7fcbc76f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2009090>, '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 0x200c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200ce40>, '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': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', '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 02:30:52 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 02:30:52 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 02:30:52 INFO - Using env: {'DISPLAY': ':0', 02:30:52 INFO - 'HOME': '/home/cltbld', 02:30:52 INFO - 'LANG': 'en_US.UTF-8', 02:30:52 INFO - 'LANGUAGE': 'en_US:en', 02:30:52 INFO - 'LOGNAME': 'cltbld', 02:30:52 INFO - 'MAIL': '/var/mail/cltbld', 02:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:52 INFO - 'MOZ_NO_REMOTE': '1', 02:30:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:52 INFO - 'NO_EM_RESTART': '1', 02:30:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:52 INFO - 'PWD': '/builds/slave/test', 02:30:52 INFO - 'SHELL': '/bin/bash', 02:30:52 INFO - 'SHLVL': '1', 02:30:52 INFO - 'TERM': 'linux', 02:30:52 INFO - 'TMOUT': '86400', 02:30:52 INFO - 'USER': 'cltbld', 02:30:52 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', 02:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:52 INFO - '_': '/tools/buildbot/bin/python'} 02:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:52 INFO - Downloading/unpacking psutil>=3.1.1 02:30:52 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 02:30:52 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 02:30:52 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 02:30:52 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 02:30:52 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 02:30:52 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 02:30:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:30:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:30:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:30:54 INFO - Installing collected packages: psutil 02:30:54 INFO - Running setup.py install for psutil 02:30:54 INFO - building 'psutil._psutil_linux' extension 02:30:54 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 02:30:54 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 02:30:54 INFO - building 'psutil._psutil_posix' extension 02:30:54 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 02:30:54 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 02:30:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:30:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:30:54 INFO - Successfully installed psutil 02:30:54 INFO - Cleaning up... 02:30:54 INFO - Return code: 0 02:30:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:54 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 0x7fcbc76f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2009090>, '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 0x200c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200ce40>, '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': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', '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 02:30:54 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 02:30:54 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 02:30:54 INFO - Using env: {'DISPLAY': ':0', 02:30:54 INFO - 'HOME': '/home/cltbld', 02:30:54 INFO - 'LANG': 'en_US.UTF-8', 02:30:54 INFO - 'LANGUAGE': 'en_US:en', 02:30:54 INFO - 'LOGNAME': 'cltbld', 02:30:54 INFO - 'MAIL': '/var/mail/cltbld', 02:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:54 INFO - 'MOZ_NO_REMOTE': '1', 02:30:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:54 INFO - 'NO_EM_RESTART': '1', 02:30:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:54 INFO - 'PWD': '/builds/slave/test', 02:30:54 INFO - 'SHELL': '/bin/bash', 02:30:54 INFO - 'SHLVL': '1', 02:30:54 INFO - 'TERM': 'linux', 02:30:54 INFO - 'TMOUT': '86400', 02:30:54 INFO - 'USER': 'cltbld', 02:30:54 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', 02:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:54 INFO - '_': '/tools/buildbot/bin/python'} 02:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:30:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:30:57 INFO - Installing collected packages: mozsystemmonitor 02:30:57 INFO - Running setup.py install for mozsystemmonitor 02:30:57 INFO - Successfully installed mozsystemmonitor 02:30:57 INFO - Cleaning up... 02:30:57 INFO - Return code: 0 02:30:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc76f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2009090>, '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 0x200c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200ce40>, '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': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', '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 02:30:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:30:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:30:57 INFO - Using env: {'DISPLAY': ':0', 02:30:57 INFO - 'HOME': '/home/cltbld', 02:30:57 INFO - 'LANG': 'en_US.UTF-8', 02:30:57 INFO - 'LANGUAGE': 'en_US:en', 02:30:57 INFO - 'LOGNAME': 'cltbld', 02:30:57 INFO - 'MAIL': '/var/mail/cltbld', 02:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:57 INFO - 'MOZ_NO_REMOTE': '1', 02:30:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:57 INFO - 'NO_EM_RESTART': '1', 02:30:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:57 INFO - 'PWD': '/builds/slave/test', 02:30:57 INFO - 'SHELL': '/bin/bash', 02:30:57 INFO - 'SHLVL': '1', 02:30:57 INFO - 'TERM': 'linux', 02:30:57 INFO - 'TMOUT': '86400', 02:30:57 INFO - 'USER': 'cltbld', 02:30:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', 02:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:57 INFO - '_': '/tools/buildbot/bin/python'} 02:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:57 INFO - Downloading/unpacking jsonschema==2.5.1 02:30:57 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 02:30:57 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 02:30:57 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 02:30:57 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 02:30:57 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 02:30:57 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 02:30:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:30:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:30:59 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 02:30:59 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 02:30:59 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 02:30:59 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 02:30:59 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 02:30:59 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 02:30:59 INFO - Downloading functools32-3.2.3-2.tar.gz 02:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:30:59 INFO - warning: no files found matching '*.txt' 02:30:59 INFO - no previously-included directories found matching 'build' 02:30:59 INFO - no previously-included directories found matching 'dist' 02:30:59 INFO - no previously-included directories found matching '.git*' 02:30:59 INFO - Installing collected packages: jsonschema, functools32 02:30:59 INFO - Running setup.py install for functools32 02:30:59 INFO - warning: no files found matching '*.txt' 02:30:59 INFO - no previously-included directories found matching 'build' 02:30:59 INFO - no previously-included directories found matching 'dist' 02:30:59 INFO - no previously-included directories found matching '.git*' 02:30:59 INFO - Successfully installed jsonschema functools32 02:30:59 INFO - Cleaning up... 02:30:59 INFO - Return code: 0 02:30:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:59 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 0x7fcbc76f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2009090>, '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 0x200c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200ce40>, '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': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', '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 02:30:59 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 02:30:59 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 02:30:59 INFO - Using env: {'DISPLAY': ':0', 02:30:59 INFO - 'HOME': '/home/cltbld', 02:30:59 INFO - 'LANG': 'en_US.UTF-8', 02:30:59 INFO - 'LANGUAGE': 'en_US:en', 02:30:59 INFO - 'LOGNAME': 'cltbld', 02:30:59 INFO - 'MAIL': '/var/mail/cltbld', 02:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:59 INFO - 'MOZ_NO_REMOTE': '1', 02:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:59 INFO - 'NO_EM_RESTART': '1', 02:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:59 INFO - 'PWD': '/builds/slave/test', 02:30:59 INFO - 'SHELL': '/bin/bash', 02:30:59 INFO - 'SHLVL': '1', 02:30:59 INFO - 'TERM': 'linux', 02:30:59 INFO - 'TMOUT': '86400', 02:30:59 INFO - 'USER': 'cltbld', 02:30:59 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', 02:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:59 INFO - '_': '/tools/buildbot/bin/python'} 02:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:31:00 INFO - Cleaning up... 02:31:00 INFO - Return code: 0 02:31:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:31:00 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')]} 02:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:00 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')]} 02:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:00 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 0x7fcbc76f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2009090>, '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 0x200c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200ce40>, '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': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', '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 02:31:00 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 02:31:00 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 02:31:00 INFO - Using env: {'DISPLAY': ':0', 02:31:00 INFO - 'HOME': '/home/cltbld', 02:31:00 INFO - 'LANG': 'en_US.UTF-8', 02:31:00 INFO - 'LANGUAGE': 'en_US:en', 02:31:00 INFO - 'LOGNAME': 'cltbld', 02:31:00 INFO - 'MAIL': '/var/mail/cltbld', 02:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:00 INFO - 'MOZ_NO_REMOTE': '1', 02:31:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:00 INFO - 'NO_EM_RESTART': '1', 02:31:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:00 INFO - 'PWD': '/builds/slave/test', 02:31:00 INFO - 'SHELL': '/bin/bash', 02:31:00 INFO - 'SHLVL': '1', 02:31:00 INFO - 'TERM': 'linux', 02:31:00 INFO - 'TMOUT': '86400', 02:31:00 INFO - 'USER': 'cltbld', 02:31:00 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', 02:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:00 INFO - '_': '/tools/buildbot/bin/python'} 02:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:00 INFO - Downloading/unpacking blobuploader==1.2.4 02:31:00 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 02:31:00 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 02:31:00 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 02:31:00 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 02:31:00 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 02:31:00 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 02:31:02 INFO - Downloading blobuploader-1.2.4.tar.gz 02:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:31:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:31:02 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 02:31:02 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 02:31:02 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 02:31:02 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 02:31:02 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 02:31:02 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 02:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:31:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:31:02 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 02:31:02 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 02:31:02 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 02:31:02 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 02:31:02 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 02:31:02 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 02:31:02 INFO - Downloading docopt-0.6.1.tar.gz 02:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:31:02 INFO - Installing collected packages: blobuploader, requests, docopt 02:31:02 INFO - Running setup.py install for blobuploader 02:31:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:31:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:31:02 INFO - Running setup.py install for requests 02:31:03 INFO - Running setup.py install for docopt 02:31:03 INFO - Successfully installed blobuploader requests docopt 02:31:03 INFO - Cleaning up... 02:31:03 INFO - Return code: 0 02:31:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:31: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')]} 02:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31: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')]} 02:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:03 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 0x7fcbc76f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2009090>, '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 0x200c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200ce40>, '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': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', '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 02:31:03 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 02:31:03 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 02:31:03 INFO - Using env: {'DISPLAY': ':0', 02:31:03 INFO - 'HOME': '/home/cltbld', 02:31:03 INFO - 'LANG': 'en_US.UTF-8', 02:31:03 INFO - 'LANGUAGE': 'en_US:en', 02:31:03 INFO - 'LOGNAME': 'cltbld', 02:31:03 INFO - 'MAIL': '/var/mail/cltbld', 02:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:03 INFO - 'MOZ_NO_REMOTE': '1', 02:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:03 INFO - 'NO_EM_RESTART': '1', 02:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:03 INFO - 'PWD': '/builds/slave/test', 02:31:03 INFO - 'SHELL': '/bin/bash', 02:31:03 INFO - 'SHLVL': '1', 02:31:03 INFO - 'TERM': 'linux', 02:31:03 INFO - 'TMOUT': '86400', 02:31:03 INFO - 'USER': 'cltbld', 02:31:03 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', 02:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:03 INFO - '_': '/tools/buildbot/bin/python'} 02:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:31:03 INFO - Running setup.py (path:/tmp/pip-UVIZUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:31:03 INFO - Running setup.py (path:/tmp/pip-mnSYkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:31:03 INFO - Running setup.py (path:/tmp/pip-tCIv8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:31:03 INFO - Running setup.py (path:/tmp/pip-eTNz0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:31:04 INFO - Running setup.py (path:/tmp/pip-3MiT2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:31:04 INFO - Running setup.py (path:/tmp/pip-eUGhkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:31:04 INFO - Running setup.py (path:/tmp/pip-wYbqNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:31:04 INFO - Running setup.py (path:/tmp/pip-ymeJL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:31:04 INFO - Running setup.py (path:/tmp/pip-tY6DGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:31:04 INFO - Running setup.py (path:/tmp/pip-jepP6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:31:04 INFO - Running setup.py (path:/tmp/pip-Hhjgyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:31:04 INFO - Running setup.py (path:/tmp/pip-B29TS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:31:04 INFO - Running setup.py (path:/tmp/pip-NxpFJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:31:04 INFO - Running setup.py (path:/tmp/pip-FxuoK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:31:04 INFO - Running setup.py (path:/tmp/pip-s_fTye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:31:04 INFO - Running setup.py (path:/tmp/pip-UEB9r9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:31:04 INFO - Running setup.py (path:/tmp/pip-THtSBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:31:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:31:04 INFO - Running setup.py install for manifestparser 02:31:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:31:05 INFO - Running setup.py install for mozcrash 02:31:05 INFO - Running setup.py install for mozdebug 02:31:05 INFO - Running setup.py install for mozdevice 02:31:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:31:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:31:05 INFO - Running setup.py install for mozfile 02:31:05 INFO - Running setup.py install for mozhttpd 02:31:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:31:05 INFO - Running setup.py install for mozinfo 02:31:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:31:05 INFO - Running setup.py install for mozInstall 02:31:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:31:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:31:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:31:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:31:05 INFO - Running setup.py install for mozleak 02:31:05 INFO - Running setup.py install for mozlog 02:31:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:31:05 INFO - Running setup.py install for moznetwork 02:31:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:31:06 INFO - Running setup.py install for mozprocess 02:31:06 INFO - Running setup.py install for mozprofile 02:31:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:31:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:31:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:31:06 INFO - Running setup.py install for mozrunner 02:31:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:31:06 INFO - Running setup.py install for mozscreenshot 02:31:06 INFO - Running setup.py install for moztest 02:31:06 INFO - Running setup.py install for mozversion 02:31:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:31:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:31:06 INFO - Cleaning up... 02:31:06 INFO - Return code: 0 02:31:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:06 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 0x7fcbc76f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2009090>, '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 0x200c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200ce40>, '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': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', '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 02:31:06 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 02:31:06 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 02:31:06 INFO - Using env: {'DISPLAY': ':0', 02:31:06 INFO - 'HOME': '/home/cltbld', 02:31:06 INFO - 'LANG': 'en_US.UTF-8', 02:31:06 INFO - 'LANGUAGE': 'en_US:en', 02:31:06 INFO - 'LOGNAME': 'cltbld', 02:31:06 INFO - 'MAIL': '/var/mail/cltbld', 02:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:06 INFO - 'MOZ_NO_REMOTE': '1', 02:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:06 INFO - 'NO_EM_RESTART': '1', 02:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:06 INFO - 'PWD': '/builds/slave/test', 02:31:06 INFO - 'SHELL': '/bin/bash', 02:31:06 INFO - 'SHLVL': '1', 02:31:06 INFO - 'TERM': 'linux', 02:31:06 INFO - 'TMOUT': '86400', 02:31:06 INFO - 'USER': 'cltbld', 02:31:06 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', 02:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:06 INFO - '_': '/tools/buildbot/bin/python'} 02:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:31:06 INFO - Running setup.py (path:/tmp/pip-qjTymT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:31:06 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)) 02:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:31:07 INFO - Running setup.py (path:/tmp/pip-1DlWID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:31:07 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)) 02:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:31:07 INFO - Running setup.py (path:/tmp/pip-cTMNiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:31:07 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)) 02:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:31:07 INFO - Running setup.py (path:/tmp/pip-Brj8Cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:31:07 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)) 02:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:31:07 INFO - Running setup.py (path:/tmp/pip-dTZYtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:31:07 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)) 02:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:31:07 INFO - Running setup.py (path:/tmp/pip-rjiMUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:31:07 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)) 02:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:31:07 INFO - Running setup.py (path:/tmp/pip-QOWBDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:31:07 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)) 02:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:31:07 INFO - Running setup.py (path:/tmp/pip-yTCh64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:31:07 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)) 02:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:31:07 INFO - Running setup.py (path:/tmp/pip-iRQBRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:31:07 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)) 02:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:31:07 INFO - Running setup.py (path:/tmp/pip-HW8grv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:31:07 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)) 02:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:31:07 INFO - Running setup.py (path:/tmp/pip-B5oRH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:31:07 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)) 02:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:31:07 INFO - Running setup.py (path:/tmp/pip-XP3FTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:31:07 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)) 02:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:31:07 INFO - Running setup.py (path:/tmp/pip-c9IswH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:31:07 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)) 02:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:31:07 INFO - Running setup.py (path:/tmp/pip-cM_vUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:31:07 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)) 02:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:31:07 INFO - Running setup.py (path:/tmp/pip-WLhCXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:31:08 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)) 02:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:31:08 INFO - Running setup.py (path:/tmp/pip-wsbxnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:31:08 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)) 02:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:31:08 INFO - Running setup.py (path:/tmp/pip-v9g19d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:31:08 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)) 02:31:08 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)) 02:31:08 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)) 02:31:08 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)) 02:31:08 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)) 02:31:08 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)) 02:31:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:31:08 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 02:31:08 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 02:31:08 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 02:31:08 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 02:31:08 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 02:31:08 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 02:31:10 INFO - Downloading blessings-1.6.tar.gz 02:31:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:31:10 INFO - Installing collected packages: blessings 02:31:10 INFO - Running setup.py install for blessings 02:31:10 INFO - Successfully installed blessings 02:31:10 INFO - Cleaning up... 02:31:10 INFO - Return code: 0 02:31:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:31:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:31:10 INFO - Reading from file tmpfile_stdout 02:31:10 INFO - Current package versions: 02:31:10 INFO - argparse == 1.2.1 02:31:10 INFO - blessings == 1.6 02:31:10 INFO - blobuploader == 1.2.4 02:31:10 INFO - docopt == 0.6.1 02:31:10 INFO - functools32 == 3.2.3-2 02:31:10 INFO - jsonschema == 2.5.1 02:31:10 INFO - manifestparser == 1.1 02:31:10 INFO - mozInstall == 1.12 02:31:10 INFO - mozcrash == 0.17 02:31:10 INFO - mozdebug == 0.1 02:31:10 INFO - mozdevice == 0.48 02:31:10 INFO - mozfile == 1.2 02:31:10 INFO - mozhttpd == 0.7 02:31:10 INFO - mozinfo == 0.9 02:31:10 INFO - mozleak == 0.1 02:31:10 INFO - mozlog == 3.3 02:31:10 INFO - moznetwork == 0.27 02:31:10 INFO - mozprocess == 0.23 02:31:10 INFO - mozprofile == 0.28 02:31:10 INFO - mozrunner == 6.12 02:31:10 INFO - mozscreenshot == 0.1 02:31:10 INFO - mozsystemmonitor == 0.3 02:31:10 INFO - moztest == 0.7 02:31:10 INFO - mozversion == 1.4 02:31:10 INFO - psutil == 3.1.1 02:31:10 INFO - requests == 1.2.3 02:31:10 INFO - wsgiref == 0.1.2 02:31:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:31: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')]} 02:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31: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')]} 02:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:10 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 0x7fcbc76f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2009090>, '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 0x200c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200ce40>, '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': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', '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 02:31:10 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 02:31:10 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 02:31:10 INFO - Using env: {'DISPLAY': ':0', 02:31:10 INFO - 'HOME': '/home/cltbld', 02:31:10 INFO - 'LANG': 'en_US.UTF-8', 02:31:10 INFO - 'LANGUAGE': 'en_US:en', 02:31:10 INFO - 'LOGNAME': 'cltbld', 02:31:10 INFO - 'MAIL': '/var/mail/cltbld', 02:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:10 INFO - 'MOZ_NO_REMOTE': '1', 02:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:10 INFO - 'NO_EM_RESTART': '1', 02:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:10 INFO - 'PWD': '/builds/slave/test', 02:31:10 INFO - 'SHELL': '/bin/bash', 02:31:10 INFO - 'SHLVL': '1', 02:31:10 INFO - 'TERM': 'linux', 02:31:10 INFO - 'TMOUT': '86400', 02:31:10 INFO - 'USER': 'cltbld', 02:31:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', 02:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:10 INFO - '_': '/tools/buildbot/bin/python'} 02:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:10 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)) 02:31:10 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)) 02:31:10 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)) 02:31:10 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)) 02:31:10 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)) 02:31:10 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)) 02:31:10 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)) 02:31:10 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)) 02:31:10 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)) 02:31:10 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)) 02:31:10 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)) 02:31:10 INFO - Cleaning up... 02:31:10 INFO - Return code: 0 02:31:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:31: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')]} 02:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31: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')]} 02:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc76f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2009090>, '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 0x200c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200ce40>, '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': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', '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 02:31: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', 'jsonschema'] in /builds/slave/test/build 02:31: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 jsonschema 02:31:10 INFO - Using env: {'DISPLAY': ':0', 02:31:10 INFO - 'HOME': '/home/cltbld', 02:31:10 INFO - 'LANG': 'en_US.UTF-8', 02:31:10 INFO - 'LANGUAGE': 'en_US:en', 02:31:10 INFO - 'LOGNAME': 'cltbld', 02:31:10 INFO - 'MAIL': '/var/mail/cltbld', 02:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:10 INFO - 'MOZ_NO_REMOTE': '1', 02:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:10 INFO - 'NO_EM_RESTART': '1', 02:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:10 INFO - 'PWD': '/builds/slave/test', 02:31:10 INFO - 'SHELL': '/bin/bash', 02:31:10 INFO - 'SHLVL': '1', 02:31:10 INFO - 'TERM': 'linux', 02:31:10 INFO - 'TMOUT': '86400', 02:31:10 INFO - 'USER': 'cltbld', 02:31:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', 02:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:10 INFO - '_': '/tools/buildbot/bin/python'} 02:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:31:10 INFO - Cleaning up... 02:31:10 INFO - Return code: 0 02:31:10 INFO - Running post-action listener: _resource_record_post_action 02:31:10 INFO - Running post-action listener: _start_resource_monitoring 02:31:11 INFO - Starting resource monitoring. 02:31:11 INFO - [mozharness: 2016-08-27 09:31:11.005152Z] Finished create-virtualenv step (success) 02:31:11 INFO - [mozharness: 2016-08-27 09:31:11.005681Z] Running install step. 02:31:11 INFO - Running pre-action listener: _resource_record_pre_action 02:31:11 INFO - Running main action method: install 02:31:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:31:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:31:11 INFO - Reading from file tmpfile_stdout 02:31:11 INFO - Detecting whether we're running mozinstall >=1.0... 02:31:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:31:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:31:11 INFO - Reading from file tmpfile_stdout 02:31:11 INFO - Output received: 02:31:11 INFO - Usage: mozinstall [options] installer 02:31:11 INFO - Options: 02:31:11 INFO - -h, --help show this help message and exit 02:31:11 INFO - -d DEST, --destination=DEST 02:31:11 INFO - Directory to install application into. [default: 02:31:11 INFO - "/builds/slave/test"] 02:31:11 INFO - --app=APP Application being installed. [default: firefox] 02:31:11 INFO - mkdir: /builds/slave/test/build/application 02:31:11 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'] 02:31:11 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 02:31:27 INFO - Reading from file tmpfile_stdout 02:31:27 INFO - Output received: 02:31:27 INFO - /builds/slave/test/build/application/firefox/firefox 02:31:27 INFO - Running post-action listener: _resource_record_post_action 02:31:27 INFO - [mozharness: 2016-08-27 09:31:27.436174Z] Finished install step (success) 02:31:27 INFO - [mozharness: 2016-08-27 09:31:27.436455Z] Running run-tests step. 02:31:27 INFO - Running pre-action listener: _resource_record_pre_action 02:31:27 INFO - Running main action method: run_tests 02:31:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:31:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:31:27 INFO - Python 2.7.3 02:31:27 INFO - Return code: 0 02:31:27 INFO - grabbing minidump binary from tooltool 02:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:27 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 0x2009090>, '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 0x200c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200ce40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:31:27 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 02:31:27 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 02:31:27 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 02:31:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:31:27 INFO - Return code: 0 02:31:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:31:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:31:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:31:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:31:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:31:27 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/IK8Ja1j0RhiZNXQqXixoPA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 02:31:27 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/IK8Ja1j0RhiZNXQqXixoPA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 02:31:27 INFO - Using env: {'DISPLAY': ':0', 02:31:27 INFO - 'HOME': '/home/cltbld', 02:31:27 INFO - 'LANG': 'en_US.UTF-8', 02:31:27 INFO - 'LANGUAGE': 'en_US:en', 02:31:27 INFO - 'LOGNAME': 'cltbld', 02:31:27 INFO - 'MAIL': '/var/mail/cltbld', 02:31:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:31:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:27 INFO - 'MOZ_NO_REMOTE': '1', 02:31:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:31:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:27 INFO - 'NO_EM_RESTART': '1', 02:31:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:27 INFO - 'PWD': '/builds/slave/test', 02:31:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:31:27 INFO - 'SHELL': '/bin/bash', 02:31:27 INFO - 'SHLVL': '1', 02:31:27 INFO - 'TERM': 'linux', 02:31:27 INFO - 'TMOUT': '86400', 02:31:27 INFO - 'USER': 'cltbld', 02:31:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382', 02:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:27 INFO - '_': '/tools/buildbot/bin/python'} 02:31:27 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/IK8Ja1j0RhiZNXQqXixoPA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 02:31:27 INFO - mozversion application_buildid: 20160827003612 02:31:27 INFO - mozversion application_changeset: 7daaea2c6f3f112da09efcf679a19687d653033a 02:31:27 INFO - mozversion application_display_name: Nightly 02:31:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:31:27 INFO - mozversion application_name: Firefox 02:31:27 INFO - mozversion application_remotingname: firefox 02:31:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 02:31:27 INFO - mozversion application_vendor: Mozilla 02:31:27 INFO - mozversion application_version: 51.0a1 02:31:27 INFO - mozversion platform_buildid: 20160827003612 02:31:27 INFO - mozversion platform_changeset: 7daaea2c6f3f112da09efcf679a19687d653033a 02:31:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 02:31:27 INFO - mozversion platform_version: 51.0a1 02:31:27 INFO - using testdate: 1472290287 02:31:27 INFO - actual date: 1472290287 02:31:27 INFO - starting webserver on 'localhost:34909' 02:31:27 INFO - SUITE-START | Running 2 tests 02:31:27 INFO - TEST-START | dromaeo_css 02:31:27 INFO - operating with platform_type : linux_ 02:31:27 INFO - Initialising browser for dromaeo_css test... 02:31:27 INFO - TEST-INFO | started process 17775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA0ru4H/profile http://localhost:34909/getInfo.html) 02:31:32 INFO - PROCESS | 17775 | __metrics Screen width/height:1600/1200 02:31:32 INFO - PROCESS | 17775 | colorDepth:24 02:31:32 INFO - PROCESS | 17775 | Browser inner width/height: 1024/697 02:31:32 INFO - PROCESS | 17775 | __metrics 02:31:33 INFO - PROCESS | 17775 | 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" 02:31:33 INFO - PROCESS | 17775 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:31:33 INFO - PROCESS | 17775 | console.error: PushService: 02:31:33 INFO - PROCESS | 17775 | stateChangeProcessEnqueue: Error transitioning state 02:31:33 INFO - PROCESS | 17775 | UnknownError 02:31:34 INFO - TEST-INFO | 17775: exit 0 02:31:34 INFO - Browser initialized. 02:31:34 INFO - Running cycle 1/1 for dromaeo_css test... 02:31:34 INFO - TEST-INFO | started process 17854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA0ru4H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:31:46 INFO - PROCESS | 17854 | RSS: Main: 180461568 02:31:46 INFO - PROCESS | 17854 | 02:32:37 INFO - PROCESS | 17854 | 1472290357880 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] 02:34:51 INFO - PROCESS | 17854 | Cycle 1(1): loaded http://localhost:34909/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34909/tests/dromaeo/cssquery-ext.html) 02:34:52 INFO - PROCESS | 17854 | RSS: Main: 305565696 02:34:52 INFO - PROCESS | 17854 | 02:37:55 INFO - PROCESS | 17854 | Cycle 1(1): loaded http://localhost:34909/tests/dromaeo/cssquery-ext.html (next: http://localhost:34909/tests/dromaeo/cssquery-jquery.html) 02:37:56 INFO - PROCESS | 17854 | RSS: Main: 269307904 02:37:56 INFO - PROCESS | 17854 | 02:40:58 INFO - PROCESS | 17854 | Cycle 1(1): loaded http://localhost:34909/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34909/tests/dromaeo/cssquery-mootools.html) 02:40:58 INFO - PROCESS | 17854 | RSS: Main: 218558464 02:40:58 INFO - PROCESS | 17854 | 02:44:01 INFO - PROCESS | 17854 | Cycle 1(1): loaded http://localhost:34909/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34909/tests/dromaeo/cssquery-prototype.html) 02:44:01 INFO - PROCESS | 17854 | RSS: Main: 218312704 02:44:01 INFO - PROCESS | 17854 | 02:47:04 INFO - PROCESS | 17854 | Cycle 1(1): loaded http://localhost:34909/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34909/tests/dromaeo/cssquery-yui.html) 02:47:05 INFO - PROCESS | 17854 | RSS: Main: 217853952 02:47:05 INFO - PROCESS | 17854 | 02:50:08 INFO - PROCESS | 17854 | Cycle 1(1): loaded http://localhost:34909/tests/dromaeo/cssquery-yui.html (next: http://localhost:34909/tests/dromaeo/cssquery-dojo.html) 02:50:08 INFO - PROCESS | 17854 | RSS: Main: 309092352 02:50:08 INFO - PROCESS | 17854 | 02:50:08 INFO - PROCESS | 17854 | __start_tp_report 02:50:08 INFO - PROCESS | 17854 | _x_x_mozilla_page_load 02:50:08 INFO - PROCESS | 17854 | _x_x_mozilla_page_load_details 02:50:08 INFO - PROCESS | 17854 | |i|pagename|runs| 02:50:08 INFO - PROCESS | 17854 | |0;dojo.html;2611.791056715463;2626.8555229462386;2628.5005848888723;2671.9599206011912;2689.3276680829795;4693.48371679115;4700.482946875845;4743.833965811189;4779.35478710374;4850.587700045496;4773.976130119353;4802.567768900798;4814.1575224335775;4823.276508523723;4861.902761944759;4340.110277393127;4426.026274219666;4454.799534020961;4475.418195634563;4478.507364189953;4395.362672412498;4427.424434823469;4432.867013989586;4485.753283569403;4542.068875880436;4487.618552423048;4488.102379524092;4531.728096314215;4534.1385136824065;4545;4319.308910574293;4352.151330490556;4389.824407023715;4397.428334316518;4436.5119836818085;4303.33298338758;4306.7631280279575;4322.286822674287;4372.715773474714;4403.559644035571;4672.0889426561835;4710.62315014798;4742.312364707098;4761.285807128924;4812.951870481285;5019.52314530119;5099.643024988252;5113.616478764107;5113.923291150636;5177.37871455424;5130.769115389817;5141.974290128563;5194.558462530689;5208.2968799212;5213.087709650834;4805.37530121082;4832.323474713543;4842.757862106881;4850.417949846041;4909.042736666387;5130.871728206825;5201.687898726089;5314.840554783363;5318.73406329682;5321.201819727072;5034.546890779774;5054.292399064134;5094.617903657167;5114.974425127925;5120.692758434506;5129.487051294841;5142.71715055668;5146.4853514648985;5147.1507201312115;5207.270982062514;5081.59347252219;5086.567641750418;5101.795928162906;5104.2343648453025;5107.310513080761;4925;4986.127427700138;5005;5063.11395505785;5066.36670416198;4358.956410435919;4374.256376416017;4376.912461750747;4413.293872980308;4429.712068715523;3792.5069740934055;3809.29528037314;3830.4062870255157;3847.076701591598;3859.5754467008605;4318.460192475941;4338.544452832471;4389.4293741814;4414.911701765946;4441.045175287329;5149.382074151051;5152.793888244429;5153.768080436389;5203.479652034766;5205.115130427836;4420.469543654782;4425.402570652921;4432.113577284556;4470.441194850644;4481.843135490308;4552.975580494429;4595.6783025187915;4616.215243408628;4623.190941585276;4626.583607475343;4839.201531747222;4842.394700662418;4901.240307752304;4901.779419926041;4908.435529914105;5160;5164.0962831505085;5165.044466773659;5175.249588809526;5207.27098206259;4710.24636058229;4820.71075735457;4833.32333473307;4844.75776211181;4902.92645610309;5090.821821236239;5139.511746384088;5143.8456846294675;5189.091908916;5201.895962080662;5189.221616757516;5211.140161873249;5217.50433708797;5219.869503262449;5291.3121294231505;4861.829835955725;4948.579370753382;5030.245463180552;5038.1435156022835;5040.924386134284;4954.727489988085;5016.2224855147515;5016.648834581544;5075.543201111917;5078.669886457368;4904.975475122602;4945.2582112683385;4946.134426475424;4954.157793175241;5012.072766538202;4902.411710594752;4947.925781113214;4952.380952380952;5063.670861393997;5085.64400491962;4805.327254184487;4823.734694591831;4839.370881785346;4846.442659094108;4856.9757151215435 02:50:08 INFO - PROCESS | 17854 | |1;ext.html;549.8982688202681;564.1396869773597;573.5698226330252;586.0681516388944;586.1325238646803;27490.862545687294;30324.241893952636;36867.63132368676;38043.61956380435;38092.619073809255;40956.38565421513;41089.178216435655;41227.58772412275;41317.17365652685;41385.172296554054;7555.924440755604;7706.6146692665425;7711.074671039483;7712.421568382366;7715.421343399239;7250.782476525686;9699.90300096997;9926.751831204205;9940.25448091396;10238.078572928434;10024.94987525065;10118.190544756439;10120.746981325452;10124.595016199342;10126.84809727851;9949.154321882648;10022.248331375176;10029.648962286357;10036;10043.14633256174;9815.41107533543;9874.654387096418;9880.505974701307;9885.110340069356;9887.851682224773;37255.813720931495;37684.623153768385;37724;37800.62199377998;37823;2756.572731226663;2866.2977570495154;2881.409311091242;2917.28526511004;2953.3354995126138;27507;27600.585991210148;28092.87628494858;28168.295792605142;28551.28621784472;3396.6942975132356;3448.2930999145115;3459.3427248822895;3533.169705119295;3557.1640664443835;251228;252108;252973;253658.73170634214;254089;51401.7429912848;51454.74272628613;51713.224301635506;51816.74091629593;51850;31500.527492087178;54942.725286373316;54948.725256373466;55157.448425516035;55218.72390638021;13950.930245348709;14431.783523247159;14433.855661443251;14452.205128717811;14477.927610361881;9857.162141218078;10185.236107291983;10840.837387439195;10954.178436617285;10962.835557466644;17234.396796112076;17394.21726022332;17607.207675654627;17679.646407071785;17850.19674114668;5517.44825517445;6699.802682518651;6786.4570834333135;6871.725130994704;6906.302300602023;719.2988582003524;816.7876352148484;842.5197637346654;936.1714882329188;975.5219942228399;25765;26839.86580067126;27244;27676.446471070467;27858.442831143264;883.7481317824389;907.945523268606;940.3417607674655;954.9140577348072;967.5936106835146;13960.301984900714;14357;14635.85364146345;14804.481843135654;14833.480828170963;386760;389439;391152;391171;391470;33078;33145.83427082849;33178.17054573655;33217.3356532868;33292.3341533168;1032.5560009195967;1124.0726400719275;1132.671525257666;1159.0322081062407;1167.6380322100176;26258.86870565635;27268.45463090767;28028.057054009034;28475.715242847305;28563.143105706862;41012.58987410207;41416.37875431811;41420.378694319006;41424.58575414207;41473.585264146976;280808;281801;282112;282504;282920.5123846288;23997.880010599834;24968;24981.87509062443;25780.613290800276;25804.61293080643;39089;39346.6065339343;39509.604903950596;39561;40366.59633403746;33539;33633.66366336403;33750.324993499504;33754.66245337515;33899.4915076279;34368.25053995724;34723.65276347204;34800;34843.82578087093;34933.82533087318;33914;34766;34941.650583493836;34947.47578786269;35215;30039.249018774706;31297.8435107823;31540.684593153775;31599.21001974969;31705.365892681555;24116;24454;24695;25001.749982499943;25153.74846251514 02:50:08 INFO - PROCESS | 17854 | |2;jquery.html;350.40955989158255;366.5161986178244;369.7411811731787;372.74094504319476;390.2039838728993;12522.373881305932;16618;17284.222210000564;17637.382691605795;18770.43688689338;15451;15569;15946.681066378665;16821.663566728657;16866.325346986137;5039.3196918415915;5105.030044291582;5196.714180720059;5226.947730522703;5227.86930326743;3657.9268414631692;5170;5252.343457067866;5778.191053252548;6058.39416058395;6134.6012509186985;6144.5698801083945;6145.692715364236;6147;6147.047207682816;5966.37353077927;6043;6110.694465276719;6116.510679145702;6120.081987701836;5208.583313334924;5387.595930305243;5389.299391079135;5399.541039011649;5401.891962160774;20904;21219.5756084879;21248.575028499497;21268.361949141396;21286.254981075745;1812.8821626594229;1835.2658936425537;1841.0518582929801;1917.88492690439;2489.9128530501525;12763.234205947672;13319.86680133196;13375.799363009563;13886.791698124536;14039.78940315896;1675.4973507947566;1767.8320559546823;1796.1320226964071;1805.4403135028183;1816.0315504554928;68890.65554672245;69252.653736731;69894.3010569893;70852.6457367715;71584.64207678981;9573.760655983657;9824.950875245579;9968.850467242997;10126.341787783771;10166.644167454104;13639.181649101085;13644.386002629906;13658.317084145752;13667.316634168252;13685.931570342085;7569.091708994956;7698.307152356315;7790.493617914817;7858.410619203582;7860;7303.379212766974;7354.448416368794;7360.411167106618;7562.848743025219;7581.090269167625;6135.662538560422;6157.9384206158265;6194.938050619527;6209.844753881189;6390.488760899117;1694.754260632226;1719.785026871641;1790.5702631368379;1804.2422182683304;1804.9784241649436;814.5967745965785;836.7322456813761;869.2788279207205;952.4190243951184;990.5146478225762;17232.138393080546;18579;18634.440966771017;18843.152058157415;19123.330683426015;822.576373167819;830.9916900831035;835.1147783349547;854.0946596607616;858.7209157023992;9756.707298781048;10462.36113951633;10588.821857705478;10600;10646.73383165427;362035;380050;380125;382445;382584;50471;58552.707236463546;76467.61766191134;86223;86902.56548717216;911.1708345405649;912.7535565397438;952.0336858089045;952.5332587032304;958.3626888119322;15777.053376797428;15809;16404.75392869084;16431;16621.16894155263;29518.852405737834;35674.28651426905;36440;36703.632963670025;37180.25639487141;51582.74208628933;52685;52742.73628631832;53458.73270633622;53646;6565.277819439762;6899;7067.752628657972;7113.217546070032;7362.6318684066655;9054.502002389932;11997.100217483548;12267.631971040882;12395.070369722127;12430.751384972069;10340.948295258475;10413.531391087268;10908.781824363627;10987.736410312917;11020.50407731638;10489.79020419572;10782;10829.891701082888;10834.729131771768;10878.673639790819;10732.248742587944;11302.547898083985;11387;11400.714982125513;11451.828222576502;7105.25394833535;7252.2747725227055;7310.744123955636;7396.4822462429265;7415.925840741524;9133.40632858862;10844.837327439936;10913.39976301311;11164.106871450427;11193.328400296008 02:50:08 INFO - PROCESS | 17854 | |3;mootools.html;1204.9638510844677;1262;1330.8469526004508;1332.2406228449781;1627.3327935546422;7504;7914.920850791497;7945.841083178333;7947.523148611073;7959.044914610247;7844.64699088541;7932.127465978738;7952.681892724284;7954.96022519888;7962.96018519908;2228.0419419649584;2251.8423710340285;2254.267363106997;2255.3459496746004;2258.1870526610405;2113.4927617371873;2200.04298130313;2205.658122990939;2205.7132572765518;2205.845590808644;2192.78072192781;2206.095500844654;2214.6567282071223;2215.94460138497;2218.223621732389;2074.2325339624285;2080.06397121296;2080.5630817528336;2082.802133797287;2082.9479263018393;2038.2560365466645;2090.6550419180817;2092.9476763080893;2094.361219827952;2095.6018356512213;7649.311561959395;7774.883376749297;7925.762227133196;7929.603519823986;7932.365410767125;4588.655850811202;4777.665563410563;4778.928316075262;4782.306565547976;4802.615790736732;2793.7485626293733;2882.0633294179474;2941.8234905905715;2950.173951293641;2962.2890506278336;1011.7824667696481;1019.1184625299137;1035.1925498111484;1037.1391744851755;1046.4767616191905;10412.635557755442;10638.57445702171;10807.945960270226;10856.45717714119;10868;4017.6986725995666;4128.318827393447;4160.521540022875;4280.464941882265;4291.506476755213;8555.14448555152;8571.400001999926;8574.614142363609;8580.742577722678;8584.098669639723;4457.821687132543;4462.219111655448;4476.35092911526;4487.147441986012;4488.035072459437;3749.268892565978;3959.8020098994934;4068.0846809468226;4083.1833633273463;4140.60664236897;3358.9496157557655;3387.271736576648;3503.264314493934;3505.859765609398;3528.8235588220487;1027.3938376357835;1043.6034306963306;1050.6847945616285;1053.4048262731685;1057;774.1136398823315;780.6331024418514;784.5880912520972;798.4251339035885;802.9277365037175;4889.511048895153;4918.95081049185;4942.406911170682;5155;5270.973645131749;418.2033226703135;424.6009399030203;425.85308068716245;426.9679774016961;431.8833914842975;3285.572875526166;3302.5871766029245;3312.7846689965077;3351.4805205193234;3454.240067185215;9303.627854885728;9804.950975245221;9808.166305863939;9819.16537094355;9833.803323933482;9743.756406089904;9759.560819763128;9759.951200243953;9769.267304952156;9778.217742580577;7345.926540734631;7379.077615298195;7394.149672787698;7424.517406368569;7431.888521672179;4768.809247630056;4812.5668689818085;4900.803967841246;4939.357883475125;5127.871803204801;8643.092475290005;8740.737777866674;8852.55737213124;8871.201591856505;8892.866607000771;8924.776880578038;9036.051214622634;9088.182063614306;9098.31762617793;9136.223421009288;5433.891322173614;5571.972140139435;6376.808695739135;6429.58207716497;6445.677716114082;7325.120985481776;7506.624668766649;7534.698612055676;7539.962300188464;7544.811379715551;6638.800835974928;6701.128853249046;6742.6291553965;6896.448284137357;6940.097787287822;6529.183852018497;6586.5389422739945;6673.466122710074;6744.966275168593;6774.593524388552;6104.298005729398;6210.813675589739;6213.285472170577;6220.03589443637;6226.5641405101205;4199.790010499401;4308.482982042175;4422.977885110683;4449.777511124366;4456.554344565518;4297.484301883794;4316.093620339764;4319.784010799384;4338.197433474817;4381.255186618347 02:50:08 INFO - PROCESS | 17854 | |4;prototype.html;291.8817878759102;294.6861592404089;301.1822900824262;301.47543274702025;304.33502796389877;4809.302651115586;4819.927701084478;4829.7585120744;4860.902781944359;4864.124457597631;4787.35370724952;4788.59296959758;4791.448983366914;4805.639577031728;4824.662273640846;3576.856925722968;3690.188158605116;3693.0582701411104;3703.166787472824;3728.328900797855;3631.1466805300734;3695.796731179784;3771.887742864005;3813.294540510001;3813.63770441809;3764.924701505968;3768.4535742317485;3775.2072064866275;3784.6972242220554;3788.90527736806;3545.450455179451;3725.1990821973136;3756.8685096021645;3768.947152806236;3774.320622287987;3268.656791036931;3271.689189526991;3272.689094536015;3282.146641873106;3282.950755738642;4688.507706690816;4705.694129881546;4707.152712511746;4708.811647534095;4713.505081966413;4281.207976524353;4300.376445415429;4302.763348015857;4306.7631280279575;4321.805518751632;4926.507349265081;5010.599152067826;5022.321986531808;5035.269885866565;5048.545630893201;3567.518385018015;3578.9284214315567;3589.766665166782;3591.4018261873216;3595.227026189356;5227.503387178212;5262.894742105174;5276.947230527684;5298.470152984671;5315.255864178979;3502.562179727534;3660.231351416179;3675.7426980111136;3679.804063679315;3685.649863263039;3721.5720192178246;3725.5529336479794;3729.4965179700935;3730.2539492101146;3732.701383889282;4228.344606585984;4257.808398622069;4262.934266433392;4274.764887931132;4285.514401647038;4900.779464924016;5051.419086804991;5054.595632349477;5061.367329083864;5071.847844564669;1273.4778740716263;1282.6088043146742;1289.9161554498928;1295.5724610878387;1298.727267273864;794.8807678848219;808.9595520223966;830.4767996162379;832.0597724571196;833.3166803221301;4307.698461107755;4308.741475511417;4477.619402350771;4516.593506584423;4537.727736335831;5258.342707161605;5268.868278293074;5271.525562699376;5281.9700158469495;5284.788608455696;4504.932426013613;4506.954930450719;4511.744127936032;4512.52618475062;4522.412086428743;2633.631291619175;2746.807723459339;2767.2918289491777;2771.3348796289147;2775.6391669083296;4893.412790465096;4896.706197628154;4901.436334821541;4908;4921.384826896638;5042.319286896222;5295.894082118413;5301.973490132525;5317.787288508416;5340.385855626575;4839.95160048395;4909.656324057353;4945.6043516517875;4946.629002824802;4954.430240522314;5128.640995130305;5177.948220517897;5181.404138523967;5195.402528709247;5203.635745497779;4955.231939049453;5070.721110338966;5074.731317170707;5088.4148322941855;5093.668911520739;4830.768154120677;4870.464248932685;4881.755912204305;4898.2897479864505;4898.975505122452;3654.378755611606;3659.396199627032;3687.9446808298435;3697.2235830474824;3699.260147970363;4996.775145118406;5220.216967454912;5232.084385232493;5246.396664383645;5291.444398338119;4990.4011518618;5003.774830132726;5011.473795251592;5016.172331565397;5018.1218286800395;4935.432425270996;5007.524285192901;5012.548870601518;5015.272785446163;5018.598512119095;4655.371524844239;4929.260610908393;4949.133901567139;4999.875003124951;5002.023795841468;4812.51874812516;4893.290472881484;5039.370078740158;5057.900971096954;5060.747967154581;4933.605311574994;4944.307796908508;4950.282209079592;4954.439351604233;4957.652964292609 02:50:08 INFO - PROCESS | 17854 | |5;yui.html;593.4688453833819;622.8660837919847;655.2497390487895;695.1415002471948;707.812429706128;11949.34278614677;12648.747025059492;12718.36408179592;12753.171043882141;12770.489180432784;12501.49994000239;12629.810552841715;12642.115051946368;12650.430730617121;12681.17572357796;595.8540157661379;730.5324592260957;741.8627553902518;742.5952855693633;743.4015617427968;728.0608015659792;754.4341743692231;754.7773406844993;755.3579457461142;757.2843662738715;801.9839603207932;801.9879701804477;802.7511471443842;803.9638216280281;804.1958041958042;628.7327885648581;796.0248695348153;796.303234669664;796.6813274690112;797.09927781607;558.7346010644952;574.9913751293734;574.9913751293734;575.6689903305574;579.0416860096547;11548.942255288754;11624.88375116255;11650;11678.532858685643;11683.474243659055;10384.84422733652;10723.892761072368;10881.401522916236;11345.078647218183;11713;10124;10208.795824083476;10224.897751022543;10294.382337059726;10411.07106127626;3745.2883952049024;3770.6606405423645;3812.218495208476;3846.3461211593817;3853.094522787143;63236.683816581084;63447.99999999954;64232.35767642357;64306.35693643051;64349.67825160891;8853.15894989975;8989.883888972023;9148.954255228682;9168.266538677024;9488.146066854017;17323.65352692939;17335.21991510385;17337.306507739802;17378.217980190922;17387.56531086733;6465.191851018622;6532.08550802888;6664.400203981665;6757.932420675828;6771.255161932184;3539.52216450781;3623.9818800905828;3637.672609465161;3719.6466335698065;3772.3398405278967;2618;2713.050432348662;2713.1046754570943;2714.1721774858856;2715.3618899558587;457.2386975685513;462.8773375055613;465.0443338938446;465.3926625753357;484.09957479088865;410.29429381463837;459.20786643040486;465.46006632306364;474.1560023158783;510.6859281541899;6777.762778302835;6917.339838438839;7065.258147894499;7162.746519359195;7169.6773645186095;458.6812165544981;460.4037771086384;476.4036003779416;485.6745980193279;486.75905426813955;3355.798652080883;3518.7009104226427;3525.9294814103573;3576.9821150894077;3789.6357311367888;82366;100678;101598.4120873359;106858.46570767097;108026.45986770016;73640;88165.55917220374;89797;90336;90385;60769.39230607637;62217.68891155515;68674;76442;79879.60060199662;7024.332688394595;7645.61771911391;7770.747006935912;7947.562884041202;7957;43447.348289775044;43674.56325436705;44653.330200046374;44763.77618111888;45604.771976139906;34571.65428345785;35441;40746.59253407546;59256.40743592509;61141.08288375589;9470.952645237005;9778.823013567626;9794.62561495656;9796.9020309796;9825.361351512129;11256.83114753263;11391.715207119889;11587.826182607436;11614.477348519506;12083.033357331567;10683.25217234786;10844.295120817122;11194.608188713355;11355.602553910574;11791.587294444653;10139.543720532447;10191.184705223712;10273.691789246335;10307.330023548446;10355.068043876086;9745.756356091155;9948;9987.450690212108;10060.39637621745;10620.84068738985;7711.0746710395115;7898.723544676139;8003.279704826594;8207.753767386988;8315.542645154332;7873.212678732081;8136.959315203623;8208.753737387888;8226.30076443509;8329.333653307842 02:50:08 INFO - PROCESS | 17854 | __end_tp_report 02:50:08 INFO - PROCESS | 17854 | __start_cc_report 02:50:08 INFO - PROCESS | 17854 | _x_x_mozilla_cycle_collect,1157 02:50:08 INFO - PROCESS | 17854 | __end_cc_report 02:50:08 INFO - PROCESS | 17854 | __startTimestamp1472291408561__endTimestamp 02:50:08 INFO - PROCESS | 17854 | 02:50:08 INFO - PROCESS | 17854 | ------- Summary: start ------- 02:50:08 INFO - PROCESS | 17854 | Number of tests: 6 02:50:08 INFO - PROCESS | 17854 | 02:50:08 INFO - PROCESS | 17854 | [#0] dojo.html Cycles:165 Average:4747.89 Median:4850.59 stddev:503.38 (10.4%) stddev-sans-first:476.21 02:50:08 INFO - PROCESS | 17854 | Values: 2611.8 2626.9 2628.5 2672.0 2689.3 4693.5 4700.5 4743.8 4779.4 4850.6 4774.0 4802.6 4814.2 4823.3 4861.9 4340.1 4426.0 4454.8 4475.4 4478.5 4395.4 4427.4 4432.9 4485.8 4542.1 4487.6 4488.1 4531.7 4534.1 4545.0 4319.3 4352.2 4389.8 4397.4 4436.5 4303.3 4306.8 4322.3 4372.7 4403.6 4672.1 4710.6 4742.3 4761.3 4813.0 5019.5 5099.6 5113.6 5113.9 5177.4 5130.8 5142.0 5194.6 5208.3 5213.1 4805.4 4832.3 4842.8 4850.4 4909.0 5130.9 5201.7 5314.8 5318.7 5321.2 5034.5 5054.3 5094.6 5115.0 5120.7 5129.5 5142.7 5146.5 5147.2 5207.3 5081.6 5086.6 5101.8 5104.2 5107.3 4925.0 4986.1 5005.0 5063.1 5066.4 4359.0 4374.3 4376.9 4413.3 4429.7 3792.5 3809.3 3830.4 3847.1 3859.6 4318.5 4338.5 4389.4 4414.9 4441.0 5149.4 5152.8 5153.8 5203.5 5205.1 4420.5 4425.4 4432.1 4470.4 4481.8 4553.0 4595.7 4616.2 4623.2 4626.6 4839.2 4842.4 4901.2 4901.8 4908.4 5160.0 5164.1 5165.0 5175.2 5207.3 4710.2 4820.7 4833.3 4844.8 4902.9 5090.8 5139.5 5143.8 5189.1 5201.9 5189.2 5211.1 5217.5 5219.9 5291.3 4861.8 4948.6 5030.2 5038.1 5040.9 4954.7 5016.2 5016.6 5075.5 5078.7 4905.0 4945.3 4946.1 4954.2 5012.1 4902.4 4947.9 4952.4 5063.7 5085.6 4805.3 4823.7 4839.4 4846.4 4857.0 02:50:08 INFO - PROCESS | 17854 | 02:50:08 INFO - PROCESS | 17854 | [#1] ext.html Cycles:180 Average:45595.28 Median:33827.08 stddev:82572.59 (244.1%) stddev-sans-first:82734.97 02:50:08 INFO - PROCESS | 17854 | Values: 549.9 564.1 573.6 586.1 586.1 27490.9 30324.2 36867.6 38043.6 38092.6 40956.4 41089.2 41227.6 41317.2 41385.2 7555.9 7706.6 7711.1 7712.4 7715.4 7250.8 9699.9 9926.8 9940.3 10238.1 10024.9 10118.2 10120.7 10124.6 10126.8 9949.2 10022.2 10029.6 10036.0 10043.1 9815.4 9874.7 9880.5 9885.1 9887.9 37255.8 37684.6 37724.0 37800.6 37823.0 2756.6 2866.3 2881.4 2917.3 2953.3 27507.0 27600.6 28092.9 28168.3 28551.3 3396.7 3448.3 3459.3 3533.2 3557.2 251228.0 252108.0 252973.0 253658.7 254089.0 51401.7 51454.7 51713.2 51816.7 51850.0 31500.5 54942.7 54948.7 55157.4 55218.7 13950.9 14431.8 14433.9 14452.2 14477.9 9857.2 10185.2 10840.8 10954.2 10962.8 17234.4 17394.2 17607.2 17679.6 17850.2 5517.4 6699.8 6786.5 6871.7 6906.3 719.3 816.8 842.5 936.2 975.5 25765.0 26839.9 27244.0 27676.4 27858.4 883.7 907.9 940.3 954.9 967.6 13960.3 14357.0 14635.9 14804.5 14833.5 386760.0 389439.0 391152.0 391171.0 391470.0 33078.0 33145.8 33178.2 33217.3 33292.3 1032.6 1124.1 1132.7 1159.0 1167.6 26258.9 27268.5 28028.1 28475.7 28563.1 41012.6 41416.4 41420.4 41424.6 41473.6 280808.0 281801.0 282112.0 282504.0 282920.5 23997.9 24968.0 24981.9 25780.6 25804.6 39089.0 39346.6 39509.6 39561.0 40366.6 33539.0 33633.7 33750.3 33754.7 33899.5 34368.3 34723.7 34800.0 34843.8 34933.8 33914.0 34766.0 34941.7 34947.5 35215.0 30039.2 31297.8 31540.7 31599.2 31705.4 24116.0 24454.0 24695.0 25001.7 25153.7 02:50:08 INFO - PROCESS | 17854 | 02:50:08 INFO - PROCESS | 17854 | [#2] jquery.html Cycles:180 Average:24179.15 Median:380087.50 stddev:62309.46 (16.4%) stddev-sans-first:62458.57 02:50:08 INFO - PROCESS | 17854 | Values: 350.4 366.5 369.7 372.7 390.2 12522.4 16618.0 17284.2 17637.4 18770.4 15451.0 15569.0 15946.7 16821.7 16866.3 5039.3 5105.0 5196.7 5226.9 5227.9 3657.9 5170.0 5252.3 5778.2 6058.4 6134.6 6144.6 6145.7 6147.0 6147.0 5966.4 6043.0 6110.7 6116.5 6120.1 5208.6 5387.6 5389.3 5399.5 5401.9 20904.0 21219.6 21248.6 21268.4 21286.3 1812.9 1835.3 1841.1 1917.9 2489.9 12763.2 13319.9 13375.8 13886.8 14039.8 1675.5 1767.8 1796.1 1805.4 1816.0 68890.7 69252.7 69894.3 70852.6 71584.6 9573.8 9825.0 9968.9 10126.3 10166.6 13639.2 13644.4 13658.3 13667.3 13685.9 7569.1 7698.3 7790.5 7858.4 7860.0 7303.4 7354.4 7360.4 7562.8 7581.1 6135.7 6157.9 6194.9 6209.8 6390.5 1694.8 1719.8 1790.6 1804.2 1805.0 814.6 836.7 869.3 952.4 990.5 17232.1 18579.0 18634.4 18843.2 19123.3 822.6 831.0 835.1 854.1 858.7 9756.7 10462.4 10588.8 10600.0 10646.7 362035.0 380050.0 380125.0 382445.0 382584.0 50471.0 58552.7 76467.6 86223.0 86902.6 911.2 912.8 952.0 952.5 958.4 15777.1 15809.0 16404.8 16431.0 16621.2 29518.9 35674.3 36440.0 36703.6 37180.3 51582.7 52685.0 52742.7 53458.7 53646.0 6565.3 6899.0 7067.8 7113.2 7362.6 9054.5 11997.1 12267.6 12395.1 12430.8 10340.9 10413.5 10908.8 10987.7 11020.5 10489.8 10782.0 10829.9 10834.7 10878.7 10732.2 11302.5 11387.0 11400.7 11451.8 7105.3 7252.3 7310.7 7396.5 7415.9 9133.4 10844.8 10913.4 11164.1 11193.3 02:50:08 INFO - PROCESS | 17854 | 02:50:08 INFO - PROCESS | 17854 | [#3] mootools.html Cycles:180 Average:5056.09 Median:4678.73 stddev:2908.84 (62.2%) stddev-sans-first:2902.60 02:50:08 INFO - PROCESS | 17854 | Values: 1205.0 1262.0 1330.8 1332.2 1627.3 7504.0 7914.9 7945.8 7947.5 7959.0 7844.6 7932.1 7952.7 7955.0 7963.0 2228.0 2251.8 2254.3 2255.3 2258.2 2113.5 2200.0 2205.7 2205.7 2205.8 2192.8 2206.1 2214.7 2215.9 2218.2 2074.2 2080.1 2080.6 2082.8 2082.9 2038.3 2090.7 2092.9 2094.4 2095.6 7649.3 7774.9 7925.8 7929.6 7932.4 4588.7 4777.7 4778.9 4782.3 4802.6 2793.7 2882.1 2941.8 2950.2 2962.3 1011.8 1019.1 1035.2 1037.1 1046.5 10412.6 10638.6 10807.9 10856.5 10868.0 4017.7 4128.3 4160.5 4280.5 4291.5 8555.1 8571.4 8574.6 8580.7 8584.1 4457.8 4462.2 4476.4 4487.1 4488.0 3749.3 3959.8 4068.1 4083.2 4140.6 3358.9 3387.3 3503.3 3505.9 3528.8 1027.4 1043.6 1050.7 1053.4 1057.0 774.1 780.6 784.6 798.4 802.9 4889.5 4919.0 4942.4 5155.0 5271.0 418.2 424.6 425.9 427.0 431.9 3285.6 3302.6 3312.8 3351.5 3454.2 9303.6 9805.0 9808.2 9819.2 9833.8 9743.8 9759.6 9760.0 9769.3 9778.2 7345.9 7379.1 7394.1 7424.5 7431.9 4768.8 4812.6 4900.8 4939.4 5127.9 8643.1 8740.7 8852.6 8871.2 8892.9 8924.8 9036.1 9088.2 9098.3 9136.2 5433.9 5572.0 6376.8 6429.6 6445.7 7325.1 7506.6 7534.7 7540.0 7544.8 6638.8 6701.1 6742.6 6896.4 6940.1 6529.2 6586.5 6673.5 6745.0 6774.6 6104.3 6210.8 6213.3 6220.0 6226.6 4199.8 4308.5 4423.0 4449.8 4456.6 4297.5 4316.1 4319.8 4338.2 4381.3 02:50:08 INFO - PROCESS | 17854 | 02:50:08 INFO - PROCESS | 17854 | [#4] prototype.html Cycles:180 Average:4184.04 Median:4810.91 stddev:1220.63 (25.4%) stddev-sans-first:1188.58 02:50:08 INFO - PROCESS | 17854 | Values: 291.9 294.7 301.2 301.5 304.3 4809.3 4819.9 4829.8 4860.9 4864.1 4787.4 4788.6 4791.4 4805.6 4824.7 3576.9 3690.2 3693.1 3703.2 3728.3 3631.1 3695.8 3771.9 3813.3 3813.6 3764.9 3768.5 3775.2 3784.7 3788.9 3545.5 3725.2 3756.9 3768.9 3774.3 3268.7 3271.7 3272.7 3282.1 3283.0 4688.5 4705.7 4707.2 4708.8 4713.5 4281.2 4300.4 4302.8 4306.8 4321.8 4926.5 5010.6 5022.3 5035.3 5048.5 3567.5 3578.9 3589.8 3591.4 3595.2 5227.5 5262.9 5276.9 5298.5 5315.3 3502.6 3660.2 3675.7 3679.8 3685.6 3721.6 3725.6 3729.5 3730.3 3732.7 4228.3 4257.8 4262.9 4274.8 4285.5 4900.8 5051.4 5054.6 5061.4 5071.8 1273.5 1282.6 1289.9 1295.6 1298.7 794.9 809.0 830.5 832.1 833.3 4307.7 4308.7 4477.6 4516.6 4537.7 5258.3 5268.9 5271.5 5282.0 5284.8 4504.9 4507.0 4511.7 4512.5 4522.4 2633.6 2746.8 2767.3 2771.3 2775.6 4893.4 4896.7 4901.4 4908.0 4921.4 5042.3 5295.9 5302.0 5317.8 5340.4 4840.0 4909.7 4945.6 4946.6 4954.4 5128.6 5177.9 5181.4 5195.4 5203.6 4955.2 5070.7 5074.7 5088.4 5093.7 4830.8 4870.5 4881.8 4898.3 4899.0 3654.4 3659.4 3687.9 3697.2 3699.3 4996.8 5220.2 5232.1 5246.4 5291.4 4990.4 5003.8 5011.5 5016.2 5018.1 4935.4 5007.5 5012.5 5015.3 5018.6 4655.4 4929.3 4949.1 4999.9 5002.0 4812.5 4893.3 5039.4 5057.9 5060.7 4933.6 4944.3 4950.3 4954.4 4957.7 02:50:08 INFO - PROCESS | 17854 | 02:50:08 INFO - PROCESS | 17854 | [#5] yui.html Cycles:180 Average:16800.30 Median:484.89 stddev:25133.94 (5183.5%) stddev-sans-first:25174.99 02:50:08 INFO - PROCESS | 17854 | Values: 593.5 622.9 655.2 695.1 707.8 11949.3 12648.7 12718.4 12753.2 12770.5 12501.5 12629.8 12642.1 12650.4 12681.2 595.9 730.5 741.9 742.6 743.4 728.1 754.4 754.8 755.4 757.3 802.0 802.0 802.8 804.0 804.2 628.7 796.0 796.3 796.7 797.1 558.7 575.0 575.0 575.7 579.0 11548.9 11624.9 11650.0 11678.5 11683.5 10384.8 10723.9 10881.4 11345.1 11713.0 10124.0 10208.8 10224.9 10294.4 10411.1 3745.3 3770.7 3812.2 3846.3 3853.1 63236.7 63448.0 64232.4 64306.4 64349.7 8853.2 8989.9 9149.0 9168.3 9488.1 17323.7 17335.2 17337.3 17378.2 17387.6 6465.2 6532.1 6664.4 6757.9 6771.3 3539.5 3624.0 3637.7 3719.6 3772.3 2618.0 2713.1 2713.1 2714.2 2715.4 457.2 462.9 465.0 465.4 484.1 410.3 459.2 465.5 474.2 510.7 6777.8 6917.3 7065.3 7162.7 7169.7 458.7 460.4 476.4 485.7 486.8 3355.8 3518.7 3525.9 3577.0 3789.6 82366.0 100678.0 101598.4 106858.5 108026.5 73640.0 88165.6 89797.0 90336.0 90385.0 60769.4 62217.7 68674.0 76442.0 79879.6 7024.3 7645.6 7770.7 7947.6 7957.0 43447.3 43674.6 44653.3 44763.8 45604.8 34571.7 35441.0 40746.6 59256.4 61141.1 9471.0 9778.8 9794.6 9796.9 9825.4 11256.8 11391.7 11587.8 11614.5 12083.0 10683.3 10844.3 11194.6 11355.6 11791.6 10139.5 10191.2 10273.7 10307.3 10355.1 9745.8 9948.0 9987.5 10060.4 10620.8 7711.1 7898.7 8003.3 8207.8 8315.5 7873.2 8137.0 8208.8 8226.3 8329.3 02:50:08 INFO - PROCESS | 17854 | -------- Summary: end -------- 02:50:08 INFO - PROCESS | 17854 | 02:50:09 INFO - TEST-INFO | 17854: exit 0 02:50:09 INFO - TEST-OK | dromaeo_css | took 1121896ms 02:50:09 INFO - TEST-START | kraken 02:50:09 INFO - operating with platform_type : linux_ 02:50:09 INFO - Initialising browser for kraken test... 02:50:09 INFO - TEST-INFO | started process 18157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa1HgZk/profile http://localhost:34909/getInfo.html) 02:50:14 INFO - PROCESS | 18157 | __metrics Screen width/height:1600/1200 02:50:14 INFO - PROCESS | 18157 | colorDepth:24 02:50:14 INFO - PROCESS | 18157 | Browser inner width/height: 1024/697 02:50:14 INFO - PROCESS | 18157 | __metrics 02:50:14 INFO - PROCESS | 18157 | 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" 02:50:14 INFO - PROCESS | 18157 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:50:15 INFO - PROCESS | 18157 | console.error: PushService: 02:50:15 INFO - PROCESS | 18157 | stateChangeProcessEnqueue: Error transitioning state 02:50:15 INFO - PROCESS | 18157 | UnknownError 02:50:16 INFO - TEST-INFO | 18157: exit 0 02:50:16 INFO - Browser initialized. 02:50:16 INFO - Running cycle 1/1 for kraken test... 02:50:16 INFO - TEST-INFO | started process 18239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa1HgZk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:50:28 INFO - PROCESS | 18239 | RSS: Main: 180920320 02:50:28 INFO - PROCESS | 18239 | 02:50:31 INFO - PROCESS | 18239 | Cycle 1(1): loaded http://localhost:34909/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34909/tests/kraken/driver.html?testName=audio-beat-detection) 02:50:32 INFO - PROCESS | 18239 | RSS: Main: 234442752 02:50:32 INFO - PROCESS | 18239 | 02:50:35 INFO - PROCESS | 18239 | Cycle 1(1): loaded http://localhost:34909/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34909/tests/kraken/driver.html?testName=audio-dft) 02:50:35 INFO - PROCESS | 18239 | RSS: Main: 225792000 02:50:35 INFO - PROCESS | 18239 | 02:50:38 INFO - PROCESS | 18239 | Cycle 1(1): loaded http://localhost:34909/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34909/tests/kraken/driver.html?testName=audio-fft) 02:50:39 INFO - PROCESS | 18239 | RSS: Main: 302456832 02:50:39 INFO - PROCESS | 18239 | 02:50:41 INFO - PROCESS | 18239 | Cycle 1(1): loaded http://localhost:34909/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34909/tests/kraken/driver.html?testName=audio-oscillator) 02:50:42 INFO - PROCESS | 18239 | RSS: Main: 213577728 02:50:42 INFO - PROCESS | 18239 | 02:50:44 INFO - PROCESS | 18239 | Cycle 1(1): loaded http://localhost:34909/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34909/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:50:45 INFO - PROCESS | 18239 | RSS: Main: 215506944 02:50:45 INFO - PROCESS | 18239 | 02:50:48 INFO - PROCESS | 18239 | Cycle 1(1): loaded http://localhost:34909/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34909/tests/kraken/driver.html?testName=imaging-darkroom) 02:50:48 INFO - PROCESS | 18239 | RSS: Main: 253284352 02:50:48 INFO - PROCESS | 18239 | 02:50:52 INFO - PROCESS | 18239 | Cycle 1(1): loaded http://localhost:34909/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34909/tests/kraken/driver.html?testName=imaging-desaturate) 02:50:52 INFO - PROCESS | 18239 | RSS: Main: 252661760 02:50:52 INFO - PROCESS | 18239 | 02:50:55 INFO - PROCESS | 18239 | Cycle 1(1): loaded http://localhost:34909/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34909/tests/kraken/driver.html?testName=json-parse-financial) 02:50:56 INFO - PROCESS | 18239 | RSS: Main: 252608512 02:50:56 INFO - PROCESS | 18239 | 02:50:58 INFO - PROCESS | 18239 | Cycle 1(1): loaded http://localhost:34909/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34909/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:50:58 INFO - PROCESS | 18239 | RSS: Main: 215220224 02:50:58 INFO - PROCESS | 18239 | 02:51:00 INFO - PROCESS | 18239 | Cycle 1(1): loaded http://localhost:34909/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34909/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:51:01 INFO - PROCESS | 18239 | RSS: Main: 222789632 02:51:01 INFO - PROCESS | 18239 | 02:51:03 INFO - PROCESS | 18239 | Cycle 1(1): loaded http://localhost:34909/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34909/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:51:04 INFO - PROCESS | 18239 | RSS: Main: 223436800 02:51:04 INFO - PROCESS | 18239 | 02:51:06 INFO - PROCESS | 18239 | Cycle 1(1): loaded http://localhost:34909/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34909/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:51:07 INFO - PROCESS | 18239 | RSS: Main: 224321536 02:51:07 INFO - PROCESS | 18239 | 02:51:10 INFO - PROCESS | 18239 | Cycle 1(1): loaded http://localhost:34909/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34909/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:51:11 INFO - PROCESS | 18239 | RSS: Main: 222236672 02:51:11 INFO - PROCESS | 18239 | 02:51:12 INFO - PROCESS | 18239 | Cycle 1(1): loaded http://localhost:34909/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34909/tests/kraken/driver.html?testName=ai-astar) 02:51:13 INFO - PROCESS | 18239 | RSS: Main: 272822272 02:51:13 INFO - PROCESS | 18239 | 02:51:13 INFO - PROCESS | 18239 | __start_tp_report 02:51:13 INFO - PROCESS | 18239 | _x_x_mozilla_page_load 02:51:13 INFO - PROCESS | 18239 | _x_x_mozilla_page_load_details 02:51:13 INFO - PROCESS | 18239 | |i|pagename|runs| 02:51:13 INFO - PROCESS | 18239 | |0;ai-astar;114;113;133;113;115;114;114;114;113;113 02:51:13 INFO - PROCESS | 18239 | |1;audio-beat-detection;154;122;152;182;131;147;153;128;202;127 02:51:13 INFO - PROCESS | 18239 | |2;audio-dft;161;162;162;161;163;161;160;161;161;161 02:51:13 INFO - PROCESS | 18239 | |3;audio-fft;75;75;76;170;76;76;81;76;158;76 02:51:13 INFO - PROCESS | 18239 | |4;audio-oscillator;86;85;153;83;82;83;140;85;84;136 02:51:13 INFO - PROCESS | 18239 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;117;118 02:51:13 INFO - PROCESS | 18239 | |6;imaging-darkroom;147;146;146;146;146;147;146;146;146;146 02:51:13 INFO - PROCESS | 18239 | |7;imaging-desaturate;95;95;94;95;95;94;95;95;95;95 02:51:13 INFO - PROCESS | 18239 | |8;json-parse-financial;63;64;64;64;64;65;71;65;64;65 02:51:13 INFO - PROCESS | 18239 | |9;json-stringify-tinderbox;66;65;65;65;65;65;65;65;65;65 02:51:13 INFO - PROCESS | 18239 | |10;stanford-crypto-aes;88;82;81;91;91;84;88;83;87;88 02:51:13 INFO - PROCESS | 18239 | |11;stanford-crypto-ccm;145;141;142;133;132;133;133;134;180;141 02:51:13 INFO - PROCESS | 18239 | |12;stanford-crypto-pbkdf2;181;172;186;175;186;177;180;172;172;174 02:51:13 INFO - PROCESS | 18239 | |13;stanford-crypto-sha256-iterative;70;69;69;70;68;68;68;69;70;69 02:51:13 INFO - PROCESS | 18239 | __end_tp_report 02:51:13 INFO - PROCESS | 18239 | __start_cc_report 02:51:13 INFO - PROCESS | 18239 | _x_x_mozilla_cycle_collect,1965 02:51:13 INFO - PROCESS | 18239 | __end_cc_report 02:51:13 INFO - PROCESS | 18239 | __startTimestamp1472291473210__endTimestamp 02:51:13 INFO - PROCESS | 18239 | 02:51:13 INFO - PROCESS | 18239 | ------- Summary: start ------- 02:51:13 INFO - PROCESS | 18239 | Number of tests: 14 02:51:13 INFO - PROCESS | 18239 | 02:51:13 INFO - PROCESS | 18239 | [#0] ai-astar Cycles:10 Average:115.60 Median:114.00 stddev:6.15 (5.4%) stddev-sans-first:6.50 02:51:13 INFO - PROCESS | 18239 | Values: 114.0 113.0 133.0 113.0 115.0 114.0 114.0 114.0 113.0 113.0 02:51:13 INFO - PROCESS | 18239 | 02:51:13 INFO - PROCESS | 18239 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:152.50 stddev:25.65 (16.8%) stddev-sans-first:27.17 02:51:13 INFO - PROCESS | 18239 | Values: 154.0 122.0 152.0 182.0 131.0 147.0 153.0 128.0 202.0 127.0 02:51:13 INFO - PROCESS | 18239 | 02:51:13 INFO - PROCESS | 18239 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 02:51:13 INFO - PROCESS | 18239 | Values: 161.0 162.0 162.0 161.0 163.0 161.0 160.0 161.0 161.0 161.0 02:51:13 INFO - PROCESS | 18239 | 02:51:13 INFO - PROCESS | 18239 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:37.09 (48.8%) stddev-sans-first:38.71 02:51:13 INFO - PROCESS | 18239 | Values: 75.0 75.0 76.0 170.0 76.0 76.0 81.0 76.0 158.0 76.0 02:51:13 INFO - PROCESS | 18239 | 02:51:13 INFO - PROCESS | 18239 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:83.50 stddev:28.83 (34.5%) stddev-sans-first:30.01 02:51:13 INFO - PROCESS | 18239 | Values: 86.0 85.0 153.0 83.0 82.0 83.0 140.0 85.0 84.0 136.0 02:51:13 INFO - PROCESS | 18239 | 02:51:13 INFO - PROCESS | 18239 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 02:51:13 INFO - PROCESS | 18239 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 02:51:13 INFO - PROCESS | 18239 | 02:51:13 INFO - PROCESS | 18239 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 02:51:13 INFO - PROCESS | 18239 | Values: 147.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 02:51:13 INFO - PROCESS | 18239 | 02:51:13 INFO - PROCESS | 18239 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:51:13 INFO - PROCESS | 18239 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 02:51:13 INFO - PROCESS | 18239 | 02:51:13 INFO - PROCESS | 18239 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:64.50 stddev:2.23 (3.5%) stddev-sans-first:2.26 02:51:13 INFO - PROCESS | 18239 | Values: 63.0 64.0 64.0 64.0 64.0 65.0 71.0 65.0 64.0 65.0 02:51:13 INFO - PROCESS | 18239 | 02:51:13 INFO - PROCESS | 18239 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.32 (0.5%) stddev-sans-first:0.00 02:51:13 INFO - PROCESS | 18239 | Values: 66.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 02:51:13 INFO - PROCESS | 18239 | 02:51:13 INFO - PROCESS | 18239 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:88.00 stddev:3.59 (4.1%) stddev-sans-first:3.76 02:51:13 INFO - PROCESS | 18239 | Values: 88.0 82.0 81.0 91.0 91.0 84.0 88.0 83.0 87.0 88.0 02:51:13 INFO - PROCESS | 18239 | 02:51:13 INFO - PROCESS | 18239 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:141.00 stddev:14.37 (10.2%) stddev-sans-first:15.18 02:51:13 INFO - PROCESS | 18239 | Values: 145.0 141.0 142.0 133.0 132.0 133.0 133.0 134.0 180.0 141.0 02:51:13 INFO - PROCESS | 18239 | 02:51:13 INFO - PROCESS | 18239 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.50 Median:178.50 stddev:5.50 (3.1%) stddev-sans-first:5.69 02:51:13 INFO - PROCESS | 18239 | Values: 181.0 172.0 186.0 175.0 186.0 177.0 180.0 172.0 172.0 174.0 02:51:13 INFO - PROCESS | 18239 | 02:51:13 INFO - PROCESS | 18239 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 02:51:13 INFO - PROCESS | 18239 | Values: 70.0 69.0 69.0 70.0 68.0 68.0 68.0 69.0 70.0 69.0 02:51:13 INFO - PROCESS | 18239 | -------- Summary: end -------- 02:51:13 INFO - PROCESS | 18239 | 02:51:14 INFO - TEST-INFO | 18239: exit 0 02:51:14 INFO - TEST-OK | kraken | took 64918ms 02:51:14 INFO - SUITE-END | took 1186s 02:51:14 INFO - Completed test suite (00:19:47) 02:51:14 INFO - javascript benchmark 02:51:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2611.791056715463, 2626.8555229462386, 2628.5005848888723, 2671.9599206011912, 2689.3276680829795, 4693.48371679115, 4700.482946875845, 4743.833965811189, 4779.35478710374, 4850.587700045496, 4773.976130119353, 4802.567768900798, 4814.1575224335775, 4823.276508523723, 4861.902761944759, 4340.110277393127, 4426.026274219666, 4454.799534020961, 4475.418195634563, 4478.507364189953, 4395.362672412498, 4427.424434823469, 4432.867013989586, 4485.753283569403, 4542.068875880436, 4487.618552423048, 4488.102379524092, 4531.728096314215, 4534.1385136824065, 4545.0, 4319.308910574293, 4352.151330490556, 4389.824407023715, 4397.428334316518, 4436.5119836818085, 4303.33298338758, 4306.7631280279575, 4322.286822674287, 4372.715773474714, 4403.559644035571, 4672.0889426561835, 4710.62315014798, 4742.312364707098, 4761.285807128924, 4812.951870481285, 5019.52314530119, 5099.643024988252, 5113.616478764107, 5113.923291150636, 5177.37871455424, 5130.769115389817, 5141.974290128563, 5194.558462530689, 5208.2968799212, 5213.087709650834, 4805.37530121082, 4832.323474713543, 4842.757862106881, 4850.417949846041, 4909.042736666387, 5130.871728206825, 5201.687898726089, 5314.840554783363, 5318.73406329682, 5321.201819727072, 5034.546890779774, 5054.292399064134, 5094.617903657167, 5114.974425127925, 5120.692758434506, 5129.487051294841, 5142.71715055668, 5146.4853514648985, 5147.1507201312115, 5207.270982062514, 5081.59347252219, 5086.567641750418, 5101.795928162906, 5104.2343648453025, 5107.310513080761, 4925.0, 4986.127427700138, 5005.0, 5063.11395505785, 5066.36670416198, 4358.956410435919, 4374.256376416017, 4376.912461750747, 4413.293872980308, 4429.712068715523, 3792.5069740934055, 3809.29528037314, 3830.4062870255157, 3847.076701591598, 3859.5754467008605, 4318.460192475941, 4338.544452832471, 4389.4293741814, 4414.911701765946, 4441.045175287329, 5149.382074151051, 5152.793888244429, 5153.768080436389, 5203.479652034766, 5205.115130427836, 4420.469543654782, 4425.402570652921, 4432.113577284556, 4470.441194850644, 4481.843135490308, 4552.975580494429, 4595.6783025187915, 4616.215243408628, 4623.190941585276, 4626.583607475343, 4839.201531747222, 4842.394700662418, 4901.240307752304, 4901.779419926041, 4908.435529914105, 5160.0, 5164.0962831505085, 5165.044466773659, 5175.249588809526, 5207.27098206259, 4710.24636058229, 4820.71075735457, 4833.32333473307, 4844.75776211181, 4902.92645610309, 5090.821821236239, 5139.511746384088, 5143.8456846294675, 5189.091908916, 5201.895962080662, 5189.221616757516, 5211.140161873249, 5217.50433708797, 5219.869503262449, 5291.3121294231505, 4861.829835955725, 4948.579370753382, 5030.245463180552, 5038.1435156022835, 5040.924386134284, 4954.727489988085, 5016.2224855147515, 5016.648834581544, 5075.543201111917, 5078.669886457368, 4904.975475122602, 4945.2582112683385, 4946.134426475424, 4954.157793175241, 5012.072766538202, 4902.411710594752, 4947.925781113214, 4952.380952380952, 5063.670861393997, 5085.64400491962, 4805.327254184487, 4823.734694591831, 4839.370881785346, 4846.442659094108, 4856.9757151215435], "value": 4715.139021434298, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.8982688202681, 564.1396869773597, 573.5698226330252, 586.0681516388944, 586.1325238646803, 27490.862545687294, 30324.241893952636, 36867.63132368676, 38043.61956380435, 38092.619073809255, 40956.38565421513, 41089.178216435655, 41227.58772412275, 41317.17365652685, 41385.172296554054, 7555.924440755604, 7706.6146692665425, 7711.074671039483, 7712.421568382366, 7715.421343399239, 7250.782476525686, 9699.90300096997, 9926.751831204205, 9940.25448091396, 10238.078572928434, 10024.94987525065, 10118.190544756439, 10120.746981325452, 10124.595016199342, 10126.84809727851, 9949.154321882648, 10022.248331375176, 10029.648962286357, 10036.0, 10043.14633256174, 9815.41107533543, 9874.654387096418, 9880.505974701307, 9885.110340069356, 9887.851682224773, 37255.813720931495, 37684.623153768385, 37724.0, 37800.62199377998, 37823.0, 2756.572731226663, 2866.2977570495154, 2881.409311091242, 2917.28526511004, 2953.3354995126138, 27507.0, 27600.585991210148, 28092.87628494858, 28168.295792605142, 28551.28621784472, 3396.6942975132356, 3448.2930999145115, 3459.3427248822895, 3533.169705119295, 3557.1640664443835, 251228.0, 252108.0, 252973.0, 253658.73170634214, 254089.0, 51401.7429912848, 51454.74272628613, 51713.224301635506, 51816.74091629593, 51850.0, 31500.527492087178, 54942.725286373316, 54948.725256373466, 55157.448425516035, 55218.72390638021, 13950.930245348709, 14431.783523247159, 14433.855661443251, 14452.205128717811, 14477.927610361881, 9857.162141218078, 10185.236107291983, 10840.837387439195, 10954.178436617285, 10962.835557466644, 17234.396796112076, 17394.21726022332, 17607.207675654627, 17679.646407071785, 17850.19674114668, 5517.44825517445, 6699.802682518651, 6786.4570834333135, 6871.725130994704, 6906.302300602023, 719.2988582003524, 816.7876352148484, 842.5197637346654, 936.1714882329188, 975.5219942228399, 25765.0, 26839.86580067126, 27244.0, 27676.446471070467, 27858.442831143264, 883.7481317824389, 907.945523268606, 940.3417607674655, 954.9140577348072, 967.5936106835146, 13960.301984900714, 14357.0, 14635.85364146345, 14804.481843135654, 14833.480828170963, 386760.0, 389439.0, 391152.0, 391171.0, 391470.0, 33078.0, 33145.83427082849, 33178.17054573655, 33217.3356532868, 33292.3341533168, 1032.5560009195967, 1124.0726400719275, 1132.671525257666, 1159.0322081062407, 1167.6380322100176, 26258.86870565635, 27268.45463090767, 28028.057054009034, 28475.715242847305, 28563.143105706862, 41012.58987410207, 41416.37875431811, 41420.378694319006, 41424.58575414207, 41473.585264146976, 280808.0, 281801.0, 282112.0, 282504.0, 282920.5123846288, 23997.880010599834, 24968.0, 24981.87509062443, 25780.613290800276, 25804.61293080643, 39089.0, 39346.6065339343, 39509.604903950596, 39561.0, 40366.59633403746, 33539.0, 33633.66366336403, 33750.324993499504, 33754.66245337515, 33899.4915076279, 34368.25053995724, 34723.65276347204, 34800.0, 34843.82578087093, 34933.82533087318, 33914.0, 34766.0, 34941.650583493836, 34947.47578786269, 35215.0, 30039.249018774706, 31297.8435107823, 31540.684593153775, 31599.21001974969, 31705.365892681555, 24116.0, 24454.0, 24695.0, 25001.749982499943, 25153.74846251514], "value": 17235.63453034179, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.40955989158255, 366.5161986178244, 369.7411811731787, 372.74094504319476, 390.2039838728993, 12522.373881305932, 16618.0, 17284.222210000564, 17637.382691605795, 18770.43688689338, 15451.0, 15569.0, 15946.681066378665, 16821.663566728657, 16866.325346986137, 5039.3196918415915, 5105.030044291582, 5196.714180720059, 5226.947730522703, 5227.86930326743, 3657.9268414631692, 5170.0, 5252.343457067866, 5778.191053252548, 6058.39416058395, 6134.6012509186985, 6144.5698801083945, 6145.692715364236, 6147.0, 6147.047207682816, 5966.37353077927, 6043.0, 6110.694465276719, 6116.510679145702, 6120.081987701836, 5208.583313334924, 5387.595930305243, 5389.299391079135, 5399.541039011649, 5401.891962160774, 20904.0, 21219.5756084879, 21248.575028499497, 21268.361949141396, 21286.254981075745, 1812.8821626594229, 1835.2658936425537, 1841.0518582929801, 1917.88492690439, 2489.9128530501525, 12763.234205947672, 13319.86680133196, 13375.799363009563, 13886.791698124536, 14039.78940315896, 1675.4973507947566, 1767.8320559546823, 1796.1320226964071, 1805.4403135028183, 1816.0315504554928, 68890.65554672245, 69252.653736731, 69894.3010569893, 70852.6457367715, 71584.64207678981, 9573.760655983657, 9824.950875245579, 9968.850467242997, 10126.341787783771, 10166.644167454104, 13639.181649101085, 13644.386002629906, 13658.317084145752, 13667.316634168252, 13685.931570342085, 7569.091708994956, 7698.307152356315, 7790.493617914817, 7858.410619203582, 7860.0, 7303.379212766974, 7354.448416368794, 7360.411167106618, 7562.848743025219, 7581.090269167625, 6135.662538560422, 6157.9384206158265, 6194.938050619527, 6209.844753881189, 6390.488760899117, 1694.754260632226, 1719.785026871641, 1790.5702631368379, 1804.2422182683304, 1804.9784241649436, 814.5967745965785, 836.7322456813761, 869.2788279207205, 952.4190243951184, 990.5146478225762, 17232.138393080546, 18579.0, 18634.440966771017, 18843.152058157415, 19123.330683426015, 822.576373167819, 830.9916900831035, 835.1147783349547, 854.0946596607616, 858.7209157023992, 9756.707298781048, 10462.36113951633, 10588.821857705478, 10600.0, 10646.73383165427, 362035.0, 380050.0, 380125.0, 382445.0, 382584.0, 50471.0, 58552.707236463546, 76467.61766191134, 86223.0, 86902.56548717216, 911.1708345405649, 912.7535565397438, 952.0336858089045, 952.5332587032304, 958.3626888119322, 15777.053376797428, 15809.0, 16404.75392869084, 16431.0, 16621.16894155263, 29518.852405737834, 35674.28651426905, 36440.0, 36703.632963670025, 37180.25639487141, 51582.74208628933, 52685.0, 52742.73628631832, 53458.73270633622, 53646.0, 6565.277819439762, 6899.0, 7067.752628657972, 7113.217546070032, 7362.6318684066655, 9054.502002389932, 11997.100217483548, 12267.631971040882, 12395.070369722127, 12430.751384972069, 10340.948295258475, 10413.531391087268, 10908.781824363627, 10987.736410312917, 11020.50407731638, 10489.79020419572, 10782.0, 10829.891701082888, 10834.729131771768, 10878.673639790819, 10732.248742587944, 11302.547898083985, 11387.0, 11400.714982125513, 11451.828222576502, 7105.25394833535, 7252.2747725227055, 7310.744123955636, 7396.4822462429265, 7415.925840741524, 9133.40632858862, 10844.837327439936, 10913.39976301311, 11164.106871450427, 11193.328400296008], "value": 8501.5559427271, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1204.9638510844677, 1262.0, 1330.8469526004508, 1332.2406228449781, 1627.3327935546422, 7504.0, 7914.920850791497, 7945.841083178333, 7947.523148611073, 7959.044914610247, 7844.64699088541, 7932.127465978738, 7952.681892724284, 7954.96022519888, 7962.96018519908, 2228.0419419649584, 2251.8423710340285, 2254.267363106997, 2255.3459496746004, 2258.1870526610405, 2113.4927617371873, 2200.04298130313, 2205.658122990939, 2205.7132572765518, 2205.845590808644, 2192.78072192781, 2206.095500844654, 2214.6567282071223, 2215.94460138497, 2218.223621732389, 2074.2325339624285, 2080.06397121296, 2080.5630817528336, 2082.802133797287, 2082.9479263018393, 2038.2560365466645, 2090.6550419180817, 2092.9476763080893, 2094.361219827952, 2095.6018356512213, 7649.311561959395, 7774.883376749297, 7925.762227133196, 7929.603519823986, 7932.365410767125, 4588.655850811202, 4777.665563410563, 4778.928316075262, 4782.306565547976, 4802.615790736732, 2793.7485626293733, 2882.0633294179474, 2941.8234905905715, 2950.173951293641, 2962.2890506278336, 1011.7824667696481, 1019.1184625299137, 1035.1925498111484, 1037.1391744851755, 1046.4767616191905, 10412.635557755442, 10638.57445702171, 10807.945960270226, 10856.45717714119, 10868.0, 4017.6986725995666, 4128.318827393447, 4160.521540022875, 4280.464941882265, 4291.506476755213, 8555.14448555152, 8571.400001999926, 8574.614142363609, 8580.742577722678, 8584.098669639723, 4457.821687132543, 4462.219111655448, 4476.35092911526, 4487.147441986012, 4488.035072459437, 3749.268892565978, 3959.8020098994934, 4068.0846809468226, 4083.1833633273463, 4140.60664236897, 3358.9496157557655, 3387.271736576648, 3503.264314493934, 3505.859765609398, 3528.8235588220487, 1027.3938376357835, 1043.6034306963306, 1050.6847945616285, 1053.4048262731685, 1057.0, 774.1136398823315, 780.6331024418514, 784.5880912520972, 798.4251339035885, 802.9277365037175, 4889.511048895153, 4918.95081049185, 4942.406911170682, 5155.0, 5270.973645131749, 418.2033226703135, 424.6009399030203, 425.85308068716245, 426.9679774016961, 431.8833914842975, 3285.572875526166, 3302.5871766029245, 3312.7846689965077, 3351.4805205193234, 3454.240067185215, 9303.627854885728, 9804.950975245221, 9808.166305863939, 9819.16537094355, 9833.803323933482, 9743.756406089904, 9759.560819763128, 9759.951200243953, 9769.267304952156, 9778.217742580577, 7345.926540734631, 7379.077615298195, 7394.149672787698, 7424.517406368569, 7431.888521672179, 4768.809247630056, 4812.5668689818085, 4900.803967841246, 4939.357883475125, 5127.871803204801, 8643.092475290005, 8740.737777866674, 8852.55737213124, 8871.201591856505, 8892.866607000771, 8924.776880578038, 9036.051214622634, 9088.182063614306, 9098.31762617793, 9136.223421009288, 5433.891322173614, 5571.972140139435, 6376.808695739135, 6429.58207716497, 6445.677716114082, 7325.120985481776, 7506.624668766649, 7534.698612055676, 7539.962300188464, 7544.811379715551, 6638.800835974928, 6701.128853249046, 6742.6291553965, 6896.448284137357, 6940.097787287822, 6529.183852018497, 6586.5389422739945, 6673.466122710074, 6744.966275168593, 6774.593524388552, 6104.298005729398, 6210.813675589739, 6213.285472170577, 6220.03589443637, 6226.5641405101205, 4199.790010499401, 4308.482982042175, 4422.977885110683, 4449.777511124366, 4456.554344565518, 4297.484301883794, 4316.093620339764, 4319.784010799384, 4338.197433474817, 4381.255186618347], "value": 3984.0856867777293, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.8817878759102, 294.6861592404089, 301.1822900824262, 301.47543274702025, 304.33502796389877, 4809.302651115586, 4819.927701084478, 4829.7585120744, 4860.902781944359, 4864.124457597631, 4787.35370724952, 4788.59296959758, 4791.448983366914, 4805.639577031728, 4824.662273640846, 3576.856925722968, 3690.188158605116, 3693.0582701411104, 3703.166787472824, 3728.328900797855, 3631.1466805300734, 3695.796731179784, 3771.887742864005, 3813.294540510001, 3813.63770441809, 3764.924701505968, 3768.4535742317485, 3775.2072064866275, 3784.6972242220554, 3788.90527736806, 3545.450455179451, 3725.1990821973136, 3756.8685096021645, 3768.947152806236, 3774.320622287987, 3268.656791036931, 3271.689189526991, 3272.689094536015, 3282.146641873106, 3282.950755738642, 4688.507706690816, 4705.694129881546, 4707.152712511746, 4708.811647534095, 4713.505081966413, 4281.207976524353, 4300.376445415429, 4302.763348015857, 4306.7631280279575, 4321.805518751632, 4926.507349265081, 5010.599152067826, 5022.321986531808, 5035.269885866565, 5048.545630893201, 3567.518385018015, 3578.9284214315567, 3589.766665166782, 3591.4018261873216, 3595.227026189356, 5227.503387178212, 5262.894742105174, 5276.947230527684, 5298.470152984671, 5315.255864178979, 3502.562179727534, 3660.231351416179, 3675.7426980111136, 3679.804063679315, 3685.649863263039, 3721.5720192178246, 3725.5529336479794, 3729.4965179700935, 3730.2539492101146, 3732.701383889282, 4228.344606585984, 4257.808398622069, 4262.934266433392, 4274.764887931132, 4285.514401647038, 4900.779464924016, 5051.419086804991, 5054.595632349477, 5061.367329083864, 5071.847844564669, 1273.4778740716263, 1282.6088043146742, 1289.9161554498928, 1295.5724610878387, 1298.727267273864, 794.8807678848219, 808.9595520223966, 830.4767996162379, 832.0597724571196, 833.3166803221301, 4307.698461107755, 4308.741475511417, 4477.619402350771, 4516.593506584423, 4537.727736335831, 5258.342707161605, 5268.868278293074, 5271.525562699376, 5281.9700158469495, 5284.788608455696, 4504.932426013613, 4506.954930450719, 4511.744127936032, 4512.52618475062, 4522.412086428743, 2633.631291619175, 2746.807723459339, 2767.2918289491777, 2771.3348796289147, 2775.6391669083296, 4893.412790465096, 4896.706197628154, 4901.436334821541, 4908.0, 4921.384826896638, 5042.319286896222, 5295.894082118413, 5301.973490132525, 5317.787288508416, 5340.385855626575, 4839.95160048395, 4909.656324057353, 4945.6043516517875, 4946.629002824802, 4954.430240522314, 5128.640995130305, 5177.948220517897, 5181.404138523967, 5195.402528709247, 5203.635745497779, 4955.231939049453, 5070.721110338966, 5074.731317170707, 5088.4148322941855, 5093.668911520739, 4830.768154120677, 4870.464248932685, 4881.755912204305, 4898.2897479864505, 4898.975505122452, 3654.378755611606, 3659.396199627032, 3687.9446808298435, 3697.2235830474824, 3699.260147970363, 4996.775145118406, 5220.216967454912, 5232.084385232493, 5246.396664383645, 5291.444398338119, 4990.4011518618, 5003.774830132726, 5011.473795251592, 5016.172331565397, 5018.1218286800395, 4935.432425270996, 5007.524285192901, 5012.548870601518, 5015.272785446163, 5018.598512119095, 4655.371524844239, 4929.260610908393, 4949.133901567139, 4999.875003124951, 5002.023795841468, 4812.51874812516, 4893.290472881484, 5039.370078740158, 5057.900971096954, 5060.747967154581, 4933.605311574994, 4944.307796908508, 4950.282209079592, 4954.439351604233, 4957.652964292609], "value": 3793.5585203653563, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.4688453833819, 622.8660837919847, 655.2497390487895, 695.1415002471948, 707.812429706128, 11949.34278614677, 12648.747025059492, 12718.36408179592, 12753.171043882141, 12770.489180432784, 12501.49994000239, 12629.810552841715, 12642.115051946368, 12650.430730617121, 12681.17572357796, 595.8540157661379, 730.5324592260957, 741.8627553902518, 742.5952855693633, 743.4015617427968, 728.0608015659792, 754.4341743692231, 754.7773406844993, 755.3579457461142, 757.2843662738715, 801.9839603207932, 801.9879701804477, 802.7511471443842, 803.9638216280281, 804.1958041958042, 628.7327885648581, 796.0248695348153, 796.303234669664, 796.6813274690112, 797.09927781607, 558.7346010644952, 574.9913751293734, 574.9913751293734, 575.6689903305574, 579.0416860096547, 11548.942255288754, 11624.88375116255, 11650.0, 11678.532858685643, 11683.474243659055, 10384.84422733652, 10723.892761072368, 10881.401522916236, 11345.078647218183, 11713.0, 10124.0, 10208.795824083476, 10224.897751022543, 10294.382337059726, 10411.07106127626, 3745.2883952049024, 3770.6606405423645, 3812.218495208476, 3846.3461211593817, 3853.094522787143, 63236.683816581084, 63447.99999999954, 64232.35767642357, 64306.35693643051, 64349.67825160891, 8853.15894989975, 8989.883888972023, 9148.954255228682, 9168.266538677024, 9488.146066854017, 17323.65352692939, 17335.21991510385, 17337.306507739802, 17378.217980190922, 17387.56531086733, 6465.191851018622, 6532.08550802888, 6664.400203981665, 6757.932420675828, 6771.255161932184, 3539.52216450781, 3623.9818800905828, 3637.672609465161, 3719.6466335698065, 3772.3398405278967, 2618.0, 2713.050432348662, 2713.1046754570943, 2714.1721774858856, 2715.3618899558587, 457.2386975685513, 462.8773375055613, 465.0443338938446, 465.3926625753357, 484.09957479088865, 410.29429381463837, 459.20786643040486, 465.46006632306364, 474.1560023158783, 510.6859281541899, 6777.762778302835, 6917.339838438839, 7065.258147894499, 7162.746519359195, 7169.6773645186095, 458.6812165544981, 460.4037771086384, 476.4036003779416, 485.6745980193279, 486.75905426813955, 3355.798652080883, 3518.7009104226427, 3525.9294814103573, 3576.9821150894077, 3789.6357311367888, 82366.0, 100678.0, 101598.4120873359, 106858.46570767097, 108026.45986770016, 73640.0, 88165.55917220374, 89797.0, 90336.0, 90385.0, 60769.39230607637, 62217.68891155515, 68674.0, 76442.0, 79879.60060199662, 7024.332688394595, 7645.61771911391, 7770.747006935912, 7947.562884041202, 7957.0, 43447.348289775044, 43674.56325436705, 44653.330200046374, 44763.77618111888, 45604.771976139906, 34571.65428345785, 35441.0, 40746.59253407546, 59256.40743592509, 61141.08288375589, 9470.952645237005, 9778.823013567626, 9794.62561495656, 9796.9020309796, 9825.361351512129, 11256.83114753263, 11391.715207119889, 11587.826182607436, 11614.477348519506, 12083.033357331567, 10683.25217234786, 10844.295120817122, 11194.608188713355, 11355.602553910574, 11791.587294444653, 10139.543720532447, 10191.184705223712, 10273.691789246335, 10307.330023548446, 10355.068043876086, 9745.756356091155, 9948.0, 9987.450690212108, 10060.39637621745, 10620.84068738985, 7711.0746710395115, 7898.723544676139, 8003.279704826594, 8207.753767386988, 8315.542645154332, 7873.212678732081, 8136.959315203623, 8208.753737387888, 8226.30076443509, 8329.333653307842], "value": 6044.391853029444, "unit": "score"}], "name": "dromaeo_css", "value": 6310.055376322212, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 133.0, 113.0, 115.0, 114.0, 114.0, 114.0, 113.0, 113.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 152.0, 182.0, 131.0, 147.0, 153.0, 128.0, 202.0, 127.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 163.0, 161.0, 160.0, 161.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 170.0, 76.0, 76.0, 81.0, 76.0, 158.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 153.0, 83.0, 82.0, 83.0, 140.0, 85.0, 84.0, 136.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 65.0, 71.0, 65.0, 64.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 81.0, 91.0, 91.0, 84.0, 88.0, 83.0, 87.0, 88.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 141.0, 142.0, 133.0, 132.0, 133.0, 133.0, 134.0, 180.0, 141.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 172.0, 186.0, 175.0, 186.0, 177.0, 180.0, 172.0, 172.0, 174.0], "value": 177.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 70.0, 68.0, 68.0, 68.0, 69.0, 70.0, 69.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1584.7, "alertThreshold": 2.0}]} 02:51:14 INFO - Return code: 0 02:51:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:51:15 INFO - # TBPL SUCCESS # 02:51:15 INFO - Running post-action listener: _resource_record_post_action 02:51:15 INFO - [mozharness: 2016-08-27 09:51:15.015053Z] Finished run-tests step (success) 02:51:15 INFO - Running post-run listener: _resource_record_post_run 02:51:15 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 217088; Write bytes: 416079872; Read time: 40; Write time: 768180 02:51:15 INFO - TinderboxPrint: CPU usage
13.1% 02:51:15 INFO - TinderboxPrint: I/O read bytes / time
217,088 / 40 02:51:15 INFO - TinderboxPrint: I/O write bytes / time
416,079,872 / 768,180 02:51:15 INFO - TinderboxPrint: CPU idle
8,344.9 (86.9%) 02:51:15 INFO - TinderboxPrint: CPU user
1,201.2 (12.5%) 02:51:15 INFO - TinderboxPrint: Swap in / out
0 / 0 02:51:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 125313024; Read time: 0; Write time: 190984 02:51:15 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 212992; Write bytes: 290766848; Read time: 28; Write time: 577196 02:51:15 INFO - Running post-run listener: _upload_blobber_files 02:51:15 INFO - Blob upload gear active. 02:51:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:51:15 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 02:51:15 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'] 02:51:15 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 02:51:16 INFO - (blobuploader) - INFO - Open directory for files ... 02:51:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:51:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:51:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:51:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:51:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:51:16 INFO - (blobuploader) - INFO - Done attempting. 02:51:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:51:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:51:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:51:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:51:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:51:20 INFO - (blobuploader) - INFO - Done attempting. 02:51:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:51:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:51:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:51:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:51:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:51:21 INFO - (blobuploader) - INFO - Done attempting. 02:51:21 INFO - (blobuploader) - INFO - Iteration through files over. 02:51:21 INFO - Return code: 0 02:51:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:51:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:51:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/028fcfbfa4d0df580a19cb43a44604c9f23db936648fa1a457d659dce291564f9909f596d92a0d3d497dd7ff6a1e012e6d89abce429e296e93d1fcc8c041ed6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/09381daac2512ac1cc1c52bb32fc851ad0f47fe81dfdebab0dc79f5018e5ee92d43c2c48768b1638707a5363de8fe79730a855f06efbd817c905bfdef15df795", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dd11ec3ef354d58543d135b932975084d2f8c7088314529370adf3b9e5a636d06f242c0b451c5cb838dfae56247c7e85aeb28778465d07bc3fff4887e1c8cca5"} 02:51:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:51:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:51:21 INFO - Contents: 02:51:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/028fcfbfa4d0df580a19cb43a44604c9f23db936648fa1a457d659dce291564f9909f596d92a0d3d497dd7ff6a1e012e6d89abce429e296e93d1fcc8c041ed6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/09381daac2512ac1cc1c52bb32fc851ad0f47fe81dfdebab0dc79f5018e5ee92d43c2c48768b1638707a5363de8fe79730a855f06efbd817c905bfdef15df795", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dd11ec3ef354d58543d135b932975084d2f8c7088314529370adf3b9e5a636d06f242c0b451c5cb838dfae56247c7e85aeb28778465d07bc3fff4887e1c8cca5"} 02:51:21 INFO - Running post-run listener: copy_logs_to_upload_dir 02:51:21 INFO - Copying logs to upload dir... 02:51:21 INFO - mkdir: /builds/slave/test/build/upload/logs 02:51:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.674960 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-27 02:51:21.609955) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 02:51:21.613528) ========= 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=8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382 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/028fcfbfa4d0df580a19cb43a44604c9f23db936648fa1a457d659dce291564f9909f596d92a0d3d497dd7ff6a1e012e6d89abce429e296e93d1fcc8c041ed6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/09381daac2512ac1cc1c52bb32fc851ad0f47fe81dfdebab0dc79f5018e5ee92d43c2c48768b1638707a5363de8fe79730a855f06efbd817c905bfdef15df795", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dd11ec3ef354d58543d135b932975084d2f8c7088314529370adf3b9e5a636d06f242c0b451c5cb838dfae56247c7e85aeb28778465d07bc3fff4887e1c8cca5"} build_url:https://queue.taskcluster.net/v1/task/IK8Ja1j0RhiZNXQqXixoPA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011141 build_url: 'https://queue.taskcluster.net/v1/task/IK8Ja1j0RhiZNXQqXixoPA/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/028fcfbfa4d0df580a19cb43a44604c9f23db936648fa1a457d659dce291564f9909f596d92a0d3d497dd7ff6a1e012e6d89abce429e296e93d1fcc8c041ed6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/09381daac2512ac1cc1c52bb32fc851ad0f47fe81dfdebab0dc79f5018e5ee92d43c2c48768b1638707a5363de8fe79730a855f06efbd817c905bfdef15df795", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dd11ec3ef354d58543d135b932975084d2f8c7088314529370adf3b9e5a636d06f242c0b451c5cb838dfae56247c7e85aeb28778465d07bc3fff4887e1c8cca5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 02:51:21.638848) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 02:51:21.639177) ========= 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=8783db0840cc980e80bb0bd400000236-1472290233.299129-774090382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 02:51:21.721969) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 02:51:21.722297) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 02:51:21.722591) ========= ========= Total master_lag: 0.18 =========