builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1470653183.61 results: success (0) buildid: 20160808020440 builduid: 8f05402547434ad1a2ee543a4c0a0c56 revision: 46dede080ba1b6bcaaf5af7b00fc5e356c66faac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 03:46:23.614938) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 03:46:23.615354) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 03:46:23.615619) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 03:46:23.630084) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 03:46:23.630348) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-08 03:46:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 104M=0s 2016-08-08 03:46:24 (104 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118988 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 03:46:23.762774) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 03:46:23.763074) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018703 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 03:46:23.811977) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 03:46:23.812316) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 46dede080ba1b6bcaaf5af7b00fc5e356c66faac --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 46dede080ba1b6bcaaf5af7b00fc5e356c66faac --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-08 03:46:24,423 truncating revision to first 12 chars 2016-08-08 03:46:24,423 Setting DEBUG logging. 2016-08-08 03:46:24,423 attempt 1/10 2016-08-08 03:46:24,423 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/46dede080ba1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 03:46:25,383 unpacking tar archive at: fx-team-46dede080ba1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.300240 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 03:46:25.126854) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 03:46:25.127229) ========= script_repo_revision: 46dede080ba1b6bcaaf5af7b00fc5e356c66faac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 03:46:25.127649) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 03:46:25.127947) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 03:46:25.137110) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-08 03:46:25.137543) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:46:25 INFO - MultiFileLogger online at 20160808 03:46:25 in /builds/slave/test 03:46:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:46:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:46:25 INFO - {'append_to_log': False, 03:46:25 INFO - 'base_work_dir': '/builds/slave/test', 03:46:25 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:46:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:46:25 INFO - 'branch': 'Fx-Team-Non-PGO', 03:46:25 INFO - 'buildbot_json_path': 'buildprops.json', 03:46:25 INFO - 'config_files': ('talos/linux_config.py',), 03:46:25 INFO - 'default_actions': ('clobber', 03:46:25 INFO - 'read-buildbot-config', 03:46:25 INFO - 'download-and-extract', 03:46:25 INFO - 'populate-webroot', 03:46:25 INFO - 'create-virtualenv', 03:46:25 INFO - 'install', 03:46:25 INFO - 'run-tests'), 03:46:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:46:25 INFO - 'download_minidump_stackwalk': True, 03:46:25 INFO - 'download_symbols': 'ondemand', 03:46:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:46:25 INFO - 'tooltool.py': '/tools/tooltool.py', 03:46:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:46:25 INFO - '/tools/misc-python/virtualenv.py')}, 03:46:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:46:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:46:25 INFO - 'installer_path': 'installer.exe', 03:46:25 INFO - 'log_level': 'info', 03:46:25 INFO - 'log_name': 'talos', 03:46:25 INFO - 'log_to_console': True, 03:46:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:46:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:46:25 INFO - 'opt_config_files': (), 03:46:25 INFO - 'pip_index': False, 03:46:25 INFO - 'sps_profile': False, 03:46:25 INFO - 'sps_profile_interval': 0, 03:46:25 INFO - 'suite': 'dromaeojs', 03:46:25 INFO - 'system_bits': '32', 03:46:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:46:25 INFO - 'title': 'talos-linux64-ix-023', 03:46:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:46:25 INFO - 'use_talos_json': True, 03:46:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:46:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:46:25 INFO - 'work_dir': 'build'} 03:46:25 INFO - [mozharness: 2016-08-08 10:46:25.840057Z] Running clobber step. 03:46:25 INFO - Running pre-action listener: _resource_record_pre_action 03:46:25 INFO - Running main action method: clobber 03:46:25 INFO - rmtree: /builds/slave/test/build 03:46:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:46:26 INFO - Running post-action listener: _resource_record_post_action 03:46:26 INFO - [mozharness: 2016-08-08 10:46:26.317504Z] Finished clobber step (success) 03:46:26 INFO - [mozharness: 2016-08-08 10:46:26.317605Z] Running read-buildbot-config step. 03:46:26 INFO - Running pre-action listener: _resource_record_pre_action 03:46:26 INFO - Running main action method: read_buildbot_config 03:46:26 INFO - Using buildbot properties: 03:46:26 INFO - { 03:46:26 INFO - "project": "", 03:46:26 INFO - "product": "firefox", 03:46:26 INFO - "script_repo_revision": "production", 03:46:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:46:26 INFO - "repository": "", 03:46:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:46:26 INFO - "buildid": "20160808020440", 03:46:26 INFO - "pgo_build": "False", 03:46:26 INFO - "basedir": "/builds/slave/test", 03:46:26 INFO - "buildnumber": 1856, 03:46:26 INFO - "slavename": "talos-linux64-ix-023", 03:46:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:46:26 INFO - "platform": "ubuntu64_hw", 03:46:26 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 03:46:26 INFO - "branch": "fx-team", 03:46:26 INFO - "repo_path": "integration/fx-team", 03:46:26 INFO - "revision": "46dede080ba1b6bcaaf5af7b00fc5e356c66faac", 03:46:26 INFO - "stage_platform": "linux64", 03:46:26 INFO - "builduid": "8f05402547434ad1a2ee543a4c0a0c56", 03:46:26 INFO - "slavebuilddir": "test" 03:46:26 INFO - } 03:46:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 03:46:26 INFO - Running post-action listener: _resource_record_post_action 03:46:26 INFO - [mozharness: 2016-08-08 10:46:26.320411Z] Finished read-buildbot-config step (success) 03:46:26 INFO - [mozharness: 2016-08-08 10:46:26.320502Z] Running download-and-extract step. 03:46:26 INFO - Running pre-action listener: _resource_record_pre_action 03:46:26 INFO - Running main action method: download_and_extract 03:46:26 INFO - mkdir: /builds/slave/test/build/tests 03:46:26 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')]} 03:46:26 INFO - trying https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:46:26 INFO - Downloading https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/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 03:46:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/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 03:46:26 INFO - Downloaded 1361 bytes. 03:46:26 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:46:26 INFO - Using the following test package requirements: 03:46:26 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 03:46:26 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:46:26 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:46:26 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:26 INFO - u'jsshell-linux-x86_64.zip'], 03:46:26 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:46:26 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 03:46:26 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:46:26 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:46:26 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:46:26 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:46:26 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:46:26 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')]} 03:46:26 INFO - trying https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:46:26 INFO - Downloading https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/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 03:46:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/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 03:46:27 INFO - Downloaded 20257787 bytes. 03:46:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:46:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:46:28 INFO - Return code: 0 03:46:28 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 03:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:28 INFO - trying https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:46:28 INFO - Downloading https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/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 03:46:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/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 03:46:29 INFO - Downloaded 20257787 bytes. 03:46:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:46:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:46:31 INFO - Return code: 0 03:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:31 INFO - trying https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 03:46:31 INFO - Downloading https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/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 03:46:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/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 03:46:32 INFO - Downloaded 14413723 bytes. 03:46:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:46:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:46:32 INFO - Return code: 0 03:46:32 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')]} 03:46:32 INFO - trying https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:46:32 INFO - Downloading https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/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 03:46:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/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 03:46:33 INFO - Downloaded 56127054 bytes. 03:46:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:46:33 INFO - mkdir: /builds/slave/test/properties 03:46:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:46:33 INFO - Writing to file /builds/slave/test/properties/build_url 03:46:33 INFO - Contents: 03:46:33 INFO - build_url:https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:46:34 INFO - Running post-action listener: _resource_record_post_action 03:46:34 INFO - Running post-action listener: set_extra_try_arguments 03:46:34 INFO - [mozharness: 2016-08-08 10:46:34.402956Z] Finished download-and-extract step (success) 03:46:34 INFO - [mozharness: 2016-08-08 10:46:34.403194Z] Running populate-webroot step. 03:46:34 INFO - Running pre-action listener: _resource_record_pre_action 03:46:34 INFO - Running main action method: populate_webroot 03:46:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:46:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:46:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:46:34 INFO - '--tppagecycles', 03:46:34 INFO - '7'], 03:46:34 INFO - 'tests': ['tsvgm']}}, 03:46:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:46:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:46:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:46:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:46:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:46:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:46:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:34 INFO - 'talos_options': ['--disable-e10s'], 03:46:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:34 INFO - 'talos_options': ['--disable-e10s'], 03:46:34 INFO - 'tests': ['damp', 'tps']}, 03:46:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:34 INFO - 'tests': ['damp', 'tps']}, 03:46:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:46:34 INFO - 'tests': ['dromaeo_dom']}, 03:46:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:46:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:46:34 INFO - 'tests': ['basic_compositor_video']}, 03:46:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:46:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:46:34 INFO - 'tests': ['a11yr', 03:46:34 INFO - 'ts_paint', 03:46:34 INFO - 'tpaint', 03:46:34 INFO - 'sessionrestore', 03:46:34 INFO - 'sessionrestore_no_auto_restore', 03:46:34 INFO - 'tabpaint']}, 03:46:34 INFO - 'other-e10s': {'tests': ['a11yr', 03:46:34 INFO - 'ts_paint', 03:46:34 INFO - 'tpaint', 03:46:34 INFO - 'sessionrestore', 03:46:34 INFO - 'sessionrestore_no_auto_restore', 03:46:34 INFO - 'tabpaint']}, 03:46:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:46:34 INFO - 'ts_paint', 03:46:34 INFO - 'tpaint', 03:46:34 INFO - 'sessionrestore', 03:46:34 INFO - 'sessionrestore_no_auto_restore', 03:46:34 INFO - 'tabpaint']}, 03:46:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:46:34 INFO - 'ts_paint', 03:46:34 INFO - 'tpaint', 03:46:34 INFO - 'sessionrestore', 03:46:34 INFO - 'sessionrestore_no_auto_restore', 03:46:34 INFO - 'tabpaint']}, 03:46:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:46:34 INFO - 'tests': ['a11yr', 03:46:34 INFO - 'ts_paint', 03:46:34 INFO - 'tpaint', 03:46:34 INFO - 'sessionrestore', 03:46:34 INFO - 'sessionrestore_no_auto_restore', 03:46:34 INFO - 'tabpaint']}, 03:46:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:46:34 INFO - 'tests': ['a11yr', 03:46:34 INFO - 'ts_paint', 03:46:34 INFO - 'tpaint', 03:46:34 INFO - 'sessionrestore', 03:46:34 INFO - 'sessionrestore_no_auto_restore', 03:46:34 INFO - 'tabpaint']}, 03:46:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:46:34 INFO - 'tests': ['tsvgx', 03:46:34 INFO - 'tsvgr_opacity', 03:46:34 INFO - 'tart', 03:46:34 INFO - 'tscrollx', 03:46:34 INFO - 'cart']}, 03:46:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:46:34 INFO - 'tsvgr_opacity', 03:46:34 INFO - 'tart', 03:46:34 INFO - 'tscrollx', 03:46:34 INFO - 'cart']}, 03:46:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:34 INFO - 'talos_options': ['--disable-e10s'], 03:46:34 INFO - 'tests': ['tp5o']}, 03:46:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:34 INFO - 'tests': ['tp5o']}, 03:46:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:34 INFO - 'talos_options': ['--disable-e10s', 03:46:34 INFO - '--xperf_path', 03:46:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:34 INFO - 'tests': ['tp5n']}, 03:46:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:34 INFO - 'talos_options': ['--xperf_path', 03:46:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:34 INFO - 'tests': ['tp5n']}}, 03:46:34 INFO - 'talos.zip': {'path': '', 03:46:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:46:34 INFO - Running post-action listener: _resource_record_post_action 03:46:34 INFO - [mozharness: 2016-08-08 10:46:34.419318Z] Finished populate-webroot step (success) 03:46:34 INFO - [mozharness: 2016-08-08 10:46:34.419409Z] Running create-virtualenv step. 03:46:34 INFO - Running pre-action listener: _resource_record_pre_action 03:46:34 INFO - Running main action method: create_virtualenv 03:46:34 INFO - Creating virtualenv /builds/slave/test/build/venv 03:46:34 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 03:46:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:46:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:46:34 INFO - Using real prefix '/usr' 03:46:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:46:35 INFO - Installing distribute.............................................................................................................................................................................................done. 03:46:37 INFO - Installing pip.................done. 03:46:37 INFO - Return code: 0 03:46:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:46:37 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')]} 03:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:37 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')]} 03:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:37 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 0xdfd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10be180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc3b0>, '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 0x10bd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', '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 03:46:37 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 03:46:37 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 03:46:37 INFO - Using env: {'DISPLAY': ':0', 03:46:37 INFO - 'HOME': '/home/cltbld', 03:46:37 INFO - 'LANG': 'en_US.UTF-8', 03:46:37 INFO - 'LANGUAGE': 'en_US:en', 03:46:37 INFO - 'LOGNAME': 'cltbld', 03:46:37 INFO - 'MAIL': '/var/mail/cltbld', 03:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:37 INFO - 'MOZ_NO_REMOTE': '1', 03:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:37 INFO - 'NO_EM_RESTART': '1', 03:46:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:37 INFO - 'PWD': '/builds/slave/test', 03:46:37 INFO - 'SHELL': '/bin/bash', 03:46:37 INFO - 'SHLVL': '1', 03:46:37 INFO - 'TERM': 'linux', 03:46:37 INFO - 'TMOUT': '86400', 03:46:37 INFO - 'USER': 'cltbld', 03:46:37 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', 03:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:37 INFO - '_': '/tools/buildbot/bin/python'} 03:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:37 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 03:46:37 INFO - Cleaning up... 03:46:37 INFO - Return code: 0 03:46:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:46:37 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')]} 03:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:37 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')]} 03:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:37 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 0xdfd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10be180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc3b0>, '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 0x10bd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', '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 03:46:37 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 03:46:37 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 03:46:37 INFO - Using env: {'DISPLAY': ':0', 03:46:37 INFO - 'HOME': '/home/cltbld', 03:46:37 INFO - 'LANG': 'en_US.UTF-8', 03:46:37 INFO - 'LANGUAGE': 'en_US:en', 03:46:37 INFO - 'LOGNAME': 'cltbld', 03:46:37 INFO - 'MAIL': '/var/mail/cltbld', 03:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:37 INFO - 'MOZ_NO_REMOTE': '1', 03:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:37 INFO - 'NO_EM_RESTART': '1', 03:46:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:37 INFO - 'PWD': '/builds/slave/test', 03:46:37 INFO - 'SHELL': '/bin/bash', 03:46:37 INFO - 'SHLVL': '1', 03:46:37 INFO - 'TERM': 'linux', 03:46:37 INFO - 'TMOUT': '86400', 03:46:37 INFO - 'USER': 'cltbld', 03:46:37 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', 03:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:37 INFO - '_': '/tools/buildbot/bin/python'} 03:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:37 INFO - Downloading/unpacking psutil>=3.1.1 03:46:37 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 03:46:37 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 03:46:37 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 03:46:37 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 03:46:37 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 03:46:37 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 03:46:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:46:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:46:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:46:39 INFO - Installing collected packages: psutil 03:46:39 INFO - Running setup.py install for psutil 03:46:39 INFO - building 'psutil._psutil_linux' extension 03:46:39 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 03:46:39 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 03:46:39 INFO - building 'psutil._psutil_posix' extension 03:46:39 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 03:46:40 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 03:46:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:46:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:46:40 INFO - Successfully installed psutil 03:46:40 INFO - Cleaning up... 03:46:40 INFO - Return code: 0 03:46:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:40 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 0xdfd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10be180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc3b0>, '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 0x10bd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', '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 03:46:40 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 03:46:40 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 03:46:40 INFO - Using env: {'DISPLAY': ':0', 03:46:40 INFO - 'HOME': '/home/cltbld', 03:46:40 INFO - 'LANG': 'en_US.UTF-8', 03:46:40 INFO - 'LANGUAGE': 'en_US:en', 03:46:40 INFO - 'LOGNAME': 'cltbld', 03:46:40 INFO - 'MAIL': '/var/mail/cltbld', 03:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:40 INFO - 'MOZ_NO_REMOTE': '1', 03:46:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:40 INFO - 'NO_EM_RESTART': '1', 03:46:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:40 INFO - 'PWD': '/builds/slave/test', 03:46:40 INFO - 'SHELL': '/bin/bash', 03:46:40 INFO - 'SHLVL': '1', 03:46:40 INFO - 'TERM': 'linux', 03:46:40 INFO - 'TMOUT': '86400', 03:46:40 INFO - 'USER': 'cltbld', 03:46:40 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', 03:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:40 INFO - '_': '/tools/buildbot/bin/python'} 03:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:46:40 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 03:46:40 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 03:46:40 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 03:46:40 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 03:46:40 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 03:46:40 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 03:46:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:46:42 INFO - Installing collected packages: mozsystemmonitor 03:46:42 INFO - Running setup.py install for mozsystemmonitor 03:46:42 INFO - Successfully installed mozsystemmonitor 03:46:42 INFO - Cleaning up... 03:46:42 INFO - Return code: 0 03:46:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:46:42 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')]} 03:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:42 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')]} 03:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:42 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 0xdfd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10be180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc3b0>, '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 0x10bd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', '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 03:46:42 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 03:46:42 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 03:46:42 INFO - Using env: {'DISPLAY': ':0', 03:46:42 INFO - 'HOME': '/home/cltbld', 03:46:42 INFO - 'LANG': 'en_US.UTF-8', 03:46:42 INFO - 'LANGUAGE': 'en_US:en', 03:46:42 INFO - 'LOGNAME': 'cltbld', 03:46:42 INFO - 'MAIL': '/var/mail/cltbld', 03:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:42 INFO - 'MOZ_NO_REMOTE': '1', 03:46:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:42 INFO - 'NO_EM_RESTART': '1', 03:46:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:42 INFO - 'PWD': '/builds/slave/test', 03:46:42 INFO - 'SHELL': '/bin/bash', 03:46:42 INFO - 'SHLVL': '1', 03:46:42 INFO - 'TERM': 'linux', 03:46:42 INFO - 'TMOUT': '86400', 03:46:42 INFO - 'USER': 'cltbld', 03:46:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', 03:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:42 INFO - '_': '/tools/buildbot/bin/python'} 03:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:42 INFO - Downloading/unpacking jsonschema==2.5.1 03:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:46:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:44 INFO - Downloading functools32-3.2.3-2.tar.gz 03:46:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:46:44 INFO - warning: no files found matching '*.txt' 03:46:44 INFO - no previously-included directories found matching 'build' 03:46:44 INFO - no previously-included directories found matching 'dist' 03:46:44 INFO - no previously-included directories found matching '.git*' 03:46:44 INFO - Installing collected packages: jsonschema, functools32 03:46:44 INFO - Running setup.py install for functools32 03:46:44 INFO - warning: no files found matching '*.txt' 03:46:44 INFO - no previously-included directories found matching 'build' 03:46:44 INFO - no previously-included directories found matching 'dist' 03:46:44 INFO - no previously-included directories found matching '.git*' 03:46:45 INFO - Successfully installed jsonschema functools32 03:46:45 INFO - Cleaning up... 03:46:45 INFO - Return code: 0 03:46:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:45 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 0xdfd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10be180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc3b0>, '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 0x10bd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', '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 03:46:45 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 03:46:45 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 03:46:45 INFO - Using env: {'DISPLAY': ':0', 03:46:45 INFO - 'HOME': '/home/cltbld', 03:46:45 INFO - 'LANG': 'en_US.UTF-8', 03:46:45 INFO - 'LANGUAGE': 'en_US:en', 03:46:45 INFO - 'LOGNAME': 'cltbld', 03:46:45 INFO - 'MAIL': '/var/mail/cltbld', 03:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:45 INFO - 'MOZ_NO_REMOTE': '1', 03:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:45 INFO - 'NO_EM_RESTART': '1', 03:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:45 INFO - 'PWD': '/builds/slave/test', 03:46:45 INFO - 'SHELL': '/bin/bash', 03:46:45 INFO - 'SHLVL': '1', 03:46:45 INFO - 'TERM': 'linux', 03:46:45 INFO - 'TMOUT': '86400', 03:46:45 INFO - 'USER': 'cltbld', 03:46:45 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', 03:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:45 INFO - '_': '/tools/buildbot/bin/python'} 03:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:46:45 INFO - Cleaning up... 03:46:45 INFO - Return code: 0 03:46:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:45 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 0xdfd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10be180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc3b0>, '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 0x10bd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', '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 03:46:45 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 03:46:45 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 03:46:45 INFO - Using env: {'DISPLAY': ':0', 03:46:45 INFO - 'HOME': '/home/cltbld', 03:46:45 INFO - 'LANG': 'en_US.UTF-8', 03:46:45 INFO - 'LANGUAGE': 'en_US:en', 03:46:45 INFO - 'LOGNAME': 'cltbld', 03:46:45 INFO - 'MAIL': '/var/mail/cltbld', 03:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:45 INFO - 'MOZ_NO_REMOTE': '1', 03:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:45 INFO - 'NO_EM_RESTART': '1', 03:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:45 INFO - 'PWD': '/builds/slave/test', 03:46:45 INFO - 'SHELL': '/bin/bash', 03:46:45 INFO - 'SHLVL': '1', 03:46:45 INFO - 'TERM': 'linux', 03:46:45 INFO - 'TMOUT': '86400', 03:46:45 INFO - 'USER': 'cltbld', 03:46:45 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', 03:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:45 INFO - '_': '/tools/buildbot/bin/python'} 03:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:45 INFO - Downloading/unpacking blobuploader==1.2.4 03:46:45 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 03:46:45 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 03:46:45 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 03:46:45 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 03:46:45 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 03:46:45 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 03:46:47 INFO - Downloading blobuploader-1.2.4.tar.gz 03:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:46:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:46:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:48 INFO - Downloading docopt-0.6.1.tar.gz 03:46:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:46:48 INFO - Installing collected packages: blobuploader, requests, docopt 03:46:48 INFO - Running setup.py install for blobuploader 03:46:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:46:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:46:48 INFO - Running setup.py install for requests 03:46:48 INFO - Running setup.py install for docopt 03:46:48 INFO - Successfully installed blobuploader requests docopt 03:46:48 INFO - Cleaning up... 03:46:48 INFO - Return code: 0 03:46:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:46:48 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')]} 03:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:48 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')]} 03:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:48 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 0xdfd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10be180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc3b0>, '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 0x10bd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', '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 03:46:48 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 03:46:48 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 03:46:48 INFO - Using env: {'DISPLAY': ':0', 03:46:48 INFO - 'HOME': '/home/cltbld', 03:46:48 INFO - 'LANG': 'en_US.UTF-8', 03:46:48 INFO - 'LANGUAGE': 'en_US:en', 03:46:48 INFO - 'LOGNAME': 'cltbld', 03:46:48 INFO - 'MAIL': '/var/mail/cltbld', 03:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:48 INFO - 'MOZ_NO_REMOTE': '1', 03:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:48 INFO - 'NO_EM_RESTART': '1', 03:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:48 INFO - 'PWD': '/builds/slave/test', 03:46:48 INFO - 'SHELL': '/bin/bash', 03:46:48 INFO - 'SHLVL': '1', 03:46:48 INFO - 'TERM': 'linux', 03:46:48 INFO - 'TMOUT': '86400', 03:46:48 INFO - 'USER': 'cltbld', 03:46:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', 03:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:48 INFO - '_': '/tools/buildbot/bin/python'} 03:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:46:49 INFO - Running setup.py (path:/tmp/pip-qWmkMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:46:49 INFO - Running setup.py (path:/tmp/pip-ktsoUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:46:49 INFO - Running setup.py (path:/tmp/pip-e_0Fia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:46:49 INFO - Running setup.py (path:/tmp/pip-7ktfw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:46:49 INFO - Running setup.py (path:/tmp/pip-aM3jFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:46:49 INFO - Running setup.py (path:/tmp/pip-09_2UG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:46:49 INFO - Running setup.py (path:/tmp/pip-cv0V8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:46:49 INFO - Running setup.py (path:/tmp/pip-pZk4NK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:46:49 INFO - Running setup.py (path:/tmp/pip-BOV_V4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:46:49 INFO - Running setup.py (path:/tmp/pip-wxvwmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:46:49 INFO - Running setup.py (path:/tmp/pip-z4n2LF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:46:49 INFO - Running setup.py (path:/tmp/pip-F3dZnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:46:49 INFO - Running setup.py (path:/tmp/pip-FZ8Izy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:46:49 INFO - Running setup.py (path:/tmp/pip-4Ho8mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:46:50 INFO - Running setup.py (path:/tmp/pip-PmAifW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:46:50 INFO - Running setup.py (path:/tmp/pip-rGwsKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:46:50 INFO - Running setup.py (path:/tmp/pip-SsPkMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:46:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:46:50 INFO - Running setup.py install for manifestparser 03:46:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:46:50 INFO - Running setup.py install for mozcrash 03:46:50 INFO - Running setup.py install for mozdebug 03:46:50 INFO - Running setup.py install for mozdevice 03:46:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:46:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:46:50 INFO - Running setup.py install for mozfile 03:46:50 INFO - Running setup.py install for mozhttpd 03:46:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:46:50 INFO - Running setup.py install for mozinfo 03:46:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:46:50 INFO - Running setup.py install for mozInstall 03:46:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:46:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:46:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:46:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:46:51 INFO - Running setup.py install for mozleak 03:46:51 INFO - Running setup.py install for mozlog 03:46:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:46:51 INFO - Running setup.py install for moznetwork 03:46:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:46:51 INFO - Running setup.py install for mozprocess 03:46:51 INFO - Running setup.py install for mozprofile 03:46:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:46:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:46:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:46:51 INFO - Running setup.py install for mozrunner 03:46:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:46:51 INFO - Running setup.py install for mozscreenshot 03:46:51 INFO - Running setup.py install for moztest 03:46:51 INFO - Running setup.py install for mozversion 03:46:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:46:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:46:51 INFO - Cleaning up... 03:46:52 INFO - Return code: 0 03:46:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:46: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')]} 03:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46: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')]} 03:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:52 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 0xdfd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10be180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc3b0>, '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 0x10bd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', '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 03:46:52 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 03:46:52 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 03:46:52 INFO - Using env: {'DISPLAY': ':0', 03:46:52 INFO - 'HOME': '/home/cltbld', 03:46:52 INFO - 'LANG': 'en_US.UTF-8', 03:46:52 INFO - 'LANGUAGE': 'en_US:en', 03:46:52 INFO - 'LOGNAME': 'cltbld', 03:46:52 INFO - 'MAIL': '/var/mail/cltbld', 03:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:52 INFO - 'MOZ_NO_REMOTE': '1', 03:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:52 INFO - 'NO_EM_RESTART': '1', 03:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:52 INFO - 'PWD': '/builds/slave/test', 03:46:52 INFO - 'SHELL': '/bin/bash', 03:46:52 INFO - 'SHLVL': '1', 03:46:52 INFO - 'TERM': 'linux', 03:46:52 INFO - 'TMOUT': '86400', 03:46:52 INFO - 'USER': 'cltbld', 03:46:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', 03:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:52 INFO - '_': '/tools/buildbot/bin/python'} 03:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:46:52 INFO - Running setup.py (path:/tmp/pip-Yzcqoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:46:52 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)) 03:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:46:52 INFO - Running setup.py (path:/tmp/pip-3F4TvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:46:52 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)) 03:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:46:52 INFO - Running setup.py (path:/tmp/pip-te3Ud7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:46:52 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)) 03:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:46:52 INFO - Running setup.py (path:/tmp/pip-hhqTQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:46:52 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)) 03:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:46:52 INFO - Running setup.py (path:/tmp/pip-3olrnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:46:52 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)) 03:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:46:52 INFO - Running setup.py (path:/tmp/pip-wUBXeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:46:52 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)) 03:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:46:52 INFO - Running setup.py (path:/tmp/pip-xkAPeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:46:52 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)) 03:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:46:52 INFO - Running setup.py (path:/tmp/pip-nEXlQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:46:52 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)) 03:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:46:52 INFO - Running setup.py (path:/tmp/pip-Pcr9iZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:46:52 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)) 03:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:46:52 INFO - Running setup.py (path:/tmp/pip-8eJD50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:46:52 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)) 03:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:46:52 INFO - Running setup.py (path:/tmp/pip-IYgKun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:46:53 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)) 03:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:46:53 INFO - Running setup.py (path:/tmp/pip-mGthPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:46:53 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)) 03:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:46:53 INFO - Running setup.py (path:/tmp/pip-ooPaHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:46:53 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)) 03:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:46:53 INFO - Running setup.py (path:/tmp/pip-0xbxpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:46:53 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)) 03:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:46:53 INFO - Running setup.py (path:/tmp/pip-_P2m7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:46:53 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)) 03:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:46:53 INFO - Running setup.py (path:/tmp/pip-VTEvHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:46:53 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)) 03:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:46:53 INFO - Running setup.py (path:/tmp/pip-11hllm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:46:53 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)) 03:46:53 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)) 03:46:53 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)) 03:46:53 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)) 03:46:53 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)) 03:46:53 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)) 03:46:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:46:53 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 03:46:53 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 03:46:53 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 03:46:53 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 03:46:53 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 03:46:53 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 03:46:55 INFO - Downloading blessings-1.6.tar.gz 03:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:46:55 INFO - Installing collected packages: blessings 03:46:55 INFO - Running setup.py install for blessings 03:46:55 INFO - Successfully installed blessings 03:46:55 INFO - Cleaning up... 03:46:55 INFO - Return code: 0 03:46:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:46:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:46:55 INFO - Reading from file tmpfile_stdout 03:46:55 INFO - Current package versions: 03:46:55 INFO - argparse == 1.2.1 03:46:55 INFO - blessings == 1.6 03:46:55 INFO - blobuploader == 1.2.4 03:46:55 INFO - docopt == 0.6.1 03:46:55 INFO - functools32 == 3.2.3-2 03:46:55 INFO - jsonschema == 2.5.1 03:46:55 INFO - manifestparser == 1.1 03:46:55 INFO - mozInstall == 1.12 03:46:55 INFO - mozcrash == 0.17 03:46:55 INFO - mozdebug == 0.1 03:46:55 INFO - mozdevice == 0.48 03:46:55 INFO - mozfile == 1.2 03:46:55 INFO - mozhttpd == 0.7 03:46:55 INFO - mozinfo == 0.9 03:46:55 INFO - mozleak == 0.1 03:46:55 INFO - mozlog == 3.3 03:46:55 INFO - moznetwork == 0.27 03:46:55 INFO - mozprocess == 0.23 03:46:55 INFO - mozprofile == 0.28 03:46:55 INFO - mozrunner == 6.12 03:46:55 INFO - mozscreenshot == 0.1 03:46:55 INFO - mozsystemmonitor == 0.3 03:46:55 INFO - moztest == 0.7 03:46:55 INFO - mozversion == 1.4 03:46:55 INFO - psutil == 3.1.1 03:46:55 INFO - requests == 1.2.3 03:46:55 INFO - wsgiref == 0.1.2 03:46:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:46:55 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')]} 03:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:55 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')]} 03:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:55 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 0xdfd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10be180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc3b0>, '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 0x10bd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', '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 03:46:55 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 03:46:55 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 03:46:55 INFO - Using env: {'DISPLAY': ':0', 03:46:55 INFO - 'HOME': '/home/cltbld', 03:46:55 INFO - 'LANG': 'en_US.UTF-8', 03:46:55 INFO - 'LANGUAGE': 'en_US:en', 03:46:55 INFO - 'LOGNAME': 'cltbld', 03:46:55 INFO - 'MAIL': '/var/mail/cltbld', 03:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:55 INFO - 'MOZ_NO_REMOTE': '1', 03:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:55 INFO - 'NO_EM_RESTART': '1', 03:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:55 INFO - 'PWD': '/builds/slave/test', 03:46:55 INFO - 'SHELL': '/bin/bash', 03:46:55 INFO - 'SHLVL': '1', 03:46:55 INFO - 'TERM': 'linux', 03:46:55 INFO - 'TMOUT': '86400', 03:46:55 INFO - 'USER': 'cltbld', 03:46:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', 03:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:55 INFO - '_': '/tools/buildbot/bin/python'} 03:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:56 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)) 03:46:56 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)) 03:46:56 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)) 03:46:56 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)) 03:46:56 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)) 03:46:56 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)) 03:46:56 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)) 03:46:56 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)) 03:46:56 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)) 03:46:56 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)) 03:46:56 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)) 03:46:56 INFO - Cleaning up... 03:46:56 INFO - Return code: 0 03:46:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:46:56 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')]} 03:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:56 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')]} 03:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:56 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 0xdfd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10be180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc3b0>, '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 0x10bd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', '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 03:46:56 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 03:46:56 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 03:46:56 INFO - Using env: {'DISPLAY': ':0', 03:46:56 INFO - 'HOME': '/home/cltbld', 03:46:56 INFO - 'LANG': 'en_US.UTF-8', 03:46:56 INFO - 'LANGUAGE': 'en_US:en', 03:46:56 INFO - 'LOGNAME': 'cltbld', 03:46:56 INFO - 'MAIL': '/var/mail/cltbld', 03:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:56 INFO - 'MOZ_NO_REMOTE': '1', 03:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:56 INFO - 'NO_EM_RESTART': '1', 03:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:56 INFO - 'PWD': '/builds/slave/test', 03:46:56 INFO - 'SHELL': '/bin/bash', 03:46:56 INFO - 'SHLVL': '1', 03:46:56 INFO - 'TERM': 'linux', 03:46:56 INFO - 'TMOUT': '86400', 03:46:56 INFO - 'USER': 'cltbld', 03:46:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', 03:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:56 INFO - '_': '/tools/buildbot/bin/python'} 03:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:46:56 INFO - Cleaning up... 03:46:56 INFO - Return code: 0 03:46:56 INFO - Running post-action listener: _resource_record_post_action 03:46:56 INFO - Running post-action listener: _start_resource_monitoring 03:46:56 INFO - Starting resource monitoring. 03:46:56 INFO - [mozharness: 2016-08-08 10:46:56.298245Z] Finished create-virtualenv step (success) 03:46:56 INFO - [mozharness: 2016-08-08 10:46:56.298682Z] Running install step. 03:46:56 INFO - Running pre-action listener: _resource_record_pre_action 03:46:56 INFO - Running main action method: install 03:46:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:46:56 INFO - Reading from file tmpfile_stdout 03:46:56 INFO - Detecting whether we're running mozinstall >=1.0... 03:46:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:46:56 INFO - Reading from file tmpfile_stdout 03:46:56 INFO - Output received: 03:46:56 INFO - Usage: mozinstall [options] installer 03:46:56 INFO - Options: 03:46:56 INFO - -h, --help show this help message and exit 03:46:56 INFO - -d DEST, --destination=DEST 03:46:56 INFO - Directory to install application into. [default: 03:46:56 INFO - "/builds/slave/test"] 03:46:56 INFO - --app=APP Application being installed. [default: firefox] 03:46:56 INFO - mkdir: /builds/slave/test/build/application 03:46:56 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'] 03:46:56 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 03:47:12 INFO - Reading from file tmpfile_stdout 03:47:12 INFO - Output received: 03:47:12 INFO - /builds/slave/test/build/application/firefox/firefox 03:47:12 INFO - Running post-action listener: _resource_record_post_action 03:47:12 INFO - [mozharness: 2016-08-08 10:47:12.813190Z] Finished install step (success) 03:47:12 INFO - [mozharness: 2016-08-08 10:47:12.813443Z] Running run-tests step. 03:47:12 INFO - Running pre-action listener: _resource_record_pre_action 03:47:12 INFO - Running main action method: run_tests 03:47:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:47:12 INFO - Python 2.7.3 03:47:12 INFO - Return code: 0 03:47:12 INFO - grabbing minidump binary from tooltool 03:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:12 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 0x10bc3b0>, '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 0x10bd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:47:12 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 03:47:12 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 03:47:12 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 03:47:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:47:12 INFO - Return code: 0 03:47:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:47:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:47:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:47:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:47:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:47:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:47:12 INFO - Using env: {'DISPLAY': ':0', 03:47:12 INFO - 'HOME': '/home/cltbld', 03:47:12 INFO - 'LANG': 'en_US.UTF-8', 03:47:12 INFO - 'LANGUAGE': 'en_US:en', 03:47:12 INFO - 'LOGNAME': 'cltbld', 03:47:12 INFO - 'MAIL': '/var/mail/cltbld', 03:47:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:47:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:12 INFO - 'MOZ_NO_REMOTE': '1', 03:47:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:47:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:12 INFO - 'NO_EM_RESTART': '1', 03:47:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:12 INFO - 'PWD': '/builds/slave/test', 03:47:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:47:12 INFO - 'SHELL': '/bin/bash', 03:47:12 INFO - 'SHLVL': '1', 03:47:12 INFO - 'TERM': 'linux', 03:47:12 INFO - 'TMOUT': '86400', 03:47:12 INFO - 'USER': 'cltbld', 03:47:12 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845', 03:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:12 INFO - '_': '/tools/buildbot/bin/python'} 03:47:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:47:13 INFO - mozversion application_buildid: 20160808020440 03:47:13 INFO - mozversion application_changeset: 46dede080ba1b6bcaaf5af7b00fc5e356c66faac 03:47:13 INFO - mozversion application_display_name: Nightly 03:47:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:47:13 INFO - mozversion application_name: Firefox 03:47:13 INFO - mozversion application_remotingname: firefox 03:47:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:47:13 INFO - mozversion application_vendor: Mozilla 03:47:13 INFO - mozversion application_version: 51.0a1 03:47:13 INFO - mozversion platform_buildid: 20160808020440 03:47:13 INFO - mozversion platform_changeset: 46dede080ba1b6bcaaf5af7b00fc5e356c66faac 03:47:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:47:13 INFO - mozversion platform_version: 51.0a1 03:47:13 INFO - using testdate: 1470653233 03:47:13 INFO - actual date: 1470653233 03:47:13 INFO - starting webserver on 'localhost:38496' 03:47:13 INFO - SUITE-START | Running 2 tests 03:47:13 INFO - TEST-START | dromaeo_css 03:47:13 INFO - operating with platform_type : linux_ 03:47:13 INFO - Initialising browser for dromaeo_css test... 03:47:13 INFO - TEST-INFO | started process 3188 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNLh3iO/profile http://localhost:38496/getInfo.html) 03:47:17 INFO - PROCESS | 3188 | __metrics Screen width/height:1600/1200 03:47:17 INFO - PROCESS | 3188 | colorDepth:24 03:47:17 INFO - PROCESS | 3188 | Browser inner width/height: 1024/697 03:47:17 INFO - PROCESS | 3188 | __metrics 03:47:18 INFO - PROCESS | 3188 | 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" 03:47:18 INFO - PROCESS | 3188 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:47:19 INFO - TEST-INFO | 3188: exit 0 03:47:19 INFO - Browser initialized. 03:47:19 INFO - Running cycle 1/1 for dromaeo_css test... 03:47:19 INFO - TEST-INFO | started process 3268 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNLh3iO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:47:31 INFO - PROCESS | 3268 | RSS: Main: 158081024 03:47:31 INFO - PROCESS | 3268 | 03:48:22 INFO - PROCESS | 3268 | 1470653302015 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] 03:50:35 INFO - PROCESS | 3268 | Cycle 1(1): loaded http://localhost:38496/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38496/tests/dromaeo/cssquery-ext.html) 03:50:36 INFO - PROCESS | 3268 | RSS: Main: 222625792 03:50:36 INFO - PROCESS | 3268 | 03:53:39 INFO - PROCESS | 3268 | Cycle 1(1): loaded http://localhost:38496/tests/dromaeo/cssquery-ext.html (next: http://localhost:38496/tests/dromaeo/cssquery-jquery.html) 03:53:39 INFO - PROCESS | 3268 | RSS: Main: 250925056 03:53:39 INFO - PROCESS | 3268 | 03:56:41 INFO - PROCESS | 3268 | Cycle 1(1): loaded http://localhost:38496/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38496/tests/dromaeo/cssquery-mootools.html) 03:56:42 INFO - PROCESS | 3268 | RSS: Main: 226816000 03:56:42 INFO - PROCESS | 3268 | 03:59:44 INFO - PROCESS | 3268 | Cycle 1(1): loaded http://localhost:38496/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38496/tests/dromaeo/cssquery-prototype.html) 03:59:45 INFO - PROCESS | 3268 | RSS: Main: 185593856 03:59:45 INFO - PROCESS | 3268 | 04:02:48 INFO - PROCESS | 3268 | Cycle 1(1): loaded http://localhost:38496/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38496/tests/dromaeo/cssquery-yui.html) 04:02:48 INFO - PROCESS | 3268 | RSS: Main: 185528320 04:02:48 INFO - PROCESS | 3268 | 04:05:51 INFO - PROCESS | 3268 | Cycle 1(1): loaded http://localhost:38496/tests/dromaeo/cssquery-yui.html (next: http://localhost:38496/tests/dromaeo/cssquery-dojo.html) 04:05:52 INFO - PROCESS | 3268 | RSS: Main: 268632064 04:05:52 INFO - PROCESS | 3268 | 04:05:52 INFO - PROCESS | 3268 | __start_tp_report 04:05:52 INFO - PROCESS | 3268 | _x_x_mozilla_page_load 04:05:52 INFO - PROCESS | 3268 | _x_x_mozilla_page_load_details 04:05:52 INFO - PROCESS | 3268 | |i|pagename|runs| 04:05:52 INFO - PROCESS | 3268 | |0;dojo.html;2640.8811603477843;2648.2849630599726;2678.142994241842;2692.111603170954;2696.7572918437336;4592.150452166343;4679.625629949596;4748.311494833251;4778.7610619469015;4797.0645724083815;4715.363425937498;4720.716756994574;4730.0776348612035;4794.089123066615;4826.058918510892;4368.5194628590825;4440.444944381944;4440.711353762012;4443.755593442359;4455.554444555551;4421.447319085114;4456.376107344974;4485.5962963333295;4527.569880861313;4565.497795242521;4530.433695788027;4539.6368290536675;4550.954490455103;4567.520410356915;4581.748003859786;4239.236937351276;4289.678274129453;4354.107407981388;4360.040791025969;4438.068005718803;4311.439512863339;4315.805788739514;4323.978380108079;4378.759168245745;4381.627561657263;4730;4770.928436073427;4774.236122220428;4793.688410253358;4822.855314340575;5200;5201.141811601081;5205.869853253661;5209.218617207412;5213.061648903196;4839.27410888366;5118.283440318359;5196.792128314863;5236.240745091978;5310.70791106489;4835.081334546495;4886.193778026657;4923.359963204796;4931.5315045070665;4936.901261974812;5409.215663728737;5420.891582168335;5423.484768946943;5423.810166644149;5426.728663566806;4771.475137734847;4999.500049994971;5076.44159142494;5079.593632509391;5147.3051138096625;5177.145770947826;5185.274061631375;5186.196139598368;5191.32512773337;5241.187615919539;5109.412417571953;5115.948840511547;5122.795088196505;5137.897242055138;5163.741812909415;4841.298011788271;4902.338184345139;4980.526849949249;5032.6225533084435;5100.5409513143995;4339.305711086211;4341.413909122291;4381.233284175257;4383.408239887638;4386.758728269912;3801.676857467091;3808.1050953026015;3810.733248672622;3845.9230815384094;3860.2665493556133;4213.304804707251;4385.429894113809;4399.5380485049245;4399.934000989988;4440.111977604492;5209.348831396075;5217.973910130425;5241.816536421284;5278.683279003272;5292.126799078109;4452.243118669834;4456.420665313489;4460.665450091256;4467.7319360838455;4508.436445444319;4389.934150987738;4542.273236282179;4614.976925115353;4711.293306004059;4750.714957102585;4804.495527969513;4821.397325334333;4823.1800593899825;4852.0295940811275;4871.318015477765;5107.668001579886;5132.538071573576;5136.30659860914;5136.614753893398;5183.403908550414;4573.268277075652;4637.188492013952;4644.442666879996;4821.734804585782;4879.292502587034;4888.9755551222015;4891.682040667345;4899.11815873132;5044;5111.718855462986;5200.947990520046;5208.8437346879655;5238.97380513095;5257.106291930458;5258.86852828667;5021.4225364083595;5029.622778291569;5030.270610761492;5033.446320904624;5071.163258062378;4697.201475749062;5053.292539044463;5073.441921388718;5074.11203039474;5075.390953085505;4924.4090709115135;4982.302477653204;4984.775685094107;5049.697018178921;5050.621203409833;4769.260764581495;4840.007798401249;4842.322074909445;5097.668651537638;5131;4854.150523658275;4886.706797592155;4889.706617602955;4893.828715994923;4946.1838796599595 04:05:52 INFO - PROCESS | 3268 | |1;ext.html;559.5523581135094;564.9039663257247;566.0377358490567;570.4267211452491;573.7332140554641;28389.574156387644;38887.80556097219;40107.598924010825;40204;40252.39621405681;40061.39907901377;40404.393934091015;40440.19119617613;40488.595114048854;40556.59443405565;7668.194839541851;7801.258880406353;7801.687932482722;7801.843963120734;7810.531368117902;7766.766996990099;7845.568493732842;7845.882311765328;7847.254510821492;7865.921340786605;7865.646045927947;7933.206679332049;7943.72196973106;7944.682212711485;7947.284744373005;7855.293023627873;7892.447528672995;7895.60521973899;7903.960480197619;7905;7748.845023099563;7811.687532498693;7813.413993950419;7813.687452501893;7831.099423566306;37713.622863771285;37787.244255115016;37858.81070594657;37892.242155157015;38192.427113593316;3129.514925186577;3142.230153612357;3175.491921292582;3207.6631953644765;3535.4520049392386;29155.271118222;29726.554101688493;29772.70227297721;29890.40219195604;29924.551131733042;3451.188970591909;3589.5513060867393;3645.7994810285422;3646.4165733482782;3774.50931378919;255229;257661;258440;258527;258918;28730.856345718137;54465;54659;54705.45294547004;54814;34569.135771605404;34585.30829383398;34641.48037779435;34773;34797.1300717479;12317.568885088978;12352.876471235173;12363.381830908418;12390.504379824886;12402.937985310016;9922.305438619227;9940.956199599083;9951.751206219902;9987.101160895554;10008.949955250177;8000.199980001953;8036.839263214703;8039;8040.477368970998;8114;3103.239706271933;3115.12776422602;3131.937361252808;3151.921201969969;3207.6792320767736;895.3821862914568;908.3096846396786;1018.4347687033768;1020.739711373595;1067;28069;28490.572641410396;28826.567601485574;29021.85489072541;29116.417671646872;897.5250969088507;971.8299297622888;1017.9847302290472;1041.6302910877662;1082.0910435234284;14998;15228.695426091415;15237.923810380877;15374.890499323123;15458.304376303093;408037;410343;411161;412034;412602;48907;49336.75331623319;49362.259566106535;49464.25803612949;49465.25802112971;1135.9659210223706;1181.3325471108797;1183.1540448579308;1209.4799236328463;1217.3061355027726;26780.59829102604;26810.329741756614;28054.85972570124;28077;28683;42747.358789618804;43268.567314327716;43329.13341733211;43342.78328608463;43355.014173370466;316346;319191;319573;320631;321563;25639.10263140781;25756.484870302866;25777;25876.8706156468;26038.86980565085;38008.23983520369;41881.37177942273;42236.155276894904;43176.136477270906;47704.76147619379;35714.28571428609;35741.46387804133;35750;36704.26591468209;36781.816090919376;36109;36618.45072323971;37458.438123428714;38235.42646860355;38554.80722596369;35585.82207088948;36405;36643.63356366402;37017.25965480729;37036.25927481381;31601.8419907899;33510.497342540366;33804.32391352209;33828.66171338255;33913.66086339204;25624.615630765926;26033.47799132052;26136.60795088037;26176.60735089013;26534.336641584116 04:05:52 INFO - PROCESS | 3268 | |2;jquery.html;338.3402365387495;359.4769610217134;361.04323542612076;365.69647192829956;384.05713972198254;12977.675558111052;16322.918385408086;16955;17251.30994760208;18154.636907261847;16934;17384.652306953885;17567.912160439213;17671.823281767178;17868.85573731154;5004.599632029447;5248.239005344223;5495.230667706524;5527.198556209347;5594.720263986805;3454.067401801512;5151.922721159186;5537.058700021006;5564.304461942257;5575.163725441196;5443.129099344106;5477.863053423656;5502.9174562381595;5509.972450137744;5514.0901751211;5316.149416093445;5396.082665946798;5442.210879422501;5505.889882202354;5510.008198524244;5275.393329767087;5281.577473802086;5285.947140528584;5285.995660824431;5287.259783630295;12029.338386388745;12102.455389507493;12198.878011219864;12297.754044919051;12395.504179832797;1859.414284500378;1866.4773863318292;1908.9522761930923;1919.2035305348263;1982.4944639116932;9074.45553266806;9093.181613654802;9231.6307347706;9454.716358509255;9731.270154738422;1685.2921772855307;1697.73685078813;1716.6995775739197;1717.8711596630303;1764.7970483394317;68340;70192.29807701909;72372.27627723708;72572;73058.63470682666;9922.206223502102;10207.336523125972;10222.897771022195;10340.069393754598;10456.738581535523;14032.228227447384;14034.719305613831;14057.507987220399;14063.718725625431;14095.436182552789;6905.930940690529;7092.716291348392;7171.247019063027;7269.636518174176;7294.781156565312;6706.497012723968;6711.4495295806055;6792.7962161134255;6818.4886133540185;6913.168010477228;4348.891277718019;4385.166818304512;4458.35353873693;4510.300903359985;4552.476465206478;1846.9076546172637;1851.3797877711118;1904.6762050451457;1918.673825449677;1956.3055115434101;823.9382046346548;829.9958500207581;874.4534665833854;911.731039343382;918.6711685876271;16237.51287461378;17129.14354282281;17527.561810954827;17698.823011769717;17918.91040544789;850.1371108325055;852.9104444033411;860.7934095817084;870.6604424274537;878.297362110322;9342.719718408458;9954.402735835873;9978.351407158512;10035.09684128432;10231.976802319708;304973;307052;307453;402665;406701;75752;76294.61852690701;79168;85061;86684.56657716671;838.387976776944;881.8853549038712;885.022050634053;885.3183049052194;887.3522328699956;16220.918895405448;16352.836471635608;16866.831331687015;16901.746473802657;17115.828841711424;36043.45934811032;37280.254394912496;39707.2058558833;40399.7980010098;41299.793501033506;50771.23843142282;51866.74066629643;52572.737136315605;52585.7370713144;53482.19776703275;7264.273572642694;7464.066991626047;7481.177070522347;7611.3530349920875;7639.885401718868;10882.564697412015;11335.489902954221;11649.242799218024;11670.299782013106;12046.578369757017;9892.208623310262;10230.335028223142;10320.587176512856;10345.120664743581;10347.327423717434;10294.897051029393;10542.15662746963;10546.947265263625;10663.573457061631;10748.785024299314;4910.9017819642695;9652.117837021713;10324.845127323246;10333;10726.463676816284;7088.539244949062;7334.669939852826;7559.924400755922;7627.923720762721;7644.579548124684;10107.949460252652;10291.84562231552;10405.219608529542;10472.947635261775;10570.365778053341 04:05:52 INFO - PROCESS | 3268 | |3;mootools.html;1257.2519350986172;1370.444969787236;1400.2298735695365;1475.1192229906867;1706.2492503298556;6019;7243.456740744446;7594.658240379183;7600.353969912557;7761.728339508119;7598.658060387282;7660.310572048515;7662.272084151997;7669.194734552875;7675.462717609769;2104.7474303083613;2127.5532138250987;2128.648772952461;2132.168454302823;2132.4029271803843;2069.5550456651818;2119.5337025854365;2137.0810551462864;2140.283005193262;2143.0142134618095;2079.085202510898;2111.820495257905;2114.38682781993;2119.607872543577;2151.9139234430604;2055.044404351976;2061.165228082614;2062.257587268582;2063.4325560470916;2063.587282543497;1977.0806574942576;2033.044469099521;2033.3899830051073;2040.653088974863;2042.4077017664858;7404.22255663153;7428.480006399554;7523.09722833258;7540.509866858692;7577.052868391451;4271.402003719481;4460.8884777880485;4483.282674772054;4483.865484035484;4486.865394038184;2673.8128331016837;2777.0835624244155;2833.4191490744347;2839.2901774556362;2851.4012057467958;880.1110878013188;897.9012308646044;905.483874191711;906.9909300907038;925.1396201532572;10111.7472063199;10208.540615672313;10236.590536378535;10237.23220758446;10242.539085741086;3674.65090816372;3838.481804956351;3952.7430717003303;3991.720579559403;4007.6192761687594;8221.630026648816;8221.671133154607;8227.876581851277;8230.588470576447;8237.135100814448;4436.112777444524;4450.35469856869;4452.5992660660695;4455.5989960903025;4460.420145381145;3325.9501107483406;3912.295786758354;4032.1330913853662;4127.277726397869;4142.79286035697;3198.760092993035;3249.8050116993054;3318.6515415881468;3321.451960426551;3337.8998630041137;973.2116985241977;977.1596427072711;982.1602529837029;993.0615568287899;993.3245393132595;841.4824882697097;849.2144766091465;867.2238346679686;869.9434536755091;874.9151052694613;5020.891225685221;5127.256547800548;5155.74221288934;5198.2722418861385;5207.869803254949;380.9466674665549;381.0644866851872;387.82935508376227;390.78897395406733;391.9784411857375;3555.5022296878456;3561.6082230955094;3637.563492380931;3694.2980833641523;3792.1088544192094;9087.591058402388;9296.581653825595;9402.764930876783;9403.905960940303;9439.292053095907;9307.674231401868;9321.95339023314;9347.766305842408;9348.018458061806;9355.532223388804;6774.932250677529;7214.891776623354;7276.818079548054;7287.744928927462;7289.343959043712;5176.886969301619;5446.809361672323;5474.972625136849;5509.917351239655;5603.80386686464;8272.710455134042;8470;8539.231469167804;8663.610137543952;8702.434341767765;8428.789280268042;8585.914140858511;8688.956555217184;8819.559022049;8827.911720882708;5499.395066542757;6504.4796416285635;6647.501437392311;6648.16897887764;6651.33486651331;5991.281046274475;7097.148342198762;7132.251113633201;7308.30571095745;7308.963455182903;6504.056911747675;6533.052707357501;6569.737210511526;6600.174978127734;6623.834404139935;6466.224053113657;6485;6495.707693153725;6504.577202482013;6517.8696426072165;6063.242094738158;6179.752809887555;6197.597156184834;6199.977003794504;6215.65813880241;4548.476925153517;4620.376249206314;4630.536946305342;4698.271767875848;4711.552402521755;4370.519242883217;4465;4511.729296242236;4513.571210734975;4524.366588677522 04:05:52 INFO - PROCESS | 3268 | |4;prototype.html;289.08072329990625;294.11764705882354;295.49912897638484;299.03262944374944;300.63022482346713;4814.76113607173;4848.400027990763;4870.391201099863;4887.802488390341;4905.215165573509;4784.40194975628;4789.80840766369;4803.975980120094;4827.46897841238;4836.863337115775;3560.1989552350774;3665.541807274091;3698.6671199592033;3784.735068545203;3811.771293722372;3784.110733977513;3784.7161462890394;3794.1273507093383;3810.6951443884564;3836.4437156612275;3780.7164462665273;3784.091817963683;3791.488149099878;3793.6775374093236;3802.16352402471;3566.286742651467;3645.4714066460215;3752.9249415011545;3794.1842503861526;3801.581825999138;3311.61916379617;3312.8239474986276;3317.286783341569;3320.153360892981;3369.7809642373413;4716.599089077433;4718.764061796896;4721.291806229059;4762.690425122356;4769.356136921506;4208.494980602347;4293.656507479394;4298.806553705091;4351.369051487548;4362.192994296065;4996.625253106032;5014.498550144993;5018.548330650259;5022.447530771612;5025.748712564357;3631.564212294515;3631.909202269938;3633.4913112164318;3659.2132691471197;3674.3202507535925;5185.896282074337;5301.6818990860675;5313.681179129226;5344.919826202571;5355.758990845382;3701;3717.5724791648768;3720.6093360197333;3736.5142531470733;3738.2056612825454;3798.7150963677836;3798.746413683533;3812.2375524895133;3812.275667623143;3820.7325487216185;4309.267424537836;4319.136172765397;4320.740755554677;4326.913461730748;4332.501762297313;4861.496329390367;5012.471196285095;5015.724135172601;5058.747062646853;5105.7024339047575;1292.9676758080934;1311.7114234868313;1313.7241179352252;1315.2371624457792;1316.6379245707508;816.5672193737329;845.9763685939959;853.5561508015921;862.0560486267527;868.2619773192736;4223.66210703143;4334.1548398062705;4338;4351.086271882877;4355.847545335898;5011.223260394645;5080.263361812516;5166.354205724285;5178.223266510054;5199.688018718889;4415.448068991376;4421.668374871898;4425.459632294152;4430.911381772411;4434.312681534368;2653.562162243247;2710.9728902711113;2738.7398197171237;2741.8080734348405;2758.655168103987;4874.926876096862;4879.39007624047;4884.389451318585;4894.185843140209;4907.68100073494;5145.202493613496;5289.656172348785;5301.761420736076;5301.920471192935;5303.329451222852;4833.32333473314;4881.731504767201;4904.141775189328;4904.229110552526;4930.556249937523;5151.587872970078;5169.172932330809;5176.482351764794;5191.157139215524;5192.844969337833;4846.933674591584;5040.294358789845;5040.672356296829;5100.617453690914;5121.974390128025;4892.119418504703;4904.730239836843;4934.432540257916;4940.5800506955875;4943.678660887031;3628.2380700052227;3633.6003039666143;3662.926741465209;3674.65090816372;3679.632036796299;5068.728522336729;5245.160774276097;5271.947280527299;5289.20661900718;5302.973485132549;5097.954919241621;5105.948940510547;5110;5112.36095488064;5119.6416250862085;5056.469070747518;5092.668976516515;5104.132297509358;5106.080905437057;5107.87230319245;4755.714657120584;4996.525330093636;4997.575206107522;5031.823886163967;5038.647294689336;4881.731504767272;5008.449070602303;5079.085764562266;5093.516115968977;5111.182210846247;4890.413150421972;4913.1893237615395;4914.877128071684;4917.508249175054;4926.605871530341 04:05:52 INFO - PROCESS | 3268 | |5;yui.html;594.3610618585022;620.4756980351602;633.5501793726456;715.5992644119291;746.2835677749358;12990.675233119176;14241.074330168532;14243.92878035611;14244.50144244953;14253.073550219242;12290.938545307283;13765.58703238902;13779.793303100436;13786.103903246307;13810.964177686663;629.3549112160027;755.5051441305953;775.2634996753079;801.5551368990208;806.379088102161;786.4141214794986;794.9085855126648;795.2921899509412;795.9681612735484;796.2952786783709;832.2301870769544;833.4832403909585;834.2116699718769;834.5535138700797;835;640.7981485831995;676.036647776916;829.340674164038;830.3066939105854;831.5301854452215;499.82506122857075;500.1996805111792;568.7270110347057;602.638416949831;605.3643674142177;12657.810132848015;12690;12703.809442858364;12723.618291451272;12735.299558524277;11087.168462365275;11603.361815100166;11973.341466219354;12333.198342107735;13043.152195107288;9778.462184579845;9965.252606054502;11462.94268528652;11552.884471155265;11688.590899318568;3265.1837040739815;3314.96685033149;3362.1090411041096;3445.13871532117;3448;62019.37980620181;62199.6890015547;62467.37532624661;62964.68517657428;63949.04076438857;9517.23862091045;9797;9821.312508124363;9999;10047.949760251153;19175.232990680215;19330.613387732166;19578.510537236398;19637.50906227356;19849.60300793976;6526.64103474304;6592.8351791205605;6718.49611279156;6782.9321706783285;6942.861142777117;3657.3233951719017;3672.2839046386234;3672.540932383452;3678.9264214715554;3681.6318368163506;2800.4399120176045;2883.4377296427415;2889.7399234069035;2894.13176047185;2898.217481280085;476.3259987118189;485.9149648811444;488.6213184781823;491.4962163782152;497.9402471703419;476.4877756411871;492.29601669612083;504.215944206762;504.37205678929234;507.76642744338017;8019.438639295194;8244.958775206085;8307.470764952679;8600.526971016528;8639.481631102153;584.5498965796313;594.1058706646469;595.684287327717;601.7953895675404;618.4063299232787;3899.200663863901;3967.385055316373;4024.577419370924;4034.8184331705143;4116.279651061052;59149.112763308585;59479.40520594738;59500.10749838756;61429.69285153546;77777;70290.64854675796;79775;83275;83370.16629833623;85187.14812851915;70370;70924.29075709281;71943;72925.3428390022;73001.2699873005;8337.624806883583;8371.288440482627;8501.14988501145;8639.438436501607;8667.133286671282;45247.773761130986;45717;46130.538694612624;46223.53776462327;46746;53348.1997770026;55037.72481137569;57436.42563574311;58656.70671646785;59549;10738.248322617343;11367.602133925273;11459.770804584028;11666.300021998708;11667.59163429276;12375.75248495043;12432.316222607844;12456.171628929755;12856.935715321364;14053.156810591398;11357.886421136014;11359.318440893572;11433.656990290305;11684.397338911793;11737.589184378847;9257.861132083159;11075.944620277169;11547;12267;12866.099373043797;11608.6517404478;11733.965332592888;12135.150539462153;12275.877241227474;12450.319206906952;9255.490947997925;9647.008542760826;9854.655087071918;10006.349587276804;10374.42940638242;9499;9663.27525435581;10195.235357348376;10488.213383996383;10558.155347572023 04:05:52 INFO - PROCESS | 3268 | __end_tp_report 04:05:52 INFO - PROCESS | 3268 | __start_cc_report 04:05:52 INFO - PROCESS | 3268 | _x_x_mozilla_cycle_collect,865 04:05:52 INFO - PROCESS | 3268 | __end_cc_report 04:05:52 INFO - PROCESS | 3268 | __startTimestamp1470654352235__endTimestamp 04:05:52 INFO - PROCESS | 3268 | 04:05:52 INFO - PROCESS | 3268 | ------- Summary: start ------- 04:05:52 INFO - PROCESS | 3268 | Number of tests: 6 04:05:52 INFO - PROCESS | 3268 | 04:05:52 INFO - PROCESS | 3268 | [#0] dojo.html Cycles:165 Average:4748.05 Median:4840.01 stddev:510.01 (10.5%) stddev-sans-first:484.04 04:05:52 INFO - PROCESS | 3268 | Values: 2640.9 2648.3 2678.1 2692.1 2696.8 4592.2 4679.6 4748.3 4778.8 4797.1 4715.4 4720.7 4730.1 4794.1 4826.1 4368.5 4440.4 4440.7 4443.8 4455.6 4421.4 4456.4 4485.6 4527.6 4565.5 4530.4 4539.6 4551.0 4567.5 4581.7 4239.2 4289.7 4354.1 4360.0 4438.1 4311.4 4315.8 4324.0 4378.8 4381.6 4730.0 4770.9 4774.2 4793.7 4822.9 5200.0 5201.1 5205.9 5209.2 5213.1 4839.3 5118.3 5196.8 5236.2 5310.7 4835.1 4886.2 4923.4 4931.5 4936.9 5409.2 5420.9 5423.5 5423.8 5426.7 4771.5 4999.5 5076.4 5079.6 5147.3 5177.1 5185.3 5186.2 5191.3 5241.2 5109.4 5115.9 5122.8 5137.9 5163.7 4841.3 4902.3 4980.5 5032.6 5100.5 4339.3 4341.4 4381.2 4383.4 4386.8 3801.7 3808.1 3810.7 3845.9 3860.3 4213.3 4385.4 4399.5 4399.9 4440.1 5209.3 5218.0 5241.8 5278.7 5292.1 4452.2 4456.4 4460.7 4467.7 4508.4 4389.9 4542.3 4615.0 4711.3 4750.7 4804.5 4821.4 4823.2 4852.0 4871.3 5107.7 5132.5 5136.3 5136.6 5183.4 4573.3 4637.2 4644.4 4821.7 4879.3 4889.0 4891.7 4899.1 5044.0 5111.7 5200.9 5208.8 5239.0 5257.1 5258.9 5021.4 5029.6 5030.3 5033.4 5071.2 4697.2 5053.3 5073.4 5074.1 5075.4 4924.4 4982.3 4984.8 5049.7 5050.6 4769.3 4840.0 4842.3 5097.7 5131.0 4854.2 4886.7 4889.7 4893.8 4946.2 04:05:52 INFO - PROCESS | 3268 | 04:05:52 INFO - PROCESS | 3268 | [#1] ext.html Cycles:180 Average:47310.25 Median:36673.95 stddev:88588.68 (241.6%) stddev-sans-first:88767.65 04:05:52 INFO - PROCESS | 3268 | Values: 559.6 564.9 566.0 570.4 573.7 28389.6 38887.8 40107.6 40204.0 40252.4 40061.4 40404.4 40440.2 40488.6 40556.6 7668.2 7801.3 7801.7 7801.8 7810.5 7766.8 7845.6 7845.9 7847.3 7865.9 7865.6 7933.2 7943.7 7944.7 7947.3 7855.3 7892.4 7895.6 7904.0 7905.0 7748.8 7811.7 7813.4 7813.7 7831.1 37713.6 37787.2 37858.8 37892.2 38192.4 3129.5 3142.2 3175.5 3207.7 3535.5 29155.3 29726.6 29772.7 29890.4 29924.6 3451.2 3589.6 3645.8 3646.4 3774.5 255229.0 257661.0 258440.0 258527.0 258918.0 28730.9 54465.0 54659.0 54705.5 54814.0 34569.1 34585.3 34641.5 34773.0 34797.1 12317.6 12352.9 12363.4 12390.5 12402.9 9922.3 9941.0 9951.8 9987.1 10008.9 8000.2 8036.8 8039.0 8040.5 8114.0 3103.2 3115.1 3131.9 3151.9 3207.7 895.4 908.3 1018.4 1020.7 1067.0 28069.0 28490.6 28826.6 29021.9 29116.4 897.5 971.8 1018.0 1041.6 1082.1 14998.0 15228.7 15237.9 15374.9 15458.3 408037.0 410343.0 411161.0 412034.0 412602.0 48907.0 49336.8 49362.3 49464.3 49465.3 1136.0 1181.3 1183.2 1209.5 1217.3 26780.6 26810.3 28054.9 28077.0 28683.0 42747.4 43268.6 43329.1 43342.8 43355.0 316346.0 319191.0 319573.0 320631.0 321563.0 25639.1 25756.5 25777.0 25876.9 26038.9 38008.2 41881.4 42236.2 43176.1 47704.8 35714.3 35741.5 35750.0 36704.3 36781.8 36109.0 36618.5 37458.4 38235.4 38554.8 35585.8 36405.0 36643.6 37017.3 37036.3 31601.8 33510.5 33804.3 33828.7 33913.7 25624.6 26033.5 26136.6 26176.6 26534.3 04:05:52 INFO - PROCESS | 3268 | 04:05:52 INFO - PROCESS | 3268 | [#2] jquery.html Cycles:180 Average:23131.08 Median:4421.76 stddev:58181.52 (1315.8%) stddev-sans-first:58319.57 04:05:52 INFO - PROCESS | 3268 | Values: 338.3 359.5 361.0 365.7 384.1 12977.7 16322.9 16955.0 17251.3 18154.6 16934.0 17384.7 17567.9 17671.8 17868.9 5004.6 5248.2 5495.2 5527.2 5594.7 3454.1 5151.9 5537.1 5564.3 5575.2 5443.1 5477.9 5502.9 5510.0 5514.1 5316.1 5396.1 5442.2 5505.9 5510.0 5275.4 5281.6 5285.9 5286.0 5287.3 12029.3 12102.5 12198.9 12297.8 12395.5 1859.4 1866.5 1909.0 1919.2 1982.5 9074.5 9093.2 9231.6 9454.7 9731.3 1685.3 1697.7 1716.7 1717.9 1764.8 68340.0 70192.3 72372.3 72572.0 73058.6 9922.2 10207.3 10222.9 10340.1 10456.7 14032.2 14034.7 14057.5 14063.7 14095.4 6905.9 7092.7 7171.2 7269.6 7294.8 6706.5 6711.4 6792.8 6818.5 6913.2 4348.9 4385.2 4458.4 4510.3 4552.5 1846.9 1851.4 1904.7 1918.7 1956.3 823.9 830.0 874.5 911.7 918.7 16237.5 17129.1 17527.6 17698.8 17918.9 850.1 852.9 860.8 870.7 878.3 9342.7 9954.4 9978.4 10035.1 10232.0 304973.0 307052.0 307453.0 402665.0 406701.0 75752.0 76294.6 79168.0 85061.0 86684.6 838.4 881.9 885.0 885.3 887.4 16220.9 16352.8 16866.8 16901.7 17115.8 36043.5 37280.3 39707.2 40399.8 41299.8 50771.2 51866.7 52572.7 52585.7 53482.2 7264.3 7464.1 7481.2 7611.4 7639.9 10882.6 11335.5 11649.2 11670.3 12046.6 9892.2 10230.3 10320.6 10345.1 10347.3 10294.9 10542.2 10546.9 10663.6 10748.8 4910.9 9652.1 10324.8 10333.0 10726.5 7088.5 7334.7 7559.9 7627.9 7644.6 10107.9 10291.8 10405.2 10472.9 10570.4 04:05:52 INFO - PROCESS | 3268 | 04:05:52 INFO - PROCESS | 3268 | [#3] mootools.html Cycles:180 Average:4933.13 Median:5327.34 stddev:2778.94 (52.2%) stddev-sans-first:2773.00 04:05:52 INFO - PROCESS | 3268 | Values: 1257.3 1370.4 1400.2 1475.1 1706.2 6019.0 7243.5 7594.7 7600.4 7761.7 7598.7 7660.3 7662.3 7669.2 7675.5 2104.7 2127.6 2128.6 2132.2 2132.4 2069.6 2119.5 2137.1 2140.3 2143.0 2079.1 2111.8 2114.4 2119.6 2151.9 2055.0 2061.2 2062.3 2063.4 2063.6 1977.1 2033.0 2033.4 2040.7 2042.4 7404.2 7428.5 7523.1 7540.5 7577.1 4271.4 4460.9 4483.3 4483.9 4486.9 2673.8 2777.1 2833.4 2839.3 2851.4 880.1 897.9 905.5 907.0 925.1 10111.7 10208.5 10236.6 10237.2 10242.5 3674.7 3838.5 3952.7 3991.7 4007.6 8221.6 8221.7 8227.9 8230.6 8237.1 4436.1 4450.4 4452.6 4455.6 4460.4 3326.0 3912.3 4032.1 4127.3 4142.8 3198.8 3249.8 3318.7 3321.5 3337.9 973.2 977.2 982.2 993.1 993.3 841.5 849.2 867.2 869.9 874.9 5020.9 5127.3 5155.7 5198.3 5207.9 380.9 381.1 387.8 390.8 392.0 3555.5 3561.6 3637.6 3694.3 3792.1 9087.6 9296.6 9402.8 9403.9 9439.3 9307.7 9322.0 9347.8 9348.0 9355.5 6774.9 7214.9 7276.8 7287.7 7289.3 5176.9 5446.8 5475.0 5509.9 5603.8 8272.7 8470.0 8539.2 8663.6 8702.4 8428.8 8585.9 8689.0 8819.6 8827.9 5499.4 6504.5 6647.5 6648.2 6651.3 5991.3 7097.1 7132.3 7308.3 7309.0 6504.1 6533.1 6569.7 6600.2 6623.8 6466.2 6485.0 6495.7 6504.6 6517.9 6063.2 6179.8 6197.6 6200.0 6215.7 4548.5 4620.4 4630.5 4698.3 4711.6 4370.5 4465.0 4511.7 4513.6 4524.4 04:05:52 INFO - PROCESS | 3268 | 04:05:52 INFO - PROCESS | 3268 | [#4] prototype.html Cycles:180 Average:4197.41 Median:4830.40 stddev:1216.52 (25.2%) stddev-sans-first:1184.04 04:05:52 INFO - PROCESS | 3268 | Values: 289.1 294.1 295.5 299.0 300.6 4814.8 4848.4 4870.4 4887.8 4905.2 4784.4 4789.8 4804.0 4827.5 4836.9 3560.2 3665.5 3698.7 3784.7 3811.8 3784.1 3784.7 3794.1 3810.7 3836.4 3780.7 3784.1 3791.5 3793.7 3802.2 3566.3 3645.5 3752.9 3794.2 3801.6 3311.6 3312.8 3317.3 3320.2 3369.8 4716.6 4718.8 4721.3 4762.7 4769.4 4208.5 4293.7 4298.8 4351.4 4362.2 4996.6 5014.5 5018.5 5022.4 5025.7 3631.6 3631.9 3633.5 3659.2 3674.3 5185.9 5301.7 5313.7 5344.9 5355.8 3701.0 3717.6 3720.6 3736.5 3738.2 3798.7 3798.7 3812.2 3812.3 3820.7 4309.3 4319.1 4320.7 4326.9 4332.5 4861.5 5012.5 5015.7 5058.7 5105.7 1293.0 1311.7 1313.7 1315.2 1316.6 816.6 846.0 853.6 862.1 868.3 4223.7 4334.2 4338.0 4351.1 4355.8 5011.2 5080.3 5166.4 5178.2 5199.7 4415.4 4421.7 4425.5 4430.9 4434.3 2653.6 2711.0 2738.7 2741.8 2758.7 4874.9 4879.4 4884.4 4894.2 4907.7 5145.2 5289.7 5301.8 5301.9 5303.3 4833.3 4881.7 4904.1 4904.2 4930.6 5151.6 5169.2 5176.5 5191.2 5192.8 4846.9 5040.3 5040.7 5100.6 5122.0 4892.1 4904.7 4934.4 4940.6 4943.7 3628.2 3633.6 3662.9 3674.7 3679.6 5068.7 5245.2 5271.9 5289.2 5303.0 5098.0 5105.9 5110.0 5112.4 5119.6 5056.5 5092.7 5104.1 5106.1 5107.9 4755.7 4996.5 4997.6 5031.8 5038.6 4881.7 5008.4 5079.1 5093.5 5111.2 4890.4 4913.2 4914.9 4917.5 4926.6 04:05:52 INFO - PROCESS | 3268 | 04:05:52 INFO - PROCESS | 3268 | [#5] yui.html Cycles:180 Average:16560.42 Median:500.01 stddev:22150.93 (4430.1%) stddev-sans-first:22180.62 04:05:52 INFO - PROCESS | 3268 | Values: 594.4 620.5 633.6 715.6 746.3 12990.7 14241.1 14243.9 14244.5 14253.1 12290.9 13765.6 13779.8 13786.1 13811.0 629.4 755.5 775.3 801.6 806.4 786.4 794.9 795.3 796.0 796.3 832.2 833.5 834.2 834.6 835.0 640.8 676.0 829.3 830.3 831.5 499.8 500.2 568.7 602.6 605.4 12657.8 12690.0 12703.8 12723.6 12735.3 11087.2 11603.4 11973.3 12333.2 13043.2 9778.5 9965.3 11462.9 11552.9 11688.6 3265.2 3315.0 3362.1 3445.1 3448.0 62019.4 62199.7 62467.4 62964.7 63949.0 9517.2 9797.0 9821.3 9999.0 10047.9 19175.2 19330.6 19578.5 19637.5 19849.6 6526.6 6592.8 6718.5 6782.9 6942.9 3657.3 3672.3 3672.5 3678.9 3681.6 2800.4 2883.4 2889.7 2894.1 2898.2 476.3 485.9 488.6 491.5 497.9 476.5 492.3 504.2 504.4 507.8 8019.4 8245.0 8307.5 8600.5 8639.5 584.5 594.1 595.7 601.8 618.4 3899.2 3967.4 4024.6 4034.8 4116.3 59149.1 59479.4 59500.1 61429.7 77777.0 70290.6 79775.0 83275.0 83370.2 85187.1 70370.0 70924.3 71943.0 72925.3 73001.3 8337.6 8371.3 8501.1 8639.4 8667.1 45247.8 45717.0 46130.5 46223.5 46746.0 53348.2 55037.7 57436.4 58656.7 59549.0 10738.2 11367.6 11459.8 11666.3 11667.6 12375.8 12432.3 12456.2 12856.9 14053.2 11357.9 11359.3 11433.7 11684.4 11737.6 9257.9 11075.9 11547.0 12267.0 12866.1 11608.7 11734.0 12135.2 12275.9 12450.3 9255.5 9647.0 9854.7 10006.3 10374.4 9499.0 9663.3 10195.2 10488.2 10558.2 04:05:52 INFO - PROCESS | 3268 | -------- Summary: end -------- 04:05:52 INFO - PROCESS | 3268 | 04:05:53 INFO - TEST-INFO | 3268: exit 0 04:05:53 INFO - TEST-OK | dromaeo_css | took 1119990ms 04:05:53 INFO - TEST-START | kraken 04:05:53 INFO - operating with platform_type : linux_ 04:05:53 INFO - Initialising browser for kraken test... 04:05:53 INFO - TEST-INFO | started process 3460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8u4dIx/profile http://localhost:38496/getInfo.html) 04:05:57 INFO - PROCESS | 3460 | __metrics Screen width/height:1600/1200 04:05:57 INFO - PROCESS | 3460 | colorDepth:24 04:05:57 INFO - PROCESS | 3460 | Browser inner width/height: 1024/697 04:05:57 INFO - PROCESS | 3460 | __metrics 04:05:57 INFO - PROCESS | 3460 | 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" 04:05:57 INFO - PROCESS | 3460 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:05:58 INFO - TEST-INFO | 3460: exit 0 04:05:58 INFO - Browser initialized. 04:05:58 INFO - Running cycle 1/1 for kraken test... 04:05:58 INFO - TEST-INFO | started process 3541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8u4dIx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:10 INFO - PROCESS | 3541 | RSS: Main: 157691904 04:06:10 INFO - PROCESS | 3541 | 04:06:13 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:38496/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38496/tests/kraken/driver.html?testName=audio-beat-detection) 04:06:14 INFO - PROCESS | 3541 | RSS: Main: 214122496 04:06:14 INFO - PROCESS | 3541 | 04:06:17 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:38496/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38496/tests/kraken/driver.html?testName=audio-dft) 04:06:17 INFO - PROCESS | 3541 | RSS: Main: 192577536 04:06:17 INFO - PROCESS | 3541 | 04:06:20 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:38496/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38496/tests/kraken/driver.html?testName=audio-fft) 04:06:21 INFO - PROCESS | 3541 | RSS: Main: 271732736 04:06:21 INFO - PROCESS | 3541 | 04:06:23 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:38496/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38496/tests/kraken/driver.html?testName=audio-oscillator) 04:06:24 INFO - PROCESS | 3541 | RSS: Main: 181030912 04:06:24 INFO - PROCESS | 3541 | 04:06:26 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:38496/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38496/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:06:27 INFO - PROCESS | 3541 | RSS: Main: 185393152 04:06:27 INFO - PROCESS | 3541 | 04:06:30 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:38496/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38496/tests/kraken/driver.html?testName=imaging-darkroom) 04:06:31 INFO - PROCESS | 3541 | RSS: Main: 221904896 04:06:31 INFO - PROCESS | 3541 | 04:06:34 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:38496/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38496/tests/kraken/driver.html?testName=imaging-desaturate) 04:06:35 INFO - PROCESS | 3541 | RSS: Main: 221212672 04:06:35 INFO - PROCESS | 3541 | 04:06:38 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:38496/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38496/tests/kraken/driver.html?testName=json-parse-financial) 04:06:38 INFO - PROCESS | 3541 | RSS: Main: 220770304 04:06:38 INFO - PROCESS | 3541 | 04:06:40 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:38496/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38496/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:06:40 INFO - PROCESS | 3541 | RSS: Main: 185217024 04:06:40 INFO - PROCESS | 3541 | 04:06:42 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:38496/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38496/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:06:43 INFO - PROCESS | 3541 | RSS: Main: 190492672 04:06:43 INFO - PROCESS | 3541 | 04:06:45 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:38496/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38496/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:06:46 INFO - PROCESS | 3541 | RSS: Main: 195162112 04:06:46 INFO - PROCESS | 3541 | 04:06:49 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:38496/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:06:49 INFO - PROCESS | 3541 | RSS: Main: 190615552 04:06:49 INFO - PROCESS | 3541 | 04:06:52 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:38496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:06:53 INFO - PROCESS | 3541 | RSS: Main: 193187840 04:06:53 INFO - PROCESS | 3541 | 04:06:54 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:38496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38496/tests/kraken/driver.html?testName=ai-astar) 04:06:55 INFO - PROCESS | 3541 | RSS: Main: 244178944 04:06:55 INFO - PROCESS | 3541 | 04:06:55 INFO - PROCESS | 3541 | __start_tp_report 04:06:55 INFO - PROCESS | 3541 | _x_x_mozilla_page_load 04:06:55 INFO - PROCESS | 3541 | _x_x_mozilla_page_load_details 04:06:55 INFO - PROCESS | 3541 | |i|pagename|runs| 04:06:55 INFO - PROCESS | 3541 | |0;ai-astar;106;113;114;115;114;115;114;113;115;113 04:06:55 INFO - PROCESS | 3541 | |1;audio-beat-detection;149;121;123;169;125;123;148;126;195;126 04:06:55 INFO - PROCESS | 3541 | |2;audio-dft;163;161;161;163;162;160;162;162;162;160 04:06:55 INFO - PROCESS | 3541 | |3;audio-fft;74;75;75;111;76;76;75;74;109;76 04:06:55 INFO - PROCESS | 3541 | |4;audio-oscillator;85;84;138;85;85;85;127;85;85;125 04:06:55 INFO - PROCESS | 3541 | |5;imaging-gaussian-blur;118;117;117;117;117;116;117;116;117;117 04:06:55 INFO - PROCESS | 3541 | |6;imaging-darkroom;146;147;146;146;146;146;146;146;146;146 04:06:55 INFO - PROCESS | 3541 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;96;94 04:06:55 INFO - PROCESS | 3541 | |8;json-parse-financial;63;62;61;61;62;64;62;63;62;62 04:06:55 INFO - PROCESS | 3541 | |9;json-stringify-tinderbox;63;65;65;65;65;65;65;65;65;65 04:06:55 INFO - PROCESS | 3541 | |10;stanford-crypto-aes;86;80;88;84;79;79;81;79;78;83 04:06:55 INFO - PROCESS | 3541 | |11;stanford-crypto-ccm;131;137;145;131;132;128;143;145;145;134 04:06:55 INFO - PROCESS | 3541 | |12;stanford-crypto-pbkdf2;165;169;163;164;163;163;163;163;163;161 04:06:55 INFO - PROCESS | 3541 | |13;stanford-crypto-sha256-iterative;67;67;68;69;69;66;66;67;68;65 04:06:55 INFO - PROCESS | 3541 | __end_tp_report 04:06:55 INFO - PROCESS | 3541 | __start_cc_report 04:06:55 INFO - PROCESS | 3541 | _x_x_mozilla_cycle_collect,1954 04:06:55 INFO - PROCESS | 3541 | __end_cc_report 04:06:55 INFO - PROCESS | 3541 | __startTimestamp1470654415217__endTimestamp 04:06:55 INFO - PROCESS | 3541 | 04:06:55 INFO - PROCESS | 3541 | ------- Summary: start ------- 04:06:55 INFO - PROCESS | 3541 | Number of tests: 14 04:06:55 INFO - PROCESS | 3541 | 04:06:55 INFO - PROCESS | 3541 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.00 stddev:2.66 (2.3%) stddev-sans-first:0.87 04:06:55 INFO - PROCESS | 3541 | Values: 106.0 113.0 114.0 115.0 114.0 115.0 114.0 113.0 115.0 113.0 04:06:55 INFO - PROCESS | 3541 | 04:06:55 INFO - PROCESS | 3541 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:137.00 stddev:24.87 (18.1%) stddev-sans-first:26.18 04:06:55 INFO - PROCESS | 3541 | Values: 149.0 121.0 123.0 169.0 125.0 123.0 148.0 126.0 195.0 126.0 04:06:55 INFO - PROCESS | 3541 | 04:06:55 INFO - PROCESS | 3541 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.01 04:06:55 INFO - PROCESS | 3541 | Values: 163.0 161.0 161.0 163.0 162.0 160.0 162.0 162.0 162.0 160.0 04:06:55 INFO - PROCESS | 3541 | 04:06:55 INFO - PROCESS | 3541 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.00 stddev:14.73 (19.6%) stddev-sans-first:15.33 04:06:55 INFO - PROCESS | 3541 | Values: 74.0 75.0 75.0 111.0 76.0 76.0 75.0 74.0 109.0 76.0 04:06:55 INFO - PROCESS | 3541 | 04:06:55 INFO - PROCESS | 3541 | [#4] audio-oscillator Cycles:10 Average:98.40 Median:85.00 stddev:22.06 (25.9%) stddev-sans-first:22.86 04:06:55 INFO - PROCESS | 3541 | Values: 85.0 84.0 138.0 85.0 85.0 85.0 127.0 85.0 85.0 125.0 04:06:55 INFO - PROCESS | 3541 | 04:06:55 INFO - PROCESS | 3541 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 04:06:55 INFO - PROCESS | 3541 | Values: 118.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 04:06:55 INFO - PROCESS | 3541 | 04:06:55 INFO - PROCESS | 3541 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 04:06:55 INFO - PROCESS | 3541 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 04:06:55 INFO - PROCESS | 3541 | 04:06:55 INFO - PROCESS | 3541 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:06:55 INFO - PROCESS | 3541 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 96.0 94.0 04:06:55 INFO - PROCESS | 3541 | 04:06:55 INFO - PROCESS | 3541 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.00 stddev:0.92 (1.5%) stddev-sans-first:0.93 04:06:55 INFO - PROCESS | 3541 | Values: 63.0 62.0 61.0 61.0 62.0 64.0 62.0 63.0 62.0 62.0 04:06:55 INFO - PROCESS | 3541 | 04:06:55 INFO - PROCESS | 3541 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.00 04:06:55 INFO - PROCESS | 3541 | Values: 63.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 04:06:55 INFO - PROCESS | 3541 | 04:06:55 INFO - PROCESS | 3541 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:82.00 stddev:3.40 (4.1%) stddev-sans-first:3.23 04:06:55 INFO - PROCESS | 3541 | Values: 86.0 80.0 88.0 84.0 79.0 79.0 81.0 79.0 78.0 83.0 04:06:55 INFO - PROCESS | 3541 | 04:06:55 INFO - PROCESS | 3541 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:140.00 stddev:6.79 (4.8%) stddev-sans-first:6.83 04:06:55 INFO - PROCESS | 3541 | Values: 131.0 137.0 145.0 131.0 132.0 128.0 143.0 145.0 145.0 134.0 04:06:55 INFO - PROCESS | 3541 | 04:06:55 INFO - PROCESS | 3541 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.70 Median:163.00 stddev:2.11 (1.3%) stddev-sans-first:2.19 04:06:55 INFO - PROCESS | 3541 | Values: 165.0 169.0 163.0 164.0 163.0 163.0 163.0 163.0 163.0 161.0 04:06:55 INFO - PROCESS | 3541 | 04:06:55 INFO - PROCESS | 3541 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.32 (2.0%) stddev-sans-first:1.39 04:06:55 INFO - PROCESS | 3541 | Values: 67.0 67.0 68.0 69.0 69.0 66.0 66.0 67.0 68.0 65.0 04:06:55 INFO - PROCESS | 3541 | -------- Summary: end -------- 04:06:55 INFO - PROCESS | 3541 | 04:06:56 INFO - TEST-INFO | 3541: exit 0 04:06:56 INFO - TEST-OK | kraken | took 63107ms 04:06:56 INFO - SUITE-END | took 1183s 04:06:56 INFO - Completed test suite (00:19:43) 04:06:56 INFO - javascript benchmark 04:06:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2640.8811603477843, 2648.2849630599726, 2678.142994241842, 2692.111603170954, 2696.7572918437336, 4592.150452166343, 4679.625629949596, 4748.311494833251, 4778.7610619469015, 4797.0645724083815, 4715.363425937498, 4720.716756994574, 4730.0776348612035, 4794.089123066615, 4826.058918510892, 4368.5194628590825, 4440.444944381944, 4440.711353762012, 4443.755593442359, 4455.554444555551, 4421.447319085114, 4456.376107344974, 4485.5962963333295, 4527.569880861313, 4565.497795242521, 4530.433695788027, 4539.6368290536675, 4550.954490455103, 4567.520410356915, 4581.748003859786, 4239.236937351276, 4289.678274129453, 4354.107407981388, 4360.040791025969, 4438.068005718803, 4311.439512863339, 4315.805788739514, 4323.978380108079, 4378.759168245745, 4381.627561657263, 4730.0, 4770.928436073427, 4774.236122220428, 4793.688410253358, 4822.855314340575, 5200.0, 5201.141811601081, 5205.869853253661, 5209.218617207412, 5213.061648903196, 4839.27410888366, 5118.283440318359, 5196.792128314863, 5236.240745091978, 5310.70791106489, 4835.081334546495, 4886.193778026657, 4923.359963204796, 4931.5315045070665, 4936.901261974812, 5409.215663728737, 5420.891582168335, 5423.484768946943, 5423.810166644149, 5426.728663566806, 4771.475137734847, 4999.500049994971, 5076.44159142494, 5079.593632509391, 5147.3051138096625, 5177.145770947826, 5185.274061631375, 5186.196139598368, 5191.32512773337, 5241.187615919539, 5109.412417571953, 5115.948840511547, 5122.795088196505, 5137.897242055138, 5163.741812909415, 4841.298011788271, 4902.338184345139, 4980.526849949249, 5032.6225533084435, 5100.5409513143995, 4339.305711086211, 4341.413909122291, 4381.233284175257, 4383.408239887638, 4386.758728269912, 3801.676857467091, 3808.1050953026015, 3810.733248672622, 3845.9230815384094, 3860.2665493556133, 4213.304804707251, 4385.429894113809, 4399.5380485049245, 4399.934000989988, 4440.111977604492, 5209.348831396075, 5217.973910130425, 5241.816536421284, 5278.683279003272, 5292.126799078109, 4452.243118669834, 4456.420665313489, 4460.665450091256, 4467.7319360838455, 4508.436445444319, 4389.934150987738, 4542.273236282179, 4614.976925115353, 4711.293306004059, 4750.714957102585, 4804.495527969513, 4821.397325334333, 4823.1800593899825, 4852.0295940811275, 4871.318015477765, 5107.668001579886, 5132.538071573576, 5136.30659860914, 5136.614753893398, 5183.403908550414, 4573.268277075652, 4637.188492013952, 4644.442666879996, 4821.734804585782, 4879.292502587034, 4888.9755551222015, 4891.682040667345, 4899.11815873132, 5044.0, 5111.718855462986, 5200.947990520046, 5208.8437346879655, 5238.97380513095, 5257.106291930458, 5258.86852828667, 5021.4225364083595, 5029.622778291569, 5030.270610761492, 5033.446320904624, 5071.163258062378, 4697.201475749062, 5053.292539044463, 5073.441921388718, 5074.11203039474, 5075.390953085505, 4924.4090709115135, 4982.302477653204, 4984.775685094107, 5049.697018178921, 5050.621203409833, 4769.260764581495, 4840.007798401249, 4842.322074909445, 5097.668651537638, 5131.0, 4854.150523658275, 4886.706797592155, 4889.706617602955, 4893.828715994923, 4946.1838796599595], "value": 4715.27957501309, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.5523581135094, 564.9039663257247, 566.0377358490567, 570.4267211452491, 573.7332140554641, 28389.574156387644, 38887.80556097219, 40107.598924010825, 40204.0, 40252.39621405681, 40061.39907901377, 40404.393934091015, 40440.19119617613, 40488.595114048854, 40556.59443405565, 7668.194839541851, 7801.258880406353, 7801.687932482722, 7801.843963120734, 7810.531368117902, 7766.766996990099, 7845.568493732842, 7845.882311765328, 7847.254510821492, 7865.921340786605, 7865.646045927947, 7933.206679332049, 7943.72196973106, 7944.682212711485, 7947.284744373005, 7855.293023627873, 7892.447528672995, 7895.60521973899, 7903.960480197619, 7905.0, 7748.845023099563, 7811.687532498693, 7813.413993950419, 7813.687452501893, 7831.099423566306, 37713.622863771285, 37787.244255115016, 37858.81070594657, 37892.242155157015, 38192.427113593316, 3129.514925186577, 3142.230153612357, 3175.491921292582, 3207.6631953644765, 3535.4520049392386, 29155.271118222, 29726.554101688493, 29772.70227297721, 29890.40219195604, 29924.551131733042, 3451.188970591909, 3589.5513060867393, 3645.7994810285422, 3646.4165733482782, 3774.50931378919, 255229.0, 257661.0, 258440.0, 258527.0, 258918.0, 28730.856345718137, 54465.0, 54659.0, 54705.45294547004, 54814.0, 34569.135771605404, 34585.30829383398, 34641.48037779435, 34773.0, 34797.1300717479, 12317.568885088978, 12352.876471235173, 12363.381830908418, 12390.504379824886, 12402.937985310016, 9922.305438619227, 9940.956199599083, 9951.751206219902, 9987.101160895554, 10008.949955250177, 8000.199980001953, 8036.839263214703, 8039.0, 8040.477368970998, 8114.0, 3103.239706271933, 3115.12776422602, 3131.937361252808, 3151.921201969969, 3207.6792320767736, 895.3821862914568, 908.3096846396786, 1018.4347687033768, 1020.739711373595, 1067.0, 28069.0, 28490.572641410396, 28826.567601485574, 29021.85489072541, 29116.417671646872, 897.5250969088507, 971.8299297622888, 1017.9847302290472, 1041.6302910877662, 1082.0910435234284, 14998.0, 15228.695426091415, 15237.923810380877, 15374.890499323123, 15458.304376303093, 408037.0, 410343.0, 411161.0, 412034.0, 412602.0, 48907.0, 49336.75331623319, 49362.259566106535, 49464.25803612949, 49465.25802112971, 1135.9659210223706, 1181.3325471108797, 1183.1540448579308, 1209.4799236328463, 1217.3061355027726, 26780.59829102604, 26810.329741756614, 28054.85972570124, 28077.0, 28683.0, 42747.358789618804, 43268.567314327716, 43329.13341733211, 43342.78328608463, 43355.014173370466, 316346.0, 319191.0, 319573.0, 320631.0, 321563.0, 25639.10263140781, 25756.484870302866, 25777.0, 25876.8706156468, 26038.86980565085, 38008.23983520369, 41881.37177942273, 42236.155276894904, 43176.136477270906, 47704.76147619379, 35714.28571428609, 35741.46387804133, 35750.0, 36704.26591468209, 36781.816090919376, 36109.0, 36618.45072323971, 37458.438123428714, 38235.42646860355, 38554.80722596369, 35585.82207088948, 36405.0, 36643.63356366402, 37017.25965480729, 37036.25927481381, 31601.8419907899, 33510.497342540366, 33804.32391352209, 33828.66171338255, 33913.66086339204, 25624.615630765926, 26033.47799132052, 26136.60795088037, 26176.60735089013, 26534.336641584116], "value": 16618.077901324938, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.3402365387495, 359.4769610217134, 361.04323542612076, 365.69647192829956, 384.05713972198254, 12977.675558111052, 16322.918385408086, 16955.0, 17251.30994760208, 18154.636907261847, 16934.0, 17384.652306953885, 17567.912160439213, 17671.823281767178, 17868.85573731154, 5004.599632029447, 5248.239005344223, 5495.230667706524, 5527.198556209347, 5594.720263986805, 3454.067401801512, 5151.922721159186, 5537.058700021006, 5564.304461942257, 5575.163725441196, 5443.129099344106, 5477.863053423656, 5502.9174562381595, 5509.972450137744, 5514.0901751211, 5316.149416093445, 5396.082665946798, 5442.210879422501, 5505.889882202354, 5510.008198524244, 5275.393329767087, 5281.577473802086, 5285.947140528584, 5285.995660824431, 5287.259783630295, 12029.338386388745, 12102.455389507493, 12198.878011219864, 12297.754044919051, 12395.504179832797, 1859.414284500378, 1866.4773863318292, 1908.9522761930923, 1919.2035305348263, 1982.4944639116932, 9074.45553266806, 9093.181613654802, 9231.6307347706, 9454.716358509255, 9731.270154738422, 1685.2921772855307, 1697.73685078813, 1716.6995775739197, 1717.8711596630303, 1764.7970483394317, 68340.0, 70192.29807701909, 72372.27627723708, 72572.0, 73058.63470682666, 9922.206223502102, 10207.336523125972, 10222.897771022195, 10340.069393754598, 10456.738581535523, 14032.228227447384, 14034.719305613831, 14057.507987220399, 14063.718725625431, 14095.436182552789, 6905.930940690529, 7092.716291348392, 7171.247019063027, 7269.636518174176, 7294.781156565312, 6706.497012723968, 6711.4495295806055, 6792.7962161134255, 6818.4886133540185, 6913.168010477228, 4348.891277718019, 4385.166818304512, 4458.35353873693, 4510.300903359985, 4552.476465206478, 1846.9076546172637, 1851.3797877711118, 1904.6762050451457, 1918.673825449677, 1956.3055115434101, 823.9382046346548, 829.9958500207581, 874.4534665833854, 911.731039343382, 918.6711685876271, 16237.51287461378, 17129.14354282281, 17527.561810954827, 17698.823011769717, 17918.91040544789, 850.1371108325055, 852.9104444033411, 860.7934095817084, 870.6604424274537, 878.297362110322, 9342.719718408458, 9954.402735835873, 9978.351407158512, 10035.09684128432, 10231.976802319708, 304973.0, 307052.0, 307453.0, 402665.0, 406701.0, 75752.0, 76294.61852690701, 79168.0, 85061.0, 86684.56657716671, 838.387976776944, 881.8853549038712, 885.022050634053, 885.3183049052194, 887.3522328699956, 16220.918895405448, 16352.836471635608, 16866.831331687015, 16901.746473802657, 17115.828841711424, 36043.45934811032, 37280.254394912496, 39707.2058558833, 40399.7980010098, 41299.793501033506, 50771.23843142282, 51866.74066629643, 52572.737136315605, 52585.7370713144, 53482.19776703275, 7264.273572642694, 7464.066991626047, 7481.177070522347, 7611.3530349920875, 7639.885401718868, 10882.564697412015, 11335.489902954221, 11649.242799218024, 11670.299782013106, 12046.578369757017, 9892.208623310262, 10230.335028223142, 10320.587176512856, 10345.120664743581, 10347.327423717434, 10294.897051029393, 10542.15662746963, 10546.947265263625, 10663.573457061631, 10748.785024299314, 4910.9017819642695, 9652.117837021713, 10324.845127323246, 10333.0, 10726.463676816284, 7088.539244949062, 7334.669939852826, 7559.924400755922, 7627.923720762721, 7644.579548124684, 10107.949460252652, 10291.84562231552, 10405.219608529542, 10472.947635261775, 10570.365778053341], "value": 8092.928593303861, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1257.2519350986172, 1370.444969787236, 1400.2298735695365, 1475.1192229906867, 1706.2492503298556, 6019.0, 7243.456740744446, 7594.658240379183, 7600.353969912557, 7761.728339508119, 7598.658060387282, 7660.310572048515, 7662.272084151997, 7669.194734552875, 7675.462717609769, 2104.7474303083613, 2127.5532138250987, 2128.648772952461, 2132.168454302823, 2132.4029271803843, 2069.5550456651818, 2119.5337025854365, 2137.0810551462864, 2140.283005193262, 2143.0142134618095, 2079.085202510898, 2111.820495257905, 2114.38682781993, 2119.607872543577, 2151.9139234430604, 2055.044404351976, 2061.165228082614, 2062.257587268582, 2063.4325560470916, 2063.587282543497, 1977.0806574942576, 2033.044469099521, 2033.3899830051073, 2040.653088974863, 2042.4077017664858, 7404.22255663153, 7428.480006399554, 7523.09722833258, 7540.509866858692, 7577.052868391451, 4271.402003719481, 4460.8884777880485, 4483.282674772054, 4483.865484035484, 4486.865394038184, 2673.8128331016837, 2777.0835624244155, 2833.4191490744347, 2839.2901774556362, 2851.4012057467958, 880.1110878013188, 897.9012308646044, 905.483874191711, 906.9909300907038, 925.1396201532572, 10111.7472063199, 10208.540615672313, 10236.590536378535, 10237.23220758446, 10242.539085741086, 3674.65090816372, 3838.481804956351, 3952.7430717003303, 3991.720579559403, 4007.6192761687594, 8221.630026648816, 8221.671133154607, 8227.876581851277, 8230.588470576447, 8237.135100814448, 4436.112777444524, 4450.35469856869, 4452.5992660660695, 4455.5989960903025, 4460.420145381145, 3325.9501107483406, 3912.295786758354, 4032.1330913853662, 4127.277726397869, 4142.79286035697, 3198.760092993035, 3249.8050116993054, 3318.6515415881468, 3321.451960426551, 3337.8998630041137, 973.2116985241977, 977.1596427072711, 982.1602529837029, 993.0615568287899, 993.3245393132595, 841.4824882697097, 849.2144766091465, 867.2238346679686, 869.9434536755091, 874.9151052694613, 5020.891225685221, 5127.256547800548, 5155.74221288934, 5198.2722418861385, 5207.869803254949, 380.9466674665549, 381.0644866851872, 387.82935508376227, 390.78897395406733, 391.9784411857375, 3555.5022296878456, 3561.6082230955094, 3637.563492380931, 3694.2980833641523, 3792.1088544192094, 9087.591058402388, 9296.581653825595, 9402.764930876783, 9403.905960940303, 9439.292053095907, 9307.674231401868, 9321.95339023314, 9347.766305842408, 9348.018458061806, 9355.532223388804, 6774.932250677529, 7214.891776623354, 7276.818079548054, 7287.744928927462, 7289.343959043712, 5176.886969301619, 5446.809361672323, 5474.972625136849, 5509.917351239655, 5603.80386686464, 8272.710455134042, 8470.0, 8539.231469167804, 8663.610137543952, 8702.434341767765, 8428.789280268042, 8585.914140858511, 8688.956555217184, 8819.559022049, 8827.911720882708, 5499.395066542757, 6504.4796416285635, 6647.501437392311, 6648.16897887764, 6651.33486651331, 5991.281046274475, 7097.148342198762, 7132.251113633201, 7308.30571095745, 7308.963455182903, 6504.056911747675, 6533.052707357501, 6569.737210511526, 6600.174978127734, 6623.834404139935, 6466.224053113657, 6485.0, 6495.707693153725, 6504.577202482013, 6517.8696426072165, 6063.242094738158, 6179.752809887555, 6197.597156184834, 6199.977003794504, 6215.65813880241, 4548.476925153517, 4620.376249206314, 4630.536946305342, 4698.271767875848, 4711.552402521755, 4370.519242883217, 4465.0, 4511.729296242236, 4513.571210734975, 4524.366588677522], "value": 3899.1228564217217, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.08072329990625, 294.11764705882354, 295.49912897638484, 299.03262944374944, 300.63022482346713, 4814.76113607173, 4848.400027990763, 4870.391201099863, 4887.802488390341, 4905.215165573509, 4784.40194975628, 4789.80840766369, 4803.975980120094, 4827.46897841238, 4836.863337115775, 3560.1989552350774, 3665.541807274091, 3698.6671199592033, 3784.735068545203, 3811.771293722372, 3784.110733977513, 3784.7161462890394, 3794.1273507093383, 3810.6951443884564, 3836.4437156612275, 3780.7164462665273, 3784.091817963683, 3791.488149099878, 3793.6775374093236, 3802.16352402471, 3566.286742651467, 3645.4714066460215, 3752.9249415011545, 3794.1842503861526, 3801.581825999138, 3311.61916379617, 3312.8239474986276, 3317.286783341569, 3320.153360892981, 3369.7809642373413, 4716.599089077433, 4718.764061796896, 4721.291806229059, 4762.690425122356, 4769.356136921506, 4208.494980602347, 4293.656507479394, 4298.806553705091, 4351.369051487548, 4362.192994296065, 4996.625253106032, 5014.498550144993, 5018.548330650259, 5022.447530771612, 5025.748712564357, 3631.564212294515, 3631.909202269938, 3633.4913112164318, 3659.2132691471197, 3674.3202507535925, 5185.896282074337, 5301.6818990860675, 5313.681179129226, 5344.919826202571, 5355.758990845382, 3701.0, 3717.5724791648768, 3720.6093360197333, 3736.5142531470733, 3738.2056612825454, 3798.7150963677836, 3798.746413683533, 3812.2375524895133, 3812.275667623143, 3820.7325487216185, 4309.267424537836, 4319.136172765397, 4320.740755554677, 4326.913461730748, 4332.501762297313, 4861.496329390367, 5012.471196285095, 5015.724135172601, 5058.747062646853, 5105.7024339047575, 1292.9676758080934, 1311.7114234868313, 1313.7241179352252, 1315.2371624457792, 1316.6379245707508, 816.5672193737329, 845.9763685939959, 853.5561508015921, 862.0560486267527, 868.2619773192736, 4223.66210703143, 4334.1548398062705, 4338.0, 4351.086271882877, 4355.847545335898, 5011.223260394645, 5080.263361812516, 5166.354205724285, 5178.223266510054, 5199.688018718889, 4415.448068991376, 4421.668374871898, 4425.459632294152, 4430.911381772411, 4434.312681534368, 2653.562162243247, 2710.9728902711113, 2738.7398197171237, 2741.8080734348405, 2758.655168103987, 4874.926876096862, 4879.39007624047, 4884.389451318585, 4894.185843140209, 4907.68100073494, 5145.202493613496, 5289.656172348785, 5301.761420736076, 5301.920471192935, 5303.329451222852, 4833.32333473314, 4881.731504767201, 4904.141775189328, 4904.229110552526, 4930.556249937523, 5151.587872970078, 5169.172932330809, 5176.482351764794, 5191.157139215524, 5192.844969337833, 4846.933674591584, 5040.294358789845, 5040.672356296829, 5100.617453690914, 5121.974390128025, 4892.119418504703, 4904.730239836843, 4934.432540257916, 4940.5800506955875, 4943.678660887031, 3628.2380700052227, 3633.6003039666143, 3662.926741465209, 3674.65090816372, 3679.632036796299, 5068.728522336729, 5245.160774276097, 5271.947280527299, 5289.20661900718, 5302.973485132549, 5097.954919241621, 5105.948940510547, 5110.0, 5112.36095488064, 5119.6416250862085, 5056.469070747518, 5092.668976516515, 5104.132297509358, 5106.080905437057, 5107.87230319245, 4755.714657120584, 4996.525330093636, 4997.575206107522, 5031.823886163967, 5038.647294689336, 4881.731504767272, 5008.449070602303, 5079.085764562266, 5093.516115968977, 5111.182210846247, 4890.413150421972, 4913.1893237615395, 4914.877128071684, 4917.508249175054, 4926.605871530341], "value": 3809.25491653188, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.3610618585022, 620.4756980351602, 633.5501793726456, 715.5992644119291, 746.2835677749358, 12990.675233119176, 14241.074330168532, 14243.92878035611, 14244.50144244953, 14253.073550219242, 12290.938545307283, 13765.58703238902, 13779.793303100436, 13786.103903246307, 13810.964177686663, 629.3549112160027, 755.5051441305953, 775.2634996753079, 801.5551368990208, 806.379088102161, 786.4141214794986, 794.9085855126648, 795.2921899509412, 795.9681612735484, 796.2952786783709, 832.2301870769544, 833.4832403909585, 834.2116699718769, 834.5535138700797, 835.0, 640.7981485831995, 676.036647776916, 829.340674164038, 830.3066939105854, 831.5301854452215, 499.82506122857075, 500.1996805111792, 568.7270110347057, 602.638416949831, 605.3643674142177, 12657.810132848015, 12690.0, 12703.809442858364, 12723.618291451272, 12735.299558524277, 11087.168462365275, 11603.361815100166, 11973.341466219354, 12333.198342107735, 13043.152195107288, 9778.462184579845, 9965.252606054502, 11462.94268528652, 11552.884471155265, 11688.590899318568, 3265.1837040739815, 3314.96685033149, 3362.1090411041096, 3445.13871532117, 3448.0, 62019.37980620181, 62199.6890015547, 62467.37532624661, 62964.68517657428, 63949.04076438857, 9517.23862091045, 9797.0, 9821.312508124363, 9999.0, 10047.949760251153, 19175.232990680215, 19330.613387732166, 19578.510537236398, 19637.50906227356, 19849.60300793976, 6526.64103474304, 6592.8351791205605, 6718.49611279156, 6782.9321706783285, 6942.861142777117, 3657.3233951719017, 3672.2839046386234, 3672.540932383452, 3678.9264214715554, 3681.6318368163506, 2800.4399120176045, 2883.4377296427415, 2889.7399234069035, 2894.13176047185, 2898.217481280085, 476.3259987118189, 485.9149648811444, 488.6213184781823, 491.4962163782152, 497.9402471703419, 476.4877756411871, 492.29601669612083, 504.215944206762, 504.37205678929234, 507.76642744338017, 8019.438639295194, 8244.958775206085, 8307.470764952679, 8600.526971016528, 8639.481631102153, 584.5498965796313, 594.1058706646469, 595.684287327717, 601.7953895675404, 618.4063299232787, 3899.200663863901, 3967.385055316373, 4024.577419370924, 4034.8184331705143, 4116.279651061052, 59149.112763308585, 59479.40520594738, 59500.10749838756, 61429.69285153546, 77777.0, 70290.64854675796, 79775.0, 83275.0, 83370.16629833623, 85187.14812851915, 70370.0, 70924.29075709281, 71943.0, 72925.3428390022, 73001.2699873005, 8337.624806883583, 8371.288440482627, 8501.14988501145, 8639.438436501607, 8667.133286671282, 45247.773761130986, 45717.0, 46130.538694612624, 46223.53776462327, 46746.0, 53348.1997770026, 55037.72481137569, 57436.42563574311, 58656.70671646785, 59549.0, 10738.248322617343, 11367.602133925273, 11459.770804584028, 11666.300021998708, 11667.59163429276, 12375.75248495043, 12432.316222607844, 12456.171628929755, 12856.935715321364, 14053.156810591398, 11357.886421136014, 11359.318440893572, 11433.656990290305, 11684.397338911793, 11737.589184378847, 9257.861132083159, 11075.944620277169, 11547.0, 12267.0, 12866.099373043797, 11608.6517404478, 11733.965332592888, 12135.150539462153, 12275.877241227474, 12450.319206906952, 9255.490947997925, 9647.008542760826, 9854.655087071918, 10006.349587276804, 10374.42940638242, 9499.0, 9663.27525435581, 10195.235357348376, 10488.213383996383, 10558.155347572023], "value": 6416.267628586835, "unit": "score"}], "name": "dromaeo_css", "value": 6264.533421066752, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 114.0, 115.0, 114.0, 115.0, 114.0, 113.0, 115.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 121.0, 123.0, 169.0, 125.0, 123.0, 148.0, 126.0, 195.0, 126.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 163.0, 162.0, 160.0, 162.0, 162.0, 162.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 111.0, 76.0, 76.0, 75.0, 74.0, 109.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 138.0, 85.0, 85.0, 85.0, 127.0, 85.0, 85.0, 125.0], "value": 98.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 61.0, 62.0, 64.0, 62.0, 63.0, 62.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 88.0, 84.0, 79.0, 79.0, 81.0, 79.0, 78.0, 83.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 137.0, 145.0, 131.0, 132.0, 128.0, 143.0, 145.0, 145.0, 134.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 169.0, 163.0, 164.0, 163.0, 163.0, 163.0, 163.0, 163.0, 161.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 69.0, 69.0, 66.0, 66.0, 67.0, 68.0, 65.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1530.4, "alertThreshold": 2.0}]} 04:06:56 INFO - Return code: 0 04:06:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:06:56 INFO - # TBPL SUCCESS # 04:06:56 INFO - Running post-action listener: _resource_record_post_action 04:06:56 INFO - [mozharness: 2016-08-08 11:06:56.498321Z] Finished run-tests step (success) 04:06:56 INFO - Running post-run listener: _resource_record_post_run 04:06:56 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 529285120; Read time: 208; Write time: 438408 04:06:56 INFO - TinderboxPrint: CPU usage
13.0% 04:06:56 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 208 04:06:56 INFO - TinderboxPrint: I/O write bytes / time
529,285,120 / 438,408 04:06:56 INFO - TinderboxPrint: CPU idle
8,335.5 (87.0%) 04:06:56 INFO - TinderboxPrint: CPU user
1,199.1 (12.5%) 04:06:56 INFO - TinderboxPrint: Swap in / out
0 / 0 04:06:56 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 241917952; Read time: 0; Write time: 244096 04:06:56 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287367168; Read time: 196; Write time: 194312 04:06:57 INFO - Running post-run listener: _upload_blobber_files 04:06:57 INFO - Blob upload gear active. 04:06:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:06:57 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 04:06:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:06:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:06:57 INFO - (blobuploader) - INFO - Open directory for files ... 04:06:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:06:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:06:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:06:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:06:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:06:58 INFO - (blobuploader) - INFO - Done attempting. 04:06:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:06:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:06:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:06:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:06:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:06:59 INFO - (blobuploader) - INFO - Done attempting. 04:06:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:06:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:06:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:07:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:03 INFO - (blobuploader) - INFO - Done attempting. 04:07:03 INFO - (blobuploader) - INFO - Iteration through files over. 04:07:03 INFO - Return code: 0 04:07:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:07:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:07:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c44b35490f868b4eb39db8a30d247386a6d32c64f5d41c3ab068fa14e0333306d7df2d499d6c68c125cac7067ab9169709e8b41d5fb4aff628bc364988d2e04", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/746d464745fb7eeb726685c7fe9cfc56de3d1fae75af0461745145e915d07c0df69361e7cb5dccd89eb2bef40c12bd6d46d106ff27d37df3050543f6b3944e83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/573ce37b99803dd99e1e7247f1588829571c03b55e4f74e09568909277f6d83693518c00ed26859a93a20f2ee148c322bd0dc1a8a4be35beead8a4ea99d8398f"} 04:07:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:07:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:07:03 INFO - Contents: 04:07:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c44b35490f868b4eb39db8a30d247386a6d32c64f5d41c3ab068fa14e0333306d7df2d499d6c68c125cac7067ab9169709e8b41d5fb4aff628bc364988d2e04", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/746d464745fb7eeb726685c7fe9cfc56de3d1fae75af0461745145e915d07c0df69361e7cb5dccd89eb2bef40c12bd6d46d106ff27d37df3050543f6b3944e83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/573ce37b99803dd99e1e7247f1588829571c03b55e4f74e09568909277f6d83693518c00ed26859a93a20f2ee148c322bd0dc1a8a4be35beead8a4ea99d8398f"} 04:07:03 INFO - Running post-run listener: copy_logs_to_upload_dir 04:07:03 INFO - Copying logs to upload dir... 04:07:03 INFO - mkdir: /builds/slave/test/build/upload/logs 04:07:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.775471 ========= master_lag: 0.95 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-08 04:07:03.861946) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 04:07:03.865731) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c44b35490f868b4eb39db8a30d247386a6d32c64f5d41c3ab068fa14e0333306d7df2d499d6c68c125cac7067ab9169709e8b41d5fb4aff628bc364988d2e04", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/746d464745fb7eeb726685c7fe9cfc56de3d1fae75af0461745145e915d07c0df69361e7cb5dccd89eb2bef40c12bd6d46d106ff27d37df3050543f6b3944e83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/573ce37b99803dd99e1e7247f1588829571c03b55e4f74e09568909277f6d83693518c00ed26859a93a20f2ee148c322bd0dc1a8a4be35beead8a4ea99d8398f"} build_url:https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009774 build_url: 'https://queue.taskcluster.net/v1/task/GX1iO3--TSW15C86fw70gA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c44b35490f868b4eb39db8a30d247386a6d32c64f5d41c3ab068fa14e0333306d7df2d499d6c68c125cac7067ab9169709e8b41d5fb4aff628bc364988d2e04", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/746d464745fb7eeb726685c7fe9cfc56de3d1fae75af0461745145e915d07c0df69361e7cb5dccd89eb2bef40c12bd6d46d106ff27d37df3050543f6b3944e83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/573ce37b99803dd99e1e7247f1588829571c03b55e4f74e09568909277f6d83693518c00ed26859a93a20f2ee148c322bd0dc1a8a4be35beead8a4ea99d8398f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 04:07:03.893357) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 04:07:03.893868) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1470653183.291016-252298845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 04:07:03.943967) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 04:07:03.944303) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 04:07:03.944601) ========= ========= Total master_lag: 1.07 =========