builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-041 starttime: 1471367662.44 results: success (0) buildid: 20160816092617 builduid: 4af28a8505e445e093332d46a623207a revision: 19455d8adc072d1b64d9a29af492258cd9c6480e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 10:14:22.438774) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 10:14:22.441439) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 10:14:22.441928) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 10:14:22.471187) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 10:14:22.471673) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-16 10:14:22-- 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% 112M=0s 2016-08-16 10:14:23 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.348167 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 10:14:22.835928) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 10:14:22.836318) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016652 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 10:14:22.886253) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 10:14:22.886605) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 19455d8adc072d1b64d9a29af492258cd9c6480e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 19455d8adc072d1b64d9a29af492258cd9c6480e --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=8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-16 10:14:23,230 truncating revision to first 12 chars 2016-08-16 10:14:23,230 Setting DEBUG logging. 2016-08-16 10:14:23,230 attempt 1/10 2016-08-16 10:14:23,230 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/19455d8adc07?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 10:14:23,559 unpacking tar archive at: autoland-19455d8adc07/testing/mozharness/ program finished with exit code 0 elapsedTime=0.662437 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 10:14:23.562770) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 10:14:23.563077) ========= script_repo_revision: 19455d8adc072d1b64d9a29af492258cd9c6480e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 10:14:23.563479) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 10:14:23.563746) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 10:14:23.573163) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-16 10:14:23.573554) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:14:24 INFO - MultiFileLogger online at 20160816 10:14:24 in /builds/slave/test 10:14:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 10:14:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:14:24 INFO - {'append_to_log': False, 10:14:24 INFO - 'base_work_dir': '/builds/slave/test', 10:14:24 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 10:14:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:14:24 INFO - 'branch': 'Autoland-Non-PGO', 10:14:24 INFO - 'buildbot_json_path': 'buildprops.json', 10:14:24 INFO - 'config_files': ('talos/linux_config.py',), 10:14:24 INFO - 'default_actions': ('clobber', 10:14:24 INFO - 'read-buildbot-config', 10:14:24 INFO - 'download-and-extract', 10:14:24 INFO - 'populate-webroot', 10:14:24 INFO - 'create-virtualenv', 10:14:24 INFO - 'install', 10:14:24 INFO - 'run-tests'), 10:14:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:14:24 INFO - 'download_minidump_stackwalk': True, 10:14:24 INFO - 'download_symbols': 'ondemand', 10:14:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:14:24 INFO - 'tooltool.py': '/tools/tooltool.py', 10:14:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:14:24 INFO - '/tools/misc-python/virtualenv.py')}, 10:14:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:14:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:14:24 INFO - 'installer_path': 'installer.exe', 10:14:24 INFO - 'log_level': 'info', 10:14:24 INFO - 'log_name': 'talos', 10:14:24 INFO - 'log_to_console': True, 10:14:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:14:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:14:24 INFO - 'opt_config_files': (), 10:14:24 INFO - 'pip_index': False, 10:14:24 INFO - 'sps_profile': False, 10:14:24 INFO - 'sps_profile_interval': 0, 10:14:24 INFO - 'suite': 'dromaeojs', 10:14:24 INFO - 'system_bits': '32', 10:14:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:14:24 INFO - 'title': 'talos-linux64-ix-041', 10:14:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:14:24 INFO - 'use_talos_json': True, 10:14:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:14:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:14:24 INFO - 'work_dir': 'build'} 10:14:24 INFO - [mozharness: 2016-08-16 17:14:24.014168Z] Running clobber step. 10:14:24 INFO - Running pre-action listener: _resource_record_pre_action 10:14:24 INFO - Running main action method: clobber 10:14:24 INFO - rmtree: /builds/slave/test/build 10:14:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:14:24 INFO - Running post-action listener: _resource_record_post_action 10:14:24 INFO - [mozharness: 2016-08-16 17:14:24.488992Z] Finished clobber step (success) 10:14:24 INFO - [mozharness: 2016-08-16 17:14:24.489093Z] Running read-buildbot-config step. 10:14:24 INFO - Running pre-action listener: _resource_record_pre_action 10:14:24 INFO - Running main action method: read_buildbot_config 10:14:24 INFO - Using buildbot properties: 10:14:24 INFO - { 10:14:24 INFO - "project": "", 10:14:24 INFO - "product": "firefox", 10:14:24 INFO - "script_repo_revision": "production", 10:14:24 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 10:14:24 INFO - "repository": "", 10:14:24 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 10:14:24 INFO - "buildid": "20160816092617", 10:14:24 INFO - "pgo_build": "False", 10:14:24 INFO - "basedir": "/builds/slave/test", 10:14:24 INFO - "buildnumber": 256, 10:14:24 INFO - "slavename": "talos-linux64-ix-041", 10:14:24 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:14:24 INFO - "platform": "ubuntu64_hw", 10:14:24 INFO - "scheduler": "tests-autoland-linux64-talos", 10:14:24 INFO - "branch": "autoland", 10:14:24 INFO - "repo_path": "integration/autoland", 10:14:24 INFO - "revision": "19455d8adc072d1b64d9a29af492258cd9c6480e", 10:14:24 INFO - "stage_platform": "linux64", 10:14:24 INFO - "builduid": "4af28a8505e445e093332d46a623207a", 10:14:24 INFO - "slavebuilddir": "test" 10:14:24 INFO - } 10:14:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:14:24 INFO - Running post-action listener: _resource_record_post_action 10:14:24 INFO - [mozharness: 2016-08-16 17:14:24.491526Z] Finished read-buildbot-config step (success) 10:14:24 INFO - [mozharness: 2016-08-16 17:14:24.491615Z] Running download-and-extract step. 10:14:24 INFO - Running pre-action listener: _resource_record_pre_action 10:14:24 INFO - Running main action method: download_and_extract 10:14:24 INFO - mkdir: /builds/slave/test/build/tests 10:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:24 INFO - trying https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:14:24 INFO - Downloading https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/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 10:14:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/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 10:14:25 INFO - Downloaded 1361 bytes. 10:14:25 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:14:25 INFO - Using the following test package requirements: 10:14:25 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:14:25 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:14:25 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:14:25 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:25 INFO - u'jsshell-linux-x86_64.zip'], 10:14:25 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:14:25 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:14:25 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:14:25 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:14:25 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:14:25 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:25 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:14:25 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:14:25 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')]} 10:14:25 INFO - trying https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:14:25 INFO - Downloading https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/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 10:14:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/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 10:14:25 INFO - Downloaded 20269096 bytes. 10:14:25 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 10:14:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:30 INFO - trying https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:14:30 INFO - Downloading https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/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 10:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/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 10:14:31 INFO - Downloaded 20269096 bytes. 10:14:31 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 10:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:35 INFO - trying https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:14:35 INFO - Downloading https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/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 10:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/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 10:14:36 INFO - Downloaded 14413719 bytes. 10:14:36 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 10:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:36 INFO - trying https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:14:36 INFO - Downloading https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/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 10:14:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/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 10:14:37 INFO - Downloaded 55646685 bytes. 10:14:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:14:37 INFO - mkdir: /builds/slave/test/properties 10:14:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:14:37 INFO - Writing to file /builds/slave/test/properties/build_url 10:14:37 INFO - Contents: 10:14:37 INFO - build_url:https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:14:38 INFO - Running post-action listener: _resource_record_post_action 10:14:38 INFO - Running post-action listener: set_extra_try_arguments 10:14:38 INFO - [mozharness: 2016-08-16 17:14:38.516136Z] Finished download-and-extract step (success) 10:14:38 INFO - [mozharness: 2016-08-16 17:14:38.516361Z] Running populate-webroot step. 10:14:38 INFO - Running pre-action listener: _resource_record_pre_action 10:14:38 INFO - Running main action method: populate_webroot 10:14:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:14:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:14:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:14:38 INFO - '--tppagecycles', 10:14:38 INFO - '7'], 10:14:38 INFO - 'tests': ['tsvgm']}}, 10:14:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:14:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:14:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:14:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:14:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:14:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:14:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:38 INFO - 'talos_options': ['--disable-e10s'], 10:14:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:14:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:14:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:38 INFO - 'talos_options': ['--disable-e10s'], 10:14:38 INFO - 'tests': ['damp', 'tps']}, 10:14:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:38 INFO - 'tests': ['damp', 'tps']}, 10:14:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:14:38 INFO - 'tests': ['dromaeo_dom']}, 10:14:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:14:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:14:38 INFO - 'tests': ['basic_compositor_video']}, 10:14:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:14:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:14:38 INFO - 'tests': ['a11yr', 10:14:38 INFO - 'ts_paint', 10:14:38 INFO - 'tpaint', 10:14:38 INFO - 'sessionrestore', 10:14:38 INFO - 'sessionrestore_no_auto_restore', 10:14:38 INFO - 'tabpaint']}, 10:14:38 INFO - 'other-e10s': {'tests': ['a11yr', 10:14:38 INFO - 'ts_paint', 10:14:38 INFO - 'tpaint', 10:14:38 INFO - 'sessionrestore', 10:14:38 INFO - 'sessionrestore_no_auto_restore', 10:14:38 INFO - 'tabpaint']}, 10:14:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:14:38 INFO - 'ts_paint', 10:14:38 INFO - 'tpaint', 10:14:38 INFO - 'sessionrestore', 10:14:38 INFO - 'sessionrestore_no_auto_restore', 10:14:38 INFO - 'tabpaint']}, 10:14:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:14:38 INFO - 'ts_paint', 10:14:38 INFO - 'tpaint', 10:14:38 INFO - 'sessionrestore', 10:14:38 INFO - 'sessionrestore_no_auto_restore', 10:14:38 INFO - 'tabpaint']}, 10:14:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:14:38 INFO - 'tests': ['a11yr', 10:14:38 INFO - 'ts_paint', 10:14:38 INFO - 'tpaint', 10:14:38 INFO - 'sessionrestore', 10:14:38 INFO - 'sessionrestore_no_auto_restore', 10:14:38 INFO - 'tabpaint']}, 10:14:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:14:38 INFO - 'tests': ['a11yr', 10:14:38 INFO - 'ts_paint', 10:14:38 INFO - 'tpaint', 10:14:38 INFO - 'sessionrestore', 10:14:38 INFO - 'sessionrestore_no_auto_restore', 10:14:38 INFO - 'tabpaint']}, 10:14:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:14:38 INFO - 'tests': ['tsvgx', 10:14:38 INFO - 'tsvgr_opacity', 10:14:38 INFO - 'tart', 10:14:38 INFO - 'tscrollx', 10:14:38 INFO - 'cart']}, 10:14:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:14:38 INFO - 'tsvgr_opacity', 10:14:38 INFO - 'tart', 10:14:38 INFO - 'tscrollx', 10:14:38 INFO - 'cart']}, 10:14:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:38 INFO - 'talos_options': ['--disable-e10s'], 10:14:38 INFO - 'tests': ['tp5o']}, 10:14:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:38 INFO - 'tests': ['tp5o']}, 10:14:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:38 INFO - 'talos_options': ['--disable-e10s', 10:14:38 INFO - '--xperf_path', 10:14:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:14:38 INFO - 'tests': ['tp5n']}, 10:14:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:38 INFO - 'talos_options': ['--xperf_path', 10:14:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:14:38 INFO - 'tests': ['tp5n']}}, 10:14:38 INFO - 'talos.zip': {'path': '', 10:14:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:14:38 INFO - Running post-action listener: _resource_record_post_action 10:14:38 INFO - [mozharness: 2016-08-16 17:14:38.532800Z] Finished populate-webroot step (success) 10:14:38 INFO - [mozharness: 2016-08-16 17:14:38.532888Z] Running create-virtualenv step. 10:14:38 INFO - Running pre-action listener: _resource_record_pre_action 10:14:38 INFO - Running main action method: create_virtualenv 10:14:38 INFO - Creating virtualenv /builds/slave/test/build/venv 10:14:38 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 10:14:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:14:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:14:38 INFO - Using real prefix '/usr' 10:14:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:14:39 INFO - Installing distribute.............................................................................................................................................................................................done. 10:14:41 INFO - Installing pip.................done. 10:14:41 INFO - Return code: 0 10:14:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5dcd450f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf05090>, '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 0xf089b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08e40>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', '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 10:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:14:41 INFO - Using env: {'DISPLAY': ':0', 10:14:41 INFO - 'HOME': '/home/cltbld', 10:14:41 INFO - 'LANG': 'en_US.UTF-8', 10:14:41 INFO - 'LANGUAGE': 'en_US:en', 10:14:41 INFO - 'LOGNAME': 'cltbld', 10:14:41 INFO - 'MAIL': '/var/mail/cltbld', 10:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:41 INFO - 'MOZ_NO_REMOTE': '1', 10:14:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:41 INFO - 'NO_EM_RESTART': '1', 10:14:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:41 INFO - 'PWD': '/builds/slave/test', 10:14:41 INFO - 'SHELL': '/bin/bash', 10:14:41 INFO - 'SHLVL': '1', 10:14:41 INFO - 'TERM': 'linux', 10:14:41 INFO - 'TMOUT': '86400', 10:14:41 INFO - 'USER': 'cltbld', 10:14:41 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', 10:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:41 INFO - '_': '/tools/buildbot/bin/python'} 10:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:41 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 10:14:41 INFO - Cleaning up... 10:14:41 INFO - Return code: 0 10:14:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5dcd450f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf05090>, '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 0xf089b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08e40>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', '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 10:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:14:41 INFO - Using env: {'DISPLAY': ':0', 10:14:41 INFO - 'HOME': '/home/cltbld', 10:14:41 INFO - 'LANG': 'en_US.UTF-8', 10:14:41 INFO - 'LANGUAGE': 'en_US:en', 10:14:41 INFO - 'LOGNAME': 'cltbld', 10:14:41 INFO - 'MAIL': '/var/mail/cltbld', 10:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:41 INFO - 'MOZ_NO_REMOTE': '1', 10:14:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:41 INFO - 'NO_EM_RESTART': '1', 10:14:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:41 INFO - 'PWD': '/builds/slave/test', 10:14:41 INFO - 'SHELL': '/bin/bash', 10:14:41 INFO - 'SHLVL': '1', 10:14:41 INFO - 'TERM': 'linux', 10:14:41 INFO - 'TMOUT': '86400', 10:14:41 INFO - 'USER': 'cltbld', 10:14:41 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', 10:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:41 INFO - '_': '/tools/buildbot/bin/python'} 10:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:41 INFO - Downloading/unpacking psutil>=3.1.1 10:14:41 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 10:14:41 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 10:14:41 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 10:14:41 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 10:14:41 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 10:14:41 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 10:14:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:14:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:43 INFO - Installing collected packages: psutil 10:14:43 INFO - Running setup.py install for psutil 10:14:43 INFO - building 'psutil._psutil_linux' extension 10:14:43 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 10:14:43 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 10:14:43 INFO - building 'psutil._psutil_posix' extension 10:14:43 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 10:14:43 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 10:14:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:44 INFO - Successfully installed psutil 10:14:44 INFO - Cleaning up... 10:14:44 INFO - Return code: 0 10:14:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5dcd450f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf05090>, '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 0xf089b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08e40>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', '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 10:14:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:14:44 INFO - Using env: {'DISPLAY': ':0', 10:14:44 INFO - 'HOME': '/home/cltbld', 10:14:44 INFO - 'LANG': 'en_US.UTF-8', 10:14:44 INFO - 'LANGUAGE': 'en_US:en', 10:14:44 INFO - 'LOGNAME': 'cltbld', 10:14:44 INFO - 'MAIL': '/var/mail/cltbld', 10:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:44 INFO - 'MOZ_NO_REMOTE': '1', 10:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:44 INFO - 'NO_EM_RESTART': '1', 10:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:44 INFO - 'PWD': '/builds/slave/test', 10:14:44 INFO - 'SHELL': '/bin/bash', 10:14:44 INFO - 'SHLVL': '1', 10:14:44 INFO - 'TERM': 'linux', 10:14:44 INFO - 'TMOUT': '86400', 10:14:44 INFO - 'USER': 'cltbld', 10:14:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', 10:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:44 INFO - '_': '/tools/buildbot/bin/python'} 10:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:14:46 INFO - Installing collected packages: mozsystemmonitor 10:14:46 INFO - Running setup.py install for mozsystemmonitor 10:14:46 INFO - Successfully installed mozsystemmonitor 10:14:46 INFO - Cleaning up... 10:14:46 INFO - Return code: 0 10:14:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5dcd450f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf05090>, '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 0xf089b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08e40>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', '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 10:14:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:14:46 INFO - Using env: {'DISPLAY': ':0', 10:14:46 INFO - 'HOME': '/home/cltbld', 10:14:46 INFO - 'LANG': 'en_US.UTF-8', 10:14:46 INFO - 'LANGUAGE': 'en_US:en', 10:14:46 INFO - 'LOGNAME': 'cltbld', 10:14:46 INFO - 'MAIL': '/var/mail/cltbld', 10:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:46 INFO - 'MOZ_NO_REMOTE': '1', 10:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:46 INFO - 'NO_EM_RESTART': '1', 10:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:46 INFO - 'PWD': '/builds/slave/test', 10:14:46 INFO - 'SHELL': '/bin/bash', 10:14:46 INFO - 'SHLVL': '1', 10:14:46 INFO - 'TERM': 'linux', 10:14:46 INFO - 'TMOUT': '86400', 10:14:46 INFO - 'USER': 'cltbld', 10:14:46 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', 10:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:46 INFO - '_': '/tools/buildbot/bin/python'} 10:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:46 INFO - Downloading/unpacking jsonschema==2.5.1 10:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:14:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:14:48 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 10:14:48 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 10:14:48 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 10:14:48 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 10:14:48 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 10:14:48 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 10:14:48 INFO - Downloading functools32-3.2.3-2.tar.gz 10:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:14:48 INFO - warning: no files found matching '*.txt' 10:14:48 INFO - no previously-included directories found matching 'build' 10:14:48 INFO - no previously-included directories found matching 'dist' 10:14:48 INFO - no previously-included directories found matching '.git*' 10:14:48 INFO - Installing collected packages: jsonschema, functools32 10:14:48 INFO - Running setup.py install for functools32 10:14:48 INFO - warning: no files found matching '*.txt' 10:14:48 INFO - no previously-included directories found matching 'build' 10:14:48 INFO - no previously-included directories found matching 'dist' 10:14:48 INFO - no previously-included directories found matching '.git*' 10:14:48 INFO - Successfully installed jsonschema functools32 10:14:48 INFO - Cleaning up... 10:14:48 INFO - Return code: 0 10:14:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:14: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')]} 10:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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')]} 10:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:48 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 0x7f5dcd450f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf05090>, '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 0xf089b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08e40>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', '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 10:14:48 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 10:14:48 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 10:14:48 INFO - Using env: {'DISPLAY': ':0', 10:14:48 INFO - 'HOME': '/home/cltbld', 10:14:48 INFO - 'LANG': 'en_US.UTF-8', 10:14:48 INFO - 'LANGUAGE': 'en_US:en', 10:14:48 INFO - 'LOGNAME': 'cltbld', 10:14:48 INFO - 'MAIL': '/var/mail/cltbld', 10:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:48 INFO - 'MOZ_NO_REMOTE': '1', 10:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:48 INFO - 'NO_EM_RESTART': '1', 10:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:48 INFO - 'PWD': '/builds/slave/test', 10:14:48 INFO - 'SHELL': '/bin/bash', 10:14:48 INFO - 'SHLVL': '1', 10:14:48 INFO - 'TERM': 'linux', 10:14:48 INFO - 'TMOUT': '86400', 10:14:48 INFO - 'USER': 'cltbld', 10:14:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', 10:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:48 INFO - '_': '/tools/buildbot/bin/python'} 10:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:14:49 INFO - Cleaning up... 10:14:49 INFO - Return code: 0 10:14:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:14:49 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')]} 10:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:49 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')]} 10:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:49 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 0x7f5dcd450f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf05090>, '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 0xf089b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08e40>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', '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 10:14:49 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 10:14:49 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 10:14:49 INFO - Using env: {'DISPLAY': ':0', 10:14:49 INFO - 'HOME': '/home/cltbld', 10:14:49 INFO - 'LANG': 'en_US.UTF-8', 10:14:49 INFO - 'LANGUAGE': 'en_US:en', 10:14:49 INFO - 'LOGNAME': 'cltbld', 10:14:49 INFO - 'MAIL': '/var/mail/cltbld', 10:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:49 INFO - 'MOZ_NO_REMOTE': '1', 10:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:49 INFO - 'NO_EM_RESTART': '1', 10:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:49 INFO - 'PWD': '/builds/slave/test', 10:14:49 INFO - 'SHELL': '/bin/bash', 10:14:49 INFO - 'SHLVL': '1', 10:14:49 INFO - 'TERM': 'linux', 10:14:49 INFO - 'TMOUT': '86400', 10:14:49 INFO - 'USER': 'cltbld', 10:14:49 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', 10:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:49 INFO - '_': '/tools/buildbot/bin/python'} 10:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:49 INFO - Downloading/unpacking blobuploader==1.2.4 10:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:51 INFO - Downloading blobuploader-1.2.4.tar.gz 10:14:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:14:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:14:51 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 10:14:51 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 10:14:51 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 10:14:51 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 10:14:51 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 10:14:51 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 10:14:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:14:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:14:51 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 10:14:51 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 10:14:51 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 10:14:51 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 10:14:51 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 10:14:51 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 10:14:51 INFO - Downloading docopt-0.6.1.tar.gz 10:14:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:14:51 INFO - Installing collected packages: blobuploader, requests, docopt 10:14:51 INFO - Running setup.py install for blobuploader 10:14:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:14:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:14:52 INFO - Running setup.py install for requests 10:14:52 INFO - Running setup.py install for docopt 10:14:52 INFO - Successfully installed blobuploader requests docopt 10:14:52 INFO - Cleaning up... 10:14:52 INFO - Return code: 0 10:14:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14: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')]} 10:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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')]} 10:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:52 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 0x7f5dcd450f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf05090>, '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 0xf089b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08e40>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', '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 10:14:52 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 10:14:52 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 10:14:52 INFO - Using env: {'DISPLAY': ':0', 10:14:52 INFO - 'HOME': '/home/cltbld', 10:14:52 INFO - 'LANG': 'en_US.UTF-8', 10:14:52 INFO - 'LANGUAGE': 'en_US:en', 10:14:52 INFO - 'LOGNAME': 'cltbld', 10:14:52 INFO - 'MAIL': '/var/mail/cltbld', 10:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:52 INFO - 'MOZ_NO_REMOTE': '1', 10:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:52 INFO - 'NO_EM_RESTART': '1', 10:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:52 INFO - 'PWD': '/builds/slave/test', 10:14:52 INFO - 'SHELL': '/bin/bash', 10:14:52 INFO - 'SHLVL': '1', 10:14:52 INFO - 'TERM': 'linux', 10:14:52 INFO - 'TMOUT': '86400', 10:14:52 INFO - 'USER': 'cltbld', 10:14:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', 10:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:52 INFO - '_': '/tools/buildbot/bin/python'} 10:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:14:52 INFO - Running setup.py (path:/tmp/pip-Tgzyzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:14:52 INFO - Running setup.py (path:/tmp/pip-e8cKzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:14:52 INFO - Running setup.py (path:/tmp/pip-wE9wpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:14:53 INFO - Running setup.py (path:/tmp/pip-IhekDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:14:53 INFO - Running setup.py (path:/tmp/pip-VN5Ksm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:14:53 INFO - Running setup.py (path:/tmp/pip-geP2nQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:14:53 INFO - Running setup.py (path:/tmp/pip-cgEI8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:14:53 INFO - Running setup.py (path:/tmp/pip-g2kx5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:14:53 INFO - Running setup.py (path:/tmp/pip-ICpboE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:14:53 INFO - Running setup.py (path:/tmp/pip-FNF4u4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:14:53 INFO - Running setup.py (path:/tmp/pip-tVxcBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:14:53 INFO - Running setup.py (path:/tmp/pip-wn5er2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:14:53 INFO - Running setup.py (path:/tmp/pip-DQ_UAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:14:53 INFO - Running setup.py (path:/tmp/pip-Emng4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:53 INFO - Running setup.py (path:/tmp/pip-6xFKwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:14:53 INFO - Running setup.py (path:/tmp/pip-HYLB4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:14:53 INFO - Running setup.py (path:/tmp/pip-b0eYW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:14:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:14:54 INFO - Running setup.py install for manifestparser 10:14:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:14:54 INFO - Running setup.py install for mozcrash 10:14:54 INFO - Running setup.py install for mozdebug 10:14:54 INFO - Running setup.py install for mozdevice 10:14:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:14:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:14:54 INFO - Running setup.py install for mozfile 10:14:54 INFO - Running setup.py install for mozhttpd 10:14:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:14:54 INFO - Running setup.py install for mozinfo 10:14:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:14:54 INFO - Running setup.py install for mozInstall 10:14:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:14:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:14:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:14:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:14:54 INFO - Running setup.py install for mozleak 10:14:54 INFO - Running setup.py install for mozlog 10:14:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:14:55 INFO - Running setup.py install for moznetwork 10:14:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:14:55 INFO - Running setup.py install for mozprocess 10:14:55 INFO - Running setup.py install for mozprofile 10:14:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:14:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:14:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:14:55 INFO - Running setup.py install for mozrunner 10:14:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:14:55 INFO - Running setup.py install for mozscreenshot 10:14:55 INFO - Running setup.py install for moztest 10:14:55 INFO - Running setup.py install for mozversion 10:14:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:14:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:14:55 INFO - Cleaning up... 10:14:55 INFO - Return code: 0 10:14:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14: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')]} 10:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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')]} 10:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:55 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 0x7f5dcd450f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf05090>, '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 0xf089b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08e40>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', '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 10:14:55 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 10:14:55 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 10:14:55 INFO - Using env: {'DISPLAY': ':0', 10:14:55 INFO - 'HOME': '/home/cltbld', 10:14:55 INFO - 'LANG': 'en_US.UTF-8', 10:14:55 INFO - 'LANGUAGE': 'en_US:en', 10:14:55 INFO - 'LOGNAME': 'cltbld', 10:14:55 INFO - 'MAIL': '/var/mail/cltbld', 10:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:55 INFO - 'MOZ_NO_REMOTE': '1', 10:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:55 INFO - 'NO_EM_RESTART': '1', 10:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:55 INFO - 'PWD': '/builds/slave/test', 10:14:55 INFO - 'SHELL': '/bin/bash', 10:14:55 INFO - 'SHLVL': '1', 10:14:55 INFO - 'TERM': 'linux', 10:14:55 INFO - 'TMOUT': '86400', 10:14:55 INFO - 'USER': 'cltbld', 10:14:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', 10:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:55 INFO - '_': '/tools/buildbot/bin/python'} 10:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:14:56 INFO - Running setup.py (path:/tmp/pip-tC9ayV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:14:56 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)) 10:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:14:56 INFO - Running setup.py (path:/tmp/pip-YkHWRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:14:56 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)) 10:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:14:56 INFO - Running setup.py (path:/tmp/pip-ZiIpZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:14:56 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)) 10:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:14:56 INFO - Running setup.py (path:/tmp/pip-mBXDah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:14:56 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)) 10:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:14:56 INFO - Running setup.py (path:/tmp/pip-sTC78_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:14:56 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)) 10:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:14:56 INFO - Running setup.py (path:/tmp/pip-0AHTi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:14:56 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)) 10:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:14:56 INFO - Running setup.py (path:/tmp/pip-3_Krsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:14:56 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)) 10:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:14:56 INFO - Running setup.py (path:/tmp/pip-BBsSQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:14:56 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)) 10:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:14:56 INFO - Running setup.py (path:/tmp/pip-9u78JQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:14:56 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)) 10:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:14:56 INFO - Running setup.py (path:/tmp/pip-0UXvkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:14:56 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)) 10:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:14:56 INFO - Running setup.py (path:/tmp/pip-RA3XOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:14:56 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)) 10:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:14:56 INFO - Running setup.py (path:/tmp/pip-2K7g4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:14:56 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)) 10:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:14:56 INFO - Running setup.py (path:/tmp/pip-DhQYB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:14:56 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)) 10:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:14:57 INFO - Running setup.py (path:/tmp/pip-UaB3kF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:14:57 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)) 10:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:57 INFO - Running setup.py (path:/tmp/pip-jAwvF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:57 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)) 10:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:14:57 INFO - Running setup.py (path:/tmp/pip-Wp1DjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:14:57 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)) 10:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:14:57 INFO - Running setup.py (path:/tmp/pip-sQKwg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:14:57 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)) 10:14:57 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)) 10:14:57 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)) 10:14:57 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)) 10:14:57 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)) 10:14:57 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)) 10:14:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:59 INFO - Downloading blessings-1.6.tar.gz 10:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:14:59 INFO - Installing collected packages: blessings 10:14:59 INFO - Running setup.py install for blessings 10:14:59 INFO - Successfully installed blessings 10:14:59 INFO - Cleaning up... 10:14:59 INFO - Return code: 0 10:14:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:14:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:14:59 INFO - Reading from file tmpfile_stdout 10:14:59 INFO - Current package versions: 10:14:59 INFO - argparse == 1.2.1 10:14:59 INFO - blessings == 1.6 10:14:59 INFO - blobuploader == 1.2.4 10:14:59 INFO - docopt == 0.6.1 10:14:59 INFO - functools32 == 3.2.3-2 10:14:59 INFO - jsonschema == 2.5.1 10:14:59 INFO - manifestparser == 1.1 10:14:59 INFO - mozInstall == 1.12 10:14:59 INFO - mozcrash == 0.17 10:14:59 INFO - mozdebug == 0.1 10:14:59 INFO - mozdevice == 0.48 10:14:59 INFO - mozfile == 1.2 10:14:59 INFO - mozhttpd == 0.7 10:14:59 INFO - mozinfo == 0.9 10:14:59 INFO - mozleak == 0.1 10:14:59 INFO - mozlog == 3.3 10:14:59 INFO - moznetwork == 0.27 10:14:59 INFO - mozprocess == 0.23 10:14:59 INFO - mozprofile == 0.28 10:14:59 INFO - mozrunner == 6.12 10:14:59 INFO - mozscreenshot == 0.1 10:14:59 INFO - mozsystemmonitor == 0.3 10:14:59 INFO - moztest == 0.7 10:14:59 INFO - mozversion == 1.4 10:14:59 INFO - psutil == 3.1.1 10:14:59 INFO - requests == 1.2.3 10:14:59 INFO - wsgiref == 0.1.2 10:14:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:59 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 0x7f5dcd450f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf05090>, '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 0xf089b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08e40>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', '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 10:14:59 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 10:14:59 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 10:14:59 INFO - Using env: {'DISPLAY': ':0', 10:14:59 INFO - 'HOME': '/home/cltbld', 10:14:59 INFO - 'LANG': 'en_US.UTF-8', 10:14:59 INFO - 'LANGUAGE': 'en_US:en', 10:14:59 INFO - 'LOGNAME': 'cltbld', 10:14:59 INFO - 'MAIL': '/var/mail/cltbld', 10:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:59 INFO - 'MOZ_NO_REMOTE': '1', 10:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:59 INFO - 'NO_EM_RESTART': '1', 10:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:59 INFO - 'PWD': '/builds/slave/test', 10:14:59 INFO - 'SHELL': '/bin/bash', 10:14:59 INFO - 'SHLVL': '1', 10:14:59 INFO - 'TERM': 'linux', 10:14:59 INFO - 'TMOUT': '86400', 10:14:59 INFO - 'USER': 'cltbld', 10:14:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', 10:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:59 INFO - '_': '/tools/buildbot/bin/python'} 10:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:59 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)) 10:14:59 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)) 10:14:59 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)) 10:14:59 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)) 10:14:59 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)) 10:14:59 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)) 10:14:59 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)) 10:14:59 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)) 10:14:59 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)) 10:14:59 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)) 10:14:59 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)) 10:14:59 INFO - Cleaning up... 10:14:59 INFO - Return code: 0 10:14:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5dcd450f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf05090>, '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 0xf089b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08e40>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', '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 10:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:14:59 INFO - Using env: {'DISPLAY': ':0', 10:14:59 INFO - 'HOME': '/home/cltbld', 10:14:59 INFO - 'LANG': 'en_US.UTF-8', 10:14:59 INFO - 'LANGUAGE': 'en_US:en', 10:14:59 INFO - 'LOGNAME': 'cltbld', 10:14:59 INFO - 'MAIL': '/var/mail/cltbld', 10:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:59 INFO - 'MOZ_NO_REMOTE': '1', 10:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:59 INFO - 'NO_EM_RESTART': '1', 10:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:59 INFO - 'PWD': '/builds/slave/test', 10:14:59 INFO - 'SHELL': '/bin/bash', 10:14:59 INFO - 'SHLVL': '1', 10:14:59 INFO - 'TERM': 'linux', 10:14:59 INFO - 'TMOUT': '86400', 10:14:59 INFO - 'USER': 'cltbld', 10:14:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', 10:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:59 INFO - '_': '/tools/buildbot/bin/python'} 10:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:15:00 INFO - Cleaning up... 10:15:00 INFO - Return code: 0 10:15:00 INFO - Running post-action listener: _resource_record_post_action 10:15:00 INFO - Running post-action listener: _start_resource_monitoring 10:15:00 INFO - Starting resource monitoring. 10:15:00 INFO - [mozharness: 2016-08-16 17:15:00.079569Z] Finished create-virtualenv step (success) 10:15:00 INFO - [mozharness: 2016-08-16 17:15:00.080065Z] Running install step. 10:15:00 INFO - Running pre-action listener: _resource_record_pre_action 10:15:00 INFO - Running main action method: install 10:15:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:15:00 INFO - Reading from file tmpfile_stdout 10:15:00 INFO - Detecting whether we're running mozinstall >=1.0... 10:15:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:15:00 INFO - Reading from file tmpfile_stdout 10:15:00 INFO - Output received: 10:15:00 INFO - Usage: mozinstall [options] installer 10:15:00 INFO - Options: 10:15:00 INFO - -h, --help show this help message and exit 10:15:00 INFO - -d DEST, --destination=DEST 10:15:00 INFO - Directory to install application into. [default: 10:15:00 INFO - "/builds/slave/test"] 10:15:00 INFO - --app=APP Application being installed. [default: firefox] 10:15:00 INFO - mkdir: /builds/slave/test/build/application 10:15:00 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'] 10:15:00 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 10:15:16 INFO - Reading from file tmpfile_stdout 10:15:16 INFO - Output received: 10:15:16 INFO - /builds/slave/test/build/application/firefox/firefox 10:15:16 INFO - Running post-action listener: _resource_record_post_action 10:15:16 INFO - [mozharness: 2016-08-16 17:15:16.454870Z] Finished install step (success) 10:15:16 INFO - [mozharness: 2016-08-16 17:15:16.455117Z] Running run-tests step. 10:15:16 INFO - Running pre-action listener: _resource_record_pre_action 10:15:16 INFO - Running main action method: run_tests 10:15:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:15:16 INFO - Python 2.7.3 10:15:16 INFO - Return code: 0 10:15:16 INFO - grabbing minidump binary from tooltool 10:15:16 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')]} 10:15:16 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 0xf05090>, '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 0xf089b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf08e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:15:16 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 10:15:16 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 10:15:16 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 10:15:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:15:16 INFO - Return code: 0 10:15:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:15:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:15:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:15:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:15:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:15:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 10:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 10:15:16 INFO - Using env: {'DISPLAY': ':0', 10:15:16 INFO - 'HOME': '/home/cltbld', 10:15:16 INFO - 'LANG': 'en_US.UTF-8', 10:15:16 INFO - 'LANGUAGE': 'en_US:en', 10:15:16 INFO - 'LOGNAME': 'cltbld', 10:15:16 INFO - 'MAIL': '/var/mail/cltbld', 10:15:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:15:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:16 INFO - 'MOZ_NO_REMOTE': '1', 10:15:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:16 INFO - 'NO_EM_RESTART': '1', 10:15:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:16 INFO - 'PWD': '/builds/slave/test', 10:15:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:15:16 INFO - 'SHELL': '/bin/bash', 10:15:16 INFO - 'SHLVL': '1', 10:15:16 INFO - 'TERM': 'linux', 10:15:16 INFO - 'TMOUT': '86400', 10:15:16 INFO - 'USER': 'cltbld', 10:15:16 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266', 10:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:16 INFO - '_': '/tools/buildbot/bin/python'} 10:15:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 10:15:16 INFO - mozversion application_buildid: 20160816092617 10:15:16 INFO - mozversion application_changeset: 19455d8adc072d1b64d9a29af492258cd9c6480e 10:15:16 INFO - mozversion application_display_name: Nightly 10:15:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:15:16 INFO - mozversion application_name: Firefox 10:15:16 INFO - mozversion application_remotingname: firefox 10:15:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 10:15:16 INFO - mozversion application_vendor: Mozilla 10:15:16 INFO - mozversion application_version: 51.0a1 10:15:16 INFO - mozversion platform_buildid: 20160816092617 10:15:16 INFO - mozversion platform_changeset: 19455d8adc072d1b64d9a29af492258cd9c6480e 10:15:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 10:15:16 INFO - mozversion platform_version: 51.0a1 10:15:16 INFO - using testdate: 1471367716 10:15:16 INFO - actual date: 1471367716 10:15:16 INFO - starting webserver on 'localhost:46236' 10:15:16 INFO - SUITE-START | Running 2 tests 10:15:16 INFO - TEST-START | dromaeo_css 10:15:16 INFO - operating with platform_type : linux_ 10:15:16 INFO - Initialising browser for dromaeo_css test... 10:15:16 INFO - TEST-INFO | started process 24724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptS9abx/profile http://localhost:46236/getInfo.html) 10:15:21 INFO - PROCESS | 24724 | __metrics Screen width/height:1600/1200 10:15:21 INFO - PROCESS | 24724 | colorDepth:24 10:15:21 INFO - PROCESS | 24724 | Browser inner width/height: 1024/697 10:15:21 INFO - PROCESS | 24724 | __metrics 10:15:21 INFO - PROCESS | 24724 | 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" 10:15:21 INFO - PROCESS | 24724 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:15:22 INFO - TEST-INFO | 24724: exit 0 10:15:22 INFO - Browser initialized. 10:15:22 INFO - Running cycle 1/1 for dromaeo_css test... 10:15:22 INFO - TEST-INFO | started process 24806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptS9abx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:15:34 INFO - PROCESS | 24806 | RSS: Main: 157077504 10:15:34 INFO - PROCESS | 24806 | 10:16:25 INFO - PROCESS | 24806 | 1471367785610 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] 10:18:39 INFO - PROCESS | 24806 | Cycle 1(1): loaded http://localhost:46236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46236/tests/dromaeo/cssquery-ext.html) 10:18:40 INFO - PROCESS | 24806 | RSS: Main: 271982592 10:18:40 INFO - PROCESS | 24806 | 10:21:43 INFO - PROCESS | 24806 | Cycle 1(1): loaded http://localhost:46236/tests/dromaeo/cssquery-ext.html (next: http://localhost:46236/tests/dromaeo/cssquery-jquery.html) 10:21:44 INFO - PROCESS | 24806 | RSS: Main: 245035008 10:21:44 INFO - PROCESS | 24806 | 10:24:46 INFO - PROCESS | 24806 | Cycle 1(1): loaded http://localhost:46236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46236/tests/dromaeo/cssquery-mootools.html) 10:24:47 INFO - PROCESS | 24806 | RSS: Main: 190205952 10:24:47 INFO - PROCESS | 24806 | 10:27:49 INFO - PROCESS | 24806 | Cycle 1(1): loaded http://localhost:46236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46236/tests/dromaeo/cssquery-prototype.html) 10:27:49 INFO - PROCESS | 24806 | RSS: Main: 190066688 10:27:49 INFO - PROCESS | 24806 | 10:30:52 INFO - PROCESS | 24806 | Cycle 1(1): loaded http://localhost:46236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46236/tests/dromaeo/cssquery-yui.html) 10:30:53 INFO - PROCESS | 24806 | RSS: Main: 190132224 10:30:53 INFO - PROCESS | 24806 | 10:33:56 INFO - PROCESS | 24806 | Cycle 1(1): loaded http://localhost:46236/tests/dromaeo/cssquery-yui.html (next: http://localhost:46236/tests/dromaeo/cssquery-dojo.html) 10:33:56 INFO - PROCESS | 24806 | RSS: Main: 277999616 10:33:56 INFO - PROCESS | 24806 | 10:33:56 INFO - PROCESS | 24806 | __start_tp_report 10:33:56 INFO - PROCESS | 24806 | _x_x_mozilla_page_load 10:33:56 INFO - PROCESS | 24806 | _x_x_mozilla_page_load_details 10:33:56 INFO - PROCESS | 24806 | |i|pagename|runs| 10:33:56 INFO - PROCESS | 24806 | |0;dojo.html;2656.4687062587486;2692.8922843086275;2706.905258315959;2734.1934129431816;2744.6294750208726;4675.111728771531;4770.451398089221;4823.734694591796;4847.248676455146;4850.175470170071;4760.690555113915;4763;4792.592629626477;4800.9519904800945;4828.927566086502;4326.632236259922;4361.3676016977515;4422.845200417986;4467.865964021084;4568.565986231302;4483.820647174109;4520.186366454037;4549.499555048942;4560.726356418609;4574.405327307462;4304.5910638489295;4333.4366532350905;4341.630961368288;4410.933835992462;4423.1153769246275;4390.868273951786;4396.450443694538;4397.670174736875;4401.713888597263;4403.911921761579;4324.718893271959;4326.113146804897;4372.781360931973;4393.51671316155;4417.160739459492;4709.764511774431;4719.480857105716;4748.477667456577;4784.186688263004;4813.133635945528;5110.66780659256;5151.2530683050745;5160.303359046518;5163.586913046947;5166.586673066184;5043.293938848564;5124.052050370656;5185.922211166836;5187.922181167285;5210.166373380241;4833.275008748646;4870.2938073979785;4875.024995001014;4876.414830220326;4887.560119589254;5107.489251074937;5336.332958380202;5341.759620817073;5347.25138480613;5347.679139251657;4999.42506611737;5045.974770126126;5049;5055.292259083732;5112.488751124858;5169;5170.276161337416;5179.249008893689;5209.895802083937;5216.947830521722;4987.127252730757;5094.719790411563;5110.003549307924;5110.923336149961;5170.767315470813;5007.123753343223;5039.974800125976;5070.138076527;5137.563307118862;5145.022445735298;4302.569743025672;4310.956890431055;4311.611954924072;4350.58669426404;4354.129174165179;3772.811359432072;3788.734788564774;3792.924141517154;3819.4270859370763;3833.463315135883;4388.4953230378915;4439.866803995886;4492.640588752892;4511.300748384006;4553.066621342617;5211.270422140903;5217.295665085241;5221.347331583552;5259.526642602108;5259.815906443256;4488.371627972087;4512.774361281923;4522.321651752263;4524.6380289576755;4565.611922986517;4501.572350626685;4551.067031258584;4596.724196548218;4653.557911998422;4689.531046895283;4865.781039853286;4877.585405240594;4879.4876537963;4898.951010489992;4922.335484709519;5121.462246464068;5157.716325601978;5162.535371816554;5165.560927321219;5208.0365132450615;4772.902232486478;4809.470958194665;4833.4441539223435;4880.974995251037;4934.087193869145;5057.216131499624;5059.443461219189;5059.797608095635;5078.187490001582;5080.593552515864;5114.232865070269;5127.92308115386;5129.948700512947;5130.102232109441;5178.300929374637;4842.176829938849;4945.901081978413;5001.474845141353;5010.974945125251;5015.874603134805;5025.346704928336;5025.673331233458;5027.446980832033;5053.166227572409;5056.82301119459;4950.925736113889;5013.623978201576;5017.347744793154;5018.146915024382;5019.247112933089;4938.728369939688;4984.252362145708;5028.069807085554;5057.418396884405;5077.898442031213;4951;4953.405591328919;4959.404871415453;4982.725950072636;4990.101781679333 10:33:56 INFO - PROCESS | 24806 | |1;ext.html;561.9747111379987;566.940471250519;567.9091345384738;576.9509591684706;580.2427831679659;28683.713162868364;30871.691283087217;30900.91846785363;31052.844735776318;38431.23137537255;36300;40102.39846402306;40269.19461610766;40298.79850600743;40305.19389612206;7634.465587408884;7767.417443691746;7772.727954521592;7783.377329813601;7783.727569535067;7388.298111679409;7553.131389890178;7665.846683066336;7764.534127952313;7782.027246594176;7621.314081732643;7675.5010924289745;9859.605615775361;10138.442385668784;10139.290249682525;10061.19510439163;10111.89888101117;10122.54448549817;10135.797284054277;10136.341137826055;9952.104310612007;10030;10032.297739158263;10034.89965100347;10036.046575575308;37255.62744372548;37658.8117059413;37674;37696;37778.055548611504;3017.6529699084667;3103.3638104188585;3275.7870738402166;3293.818839963801;3617.475466057433;28060.719392806015;28121.29696757577;28293.85853070742;28706;28812.711872881213;3482.982585087084;3542.3092496963104;3564.590072141685;3565.8395372208315;3611.801350925698;249335;249637.9999999982;250422;250646;252109;50691.23963140556;51061.48938510568;51090.48909510932;51095.48904510982;51124;32251.677483225336;32813.34373312568;33144.50283245753;34784.130396740286;34803.65196348004;11926.821097683542;12171.391430428443;12184.81722774159;12187.75624487523;12201.084918631139;8334.20825021622;8482;8483.109273526314;8483.533405662625;8496.235338819535;15444.837722718828;17487;17515.73726394105;17568.486302739504;17795.110244487725;6175.814725558241;6622.602643841385;6835.692393842289;6860.142482189726;6907.13660792401;780.8282177920848;810.9472884262622;857.5583574459158;864.2178828160525;967.7096870938831;27138.457230855667;27476;27512.862435687694;27862.67333881079;28354;898.8427025270552;908.8091500784909;922.7462447826902;967.5259123029806;984.2863923655435;13952.302384880715;14576.794699347467;14657.560273191608;14821.258937053104;14963.551093467213;393893;396957;398923;399004;400038;48605.75697121492;49136.508634913196;49156.75421622869;49406.25890611644;49441.50558494441;1137.4881303413497;1162.3839365136491;1166.0321932795928;1166.288563975974;1167.6555416152255;25165.622515662646;26107;26642.467150656492;26852;26932.326691832863;40491.39262911;46116;47311;47381.52618473771;51670.48329516807;349447;353286;353289;353639;356042;31757;31880;37632.623673762915;37824.43263350997;38375.616243837205;31923;35708.64291357053;39704.404433932934;40057.1988560233;40437;33418;34218.315633687685;35495.822520888265;35609.64390356167;35896.820515897256;34920.12699682426;35433.393658824185;35470.822645886605;35515;35792.64207357997;34913;35202.64797351994;35246;35867.64132358643;35939.46090808588;30723.692763072082;32061.793820617753;32982.175445614055;33133;33178;24630.753692463564;24711.62932556049;25105.87447062753;25242.699053173565;25444.618330725425 10:33:56 INFO - PROCESS | 24806 | |2;jquery.html;333.0624292616283;340.88750712264937;351.8610148991148;354.7091385064248;371.49662207708553;12814.679633009167;15908.363665453382;16556.58608534786;17012.82987170128;17926.731099033525;16589.751153732705;16737.665246695058;17441;17605.91197044016;17626.206820693067;4872.65891387603;4904.681195722275;4997.900041999158;5034.521720436571;5040.092783299005;3745;4984.950150498485;5066.392032956032;5664.830055098333;5950.166976623276;5977.222961015062;5997.940020599782;6007.939920600782;6010.308814486346;6014.4286292802335;5189.662671926331;5480.725963701839;5506.063969125258;5576.86057848553;6009.609375390585;5387.622866399353;5394.91907621386;5400.891982160335;5401.621886467949;5402;19457.902710486356;20188;20221.39335819928;20441.897790510953;20684.48288792777;1938.6122775444967;1957.618264438435;2072.347210628662;2230.9330720078424;2446.788839524429;9290.953545232298;9331.113544213289;9475;9517.809643807084;9891.653792117242;1767.9558011049699;1800.8664923033957;1817.8273064058894;1835.2842391467339;1841.7513635659147;67720;68362.3163768361;69248;69366.30633693648;69551.65224173847;10062.69811905644;10161.339512931636;10283.742906427398;10459.633912813015;11026.889731102747;14013.509527166703;14017.369218385196;14052.508162214477;14077.436902523988;14102.435902563782;6337.461315788118;6552;6563;6687.565308254948;6692.665366731644;5845.1232315153065;5875.764969401262;6026.337102918676;6029.155918171459;6031.366706495754;4416.4258646375765;4417.337399390053;4427.2252355838245;4459.509453960061;4560.794764235618;1786.7855857296947;1842.1986435900426;1845.2526726675717;1864.0959134819602;1879.248300679739;794.4518282385136;852.5992783391796;865.8268346330759;928.4661319741041;929.972100836976;16602;17706;17735.201915913814;17895.910520447316;18218.180181891847;822.880682301063;842.5450256861226;852.7527017165077;861.8965724113147;890.6882591093066;9374.359487089732;10321.535530901128;10368.170546356274;10696.251262411557;10707.196960228013;281566.7649852497;282735;283210;391265;395571;76628;78714;79303.60348198337;80655.59672201719;81370.59314703508;918.2562124678898;931.6413180925392;980.4999450280266;980.563649176124;981.1562056631292;15793.763093553376;16080.678386431971;16250.51248462548;16923.23845426934;17142.742858856876;37131.07172320713;37472.250554989296;37681.81159094187;38467;38666.36003679464;52164.739176303876;52365.21452178144;52789;52913.470865292395;53518.464815352905;7758.728444504415;7931.444798864024;7955.880661789962;8060.31487323584;8140.348772098337;11293.830592541282;11411.315321080761;11503.884961150281;11726.120540959633;12141.575044873387;6371.840703982438;9985.301028927905;10000.24998125129;10186.592536298465;10379.740506487398;9672;9894.356866803635;9915.900840991786;10179.491025448846;10278.126359259248;10077.69766906994;10087.243456740627;10225.647544891102;10288.742781430225;10576.682699519026;7548.346232259757;7714.652840622298;7754;7775.533467991939;7884.1327453978865;7372.82968323626;8264.297534709616;9863.506824658594;10050.396976181453;10279.434631095362 10:33:56 INFO - PROCESS | 24806 | |3;mootools.html;1223.3699644682983;1305.7649623067846;1358.3547814787978;1385.314269436629;1629.967400651987;6773.221079575844;7438.516496427728;7699.268569485904;7716.189800070989;7964.323032542241;7743.961280193591;7795.454318197714;7809.60951952403;7811;7817.960910195456;2167.880766557839;2178.3573845715473;2187.2344679362254;2188.1575593396497;2189.036823797532;2131.5523740014614;2186.0599942024924;2195.5718634866207;2199.9340019799433;2206.8013878750908;2165.664322030088;2176.847620666554;2191.0359441845617;2196.2203417786695;2203.019656252968;2121.1197353098446;2122.1829595605727;2123.968140477894;2126.5002724359765;2126.723525941633;2055.547779488525;2113.947151321214;2114.7990940860595;2116.9576608467896;2117.3118736410574;7679.57762323072;7811.1017233018365;7857.2928436440425;7956.204379562056;7968.60156992148;4456.19788438081;4588.701734387254;4592;4595.379623750784;4596.839110631112;2819.8731057102273;2937.1775902747263;2970.598969139182;2972.9256768580744;2986.1937276935105;864.4856310495245;880.3265501891059;884.823035392924;885.9734207973771;897.4839467306259;10706.518206680717;10766.084882784973;10778.083862871665;10804.891951080468;10824.837627435594;3830.697562828596;4038;4070.430139780433;4135.048938744106;4156.667466602665;8459.111793261742;8480.491170529665;8481.491110533389;8486.830263394697;8491.830163396697;4413;4425.911481770347;4438.068005718836;4438.378626992224;4443.822247110144;3650.2699460107556;4002.399640053957;4076.286649836267;4076.5311989121633;4141.544430112685;3385.119868834121;3402.7447941404494;3516.191276006533;3518.7536872418686;3532.364174448624;989.6486747204783;993.8757655293089;1008.2135933971514;1009.6365308488938;1019.9490025498844;758.5789886612982;788;796;809.7773112394138;815.4740192575755;4875.293082503017;4894.486078961729;4989.401271847329;5097.08252514551;5231.843044708665;416.7207970659665;424.73241857629495;424.79185199252146;426.1073051956147;429.29809761040923;3460.3425349183576;3477.6522347765526;3491.8428670709877;3515.3848076586496;3559.982200088983;9536.28477864163;9772.071653192936;9863.605455781832;9884.061014203638;9894.653687120915;9800.901990979999;9808;9816.165625921734;9818.901810981799;9821.312508124363;7259.709611615582;7283.817904552323;7360.447966402541;7418.851622967511;7466.664000120008;5049.899002019865;5056.241563765465;5056.418511871182;5086.28791969132;5136.794528218829;8826.867596986178;8867.68963086289;8958.641654333753;8968.506732129796;8977.326700497359;8999.19007289347;9160.450372977642;9220.400673956172;9229.815403691755;9231.630734770533;5800;6342.841428964312;6553.115329430466;6608.140941677551;6614.173228346457;7601.277878601524;7688;7718.266764657348;7739.729109481141;7746.535207887545;6734.730610775514;6747.089142965637;6776.7628133015105;6832.897506537505;7002.649867506502;6744.426723728538;6754;6900.827479313058;6976.7558135465015;7000.50996430245;6222.28443728977;6310.5898116622275;6320.810375688737;6322.873542529215;6323.430891219812;4296.011917258986;4315.438992930899;4408;4472.1502914446155;4475.977620111878;4349.869503914888;4397.597526165465;4488.349189367589;4499.730016199039;4636.327732478839 10:33:56 INFO - PROCESS | 24806 | |4;prototype.html;294.41117764471056;298.83116039437715;302.3529646556369;304.08470503783633;305.6378191842665;4838.250071238955;4854.4174699036075;4855.7086574805535;4855.927161092582;4869.318295438641;4767.737774422405;4779.426468823737;4789.257665061912;4812.15787237233;4813.951860481394;3567.3757092508836;3681.392570225923;3691.187938653492;3700.9259814803686;3711.4061750119986;3580.5166302549083;3710.8701195458166;3745.606711295302;3776.5090538229992;3793.3172029034763;3739.5699494558066;3759.0602349412648;3759.2669429461266;3772.0192749884955;3782.1301100746846;3596.2447885943984;3751.1747415568666;3756.417755247941;3757.981210093932;3764.5106136202394;3123.890663826778;3204.3110731192673;3276.57404537411;3290.3748287825474;3309.834508274601;4645.651576131803;4646.930296045562;4648.163330600491;4650.837220697259;4657.278121891112;4234.745915245096;4244.639205667522;4244.745315281062;4247.957520424818;4258.659307255412;4735.195016847144;4964.120809930232;4982.185065438016;4988.102141614544;4990.351254336913;3564.429691249388;3567.8751243706347;3568.8230179590428;3578.8389522471552;3585.8924232273075;5272.209168624699;5274.604404669627;5281.577473802125;5291.603129765283;5306.92039619406;3620.7827530348263;3621.2576421833987;3629.7277704172293;3631.7094632429344;3632.5096112025067;3555.8044307562814;3626.800525971044;3642.8907132786057;3647.5805282392334;3662.597114317423;4191.76342978822;4191.811368488426;4206.642435392964;4222.59885310895;4224.1129362834145;5020.47285035066;5025.899482010413;5043.293938848564;5053.978408636574;5058.898822023539;1226.8159776033488;1250.5060501102014;1250.8123781432857;1254.7365053338901;1271.6630093025356;789.128013545036;796.5021861336664;814.4828034198208;816.7345612675786;820.5568992743971;3991.691050902293;4001.6998725095737;4024.9798751006056;4046.523019098008;4058.127502586899;4590.54094590545;4611;4620.752396852831;4633.675642705046;4648.837290694877;4059.330210515291;4062.6343629073526;4071.206114807584;4098.159877225162;4125.071858831739;2342.695449591542;2434.9529702227856;2447.596146635821;2459.8561668823727;2470.5800013997664;4676.742779147112;4819.277108433763;4920.040592084581;4945.55490005894;4955.851324460272;5308.681479111266;5314.601404894571;5327.973360133252;5329.120695085345;5337.466253374709;4744.027474367677;4919.204490360992;4957.405111386656;4959.454460009396;4965.155923492943;5146.356705411824;5154.587632989427;5183.585313174862;5189.6886186828915;5198.324217851655;5123.769430375568;5132.666376685504;5133.383993920754;5137.2037334213255;5163.5610973066205;4729.3993193816605;4922.581580565548;4928.654994150518;4928.778204980713;4937.284093806306;3682.208325210093;3718.9628103719697;3721.5720192178246;3726.9440958385103;3748.306563285801;5163.328767260232;5197.726556993561;5214.608904332114;5235.973820130875;5243.449437808975;4791.592714619296;5056.82301119459;5060.532445590738;5070.746462676778;5075.137226671401;5018.4981501849525;5046.21783623539;5057.772400242072;5065.39215294167;5090.516400941905;5006.374203224597;5023.497650234947;5026.798928042837;5033.84898453047;5044.293798868088;4893;5119.360079990001;5132.9743351283005;5133.358330208724;5138.76875540609;4976.800927962841;4997.175466048061;5003.499650034967;5017.147084995487;5023.191651005708 10:33:56 INFO - PROCESS | 24806 | |5;yui.html;607.9179310793043;677.3429773120072;677.9221038548707;689.331348591866;752.2627824731762;13263.93368033161;13915.58253252404;13960.650983725387;13964.790528142074;14173.433062677494;13384.464621415156;13501.2574308413;13535.458581656721;13540.322983850818;13546.593602191926;610.3377835048977;729.2998721227627;749.8612756640039;768.2356055724562;771.3173841150566;762.2606072110073;770.2567022822975;771.4484143837155;772.5673622771238;773.342658740072;810.7040930060544;811.2050190813006;812.9715459958902;813.1340122769261;813.9837203255931;637.3594537489839;772.7102336623766;794.8648729715962;803.9437239393216;805.7784109369941;592.0349829777479;593.0067137544596;593.4362355762;593.4510577715596;593.9049752039696;12801.871981280161;12841.87158128416;12846.100772945898;12848.357582120856;12876.871231287754;12039;12101.757964840743;12517.146605346225;12555.309457979807;12802.48790048397;11704.763843850453;11803;12032.458539365749;12361.07291953107;12681.907485265012;4082.632563069308;4130.297849365585;4188.874333769992;4194.2450358935375;4194.622483976456;61698.69150654218;62660.37339626637;62821;62833.68583157055;63839;10060.295779295526;10416.322939009091;10504.789904201873;10614.89385106139;10784.299020563638;16942.661146776994;17039.91480042592;17077.402290920007;17186.65626687484;17219.82780172182;6405.35946405365;6598.274189839114;6727.93272067273;6845.520813543104;6935.965320173468;3643.708503319728;3677.374846276086;3684.4841722158917;3738.1776009277914;3807.7905715185375;2693.8383696978244;2794.720527947189;2797.1468702046072;2802.047303916678;2805.228562145426;449.5594317568801;458.2416101352267;462.83569332887015;469.2234352147134;493.5582653525075;407.7573843563075;483.6348556839634;528.6527816494751;534.9919751203735;558.4359796605377;7007.684654190573;7075.292470752884;7329.486935914541;7332.926670733331;7773.183815699384;428.63734006717874;520.8359366799446;564.5540023381483;564.906790379591;584.187978709594;3751.643593858579;3768.340540405473;3792.8482860685262;3824.29250588642;3869.8390482855593;90791;91562;91991.54004229936;93892.53053734687;93987;79628.60185699034;81486.59256703679;81907;82330.58834705788;83970.16029839746;71571.98996070225;71807.64096179485;73508.63245683737;73617.6319118401;74130.25869741342;7291.41668666516;7430.814229644302;7687.615619218905;7914.643841027052;7942.205779422012;40771.59228407678;42119.31522739056;42545.149097018504;42668.14663706771;42897.49293873497;53682.19476707931;54363.72818135884;57595;65851.34148658453;67203.32796672166;10284.177265818567;11100.61147859821;11120.833187502032;11351.37567433799;11931.582394616147;11431.371274579978;11948.34284114382;12388.752224955631;13061;13119.934400327937;8581.442206256574;10936.179786515884;11419.200655954004;11998.940005299917;12011.4594843234;9753.903360588713;10113.19094472455;10119.595216191565;10389.584416623553;10483.37099774016;9869.161121304769;10481.37111773296;10829.350238985686;11534.077273817906;11721.941390292994;9360.391574547633;9426.245900328095;9568.521573921415;9751.902480975099;9848.409095454295;9194.678186263449;9349.158575727944;9579;9618.855717164388;9963.402195868272 10:33:56 INFO - PROCESS | 24806 | __end_tp_report 10:33:56 INFO - PROCESS | 24806 | __start_cc_report 10:33:56 INFO - PROCESS | 24806 | _x_x_mozilla_cycle_collect,1142 10:33:56 INFO - PROCESS | 24806 | __end_cc_report 10:33:56 INFO - PROCESS | 24806 | __startTimestamp1471368836947__endTimestamp 10:33:56 INFO - PROCESS | 24806 | 10:33:56 INFO - PROCESS | 24806 | ------- Summary: start ------- 10:33:56 INFO - PROCESS | 24806 | Number of tests: 6 10:33:56 INFO - PROCESS | 24806 | 10:33:56 INFO - PROCESS | 24806 | [#0] dojo.html Cycles:165 Average:4759.74 Median:4887.56 stddev:499.20 (10.2%) stddev-sans-first:472.67 10:33:56 INFO - PROCESS | 24806 | Values: 2656.5 2692.9 2706.9 2734.2 2744.6 4675.1 4770.5 4823.7 4847.2 4850.2 4760.7 4763.0 4792.6 4801.0 4828.9 4326.6 4361.4 4422.8 4467.9 4568.6 4483.8 4520.2 4549.5 4560.7 4574.4 4304.6 4333.4 4341.6 4410.9 4423.1 4390.9 4396.5 4397.7 4401.7 4403.9 4324.7 4326.1 4372.8 4393.5 4417.2 4709.8 4719.5 4748.5 4784.2 4813.1 5110.7 5151.3 5160.3 5163.6 5166.6 5043.3 5124.1 5185.9 5187.9 5210.2 4833.3 4870.3 4875.0 4876.4 4887.6 5107.5 5336.3 5341.8 5347.3 5347.7 4999.4 5046.0 5049.0 5055.3 5112.5 5169.0 5170.3 5179.2 5209.9 5216.9 4987.1 5094.7 5110.0 5110.9 5170.8 5007.1 5040.0 5070.1 5137.6 5145.0 4302.6 4311.0 4311.6 4350.6 4354.1 3772.8 3788.7 3792.9 3819.4 3833.5 4388.5 4439.9 4492.6 4511.3 4553.1 5211.3 5217.3 5221.3 5259.5 5259.8 4488.4 4512.8 4522.3 4524.6 4565.6 4501.6 4551.1 4596.7 4653.6 4689.5 4865.8 4877.6 4879.5 4899.0 4922.3 5121.5 5157.7 5162.5 5165.6 5208.0 4772.9 4809.5 4833.4 4881.0 4934.1 5057.2 5059.4 5059.8 5078.2 5080.6 5114.2 5127.9 5129.9 5130.1 5178.3 4842.2 4945.9 5001.5 5011.0 5015.9 5025.3 5025.7 5027.4 5053.2 5056.8 4950.9 5013.6 5017.3 5018.1 5019.2 4938.7 4984.3 5028.1 5057.4 5077.9 4951.0 4953.4 4959.4 4982.7 4990.1 10:33:56 INFO - PROCESS | 24806 | 10:33:56 INFO - PROCESS | 24806 | [#1] ext.html Cycles:180 Average:47871.26 Median:35483.32 stddev:89545.34 (252.4%) stddev-sans-first:89726.09 10:33:56 INFO - PROCESS | 24806 | Values: 562.0 566.9 567.9 577.0 580.2 28683.7 30871.7 30900.9 31052.8 38431.2 36300.0 40102.4 40269.2 40298.8 40305.2 7634.5 7767.4 7772.7 7783.4 7783.7 7388.3 7553.1 7665.8 7764.5 7782.0 7621.3 7675.5 9859.6 10138.4 10139.3 10061.2 10111.9 10122.5 10135.8 10136.3 9952.1 10030.0 10032.3 10034.9 10036.0 37255.6 37658.8 37674.0 37696.0 37778.1 3017.7 3103.4 3275.8 3293.8 3617.5 28060.7 28121.3 28293.9 28706.0 28812.7 3483.0 3542.3 3564.6 3565.8 3611.8 249335.0 249638.0 250422.0 250646.0 252109.0 50691.2 51061.5 51090.5 51095.5 51124.0 32251.7 32813.3 33144.5 34784.1 34803.7 11926.8 12171.4 12184.8 12187.8 12201.1 8334.2 8482.0 8483.1 8483.5 8496.2 15444.8 17487.0 17515.7 17568.5 17795.1 6175.8 6622.6 6835.7 6860.1 6907.1 780.8 810.9 857.6 864.2 967.7 27138.5 27476.0 27512.9 27862.7 28354.0 898.8 908.8 922.7 967.5 984.3 13952.3 14576.8 14657.6 14821.3 14963.6 393893.0 396957.0 398923.0 399004.0 400038.0 48605.8 49136.5 49156.8 49406.3 49441.5 1137.5 1162.4 1166.0 1166.3 1167.7 25165.6 26107.0 26642.5 26852.0 26932.3 40491.4 46116.0 47311.0 47381.5 51670.5 349447.0 353286.0 353289.0 353639.0 356042.0 31757.0 31880.0 37632.6 37824.4 38375.6 31923.0 35708.6 39704.4 40057.2 40437.0 33418.0 34218.3 35495.8 35609.6 35896.8 34920.1 35433.4 35470.8 35515.0 35792.6 34913.0 35202.6 35246.0 35867.6 35939.5 30723.7 32061.8 32982.2 33133.0 33178.0 24630.8 24711.6 25105.9 25242.7 25444.6 10:33:56 INFO - PROCESS | 24806 | 10:33:56 INFO - PROCESS | 24806 | [#2] jquery.html Cycles:180 Average:22676.86 Median:4510.15 stddev:55302.23 (1226.2%) stddev-sans-first:55431.92 10:33:56 INFO - PROCESS | 24806 | Values: 333.1 340.9 351.9 354.7 371.5 12814.7 15908.4 16556.6 17012.8 17926.7 16589.8 16737.7 17441.0 17605.9 17626.2 4872.7 4904.7 4997.9 5034.5 5040.1 3745.0 4985.0 5066.4 5664.8 5950.2 5977.2 5997.9 6007.9 6010.3 6014.4 5189.7 5480.7 5506.1 5576.9 6009.6 5387.6 5394.9 5400.9 5401.6 5402.0 19457.9 20188.0 20221.4 20441.9 20684.5 1938.6 1957.6 2072.3 2230.9 2446.8 9291.0 9331.1 9475.0 9517.8 9891.7 1768.0 1800.9 1817.8 1835.3 1841.8 67720.0 68362.3 69248.0 69366.3 69551.7 10062.7 10161.3 10283.7 10459.6 11026.9 14013.5 14017.4 14052.5 14077.4 14102.4 6337.5 6552.0 6563.0 6687.6 6692.7 5845.1 5875.8 6026.3 6029.2 6031.4 4416.4 4417.3 4427.2 4459.5 4560.8 1786.8 1842.2 1845.3 1864.1 1879.2 794.5 852.6 865.8 928.5 930.0 16602.0 17706.0 17735.2 17895.9 18218.2 822.9 842.5 852.8 861.9 890.7 9374.4 10321.5 10368.2 10696.3 10707.2 281566.8 282735.0 283210.0 391265.0 395571.0 76628.0 78714.0 79303.6 80655.6 81370.6 918.3 931.6 980.5 980.6 981.2 15793.8 16080.7 16250.5 16923.2 17142.7 37131.1 37472.3 37681.8 38467.0 38666.4 52164.7 52365.2 52789.0 52913.5 53518.5 7758.7 7931.4 7955.9 8060.3 8140.3 11293.8 11411.3 11503.9 11726.1 12141.6 6371.8 9985.3 10000.2 10186.6 10379.7 9672.0 9894.4 9915.9 10179.5 10278.1 10077.7 10087.2 10225.6 10288.7 10576.7 7548.3 7714.7 7754.0 7775.5 7884.1 7372.8 8264.3 9863.5 10050.4 10279.4 10:33:56 INFO - PROCESS | 24806 | 10:33:56 INFO - PROCESS | 24806 | [#3] mootools.html Cycles:180 Average:5075.59 Median:5019.65 stddev:2929.19 (58.4%) stddev-sans-first:2923.11 10:33:56 INFO - PROCESS | 24806 | Values: 1223.4 1305.8 1358.4 1385.3 1630.0 6773.2 7438.5 7699.3 7716.2 7964.3 7744.0 7795.5 7809.6 7811.0 7818.0 2167.9 2178.4 2187.2 2188.2 2189.0 2131.6 2186.1 2195.6 2199.9 2206.8 2165.7 2176.8 2191.0 2196.2 2203.0 2121.1 2122.2 2124.0 2126.5 2126.7 2055.5 2113.9 2114.8 2117.0 2117.3 7679.6 7811.1 7857.3 7956.2 7968.6 4456.2 4588.7 4592.0 4595.4 4596.8 2819.9 2937.2 2970.6 2972.9 2986.2 864.5 880.3 884.8 886.0 897.5 10706.5 10766.1 10778.1 10804.9 10824.8 3830.7 4038.0 4070.4 4135.0 4156.7 8459.1 8480.5 8481.5 8486.8 8491.8 4413.0 4425.9 4438.1 4438.4 4443.8 3650.3 4002.4 4076.3 4076.5 4141.5 3385.1 3402.7 3516.2 3518.8 3532.4 989.6 993.9 1008.2 1009.6 1019.9 758.6 788.0 796.0 809.8 815.5 4875.3 4894.5 4989.4 5097.1 5231.8 416.7 424.7 424.8 426.1 429.3 3460.3 3477.7 3491.8 3515.4 3560.0 9536.3 9772.1 9863.6 9884.1 9894.7 9800.9 9808.0 9816.2 9818.9 9821.3 7259.7 7283.8 7360.4 7418.9 7466.7 5049.9 5056.2 5056.4 5086.3 5136.8 8826.9 8867.7 8958.6 8968.5 8977.3 8999.2 9160.5 9220.4 9229.8 9231.6 5800.0 6342.8 6553.1 6608.1 6614.2 7601.3 7688.0 7718.3 7739.7 7746.5 6734.7 6747.1 6776.8 6832.9 7002.6 6744.4 6754.0 6900.8 6976.8 7000.5 6222.3 6310.6 6320.8 6322.9 6323.4 4296.0 4315.4 4408.0 4472.2 4476.0 4349.9 4397.6 4488.3 4499.7 4636.3 10:33:56 INFO - PROCESS | 24806 | 10:33:56 INFO - PROCESS | 24806 | [#4] prototype.html Cycles:180 Average:4135.70 Median:4703.07 stddev:1231.06 (26.2%) stddev-sans-first:1200.28 10:33:56 INFO - PROCESS | 24806 | Values: 294.4 298.8 302.4 304.1 305.6 4838.3 4854.4 4855.7 4855.9 4869.3 4767.7 4779.4 4789.3 4812.2 4814.0 3567.4 3681.4 3691.2 3700.9 3711.4 3580.5 3710.9 3745.6 3776.5 3793.3 3739.6 3759.1 3759.3 3772.0 3782.1 3596.2 3751.2 3756.4 3758.0 3764.5 3123.9 3204.3 3276.6 3290.4 3309.8 4645.7 4646.9 4648.2 4650.8 4657.3 4234.7 4244.6 4244.7 4248.0 4258.7 4735.2 4964.1 4982.2 4988.1 4990.4 3564.4 3567.9 3568.8 3578.8 3585.9 5272.2 5274.6 5281.6 5291.6 5306.9 3620.8 3621.3 3629.7 3631.7 3632.5 3555.8 3626.8 3642.9 3647.6 3662.6 4191.8 4191.8 4206.6 4222.6 4224.1 5020.5 5025.9 5043.3 5054.0 5058.9 1226.8 1250.5 1250.8 1254.7 1271.7 789.1 796.5 814.5 816.7 820.6 3991.7 4001.7 4025.0 4046.5 4058.1 4590.5 4611.0 4620.8 4633.7 4648.8 4059.3 4062.6 4071.2 4098.2 4125.1 2342.7 2435.0 2447.6 2459.9 2470.6 4676.7 4819.3 4920.0 4945.6 4955.9 5308.7 5314.6 5328.0 5329.1 5337.5 4744.0 4919.2 4957.4 4959.5 4965.2 5146.4 5154.6 5183.6 5189.7 5198.3 5123.8 5132.7 5133.4 5137.2 5163.6 4729.4 4922.6 4928.7 4928.8 4937.3 3682.2 3719.0 3721.6 3726.9 3748.3 5163.3 5197.7 5214.6 5236.0 5243.4 4791.6 5056.8 5060.5 5070.7 5075.1 5018.5 5046.2 5057.8 5065.4 5090.5 5006.4 5023.5 5026.8 5033.8 5044.3 4893.0 5119.4 5133.0 5133.4 5138.8 4976.8 4997.2 5003.5 5017.1 5023.2 10:33:56 INFO - PROCESS | 24806 | 10:33:56 INFO - PROCESS | 24806 | [#5] yui.html Cycles:180 Average:17247.77 Median:524.74 stddev:24476.64 (4664.5%) stddev-sans-first:24513.42 10:33:56 INFO - PROCESS | 24806 | Values: 607.9 677.3 677.9 689.3 752.3 13263.9 13915.6 13960.7 13964.8 14173.4 13384.5 13501.3 13535.5 13540.3 13546.6 610.3 729.3 749.9 768.2 771.3 762.3 770.3 771.4 772.6 773.3 810.7 811.2 813.0 813.1 814.0 637.4 772.7 794.9 803.9 805.8 592.0 593.0 593.4 593.5 593.9 12801.9 12841.9 12846.1 12848.4 12876.9 12039.0 12101.8 12517.1 12555.3 12802.5 11704.8 11803.0 12032.5 12361.1 12681.9 4082.6 4130.3 4188.9 4194.2 4194.6 61698.7 62660.4 62821.0 62833.7 63839.0 10060.3 10416.3 10504.8 10614.9 10784.3 16942.7 17039.9 17077.4 17186.7 17219.8 6405.4 6598.3 6727.9 6845.5 6936.0 3643.7 3677.4 3684.5 3738.2 3807.8 2693.8 2794.7 2797.1 2802.0 2805.2 449.6 458.2 462.8 469.2 493.6 407.8 483.6 528.7 535.0 558.4 7007.7 7075.3 7329.5 7332.9 7773.2 428.6 520.8 564.6 564.9 584.2 3751.6 3768.3 3792.8 3824.3 3869.8 90791.0 91562.0 91991.5 93892.5 93987.0 79628.6 81486.6 81907.0 82330.6 83970.2 71572.0 71807.6 73508.6 73617.6 74130.3 7291.4 7430.8 7687.6 7914.6 7942.2 40771.6 42119.3 42545.1 42668.1 42897.5 53682.2 54363.7 57595.0 65851.3 67203.3 10284.2 11100.6 11120.8 11351.4 11931.6 11431.4 11948.3 12388.8 13061.0 13119.9 8581.4 10936.2 11419.2 11998.9 12011.5 9753.9 10113.2 10119.6 10389.6 10483.4 9869.2 10481.4 10829.4 11534.1 11721.9 9360.4 9426.2 9568.5 9751.9 9848.4 9194.7 9349.2 9579.0 9618.9 9963.4 10:33:56 INFO - PROCESS | 24806 | -------- Summary: end -------- 10:33:56 INFO - PROCESS | 24806 | 10:33:57 INFO - TEST-INFO | 24806: exit 0 10:33:57 INFO - TEST-OK | dromaeo_css | took 1120934ms 10:33:57 INFO - TEST-START | kraken 10:33:57 INFO - operating with platform_type : linux_ 10:33:57 INFO - Initialising browser for kraken test... 10:33:57 INFO - TEST-INFO | started process 25109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmtuRZt/profile http://localhost:46236/getInfo.html) 10:34:01 INFO - PROCESS | 25109 | __metrics Screen width/height:1600/1200 10:34:01 INFO - PROCESS | 25109 | colorDepth:24 10:34:01 INFO - PROCESS | 25109 | Browser inner width/height: 1024/697 10:34:01 INFO - PROCESS | 25109 | __metrics 10:34:02 INFO - PROCESS | 25109 | 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" 10:34:02 INFO - PROCESS | 25109 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:34:03 INFO - TEST-INFO | 25109: exit 0 10:34:03 INFO - Browser initialized. 10:34:03 INFO - Running cycle 1/1 for kraken test... 10:34:03 INFO - TEST-INFO | started process 25190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmtuRZt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:34:15 INFO - PROCESS | 25190 | RSS: Main: 157634560 10:34:15 INFO - PROCESS | 25190 | 10:34:18 INFO - PROCESS | 25190 | Cycle 1(1): loaded http://localhost:46236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46236/tests/kraken/driver.html?testName=audio-beat-detection) 10:34:19 INFO - PROCESS | 25190 | RSS: Main: 205086720 10:34:19 INFO - PROCESS | 25190 | 10:34:22 INFO - PROCESS | 25190 | Cycle 1(1): loaded http://localhost:46236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46236/tests/kraken/driver.html?testName=audio-dft) 10:34:22 INFO - PROCESS | 25190 | RSS: Main: 196485120 10:34:22 INFO - PROCESS | 25190 | 10:34:26 INFO - PROCESS | 25190 | Cycle 1(1): loaded http://localhost:46236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46236/tests/kraken/driver.html?testName=audio-fft) 10:34:26 INFO - PROCESS | 25190 | RSS: Main: 277909504 10:34:26 INFO - PROCESS | 25190 | 10:34:29 INFO - PROCESS | 25190 | Cycle 1(1): loaded http://localhost:46236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46236/tests/kraken/driver.html?testName=audio-oscillator) 10:34:29 INFO - PROCESS | 25190 | RSS: Main: 188243968 10:34:29 INFO - PROCESS | 25190 | 10:34:31 INFO - PROCESS | 25190 | Cycle 1(1): loaded http://localhost:46236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:34:32 INFO - PROCESS | 25190 | RSS: Main: 192028672 10:34:32 INFO - PROCESS | 25190 | 10:34:35 INFO - PROCESS | 25190 | Cycle 1(1): loaded http://localhost:46236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46236/tests/kraken/driver.html?testName=imaging-darkroom) 10:34:36 INFO - PROCESS | 25190 | RSS: Main: 228544512 10:34:36 INFO - PROCESS | 25190 | 10:34:39 INFO - PROCESS | 25190 | Cycle 1(1): loaded http://localhost:46236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46236/tests/kraken/driver.html?testName=imaging-desaturate) 10:34:40 INFO - PROCESS | 25190 | RSS: Main: 228167680 10:34:40 INFO - PROCESS | 25190 | 10:34:43 INFO - PROCESS | 25190 | Cycle 1(1): loaded http://localhost:46236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46236/tests/kraken/driver.html?testName=json-parse-financial) 10:34:43 INFO - PROCESS | 25190 | RSS: Main: 227938304 10:34:43 INFO - PROCESS | 25190 | 10:34:45 INFO - PROCESS | 25190 | Cycle 1(1): loaded http://localhost:46236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:34:46 INFO - PROCESS | 25190 | RSS: Main: 190439424 10:34:46 INFO - PROCESS | 25190 | 10:34:48 INFO - PROCESS | 25190 | Cycle 1(1): loaded http://localhost:46236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46236/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:34:48 INFO - PROCESS | 25190 | RSS: Main: 196841472 10:34:48 INFO - PROCESS | 25190 | 10:34:50 INFO - PROCESS | 25190 | Cycle 1(1): loaded http://localhost:46236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:34:51 INFO - PROCESS | 25190 | RSS: Main: 194011136 10:34:51 INFO - PROCESS | 25190 | 10:34:54 INFO - PROCESS | 25190 | Cycle 1(1): loaded http://localhost:46236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:34:55 INFO - PROCESS | 25190 | RSS: Main: 189521920 10:34:55 INFO - PROCESS | 25190 | 10:34:57 INFO - PROCESS | 25190 | Cycle 1(1): loaded http://localhost:46236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:34:58 INFO - PROCESS | 25190 | RSS: Main: 192774144 10:34:58 INFO - PROCESS | 25190 | 10:35:00 INFO - PROCESS | 25190 | Cycle 1(1): loaded http://localhost:46236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46236/tests/kraken/driver.html?testName=ai-astar) 10:35:00 INFO - PROCESS | 25190 | RSS: Main: 243478528 10:35:00 INFO - PROCESS | 25190 | 10:35:00 INFO - PROCESS | 25190 | __start_tp_report 10:35:00 INFO - PROCESS | 25190 | _x_x_mozilla_page_load 10:35:00 INFO - PROCESS | 25190 | _x_x_mozilla_page_load_details 10:35:00 INFO - PROCESS | 25190 | |i|pagename|runs| 10:35:00 INFO - PROCESS | 25190 | |0;ai-astar;106;115;114;113;111;115;114;114;115;113 10:35:00 INFO - PROCESS | 25190 | |1;audio-beat-detection;149;122;125;184;128;138;152;127;166;129 10:35:00 INFO - PROCESS | 25190 | |2;audio-dft;161;161;162;163;160;161;163;163;163;161 10:35:00 INFO - PROCESS | 25190 | |3;audio-fft;75;77;76;119;76;77;76;77;131;75 10:35:00 INFO - PROCESS | 25190 | |4;audio-oscillator;87;86;141;87;86;86;120;85;87;123 10:35:00 INFO - PROCESS | 25190 | |5;imaging-gaussian-blur;117;117;117;117;117;116;116;117;116;116 10:35:00 INFO - PROCESS | 25190 | |6;imaging-darkroom;147;147;147;146;147;146;147;146;147;147 10:35:00 INFO - PROCESS | 25190 | |7;imaging-desaturate;95;94;95;96;96;95;95;95;96;95 10:35:00 INFO - PROCESS | 25190 | |8;json-parse-financial;66;70;66;64;64;68;66;65;66;65 10:35:00 INFO - PROCESS | 25190 | |9;json-stringify-tinderbox;66;66;66;65;66;65;66;65;66;66 10:35:00 INFO - PROCESS | 25190 | |10;stanford-crypto-aes;83;83;91;88;84;83;82;83;83;83 10:35:00 INFO - PROCESS | 25190 | |11;stanford-crypto-ccm;141;142;132;139;143;132;132;135;147;128 10:35:00 INFO - PROCESS | 25190 | |12;stanford-crypto-pbkdf2;170;179;169;173;176;175;172;168;168;171 10:35:00 INFO - PROCESS | 25190 | |13;stanford-crypto-sha256-iterative;72;68;69;69;68;70;70;68;73;71 10:35:00 INFO - PROCESS | 25190 | __end_tp_report 10:35:00 INFO - PROCESS | 25190 | __start_cc_report 10:35:00 INFO - PROCESS | 25190 | _x_x_mozilla_cycle_collect,1945 10:35:00 INFO - PROCESS | 25190 | __end_cc_report 10:35:00 INFO - PROCESS | 25190 | __startTimestamp1471368900574__endTimestamp 10:35:00 INFO - PROCESS | 25190 | 10:35:00 INFO - PROCESS | 25190 | ------- Summary: start ------- 10:35:00 INFO - PROCESS | 25190 | Number of tests: 14 10:35:00 INFO - PROCESS | 25190 | 10:35:00 INFO - PROCESS | 25190 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:2.75 (2.4%) stddev-sans-first:1.30 10:35:00 INFO - PROCESS | 25190 | Values: 106.0 115.0 114.0 113.0 111.0 115.0 114.0 114.0 115.0 113.0 10:35:00 INFO - PROCESS | 25190 | 10:35:00 INFO - PROCESS | 25190 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:143.50 stddev:20.50 (14.3%) stddev-sans-first:21.59 10:35:00 INFO - PROCESS | 25190 | Values: 149.0 122.0 125.0 184.0 128.0 138.0 152.0 127.0 166.0 129.0 10:35:00 INFO - PROCESS | 25190 | 10:35:00 INFO - PROCESS | 25190 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.50 stddev:1.14 (0.7%) stddev-sans-first:1.17 10:35:00 INFO - PROCESS | 25190 | Values: 161.0 161.0 162.0 163.0 160.0 161.0 163.0 163.0 163.0 161.0 10:35:00 INFO - PROCESS | 25190 | 10:35:00 INFO - PROCESS | 25190 | [#3] audio-fft Cycles:10 Average:85.90 Median:76.00 stddev:20.81 (27.4%) stddev-sans-first:21.70 10:35:00 INFO - PROCESS | 25190 | Values: 75.0 77.0 76.0 119.0 76.0 77.0 76.0 77.0 131.0 75.0 10:35:00 INFO - PROCESS | 25190 | 10:35:00 INFO - PROCESS | 25190 | [#4] audio-oscillator Cycles:10 Average:98.80 Median:86.00 stddev:20.86 (24.3%) stddev-sans-first:21.68 10:35:00 INFO - PROCESS | 25190 | Values: 87.0 86.0 141.0 87.0 86.0 86.0 120.0 85.0 87.0 123.0 10:35:00 INFO - PROCESS | 25190 | 10:35:00 INFO - PROCESS | 25190 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:35:00 INFO - PROCESS | 25190 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 116.0 10:35:00 INFO - PROCESS | 25190 | 10:35:00 INFO - PROCESS | 25190 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 10:35:00 INFO - PROCESS | 25190 | Values: 147.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 147.0 10:35:00 INFO - PROCESS | 25190 | 10:35:00 INFO - PROCESS | 25190 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 10:35:00 INFO - PROCESS | 25190 | Values: 95.0 94.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 10:35:00 INFO - PROCESS | 25190 | 10:35:00 INFO - PROCESS | 25190 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.00 stddev:1.83 (2.8%) stddev-sans-first:1.94 10:35:00 INFO - PROCESS | 25190 | Values: 66.0 70.0 66.0 64.0 64.0 68.0 66.0 65.0 66.0 65.0 10:35:00 INFO - PROCESS | 25190 | 10:35:00 INFO - PROCESS | 25190 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 10:35:00 INFO - PROCESS | 25190 | Values: 66.0 66.0 66.0 65.0 66.0 65.0 66.0 65.0 66.0 66.0 10:35:00 INFO - PROCESS | 25190 | 10:35:00 INFO - PROCESS | 25190 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.00 stddev:2.87 (3.5%) stddev-sans-first:3.00 10:35:00 INFO - PROCESS | 25190 | Values: 83.0 83.0 91.0 88.0 84.0 83.0 82.0 83.0 83.0 83.0 10:35:00 INFO - PROCESS | 25190 | 10:35:00 INFO - PROCESS | 25190 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:140.00 stddev:6.15 (4.4%) stddev-sans-first:6.36 10:35:00 INFO - PROCESS | 25190 | Values: 141.0 142.0 132.0 139.0 143.0 132.0 132.0 135.0 147.0 128.0 10:35:00 INFO - PROCESS | 25190 | 10:35:00 INFO - PROCESS | 25190 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:172.50 stddev:3.67 (2.1%) stddev-sans-first:3.81 10:35:00 INFO - PROCESS | 25190 | Values: 170.0 179.0 169.0 173.0 176.0 175.0 172.0 168.0 168.0 171.0 10:35:00 INFO - PROCESS | 25190 | 10:35:00 INFO - PROCESS | 25190 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.75 (2.5%) stddev-sans-first:1.67 10:35:00 INFO - PROCESS | 25190 | Values: 72.0 68.0 69.0 69.0 68.0 70.0 70.0 68.0 73.0 71.0 10:35:00 INFO - PROCESS | 25190 | -------- Summary: end -------- 10:35:00 INFO - PROCESS | 25190 | 10:35:01 INFO - TEST-INFO | 25190: exit 0 10:35:01 INFO - TEST-OK | kraken | took 64132ms 10:35:01 INFO - SUITE-END | took 1185s 10:35:02 INFO - Completed test suite (00:19:45) 10:35:02 INFO - javascript benchmark 10:35:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2656.4687062587486, 2692.8922843086275, 2706.905258315959, 2734.1934129431816, 2744.6294750208726, 4675.111728771531, 4770.451398089221, 4823.734694591796, 4847.248676455146, 4850.175470170071, 4760.690555113915, 4763.0, 4792.592629626477, 4800.9519904800945, 4828.927566086502, 4326.632236259922, 4361.3676016977515, 4422.845200417986, 4467.865964021084, 4568.565986231302, 4483.820647174109, 4520.186366454037, 4549.499555048942, 4560.726356418609, 4574.405327307462, 4304.5910638489295, 4333.4366532350905, 4341.630961368288, 4410.933835992462, 4423.1153769246275, 4390.868273951786, 4396.450443694538, 4397.670174736875, 4401.713888597263, 4403.911921761579, 4324.718893271959, 4326.113146804897, 4372.781360931973, 4393.51671316155, 4417.160739459492, 4709.764511774431, 4719.480857105716, 4748.477667456577, 4784.186688263004, 4813.133635945528, 5110.66780659256, 5151.2530683050745, 5160.303359046518, 5163.586913046947, 5166.586673066184, 5043.293938848564, 5124.052050370656, 5185.922211166836, 5187.922181167285, 5210.166373380241, 4833.275008748646, 4870.2938073979785, 4875.024995001014, 4876.414830220326, 4887.560119589254, 5107.489251074937, 5336.332958380202, 5341.759620817073, 5347.25138480613, 5347.679139251657, 4999.42506611737, 5045.974770126126, 5049.0, 5055.292259083732, 5112.488751124858, 5169.0, 5170.276161337416, 5179.249008893689, 5209.895802083937, 5216.947830521722, 4987.127252730757, 5094.719790411563, 5110.003549307924, 5110.923336149961, 5170.767315470813, 5007.123753343223, 5039.974800125976, 5070.138076527, 5137.563307118862, 5145.022445735298, 4302.569743025672, 4310.956890431055, 4311.611954924072, 4350.58669426404, 4354.129174165179, 3772.811359432072, 3788.734788564774, 3792.924141517154, 3819.4270859370763, 3833.463315135883, 4388.4953230378915, 4439.866803995886, 4492.640588752892, 4511.300748384006, 4553.066621342617, 5211.270422140903, 5217.295665085241, 5221.347331583552, 5259.526642602108, 5259.815906443256, 4488.371627972087, 4512.774361281923, 4522.321651752263, 4524.6380289576755, 4565.611922986517, 4501.572350626685, 4551.067031258584, 4596.724196548218, 4653.557911998422, 4689.531046895283, 4865.781039853286, 4877.585405240594, 4879.4876537963, 4898.951010489992, 4922.335484709519, 5121.462246464068, 5157.716325601978, 5162.535371816554, 5165.560927321219, 5208.0365132450615, 4772.902232486478, 4809.470958194665, 4833.4441539223435, 4880.974995251037, 4934.087193869145, 5057.216131499624, 5059.443461219189, 5059.797608095635, 5078.187490001582, 5080.593552515864, 5114.232865070269, 5127.92308115386, 5129.948700512947, 5130.102232109441, 5178.300929374637, 4842.176829938849, 4945.901081978413, 5001.474845141353, 5010.974945125251, 5015.874603134805, 5025.346704928336, 5025.673331233458, 5027.446980832033, 5053.166227572409, 5056.82301119459, 4950.925736113889, 5013.623978201576, 5017.347744793154, 5018.146915024382, 5019.247112933089, 4938.728369939688, 4984.252362145708, 5028.069807085554, 5057.418396884405, 5077.898442031213, 4951.0, 4953.405591328919, 4959.404871415453, 4982.725950072636, 4990.101781679333], "value": 4727.955974530065, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.9747111379987, 566.940471250519, 567.9091345384738, 576.9509591684706, 580.2427831679659, 28683.713162868364, 30871.691283087217, 30900.91846785363, 31052.844735776318, 38431.23137537255, 36300.0, 40102.39846402306, 40269.19461610766, 40298.79850600743, 40305.19389612206, 7634.465587408884, 7767.417443691746, 7772.727954521592, 7783.377329813601, 7783.727569535067, 7388.298111679409, 7553.131389890178, 7665.846683066336, 7764.534127952313, 7782.027246594176, 7621.314081732643, 7675.5010924289745, 9859.605615775361, 10138.442385668784, 10139.290249682525, 10061.19510439163, 10111.89888101117, 10122.54448549817, 10135.797284054277, 10136.341137826055, 9952.104310612007, 10030.0, 10032.297739158263, 10034.89965100347, 10036.046575575308, 37255.62744372548, 37658.8117059413, 37674.0, 37696.0, 37778.055548611504, 3017.6529699084667, 3103.3638104188585, 3275.7870738402166, 3293.818839963801, 3617.475466057433, 28060.719392806015, 28121.29696757577, 28293.85853070742, 28706.0, 28812.711872881213, 3482.982585087084, 3542.3092496963104, 3564.590072141685, 3565.8395372208315, 3611.801350925698, 249335.0, 249637.9999999982, 250422.0, 250646.0, 252109.0, 50691.23963140556, 51061.48938510568, 51090.48909510932, 51095.48904510982, 51124.0, 32251.677483225336, 32813.34373312568, 33144.50283245753, 34784.130396740286, 34803.65196348004, 11926.821097683542, 12171.391430428443, 12184.81722774159, 12187.75624487523, 12201.084918631139, 8334.20825021622, 8482.0, 8483.109273526314, 8483.533405662625, 8496.235338819535, 15444.837722718828, 17487.0, 17515.73726394105, 17568.486302739504, 17795.110244487725, 6175.814725558241, 6622.602643841385, 6835.692393842289, 6860.142482189726, 6907.13660792401, 780.8282177920848, 810.9472884262622, 857.5583574459158, 864.2178828160525, 967.7096870938831, 27138.457230855667, 27476.0, 27512.862435687694, 27862.67333881079, 28354.0, 898.8427025270552, 908.8091500784909, 922.7462447826902, 967.5259123029806, 984.2863923655435, 13952.302384880715, 14576.794699347467, 14657.560273191608, 14821.258937053104, 14963.551093467213, 393893.0, 396957.0, 398923.0, 399004.0, 400038.0, 48605.75697121492, 49136.508634913196, 49156.75421622869, 49406.25890611644, 49441.50558494441, 1137.4881303413497, 1162.3839365136491, 1166.0321932795928, 1166.288563975974, 1167.6555416152255, 25165.622515662646, 26107.0, 26642.467150656492, 26852.0, 26932.326691832863, 40491.39262911, 46116.0, 47311.0, 47381.52618473771, 51670.48329516807, 349447.0, 353286.0, 353289.0, 353639.0, 356042.0, 31757.0, 31880.0, 37632.623673762915, 37824.43263350997, 38375.616243837205, 31923.0, 35708.64291357053, 39704.404433932934, 40057.1988560233, 40437.0, 33418.0, 34218.315633687685, 35495.822520888265, 35609.64390356167, 35896.820515897256, 34920.12699682426, 35433.393658824185, 35470.822645886605, 35515.0, 35792.64207357997, 34913.0, 35202.64797351994, 35246.0, 35867.64132358643, 35939.46090808588, 30723.692763072082, 32061.793820617753, 32982.175445614055, 33133.0, 33178.0, 24630.753692463564, 24711.62932556049, 25105.87447062753, 25242.699053173565, 25444.618330725425], "value": 17300.103599996117, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.0624292616283, 340.88750712264937, 351.8610148991148, 354.7091385064248, 371.49662207708553, 12814.679633009167, 15908.363665453382, 16556.58608534786, 17012.82987170128, 17926.731099033525, 16589.751153732705, 16737.665246695058, 17441.0, 17605.91197044016, 17626.206820693067, 4872.65891387603, 4904.681195722275, 4997.900041999158, 5034.521720436571, 5040.092783299005, 3745.0, 4984.950150498485, 5066.392032956032, 5664.830055098333, 5950.166976623276, 5977.222961015062, 5997.940020599782, 6007.939920600782, 6010.308814486346, 6014.4286292802335, 5189.662671926331, 5480.725963701839, 5506.063969125258, 5576.86057848553, 6009.609375390585, 5387.622866399353, 5394.91907621386, 5400.891982160335, 5401.621886467949, 5402.0, 19457.902710486356, 20188.0, 20221.39335819928, 20441.897790510953, 20684.48288792777, 1938.6122775444967, 1957.618264438435, 2072.347210628662, 2230.9330720078424, 2446.788839524429, 9290.953545232298, 9331.113544213289, 9475.0, 9517.809643807084, 9891.653792117242, 1767.9558011049699, 1800.8664923033957, 1817.8273064058894, 1835.2842391467339, 1841.7513635659147, 67720.0, 68362.3163768361, 69248.0, 69366.30633693648, 69551.65224173847, 10062.69811905644, 10161.339512931636, 10283.742906427398, 10459.633912813015, 11026.889731102747, 14013.509527166703, 14017.369218385196, 14052.508162214477, 14077.436902523988, 14102.435902563782, 6337.461315788118, 6552.0, 6563.0, 6687.565308254948, 6692.665366731644, 5845.1232315153065, 5875.764969401262, 6026.337102918676, 6029.155918171459, 6031.366706495754, 4416.4258646375765, 4417.337399390053, 4427.2252355838245, 4459.509453960061, 4560.794764235618, 1786.7855857296947, 1842.1986435900426, 1845.2526726675717, 1864.0959134819602, 1879.248300679739, 794.4518282385136, 852.5992783391796, 865.8268346330759, 928.4661319741041, 929.972100836976, 16602.0, 17706.0, 17735.201915913814, 17895.910520447316, 18218.180181891847, 822.880682301063, 842.5450256861226, 852.7527017165077, 861.8965724113147, 890.6882591093066, 9374.359487089732, 10321.535530901128, 10368.170546356274, 10696.251262411557, 10707.196960228013, 281566.7649852497, 282735.0, 283210.0, 391265.0, 395571.0, 76628.0, 78714.0, 79303.60348198337, 80655.59672201719, 81370.59314703508, 918.2562124678898, 931.6413180925392, 980.4999450280266, 980.563649176124, 981.1562056631292, 15793.763093553376, 16080.678386431971, 16250.51248462548, 16923.23845426934, 17142.742858856876, 37131.07172320713, 37472.250554989296, 37681.81159094187, 38467.0, 38666.36003679464, 52164.739176303876, 52365.21452178144, 52789.0, 52913.470865292395, 53518.464815352905, 7758.728444504415, 7931.444798864024, 7955.880661789962, 8060.31487323584, 8140.348772098337, 11293.830592541282, 11411.315321080761, 11503.884961150281, 11726.120540959633, 12141.575044873387, 6371.840703982438, 9985.301028927905, 10000.24998125129, 10186.592536298465, 10379.740506487398, 9672.0, 9894.356866803635, 9915.900840991786, 10179.491025448846, 10278.126359259248, 10077.69766906994, 10087.243456740627, 10225.647544891102, 10288.742781430225, 10576.682699519026, 7548.346232259757, 7714.652840622298, 7754.0, 7775.533467991939, 7884.1327453978865, 7372.82968323626, 8264.297534709616, 9863.506824658594, 10050.396976181453, 10279.434631095362], "value": 8185.113633769355, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1223.3699644682983, 1305.7649623067846, 1358.3547814787978, 1385.314269436629, 1629.967400651987, 6773.221079575844, 7438.516496427728, 7699.268569485904, 7716.189800070989, 7964.323032542241, 7743.961280193591, 7795.454318197714, 7809.60951952403, 7811.0, 7817.960910195456, 2167.880766557839, 2178.3573845715473, 2187.2344679362254, 2188.1575593396497, 2189.036823797532, 2131.5523740014614, 2186.0599942024924, 2195.5718634866207, 2199.9340019799433, 2206.8013878750908, 2165.664322030088, 2176.847620666554, 2191.0359441845617, 2196.2203417786695, 2203.019656252968, 2121.1197353098446, 2122.1829595605727, 2123.968140477894, 2126.5002724359765, 2126.723525941633, 2055.547779488525, 2113.947151321214, 2114.7990940860595, 2116.9576608467896, 2117.3118736410574, 7679.57762323072, 7811.1017233018365, 7857.2928436440425, 7956.204379562056, 7968.60156992148, 4456.19788438081, 4588.701734387254, 4592.0, 4595.379623750784, 4596.839110631112, 2819.8731057102273, 2937.1775902747263, 2970.598969139182, 2972.9256768580744, 2986.1937276935105, 864.4856310495245, 880.3265501891059, 884.823035392924, 885.9734207973771, 897.4839467306259, 10706.518206680717, 10766.084882784973, 10778.083862871665, 10804.891951080468, 10824.837627435594, 3830.697562828596, 4038.0, 4070.430139780433, 4135.048938744106, 4156.667466602665, 8459.111793261742, 8480.491170529665, 8481.491110533389, 8486.830263394697, 8491.830163396697, 4413.0, 4425.911481770347, 4438.068005718836, 4438.378626992224, 4443.822247110144, 3650.2699460107556, 4002.399640053957, 4076.286649836267, 4076.5311989121633, 4141.544430112685, 3385.119868834121, 3402.7447941404494, 3516.191276006533, 3518.7536872418686, 3532.364174448624, 989.6486747204783, 993.8757655293089, 1008.2135933971514, 1009.6365308488938, 1019.9490025498844, 758.5789886612982, 788.0, 796.0, 809.7773112394138, 815.4740192575755, 4875.293082503017, 4894.486078961729, 4989.401271847329, 5097.08252514551, 5231.843044708665, 416.7207970659665, 424.73241857629495, 424.79185199252146, 426.1073051956147, 429.29809761040923, 3460.3425349183576, 3477.6522347765526, 3491.8428670709877, 3515.3848076586496, 3559.982200088983, 9536.28477864163, 9772.071653192936, 9863.605455781832, 9884.061014203638, 9894.653687120915, 9800.901990979999, 9808.0, 9816.165625921734, 9818.901810981799, 9821.312508124363, 7259.709611615582, 7283.817904552323, 7360.447966402541, 7418.851622967511, 7466.664000120008, 5049.899002019865, 5056.241563765465, 5056.418511871182, 5086.28791969132, 5136.794528218829, 8826.867596986178, 8867.68963086289, 8958.641654333753, 8968.506732129796, 8977.326700497359, 8999.19007289347, 9160.450372977642, 9220.400673956172, 9229.815403691755, 9231.630734770533, 5800.0, 6342.841428964312, 6553.115329430466, 6608.140941677551, 6614.173228346457, 7601.277878601524, 7688.0, 7718.266764657348, 7739.729109481141, 7746.535207887545, 6734.730610775514, 6747.089142965637, 6776.7628133015105, 6832.897506537505, 7002.649867506502, 6744.426723728538, 6754.0, 6900.827479313058, 6976.7558135465015, 7000.50996430245, 6222.28443728977, 6310.5898116622275, 6320.810375688737, 6322.873542529215, 6323.430891219812, 4296.011917258986, 4315.438992930899, 4408.0, 4472.1502914446155, 4475.977620111878, 4349.869503914888, 4397.597526165465, 4488.349189367589, 4499.730016199039, 4636.327732478839], "value": 3980.816301822009, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.41117764471056, 298.83116039437715, 302.3529646556369, 304.08470503783633, 305.6378191842665, 4838.250071238955, 4854.4174699036075, 4855.7086574805535, 4855.927161092582, 4869.318295438641, 4767.737774422405, 4779.426468823737, 4789.257665061912, 4812.15787237233, 4813.951860481394, 3567.3757092508836, 3681.392570225923, 3691.187938653492, 3700.9259814803686, 3711.4061750119986, 3580.5166302549083, 3710.8701195458166, 3745.606711295302, 3776.5090538229992, 3793.3172029034763, 3739.5699494558066, 3759.0602349412648, 3759.2669429461266, 3772.0192749884955, 3782.1301100746846, 3596.2447885943984, 3751.1747415568666, 3756.417755247941, 3757.981210093932, 3764.5106136202394, 3123.890663826778, 3204.3110731192673, 3276.57404537411, 3290.3748287825474, 3309.834508274601, 4645.651576131803, 4646.930296045562, 4648.163330600491, 4650.837220697259, 4657.278121891112, 4234.745915245096, 4244.639205667522, 4244.745315281062, 4247.957520424818, 4258.659307255412, 4735.195016847144, 4964.120809930232, 4982.185065438016, 4988.102141614544, 4990.351254336913, 3564.429691249388, 3567.8751243706347, 3568.8230179590428, 3578.8389522471552, 3585.8924232273075, 5272.209168624699, 5274.604404669627, 5281.577473802125, 5291.603129765283, 5306.92039619406, 3620.7827530348263, 3621.2576421833987, 3629.7277704172293, 3631.7094632429344, 3632.5096112025067, 3555.8044307562814, 3626.800525971044, 3642.8907132786057, 3647.5805282392334, 3662.597114317423, 4191.76342978822, 4191.811368488426, 4206.642435392964, 4222.59885310895, 4224.1129362834145, 5020.47285035066, 5025.899482010413, 5043.293938848564, 5053.978408636574, 5058.898822023539, 1226.8159776033488, 1250.5060501102014, 1250.8123781432857, 1254.7365053338901, 1271.6630093025356, 789.128013545036, 796.5021861336664, 814.4828034198208, 816.7345612675786, 820.5568992743971, 3991.691050902293, 4001.6998725095737, 4024.9798751006056, 4046.523019098008, 4058.127502586899, 4590.54094590545, 4611.0, 4620.752396852831, 4633.675642705046, 4648.837290694877, 4059.330210515291, 4062.6343629073526, 4071.206114807584, 4098.159877225162, 4125.071858831739, 2342.695449591542, 2434.9529702227856, 2447.596146635821, 2459.8561668823727, 2470.5800013997664, 4676.742779147112, 4819.277108433763, 4920.040592084581, 4945.55490005894, 4955.851324460272, 5308.681479111266, 5314.601404894571, 5327.973360133252, 5329.120695085345, 5337.466253374709, 4744.027474367677, 4919.204490360992, 4957.405111386656, 4959.454460009396, 4965.155923492943, 5146.356705411824, 5154.587632989427, 5183.585313174862, 5189.6886186828915, 5198.324217851655, 5123.769430375568, 5132.666376685504, 5133.383993920754, 5137.2037334213255, 5163.5610973066205, 4729.3993193816605, 4922.581580565548, 4928.654994150518, 4928.778204980713, 4937.284093806306, 3682.208325210093, 3718.9628103719697, 3721.5720192178246, 3726.9440958385103, 3748.306563285801, 5163.328767260232, 5197.726556993561, 5214.608904332114, 5235.973820130875, 5243.449437808975, 4791.592714619296, 5056.82301119459, 5060.532445590738, 5070.746462676778, 5075.137226671401, 5018.4981501849525, 5046.21783623539, 5057.772400242072, 5065.39215294167, 5090.516400941905, 5006.374203224597, 5023.497650234947, 5026.798928042837, 5033.84898453047, 5044.293798868088, 4893.0, 5119.360079990001, 5132.9743351283005, 5133.358330208724, 5138.76875540609, 4976.800927962841, 4997.175466048061, 5003.499650034967, 5017.147084995487, 5023.191651005708], "value": 3743.107075515786, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.9179310793043, 677.3429773120072, 677.9221038548707, 689.331348591866, 752.2627824731762, 13263.93368033161, 13915.58253252404, 13960.650983725387, 13964.790528142074, 14173.433062677494, 13384.464621415156, 13501.2574308413, 13535.458581656721, 13540.322983850818, 13546.593602191926, 610.3377835048977, 729.2998721227627, 749.8612756640039, 768.2356055724562, 771.3173841150566, 762.2606072110073, 770.2567022822975, 771.4484143837155, 772.5673622771238, 773.342658740072, 810.7040930060544, 811.2050190813006, 812.9715459958902, 813.1340122769261, 813.9837203255931, 637.3594537489839, 772.7102336623766, 794.8648729715962, 803.9437239393216, 805.7784109369941, 592.0349829777479, 593.0067137544596, 593.4362355762, 593.4510577715596, 593.9049752039696, 12801.871981280161, 12841.87158128416, 12846.100772945898, 12848.357582120856, 12876.871231287754, 12039.0, 12101.757964840743, 12517.146605346225, 12555.309457979807, 12802.48790048397, 11704.763843850453, 11803.0, 12032.458539365749, 12361.07291953107, 12681.907485265012, 4082.632563069308, 4130.297849365585, 4188.874333769992, 4194.2450358935375, 4194.622483976456, 61698.69150654218, 62660.37339626637, 62821.0, 62833.68583157055, 63839.0, 10060.295779295526, 10416.322939009091, 10504.789904201873, 10614.89385106139, 10784.299020563638, 16942.661146776994, 17039.91480042592, 17077.402290920007, 17186.65626687484, 17219.82780172182, 6405.35946405365, 6598.274189839114, 6727.93272067273, 6845.520813543104, 6935.965320173468, 3643.708503319728, 3677.374846276086, 3684.4841722158917, 3738.1776009277914, 3807.7905715185375, 2693.8383696978244, 2794.720527947189, 2797.1468702046072, 2802.047303916678, 2805.228562145426, 449.5594317568801, 458.2416101352267, 462.83569332887015, 469.2234352147134, 493.5582653525075, 407.7573843563075, 483.6348556839634, 528.6527816494751, 534.9919751203735, 558.4359796605377, 7007.684654190573, 7075.292470752884, 7329.486935914541, 7332.926670733331, 7773.183815699384, 428.63734006717874, 520.8359366799446, 564.5540023381483, 564.906790379591, 584.187978709594, 3751.643593858579, 3768.340540405473, 3792.8482860685262, 3824.29250588642, 3869.8390482855593, 90791.0, 91562.0, 91991.54004229936, 93892.53053734687, 93987.0, 79628.60185699034, 81486.59256703679, 81907.0, 82330.58834705788, 83970.16029839746, 71571.98996070225, 71807.64096179485, 73508.63245683737, 73617.6319118401, 74130.25869741342, 7291.41668666516, 7430.814229644302, 7687.615619218905, 7914.643841027052, 7942.205779422012, 40771.59228407678, 42119.31522739056, 42545.149097018504, 42668.14663706771, 42897.49293873497, 53682.19476707931, 54363.72818135884, 57595.0, 65851.34148658453, 67203.32796672166, 10284.177265818567, 11100.61147859821, 11120.833187502032, 11351.37567433799, 11931.582394616147, 11431.371274579978, 11948.34284114382, 12388.752224955631, 13061.0, 13119.934400327937, 8581.442206256574, 10936.179786515884, 11419.200655954004, 11998.940005299917, 12011.4594843234, 9753.903360588713, 10113.19094472455, 10119.595216191565, 10389.584416623553, 10483.37099774016, 9869.161121304769, 10481.37111773296, 10829.350238985686, 11534.077273817906, 11721.941390292994, 9360.391574547633, 9426.245900328095, 9568.521573921415, 9751.902480975099, 9848.409095454295, 9194.678186263449, 9349.158575727944, 9579.0, 9618.855717164388, 9963.402195868272], "value": 6379.597915224546, "unit": "score"}], "name": "dromaeo_css", "value": 6318.770162395136, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 114.0, 113.0, 111.0, 115.0, 114.0, 114.0, 115.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 122.0, 125.0, 184.0, 128.0, 138.0, 152.0, 127.0, 166.0, 129.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 163.0, 160.0, 161.0, 163.0, 163.0, 163.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 119.0, 76.0, 77.0, 76.0, 77.0, 131.0, 75.0], "value": 85.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 141.0, 87.0, 86.0, 86.0, 120.0, 85.0, 87.0, 123.0], "value": 98.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 66.0, 64.0, 64.0, 68.0, 66.0, 65.0, 66.0, 65.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 91.0, 88.0, 84.0, 83.0, 82.0, 83.0, 83.0, 83.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 142.0, 132.0, 139.0, 143.0, 132.0, 132.0, 135.0, 147.0, 128.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 179.0, 169.0, 173.0, 176.0, 175.0, 172.0, 168.0, 168.0, 171.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 69.0, 69.0, 68.0, 70.0, 70.0, 68.0, 73.0, 71.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1554.9999999999998, "alertThreshold": 2.0}]} 10:35:02 INFO - Return code: 0 10:35:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:35:02 INFO - # TBPL SUCCESS # 10:35:02 INFO - Running post-action listener: _resource_record_post_action 10:35:02 INFO - [mozharness: 2016-08-16 17:35:02.395597Z] Finished run-tests step (success) 10:35:02 INFO - Running post-run listener: _resource_record_post_run 10:35:02 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 419561472; Read time: 16; Write time: 250824 10:35:02 INFO - TinderboxPrint: CPU usage
13.0% 10:35:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:35:02 INFO - TinderboxPrint: I/O write bytes / time
419,561,472 / 250,824 10:35:02 INFO - TinderboxPrint: CPU idle
8,347.4 (87.0%) 10:35:02 INFO - TinderboxPrint: CPU user
1,201.4 (12.5%) 10:35:02 INFO - TinderboxPrint: Swap in / out
0 / 0 10:35:02 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124788736; Read time: 0; Write time: 67852 10:35:02 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294772736; Read time: 16; Write time: 182972 10:35:03 INFO - Running post-run listener: _upload_blobber_files 10:35:03 INFO - Blob upload gear active. 10:35:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:35:03 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 10:35:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:35:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:35:03 INFO - (blobuploader) - INFO - Open directory for files ... 10:35:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:35:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:35:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:08 INFO - (blobuploader) - INFO - Done attempting. 10:35:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:35:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:35:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:09 INFO - (blobuploader) - INFO - Done attempting. 10:35:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:35:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:35:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:09 INFO - (blobuploader) - INFO - Done attempting. 10:35:09 INFO - (blobuploader) - INFO - Iteration through files over. 10:35:09 INFO - Return code: 0 10:35:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:35:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:35:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a1449a3aa3de1650e160fd55382f1a2be61d3ae1c9341be7030bfd6f110ed7aa548ac3338758c4835727b5888f98564c9443b8d449a8656b482ebff94eb21ab2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9fdf7411de8ca5bbb28380fd38013040b66346e97b98efc8311414665ab58471541535b10270c389322fe82735ec810415c4008b6cbc8117b5075b9cd6ed79e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/64ebdf7e348b409c162e873ae6cbafe9e84e919a8556971ef2544a9cc071e5486918491117273ccdcd334fcb961de36f86795621273126ba5d18a2847fcbf5a6"} 10:35:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:35:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:35:09 INFO - Contents: 10:35:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a1449a3aa3de1650e160fd55382f1a2be61d3ae1c9341be7030bfd6f110ed7aa548ac3338758c4835727b5888f98564c9443b8d449a8656b482ebff94eb21ab2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9fdf7411de8ca5bbb28380fd38013040b66346e97b98efc8311414665ab58471541535b10270c389322fe82735ec810415c4008b6cbc8117b5075b9cd6ed79e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/64ebdf7e348b409c162e873ae6cbafe9e84e919a8556971ef2544a9cc071e5486918491117273ccdcd334fcb961de36f86795621273126ba5d18a2847fcbf5a6"} 10:35:09 INFO - Running post-run listener: copy_logs_to_upload_dir 10:35:09 INFO - Copying logs to upload dir... 10:35:09 INFO - mkdir: /builds/slave/test/build/upload/logs 10:35:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.982995 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-16 10:35:09.580702) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 10:35:09.585166) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a1449a3aa3de1650e160fd55382f1a2be61d3ae1c9341be7030bfd6f110ed7aa548ac3338758c4835727b5888f98564c9443b8d449a8656b482ebff94eb21ab2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9fdf7411de8ca5bbb28380fd38013040b66346e97b98efc8311414665ab58471541535b10270c389322fe82735ec810415c4008b6cbc8117b5075b9cd6ed79e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/64ebdf7e348b409c162e873ae6cbafe9e84e919a8556971ef2544a9cc071e5486918491117273ccdcd334fcb961de36f86795621273126ba5d18a2847fcbf5a6"} build_url:https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011448 build_url: 'https://queue.taskcluster.net/v1/task/UMCA-cbBToGjjhqirw5sTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a1449a3aa3de1650e160fd55382f1a2be61d3ae1c9341be7030bfd6f110ed7aa548ac3338758c4835727b5888f98564c9443b8d449a8656b482ebff94eb21ab2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9fdf7411de8ca5bbb28380fd38013040b66346e97b98efc8311414665ab58471541535b10270c389322fe82735ec810415c4008b6cbc8117b5075b9cd6ed79e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/64ebdf7e348b409c162e873ae6cbafe9e84e919a8556971ef2544a9cc071e5486918491117273ccdcd334fcb961de36f86795621273126ba5d18a2847fcbf5a6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 10:35:09.617608) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 10:35:09.618192) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1471365522.600958-831673266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 10:35:09.700481) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 10:35:09.700862) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 10:35:09.701221) ========= ========= Total master_lag: 0.19 =========