builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1470819410.84 results: success (0) buildid: 20160809233002 builduid: 64a68fd7ce8141209c4f9a6ff74e83ac revision: 3269dd1a824d1b42cb021d1fb6858885179940b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 01:56:50.840219) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 01:56:50.840626) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 01:56:50.840893) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 01:56:50.886779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 01:56:50.887029) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-10 01:56:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.7M=0s 2016-08-10 01:56:51 (37.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098837 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 01:56:51.009475) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 01:56:51.009751) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018194 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 01:56:51.075479) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 01:56:51.075777) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3269dd1a824d1b42cb021d1fb6858885179940b0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 3269dd1a824d1b42cb021d1fb6858885179940b0 --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=516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-10 01:56:51,265 truncating revision to first 12 chars 2016-08-10 01:56:51,265 Setting DEBUG logging. 2016-08-10 01:56:51,265 attempt 1/10 2016-08-10 01:56:51,265 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3269dd1a824d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 01:56:51,568 unpacking tar archive at: fx-team-3269dd1a824d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.691724 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 01:56:51.783250) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 01:56:51.783515) ========= script_repo_revision: 3269dd1a824d1b42cb021d1fb6858885179940b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 01:56:51.783884) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 01:56:51.784166) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 01:56:51.802207) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-10 01:56:51.802455) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:56:52 INFO - MultiFileLogger online at 20160810 01:56:52 in /builds/slave/test 01:56:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:56:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:56:52 INFO - {'append_to_log': False, 01:56:52 INFO - 'base_work_dir': '/builds/slave/test', 01:56:52 INFO - 'blob_upload_branch': 'Fx-Team', 01:56:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:56:52 INFO - 'branch': 'Fx-Team', 01:56:52 INFO - 'buildbot_json_path': 'buildprops.json', 01:56:52 INFO - 'config_files': ('talos/linux_config.py',), 01:56:52 INFO - 'default_actions': ('clobber', 01:56:52 INFO - 'read-buildbot-config', 01:56:52 INFO - 'download-and-extract', 01:56:52 INFO - 'populate-webroot', 01:56:52 INFO - 'create-virtualenv', 01:56:52 INFO - 'install', 01:56:52 INFO - 'run-tests'), 01:56:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:56:52 INFO - 'download_minidump_stackwalk': True, 01:56:52 INFO - 'download_symbols': 'ondemand', 01:56:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:56:52 INFO - 'tooltool.py': '/tools/tooltool.py', 01:56:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:56:52 INFO - '/tools/misc-python/virtualenv.py')}, 01:56:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:56:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:56:52 INFO - 'installer_path': 'installer.exe', 01:56:52 INFO - 'log_level': 'info', 01:56:52 INFO - 'log_name': 'talos', 01:56:52 INFO - 'log_to_console': True, 01:56:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:56:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:56:52 INFO - 'opt_config_files': (), 01:56:52 INFO - 'pip_index': False, 01:56:52 INFO - 'sps_profile': False, 01:56:52 INFO - 'sps_profile_interval': 0, 01:56:52 INFO - 'suite': 'dromaeojs', 01:56:52 INFO - 'system_bits': '32', 01:56:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:56:52 INFO - 'title': 'talos-linux64-ix-061', 01:56:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:56:52 INFO - 'use_talos_json': True, 01:56:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:56:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:56:52 INFO - 'work_dir': 'build'} 01:56:52 INFO - [mozharness: 2016-08-10 08:56:52.078239Z] Running clobber step. 01:56:52 INFO - Running pre-action listener: _resource_record_pre_action 01:56:52 INFO - Running main action method: clobber 01:56:52 INFO - rmtree: /builds/slave/test/build 01:56:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:56:52 INFO - Running post-action listener: _resource_record_post_action 01:56:52 INFO - [mozharness: 2016-08-10 08:56:52.523736Z] Finished clobber step (success) 01:56:52 INFO - [mozharness: 2016-08-10 08:56:52.523838Z] Running read-buildbot-config step. 01:56:52 INFO - Running pre-action listener: _resource_record_pre_action 01:56:52 INFO - Running main action method: read_buildbot_config 01:56:52 INFO - Using buildbot properties: 01:56:52 INFO - { 01:56:52 INFO - "project": "", 01:56:52 INFO - "product": "firefox", 01:56:52 INFO - "script_repo_revision": "production", 01:56:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:56:52 INFO - "repository": "", 01:56:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 01:56:52 INFO - "buildid": "20160809233002", 01:56:52 INFO - "pgo_build": "True", 01:56:52 INFO - "basedir": "/builds/slave/test", 01:56:52 INFO - "buildnumber": 968, 01:56:52 INFO - "slavename": "talos-linux64-ix-061", 01:56:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:56:52 INFO - "platform": "ubuntu64_hw", 01:56:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:56:52 INFO - "branch": "fx-team", 01:56:52 INFO - "repo_path": "integration/fx-team", 01:56:52 INFO - "revision": "3269dd1a824d1b42cb021d1fb6858885179940b0", 01:56:52 INFO - "stage_platform": "linux64-pgo", 01:56:52 INFO - "builduid": "64a68fd7ce8141209c4f9a6ff74e83ac", 01:56:52 INFO - "slavebuilddir": "test" 01:56:52 INFO - } 01:56:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 01:56:52 INFO - Running post-action listener: _resource_record_post_action 01:56:52 INFO - [mozharness: 2016-08-10 08:56:52.526299Z] Finished read-buildbot-config step (success) 01:56:52 INFO - [mozharness: 2016-08-10 08:56:52.526388Z] Running download-and-extract step. 01:56:52 INFO - Running pre-action listener: _resource_record_pre_action 01:56:52 INFO - Running main action method: download_and_extract 01:56:52 INFO - mkdir: /builds/slave/test/build/tests 01:56: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')]} 01:56:52 INFO - trying https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 01:56:52 INFO - Downloading https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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 01:56:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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 01:56:53 INFO - Downloaded 1361 bytes. 01:56:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 01:56:53 INFO - Using the following test package requirements: 01:56:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 01:56:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:56:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:56:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:56:53 INFO - u'jsshell-linux-x86_64.zip'], 01:56:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:56:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 01:56:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:56:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:56:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:56:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 01:56:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:56:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:56:53 INFO - trying https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 01:56:53 INFO - Downloading https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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 01:56:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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 01:56:54 INFO - Downloaded 21831225 bytes. 01:56:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:56:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:56:55 INFO - Return code: 0 01:56:55 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 01:56: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')]} 01:56:55 INFO - trying https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 01:56:55 INFO - Downloading https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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 01:56:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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 01:56:56 INFO - Downloaded 21831225 bytes. 01:56:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:56:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:56:57 INFO - Return code: 0 01:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:56:57 INFO - trying https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 01:56:57 INFO - Downloading https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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 01:56:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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 01:56:58 INFO - Downloaded 14413723 bytes. 01:56:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:56:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:56:59 INFO - Return code: 0 01:56: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')]} 01:56:59 INFO - trying https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 01:56:59 INFO - Downloading https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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 01:56:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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 01:57:01 INFO - Downloaded 59300254 bytes. 01:57:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 01:57:01 INFO - mkdir: /builds/slave/test/properties 01:57:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:57:01 INFO - Writing to file /builds/slave/test/properties/build_url 01:57:01 INFO - Contents: 01:57:01 INFO - build_url:https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 01:57:01 INFO - Running post-action listener: _resource_record_post_action 01:57:01 INFO - Running post-action listener: set_extra_try_arguments 01:57:01 INFO - [mozharness: 2016-08-10 08:57:01.898885Z] Finished download-and-extract step (success) 01:57:01 INFO - [mozharness: 2016-08-10 08:57:01.899124Z] Running populate-webroot step. 01:57:01 INFO - Running pre-action listener: _resource_record_pre_action 01:57:01 INFO - Running main action method: populate_webroot 01:57:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:57:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:57:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:57:01 INFO - '--tppagecycles', 01:57:01 INFO - '7'], 01:57:01 INFO - 'tests': ['tsvgm']}}, 01:57:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:57:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:57:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:57:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:57:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:57:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:57:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:01 INFO - 'talos_options': ['--disable-e10s'], 01:57:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:57:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:57:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:01 INFO - 'talos_options': ['--disable-e10s'], 01:57:01 INFO - 'tests': ['damp', 'tps']}, 01:57:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:01 INFO - 'tests': ['damp', 'tps']}, 01:57:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:57:01 INFO - 'tests': ['dromaeo_dom']}, 01:57:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:57:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:57:01 INFO - 'tests': ['basic_compositor_video']}, 01:57:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:57:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:57:01 INFO - 'tests': ['a11yr', 01:57:01 INFO - 'ts_paint', 01:57:01 INFO - 'tpaint', 01:57:01 INFO - 'sessionrestore', 01:57:01 INFO - 'sessionrestore_no_auto_restore', 01:57:01 INFO - 'tabpaint']}, 01:57:01 INFO - 'other-e10s': {'tests': ['a11yr', 01:57:01 INFO - 'ts_paint', 01:57:01 INFO - 'tpaint', 01:57:01 INFO - 'sessionrestore', 01:57:01 INFO - 'sessionrestore_no_auto_restore', 01:57:01 INFO - 'tabpaint']}, 01:57:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:57:01 INFO - 'ts_paint', 01:57:01 INFO - 'tpaint', 01:57:01 INFO - 'sessionrestore', 01:57:01 INFO - 'sessionrestore_no_auto_restore', 01:57:01 INFO - 'tabpaint']}, 01:57:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:57:01 INFO - 'ts_paint', 01:57:01 INFO - 'tpaint', 01:57:01 INFO - 'sessionrestore', 01:57:01 INFO - 'sessionrestore_no_auto_restore', 01:57:01 INFO - 'tabpaint']}, 01:57:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:57:01 INFO - 'tests': ['a11yr', 01:57:01 INFO - 'ts_paint', 01:57:01 INFO - 'tpaint', 01:57:01 INFO - 'sessionrestore', 01:57:01 INFO - 'sessionrestore_no_auto_restore', 01:57:01 INFO - 'tabpaint']}, 01:57:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:57:01 INFO - 'tests': ['a11yr', 01:57:01 INFO - 'ts_paint', 01:57:01 INFO - 'tpaint', 01:57:01 INFO - 'sessionrestore', 01:57:01 INFO - 'sessionrestore_no_auto_restore', 01:57:01 INFO - 'tabpaint']}, 01:57:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:57:01 INFO - 'tests': ['tsvgx', 01:57:01 INFO - 'tsvgr_opacity', 01:57:01 INFO - 'tart', 01:57:01 INFO - 'tscrollx', 01:57:01 INFO - 'cart']}, 01:57:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:57:01 INFO - 'tsvgr_opacity', 01:57:01 INFO - 'tart', 01:57:01 INFO - 'tscrollx', 01:57:01 INFO - 'cart']}, 01:57:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:01 INFO - 'talos_options': ['--disable-e10s'], 01:57:01 INFO - 'tests': ['tp5o']}, 01:57:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:01 INFO - 'tests': ['tp5o']}, 01:57:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:01 INFO - 'talos_options': ['--disable-e10s', 01:57:01 INFO - '--xperf_path', 01:57:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:57:01 INFO - 'tests': ['tp5n']}, 01:57:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:01 INFO - 'talos_options': ['--xperf_path', 01:57:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:57:01 INFO - 'tests': ['tp5n']}}, 01:57:01 INFO - 'talos.zip': {'path': '', 01:57:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:57:01 INFO - Running post-action listener: _resource_record_post_action 01:57:01 INFO - [mozharness: 2016-08-10 08:57:01.916079Z] Finished populate-webroot step (success) 01:57:01 INFO - [mozharness: 2016-08-10 08:57:01.916167Z] Running create-virtualenv step. 01:57:01 INFO - Running pre-action listener: _resource_record_pre_action 01:57:01 INFO - Running main action method: create_virtualenv 01:57:01 INFO - Creating virtualenv /builds/slave/test/build/venv 01:57:01 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 01:57:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:57:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:57:02 INFO - Using real prefix '/usr' 01:57:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:57:02 INFO - Installing distribute.............................................................................................................................................................................................done. 01:57:04 INFO - Installing pip.................done. 01:57:04 INFO - Return code: 0 01:57:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:57:04 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')]} 01:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:04 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')]} 01:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:04 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 0xcae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d3b0>, '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 0xf6e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6e740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', '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 01:57:04 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 01:57:04 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 01:57:04 INFO - Using env: {'DISPLAY': ':0', 01:57:04 INFO - 'HOME': '/home/cltbld', 01:57:04 INFO - 'LANG': 'en_US.UTF-8', 01:57:04 INFO - 'LANGUAGE': 'en_US:en', 01:57:04 INFO - 'LOGNAME': 'cltbld', 01:57:04 INFO - 'MAIL': '/var/mail/cltbld', 01:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:04 INFO - 'MOZ_NO_REMOTE': '1', 01:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:04 INFO - 'NO_EM_RESTART': '1', 01:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:04 INFO - 'PWD': '/builds/slave/test', 01:57:04 INFO - 'SHELL': '/bin/bash', 01:57:04 INFO - 'SHLVL': '1', 01:57:04 INFO - 'TERM': 'linux', 01:57:04 INFO - 'TMOUT': '86400', 01:57:04 INFO - 'USER': 'cltbld', 01:57:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', 01:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:04 INFO - '_': '/tools/buildbot/bin/python'} 01:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:04 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 01:57:04 INFO - Cleaning up... 01:57:04 INFO - Return code: 0 01:57:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:57:04 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')]} 01:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:04 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')]} 01:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:04 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 0xcae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d3b0>, '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 0xf6e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6e740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', '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 01:57:04 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 01:57:04 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 01:57:04 INFO - Using env: {'DISPLAY': ':0', 01:57:04 INFO - 'HOME': '/home/cltbld', 01:57:04 INFO - 'LANG': 'en_US.UTF-8', 01:57:04 INFO - 'LANGUAGE': 'en_US:en', 01:57:04 INFO - 'LOGNAME': 'cltbld', 01:57:04 INFO - 'MAIL': '/var/mail/cltbld', 01:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:04 INFO - 'MOZ_NO_REMOTE': '1', 01:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:04 INFO - 'NO_EM_RESTART': '1', 01:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:04 INFO - 'PWD': '/builds/slave/test', 01:57:04 INFO - 'SHELL': '/bin/bash', 01:57:04 INFO - 'SHLVL': '1', 01:57:04 INFO - 'TERM': 'linux', 01:57:04 INFO - 'TMOUT': '86400', 01:57:04 INFO - 'USER': 'cltbld', 01:57:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', 01:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:04 INFO - '_': '/tools/buildbot/bin/python'} 01:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:04 INFO - Downloading/unpacking psutil>=3.1.1 01:57:04 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 01:57:04 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 01:57:04 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 01:57:04 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 01:57:04 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 01:57:04 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 01:57:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:57:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:57:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:57:06 INFO - Installing collected packages: psutil 01:57:06 INFO - Running setup.py install for psutil 01:57:07 INFO - building 'psutil._psutil_linux' extension 01:57:07 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 01:57:07 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 01:57:07 INFO - building 'psutil._psutil_posix' extension 01:57:07 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 01:57:07 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 01:57:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:57:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:57:08 INFO - Successfully installed psutil 01:57:08 INFO - Cleaning up... 01:57:08 INFO - Return code: 0 01:57:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:57:08 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')]} 01:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:08 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')]} 01:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:08 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 0xcae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d3b0>, '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 0xf6e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6e740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', '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 01:57:08 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 01:57:08 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 01:57:08 INFO - Using env: {'DISPLAY': ':0', 01:57:08 INFO - 'HOME': '/home/cltbld', 01:57:08 INFO - 'LANG': 'en_US.UTF-8', 01:57:08 INFO - 'LANGUAGE': 'en_US:en', 01:57:08 INFO - 'LOGNAME': 'cltbld', 01:57:08 INFO - 'MAIL': '/var/mail/cltbld', 01:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:08 INFO - 'MOZ_NO_REMOTE': '1', 01:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:08 INFO - 'NO_EM_RESTART': '1', 01:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:08 INFO - 'PWD': '/builds/slave/test', 01:57:08 INFO - 'SHELL': '/bin/bash', 01:57:08 INFO - 'SHLVL': '1', 01:57:08 INFO - 'TERM': 'linux', 01:57:08 INFO - 'TMOUT': '86400', 01:57:08 INFO - 'USER': 'cltbld', 01:57:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', 01:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:08 INFO - '_': '/tools/buildbot/bin/python'} 01:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:57:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:57:10 INFO - Installing collected packages: mozsystemmonitor 01:57:10 INFO - Running setup.py install for mozsystemmonitor 01:57:10 INFO - Successfully installed mozsystemmonitor 01:57:10 INFO - Cleaning up... 01:57:10 INFO - Return code: 0 01:57:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d3b0>, '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 0xf6e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6e740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', '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 01:57:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:57:10 INFO - Using env: {'DISPLAY': ':0', 01:57:10 INFO - 'HOME': '/home/cltbld', 01:57:10 INFO - 'LANG': 'en_US.UTF-8', 01:57:10 INFO - 'LANGUAGE': 'en_US:en', 01:57:10 INFO - 'LOGNAME': 'cltbld', 01:57:10 INFO - 'MAIL': '/var/mail/cltbld', 01:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:10 INFO - 'MOZ_NO_REMOTE': '1', 01:57:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:10 INFO - 'NO_EM_RESTART': '1', 01:57:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:10 INFO - 'PWD': '/builds/slave/test', 01:57:10 INFO - 'SHELL': '/bin/bash', 01:57:10 INFO - 'SHLVL': '1', 01:57:10 INFO - 'TERM': 'linux', 01:57:10 INFO - 'TMOUT': '86400', 01:57:10 INFO - 'USER': 'cltbld', 01:57:10 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', 01:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:10 INFO - '_': '/tools/buildbot/bin/python'} 01:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:10 INFO - Downloading/unpacking jsonschema==2.5.1 01:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:57:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:57:12 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 01:57:12 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 01:57:12 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 01:57:12 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 01:57:12 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 01:57:12 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 01:57:12 INFO - Downloading functools32-3.2.3-2.tar.gz 01:57:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:57:13 INFO - warning: no files found matching '*.txt' 01:57:13 INFO - no previously-included directories found matching 'build' 01:57:13 INFO - no previously-included directories found matching 'dist' 01:57:13 INFO - no previously-included directories found matching '.git*' 01:57:13 INFO - Installing collected packages: jsonschema, functools32 01:57:13 INFO - Running setup.py install for functools32 01:57:13 INFO - warning: no files found matching '*.txt' 01:57:13 INFO - no previously-included directories found matching 'build' 01:57:13 INFO - no previously-included directories found matching 'dist' 01:57:13 INFO - no previously-included directories found matching '.git*' 01:57:13 INFO - Successfully installed jsonschema functools32 01:57:13 INFO - Cleaning up... 01:57:13 INFO - Return code: 0 01:57:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:57:13 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')]} 01:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:13 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')]} 01:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:13 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 0xcae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d3b0>, '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 0xf6e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6e740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', '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 01:57:13 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 01:57:13 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 01:57:13 INFO - Using env: {'DISPLAY': ':0', 01:57:13 INFO - 'HOME': '/home/cltbld', 01:57:13 INFO - 'LANG': 'en_US.UTF-8', 01:57:13 INFO - 'LANGUAGE': 'en_US:en', 01:57:13 INFO - 'LOGNAME': 'cltbld', 01:57:13 INFO - 'MAIL': '/var/mail/cltbld', 01:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:13 INFO - 'MOZ_NO_REMOTE': '1', 01:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:13 INFO - 'NO_EM_RESTART': '1', 01:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:13 INFO - 'PWD': '/builds/slave/test', 01:57:13 INFO - 'SHELL': '/bin/bash', 01:57:13 INFO - 'SHLVL': '1', 01:57:13 INFO - 'TERM': 'linux', 01:57:13 INFO - 'TMOUT': '86400', 01:57:13 INFO - 'USER': 'cltbld', 01:57:13 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', 01:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:13 INFO - '_': '/tools/buildbot/bin/python'} 01:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:57:13 INFO - Cleaning up... 01:57:13 INFO - Return code: 0 01:57:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:57:13 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')]} 01:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:13 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')]} 01:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:13 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 0xcae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d3b0>, '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 0xf6e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6e740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', '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 01:57:13 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 01:57:13 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 01:57:13 INFO - Using env: {'DISPLAY': ':0', 01:57:13 INFO - 'HOME': '/home/cltbld', 01:57:13 INFO - 'LANG': 'en_US.UTF-8', 01:57:13 INFO - 'LANGUAGE': 'en_US:en', 01:57:13 INFO - 'LOGNAME': 'cltbld', 01:57:13 INFO - 'MAIL': '/var/mail/cltbld', 01:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:13 INFO - 'MOZ_NO_REMOTE': '1', 01:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:13 INFO - 'NO_EM_RESTART': '1', 01:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:13 INFO - 'PWD': '/builds/slave/test', 01:57:13 INFO - 'SHELL': '/bin/bash', 01:57:13 INFO - 'SHLVL': '1', 01:57:13 INFO - 'TERM': 'linux', 01:57:13 INFO - 'TMOUT': '86400', 01:57:13 INFO - 'USER': 'cltbld', 01:57:13 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', 01:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:13 INFO - '_': '/tools/buildbot/bin/python'} 01:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:13 INFO - Downloading/unpacking blobuploader==1.2.4 01:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:15 INFO - Downloading blobuploader-1.2.4.tar.gz 01:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:57:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:57:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:16 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 01:57:16 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 01:57:16 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 01:57:16 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 01:57:16 INFO - Downloading docopt-0.6.1.tar.gz 01:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:57:16 INFO - Installing collected packages: blobuploader, requests, docopt 01:57:16 INFO - Running setup.py install for blobuploader 01:57:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:57:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:57:16 INFO - Running setup.py install for requests 01:57:16 INFO - Running setup.py install for docopt 01:57:16 INFO - Successfully installed blobuploader requests docopt 01:57:16 INFO - Cleaning up... 01:57:16 INFO - Return code: 0 01:57:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:57: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')]} 01:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57: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')]} 01:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:16 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 0xcae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d3b0>, '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 0xf6e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6e740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', '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 01:57:16 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 01:57:16 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 01:57:16 INFO - Using env: {'DISPLAY': ':0', 01:57:16 INFO - 'HOME': '/home/cltbld', 01:57:16 INFO - 'LANG': 'en_US.UTF-8', 01:57:16 INFO - 'LANGUAGE': 'en_US:en', 01:57:16 INFO - 'LOGNAME': 'cltbld', 01:57:16 INFO - 'MAIL': '/var/mail/cltbld', 01:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:16 INFO - 'MOZ_NO_REMOTE': '1', 01:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:16 INFO - 'NO_EM_RESTART': '1', 01:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:16 INFO - 'PWD': '/builds/slave/test', 01:57:16 INFO - 'SHELL': '/bin/bash', 01:57:16 INFO - 'SHLVL': '1', 01:57:16 INFO - 'TERM': 'linux', 01:57:16 INFO - 'TMOUT': '86400', 01:57:16 INFO - 'USER': 'cltbld', 01:57:16 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', 01:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:16 INFO - '_': '/tools/buildbot/bin/python'} 01:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:57:17 INFO - Running setup.py (path:/tmp/pip-JcsXSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:57:17 INFO - Running setup.py (path:/tmp/pip-QYIjOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:57:17 INFO - Running setup.py (path:/tmp/pip-pFIf3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:57:17 INFO - Running setup.py (path:/tmp/pip-uvAzsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:57:17 INFO - Running setup.py (path:/tmp/pip-BCFDNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:57:17 INFO - Running setup.py (path:/tmp/pip-wnJPOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:57:17 INFO - Running setup.py (path:/tmp/pip-hN2iYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:57:17 INFO - Running setup.py (path:/tmp/pip-tce12r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:57:17 INFO - Running setup.py (path:/tmp/pip-nNgHY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:57:17 INFO - Running setup.py (path:/tmp/pip-Fx2r8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:57:17 INFO - Running setup.py (path:/tmp/pip-JmcXQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:57:17 INFO - Running setup.py (path:/tmp/pip-68utD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:57:17 INFO - Running setup.py (path:/tmp/pip-cDwYLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:57:18 INFO - Running setup.py (path:/tmp/pip-Sxe9Q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:57:18 INFO - Running setup.py (path:/tmp/pip-pvZ4Rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:57:18 INFO - Running setup.py (path:/tmp/pip-vzyjhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:57:18 INFO - Running setup.py (path:/tmp/pip-CFO38V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:57:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:57:18 INFO - Running setup.py install for manifestparser 01:57:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:57:18 INFO - Running setup.py install for mozcrash 01:57:18 INFO - Running setup.py install for mozdebug 01:57:18 INFO - Running setup.py install for mozdevice 01:57:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:57:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:57:18 INFO - Running setup.py install for mozfile 01:57:18 INFO - Running setup.py install for mozhttpd 01:57:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:57:18 INFO - Running setup.py install for mozinfo 01:57:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:57:19 INFO - Running setup.py install for mozInstall 01:57:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:57:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:57:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:57:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:57:19 INFO - Running setup.py install for mozleak 01:57:19 INFO - Running setup.py install for mozlog 01:57:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:57:19 INFO - Running setup.py install for moznetwork 01:57:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:57:19 INFO - Running setup.py install for mozprocess 01:57:19 INFO - Running setup.py install for mozprofile 01:57:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:57:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:57:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:57:19 INFO - Running setup.py install for mozrunner 01:57:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:57:19 INFO - Running setup.py install for mozscreenshot 01:57:19 INFO - Running setup.py install for moztest 01:57:20 INFO - Running setup.py install for mozversion 01:57:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:57:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:57:20 INFO - Cleaning up... 01:57:20 INFO - Return code: 0 01:57:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:57:20 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')]} 01:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:20 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')]} 01:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:20 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 0xcae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d3b0>, '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 0xf6e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6e740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', '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 01:57:20 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 01:57:20 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 01:57:20 INFO - Using env: {'DISPLAY': ':0', 01:57:20 INFO - 'HOME': '/home/cltbld', 01:57:20 INFO - 'LANG': 'en_US.UTF-8', 01:57:20 INFO - 'LANGUAGE': 'en_US:en', 01:57:20 INFO - 'LOGNAME': 'cltbld', 01:57:20 INFO - 'MAIL': '/var/mail/cltbld', 01:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:20 INFO - 'MOZ_NO_REMOTE': '1', 01:57:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:20 INFO - 'NO_EM_RESTART': '1', 01:57:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:20 INFO - 'PWD': '/builds/slave/test', 01:57:20 INFO - 'SHELL': '/bin/bash', 01:57:20 INFO - 'SHLVL': '1', 01:57:20 INFO - 'TERM': 'linux', 01:57:20 INFO - 'TMOUT': '86400', 01:57:20 INFO - 'USER': 'cltbld', 01:57:20 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', 01:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:20 INFO - '_': '/tools/buildbot/bin/python'} 01:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:57:20 INFO - Running setup.py (path:/tmp/pip-SjuJWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:57:20 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)) 01:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:57:20 INFO - Running setup.py (path:/tmp/pip-06QNoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:57:20 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)) 01:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:57:20 INFO - Running setup.py (path:/tmp/pip-E4atDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:57:20 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)) 01:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:57:20 INFO - Running setup.py (path:/tmp/pip-sESa89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:57:20 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)) 01:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:57:20 INFO - Running setup.py (path:/tmp/pip-PMEKnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:57:20 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)) 01:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:57:20 INFO - Running setup.py (path:/tmp/pip-hs0ZUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:57:20 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)) 01:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:57:20 INFO - Running setup.py (path:/tmp/pip-CcJpS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:57:20 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)) 01:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:57:20 INFO - Running setup.py (path:/tmp/pip-Ff9_Uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:57:20 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)) 01:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:57:20 INFO - Running setup.py (path:/tmp/pip-tydZX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:57:20 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)) 01:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:57:21 INFO - Running setup.py (path:/tmp/pip-KGT3lN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:57:21 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)) 01:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:57:21 INFO - Running setup.py (path:/tmp/pip-RE1ETf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:57:21 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)) 01:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:57:21 INFO - Running setup.py (path:/tmp/pip-nYq_zM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:57:21 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)) 01:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:57:21 INFO - Running setup.py (path:/tmp/pip-ylMEXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:57:21 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)) 01:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:57:21 INFO - Running setup.py (path:/tmp/pip-hpCa95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:57:21 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)) 01:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:57:21 INFO - Running setup.py (path:/tmp/pip-McbKk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:57:21 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)) 01:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:57:21 INFO - Running setup.py (path:/tmp/pip-ugTzH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:57:21 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)) 01:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:57:21 INFO - Running setup.py (path:/tmp/pip-xCelTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:57:21 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)) 01:57:21 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)) 01:57:21 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)) 01:57:21 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)) 01:57:21 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)) 01:57:21 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)) 01:57:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:57:21 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 01:57:21 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 01:57:21 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 01:57:21 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 01:57:21 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 01:57:21 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 01:57:23 INFO - Downloading blessings-1.6.tar.gz 01:57:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:57:23 INFO - Installing collected packages: blessings 01:57:23 INFO - Running setup.py install for blessings 01:57:23 INFO - Successfully installed blessings 01:57:23 INFO - Cleaning up... 01:57:23 INFO - Return code: 0 01:57:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:57:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:57:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:57:23 INFO - Reading from file tmpfile_stdout 01:57:23 INFO - Current package versions: 01:57:23 INFO - argparse == 1.2.1 01:57:23 INFO - blessings == 1.6 01:57:23 INFO - blobuploader == 1.2.4 01:57:23 INFO - docopt == 0.6.1 01:57:23 INFO - functools32 == 3.2.3-2 01:57:23 INFO - jsonschema == 2.5.1 01:57:23 INFO - manifestparser == 1.1 01:57:23 INFO - mozInstall == 1.12 01:57:23 INFO - mozcrash == 0.17 01:57:23 INFO - mozdebug == 0.1 01:57:23 INFO - mozdevice == 0.48 01:57:23 INFO - mozfile == 1.2 01:57:23 INFO - mozhttpd == 0.7 01:57:23 INFO - mozinfo == 0.9 01:57:23 INFO - mozleak == 0.1 01:57:23 INFO - mozlog == 3.3 01:57:23 INFO - moznetwork == 0.27 01:57:23 INFO - mozprocess == 0.23 01:57:23 INFO - mozprofile == 0.28 01:57:23 INFO - mozrunner == 6.12 01:57:23 INFO - mozscreenshot == 0.1 01:57:23 INFO - mozsystemmonitor == 0.3 01:57:23 INFO - moztest == 0.7 01:57:23 INFO - mozversion == 1.4 01:57:23 INFO - psutil == 3.1.1 01:57:23 INFO - requests == 1.2.3 01:57:23 INFO - wsgiref == 0.1.2 01:57:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:57:23 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')]} 01:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:23 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')]} 01:57:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:23 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 0xcae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d3b0>, '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 0xf6e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6e740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', '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 01:57:23 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 01:57:23 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 01:57:23 INFO - Using env: {'DISPLAY': ':0', 01:57:23 INFO - 'HOME': '/home/cltbld', 01:57:23 INFO - 'LANG': 'en_US.UTF-8', 01:57:23 INFO - 'LANGUAGE': 'en_US:en', 01:57:23 INFO - 'LOGNAME': 'cltbld', 01:57:23 INFO - 'MAIL': '/var/mail/cltbld', 01:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:23 INFO - 'MOZ_NO_REMOTE': '1', 01:57:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:23 INFO - 'NO_EM_RESTART': '1', 01:57:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:23 INFO - 'PWD': '/builds/slave/test', 01:57:23 INFO - 'SHELL': '/bin/bash', 01:57:23 INFO - 'SHLVL': '1', 01:57:23 INFO - 'TERM': 'linux', 01:57:23 INFO - 'TMOUT': '86400', 01:57:23 INFO - 'USER': 'cltbld', 01:57:23 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', 01:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:23 INFO - '_': '/tools/buildbot/bin/python'} 01:57:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:24 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)) 01:57:24 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)) 01:57:24 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)) 01:57:24 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)) 01:57:24 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)) 01:57:24 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)) 01:57:24 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)) 01:57:24 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)) 01:57:24 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)) 01:57:24 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)) 01:57:24 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)) 01:57:24 INFO - Cleaning up... 01:57:24 INFO - Return code: 0 01:57:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:57: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')]} 01:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57: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')]} 01:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:24 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 0xcae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d3b0>, '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 0xf6e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6e740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', '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 01:57:24 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 01:57:24 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 01:57:24 INFO - Using env: {'DISPLAY': ':0', 01:57:24 INFO - 'HOME': '/home/cltbld', 01:57:24 INFO - 'LANG': 'en_US.UTF-8', 01:57:24 INFO - 'LANGUAGE': 'en_US:en', 01:57:24 INFO - 'LOGNAME': 'cltbld', 01:57:24 INFO - 'MAIL': '/var/mail/cltbld', 01:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:24 INFO - 'MOZ_NO_REMOTE': '1', 01:57:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:24 INFO - 'NO_EM_RESTART': '1', 01:57:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:24 INFO - 'PWD': '/builds/slave/test', 01:57:24 INFO - 'SHELL': '/bin/bash', 01:57:24 INFO - 'SHLVL': '1', 01:57:24 INFO - 'TERM': 'linux', 01:57:24 INFO - 'TMOUT': '86400', 01:57:24 INFO - 'USER': 'cltbld', 01:57:24 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', 01:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:24 INFO - '_': '/tools/buildbot/bin/python'} 01:57:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:57:24 INFO - Cleaning up... 01:57:24 INFO - Return code: 0 01:57:24 INFO - Running post-action listener: _resource_record_post_action 01:57:24 INFO - Running post-action listener: _start_resource_monitoring 01:57:24 INFO - Starting resource monitoring. 01:57:24 INFO - [mozharness: 2016-08-10 08:57:24.397117Z] Finished create-virtualenv step (success) 01:57:24 INFO - [mozharness: 2016-08-10 08:57:24.397551Z] Running install step. 01:57:24 INFO - Running pre-action listener: _resource_record_pre_action 01:57:24 INFO - Running main action method: install 01:57:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:57:24 INFO - Reading from file tmpfile_stdout 01:57:24 INFO - Detecting whether we're running mozinstall >=1.0... 01:57:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:57:24 INFO - Reading from file tmpfile_stdout 01:57:24 INFO - Output received: 01:57:24 INFO - Usage: mozinstall [options] installer 01:57:24 INFO - Options: 01:57:24 INFO - -h, --help show this help message and exit 01:57:24 INFO - -d DEST, --destination=DEST 01:57:24 INFO - Directory to install application into. [default: 01:57:24 INFO - "/builds/slave/test"] 01:57:24 INFO - --app=APP Application being installed. [default: firefox] 01:57:24 INFO - mkdir: /builds/slave/test/build/application 01:57:24 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'] 01:57:24 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 01:57:41 INFO - Reading from file tmpfile_stdout 01:57:41 INFO - Output received: 01:57:41 INFO - /builds/slave/test/build/application/firefox/firefox 01:57:41 INFO - Running post-action listener: _resource_record_post_action 01:57:41 INFO - [mozharness: 2016-08-10 08:57:41.544718Z] Finished install step (success) 01:57:41 INFO - [mozharness: 2016-08-10 08:57:41.545025Z] Running run-tests step. 01:57:41 INFO - Running pre-action listener: _resource_record_pre_action 01:57:41 INFO - Running main action method: run_tests 01:57:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:57:41 INFO - Python 2.7.3 01:57:41 INFO - Return code: 0 01:57:41 INFO - grabbing minidump binary from tooltool 01:57: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')]} 01:57:41 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 0xf6d3b0>, '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 0xf6e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:57:41 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 01:57:41 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 01:57:41 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 01:57:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:57:41 INFO - Return code: 0 01:57:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:57:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:57:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:57:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:57:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:57:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 01:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 01:57:41 INFO - Using env: {'DISPLAY': ':0', 01:57:41 INFO - 'HOME': '/home/cltbld', 01:57:41 INFO - 'LANG': 'en_US.UTF-8', 01:57:41 INFO - 'LANGUAGE': 'en_US:en', 01:57:41 INFO - 'LOGNAME': 'cltbld', 01:57:41 INFO - 'MAIL': '/var/mail/cltbld', 01:57:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:57:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:41 INFO - 'MOZ_NO_REMOTE': '1', 01:57:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:41 INFO - 'NO_EM_RESTART': '1', 01:57:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:41 INFO - 'PWD': '/builds/slave/test', 01:57:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:57:41 INFO - 'SHELL': '/bin/bash', 01:57:41 INFO - 'SHLVL': '1', 01:57:41 INFO - 'TERM': 'linux', 01:57:41 INFO - 'TMOUT': '86400', 01:57:41 INFO - 'USER': 'cltbld', 01:57:41 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895', 01:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:41 INFO - '_': '/tools/buildbot/bin/python'} 01:57:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 01:57:41 INFO - mozversion application_buildid: 20160809233002 01:57:41 INFO - mozversion application_changeset: 3269dd1a824d1b42cb021d1fb6858885179940b0 01:57:41 INFO - mozversion application_display_name: Nightly 01:57:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:57:41 INFO - mozversion application_name: Firefox 01:57:41 INFO - mozversion application_remotingname: firefox 01:57:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:57:41 INFO - mozversion application_vendor: Mozilla 01:57:41 INFO - mozversion application_version: 51.0a1 01:57:41 INFO - mozversion platform_buildid: 20160809233002 01:57:41 INFO - mozversion platform_changeset: 3269dd1a824d1b42cb021d1fb6858885179940b0 01:57:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:57:41 INFO - mozversion platform_version: 51.0a1 01:57:41 INFO - using testdate: 1470819461 01:57:41 INFO - actual date: 1470819461 01:57:41 INFO - starting webserver on 'localhost:39672' 01:57:41 INFO - SUITE-START | Running 2 tests 01:57:41 INFO - TEST-START | dromaeo_css 01:57:41 INFO - operating with platform_type : linux_ 01:57:41 INFO - Initialising browser for dromaeo_css test... 01:57:41 INFO - TEST-INFO | started process 4288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKQuyyE/profile http://localhost:39672/getInfo.html) 01:57:46 INFO - PROCESS | 4288 | __metrics Screen width/height:1600/1200 01:57:46 INFO - PROCESS | 4288 | colorDepth:24 01:57:46 INFO - PROCESS | 4288 | Browser inner width/height: 1024/697 01:57:46 INFO - PROCESS | 4288 | __metrics 01:57:47 INFO - PROCESS | 4288 | 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" 01:57:47 INFO - PROCESS | 4288 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:57:48 INFO - TEST-INFO | 4288: exit 0 01:57:48 INFO - Browser initialized. 01:57:48 INFO - Running cycle 1/1 for dromaeo_css test... 01:57:48 INFO - TEST-INFO | started process 4371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKQuyyE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:57:59 INFO - PROCESS | 4371 | RSS: Main: 155680768 01:57:59 INFO - PROCESS | 4371 | 01:58:50 INFO - PROCESS | 4371 | 1470819530657 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:01:01 INFO - PROCESS | 4371 | Cycle 1(1): loaded http://localhost:39672/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39672/tests/dromaeo/cssquery-ext.html) 02:01:02 INFO - PROCESS | 4371 | RSS: Main: 277450752 02:01:02 INFO - PROCESS | 4371 | 02:04:05 INFO - PROCESS | 4371 | Cycle 1(1): loaded http://localhost:39672/tests/dromaeo/cssquery-ext.html (next: http://localhost:39672/tests/dromaeo/cssquery-jquery.html) 02:04:05 INFO - PROCESS | 4371 | RSS: Main: 253714432 02:04:05 INFO - PROCESS | 4371 | 02:07:07 INFO - PROCESS | 4371 | Cycle 1(1): loaded http://localhost:39672/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39672/tests/dromaeo/cssquery-mootools.html) 02:07:08 INFO - PROCESS | 4371 | RSS: Main: 185548800 02:07:08 INFO - PROCESS | 4371 | 02:10:10 INFO - PROCESS | 4371 | Cycle 1(1): loaded http://localhost:39672/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39672/tests/dromaeo/cssquery-prototype.html) 02:10:10 INFO - PROCESS | 4371 | RSS: Main: 216313856 02:10:10 INFO - PROCESS | 4371 | 02:13:13 INFO - PROCESS | 4371 | Cycle 1(1): loaded http://localhost:39672/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39672/tests/dromaeo/cssquery-yui.html) 02:13:13 INFO - PROCESS | 4371 | RSS: Main: 187142144 02:13:13 INFO - PROCESS | 4371 | 02:16:17 INFO - PROCESS | 4371 | Cycle 1(1): loaded http://localhost:39672/tests/dromaeo/cssquery-yui.html (next: http://localhost:39672/tests/dromaeo/cssquery-dojo.html) 02:16:17 INFO - PROCESS | 4371 | RSS: Main: 274964480 02:16:17 INFO - PROCESS | 4371 | 02:16:17 INFO - PROCESS | 4371 | __start_tp_report 02:16:17 INFO - PROCESS | 4371 | _x_x_mozilla_page_load 02:16:17 INFO - PROCESS | 4371 | _x_x_mozilla_page_load_details 02:16:17 INFO - PROCESS | 4371 | |i|pagename|runs| 02:16:17 INFO - PROCESS | 4371 | |0;dojo.html;3016.2308611304115;3024.652165001025;3029.0307101727444;3054.938901221977;3077.553754705568;5091.974540127303;5177.482251774821;5181.974090129549;5244.239585260135;5248.5538729207965;5186.7147306898105;5252.737363131847;5365.812196573121;5405.783768649259;5453.345598528173;4727.196376615983;4732.432108147027;4751.85744427666;4752.429708434993;4923.433805112404;4830.420349558058;4861.683990540621;4867.367242258501;4868.172410690174;4899.730514821684;4714.740689262089;4727.952720472786;4744.952550474485;4781.8087276508895;4848.539388758062;4782.713037217778;4787.114383839001;4790.305405716152;4817.108834865561;4892.168331383673;4797.472278049412;4833.226683730586;4845.3216549683075;4882;4902.240152776325;5160.664556803796;5191.844244672666;5352.759125839347;5353.812616558402;5376.1398176291605;5556.277683901108;5580.525655319262;5621.128725047624;5626.184203290541;5645.2096706461125;5638.971805140948;5639.887202255973;5671.7731290748325;5679.574031947579;5694.202811606378;5171.870703232449;5201.011807756589;5215.530602245816;5230.320058392384;5297.602679798992;5736.741846616912;5739.540836733051;5773.39379365169;5782.45066718661;5798;5514.862128446821;5559.33288005442;5561.555075593943;5562.638428502134;5562.805301814417;5496.340439147328;5580.469855363734;5592.972035139798;5633.352164501053;5662.320521537442;5653.038983372837;5668;5691.8292451226525;5693.060644993612;5695.772169113272;5641.689707066069;5684.403137670568;5686.516646085046;5691.658500489983;5697.401772813795;4260.68044896634;4286.164197981364;4337.306031035019;4374;4400.647948164139;3925.9018524537114;3950.9604903951167;3961.7028722845903;3962.306596345628;3962.841486340572;5417.26866872975;5418.133098704188;5420.159875219348;5425.755840987165;5429.918551221735;5630.521405680481;5672.631278966854;5696.857578560486;5728.828135155952;5781.335146458211;5348.224507446398;5371.62398632092;5372.516473517402;5386.811461598825;5398.62209645321;4758.928616070762;4933.28467372229;4938.506149385033;4945;4946.9010619787405;5790.913136302959;5846.736896839568;5857.033589457692;5890.646561206341;5952;5630.127330263816;5680.602357834912;5682.516986056232;5684.516816070515;5685.914711279417;5654.123610840326;5889.38161493037;5894.705264736832;5903.970480147572;5904.586678932434;5406.189071639285;5427.158790387496;5428.647137936022;5464.262324586289;5527.115661494142;5519.503244707996;5529.806456773994;5539.169124631338;5540.335159780852;5543.695096769717;5308.25684404176;5428.83713488596;5441.972790136024;5447.754851031792;5488.121900495901;5442.891142177055;5495.890082198253;5498.697571633598;5521.3926468087675;5600.299962504687;5478.424765399575;5514.228008078792;5521.861953451035;5522.972385138049;5530.529904958124;5479.506844384025;5583.581231407579;5640;5644.322681278109;5644.548436125182;5296.523312901703;5317;5344.625876188629;5438.102713052302;5442.891142177214 02:16:17 INFO - PROCESS | 4371 | |1;ext.html;564.1005621486571;590.7282649981014;591.0543130990415;600.2796644027167;601.3325209017992;33079.33841323175;45058;46081.769591152;46243;46300.07399852005;47297.527024729745;47364.526354736445;47757.283640745416;47792.52207477924;47888.28167577489;9035.72892813215;9181.173694367506;9185.724428267162;9192.080791920822;9192.35653504255;8945.0607686193;9039.41243819153;9042.593083311234;9043.502607356593;9047.23098536622;9075.727728168133;9116.8632470513;9117.361784675075;9124.589393477276;9126.680566180185;9042.095790420972;9074.591643376063;9082.09179082093;9090.13643703847;9090.454572725625;8993.325500587416;9072.36493445459;9086.045965173627;9088.50013249271;9089.909100908972;44577.554224457665;44972;44994.77502612499;45162.54837451649;45199.096018079785;3639.70882329413;3828.3874580067054;3954.2486927483974;4084.5711200323835;4402.1855956647805;34227.486587701205;34250.31499370024;34676.30647387063;35786.284274314625;35791.4631280531;4159.896002599929;4381.233284175257;4423.5797599228345;4452.777361131931;4505.887352816173;379138.99999999726;381070;381245;382761;382899;54188.45811541913;60618.696906515186;63289.36710632835;63649;63699.36300637027;66882.66558667175;67309.66345168243;67398.66300668563;67401;67411.32588674051;17857.642847143245;17892.194851231725;17925.910370448324;18104.456866294033;18121;13851.445942162201;13858.4456621734;13879.930600346934;13888.861111388958;13892.583222503341;18676.626467470847;18853.717194242097;18863.90568047151;18870.81129188718;18875.244990200237;5434.3207099112615;6218.626882387071;6278.497720182374;6325.272593651697;6665.633390163587;1026.3431403901359;1063.6596289187385;1098.8846171151913;1121.8205087186175;1177.1348059176498;33189.66810331914;33474.832625836716;33550.664493355245;33777.49333759995;33879;1102.2945314998408;1130.2032067392468;1164.778692048508;1177.8174382970653;1284.78158713019;17475.47573572795;17703.114844257736;17794.91102544505;17806;17831.197596108206;530697;534123;535052;535395;535603;61647.38352616506;61676;62011.37988620147;62199.378006220264;62200.68899655473;1325.801129830514;1372.6499742565782;1373.9931300343635;1377.8208832851865;1389.3956129084083;32141.67858321387;32176.839115805207;33223.501647474826;33250;33837.32325353529;55664.16503752366;56033;56072.439275608354;56203.43796562146;56231.718841405534;477896;479467;480472;480701;480845;28831.711682883742;29570.852145739133;29697.703022969494;31438.371232574762;44994.3250851244;48995.755021224664;49741.75129124476;50082.2487662678;51899.74050129725;54696.45303546914;41643;43570.78214608907;44424.555754442044;45377.77311113424;45675;43696.56303437052;43828.56171438245;44428.62830977478;45301.32048019217;45426.54573454223;41795.1640967185;43313.350299744896;43468.347974781034;44249.33625995548;46156.30765538587;34728;38315.61684383232;38644.420333694456;38711.61288387193;39532.80233598813;28110.96904641489;29293.974710885017;29410.411791763618;29580.556291656074;30759.2310192247 02:16:17 INFO - PROCESS | 4371 | |2;jquery.html;361.2504054087768;369.6488336080724;386.1812956532152;389.8382171398869;407.0190840075417;17660.02869842158;19396.70904936427;19604.117814698337;20289.797102028977;20441.080151393187;19867.20531178751;20004.69992950107;20177.293794717152;20206.49483762903;20399.898000509977;5340.172273297645;5645.8588535286635;5751.741171647286;5804.854878628026;5928.081147422135;5683.8010669626365;5756.338021127582;5765.423457654243;5766.711664416784;5775;5673.773049078052;5735.541156707453;5766.221560089397;5794.565407594426;5804.680742559158;5525.557955363562;5632.211490391349;5655.0386434306265;5656.2929633795775;5658.603897727161;4800.903981920377;5100.362454693163;5174.353205849269;5178.844634660966;5178.870528236786;23880;24032.158874439312;24312;24415.267541973593;24457.755422445905;2329.7087864017;2343.320437073247;2373.465970156701;2495.151648439521;2518.5214809186195;14541.563753087425;14859.182744949023;15033.774493382609;15091.849081509265;15474.767878481833;1864.1611274926338;1939.7890280683134;1944.9222031118738;1964.5383334916282;1977.2486455147096;78990.21009789886;81763;82286;83271.16728832755;83705.58147209225;9278.536073196448;9403.952980235055;10208.336458130198;10347.586096556204;10347.63783267582;14913.627159321104;14927.552173434815;14943.252837358088;14959.252037398086;14971.101733896001;8450.81445971731;8555.529445880411;8629.395942284105;8727.334519501825;8797.29621630268;8500.617472213766;8504.277136443348;8559.22966932979;8757.080506546848;8805.559722013873;6534;6594.340565943463;6628.801135965929;6651.467882569383;6790.860878823254;1754.3421217043608;1789.7225929980873;1794.246416505071;1807.8372946434883;1810.384469280451;937.2408349237004;1005.2561104782409;1016.1058268723476;1083.978320433587;1090.9618163364244;20600.793992059887;20795.480112996993;20872.47818804542;21098.738825031818;21104;1034.0590063042596;1053.1890444357803;1075.9946200268948;1088.031651829872;1104.4091411095026;11267.661970140909;11441.713957151138;11786.58746943853;11857.762844743056;11977.760444791056;444162;445964;453420;483057;491495;58520;75506;89486;90541.54729226312;95371.52314238524;1001.4291853643499;1011.1607365886297;1058.142904247562;1061.4639606998571;1065.4299949526967;17696.29214831392;17984.367503598085;18462.630747385247;18498.445046648623;18859.90570047141;41507.584924150375;43259.918502037704;43413.34879976866;44182.11635767202;44248.55751442573;60638.39361606504;60782.39217607767;62111;62214.68892655508;62741.180329824936;8383.874241886499;8643.611037503202;8735;8791;8924.553772311489;12176.817347739614;13001.349932503526;13114.868851311365;13233.80149297742;13238.669033274246;11309.434528273718;11403.144764142888;11638.592649257236;11693.707657308296;12002.099842511672;11272.943635281772;11393.316401015965;11657.358845263592;11897.286162830258;12063.75872482563;11477.253978491372;11559.942200288944;11698.35659038761;11708.590199342982;12305.630831075083;8296.502209867427;8316.792080198044;8331.83336333282;8407.621657025571;8738.91261087381;10957.671269861918;11548.538058477567;11627.244229125079;11652.30086194831;11722.120840936794 02:16:17 INFO - PROCESS | 4371 | |3;mootools.html;1364.8089267502546;1425.2374979386027;1516.9924150379247;1600.9199540022996;1757.297081167532;8415.621297041633;8839.408906396846;8892.421992570486;9180.081991800816;9183.862242066374;9001.099890011012;9059.864102038475;9088.863667045;9150.267978561717;9185.954070229656;2373.964390534143;2402.783749462548;2407.085307583116;2417.02110645189;2426.3570153909227;2347.6126439137606;2366.2428023032635;2405.458771776354;2407.2898494944034;2408.7109546854313;2362.692849929507;2363.6927199464044;2370.573296806574;2400.6759087523224;2403.831731778776;2312.7571604981404;2325.686032385623;2333.9999999999914;2335.719713634358;2354.835161538693;2288.21056735426;2319.501307218956;2319.6404557293645;2321.152779235567;2323.2913961241816;8872.556372181365;9058.864117038249;9115.453072815651;9141.31440141992;9165.266778657691;5120.385553733576;5306.946930530722;5328.573714102862;5331.253624492574;5338.519533242027;3422.7946323220685;3486.808225547594;3540.4689296605457;3548.414511605582;3555.6266592007723;1146.816509358507;1156.7455159864817;1177.146568737667;1186.3060109835756;1202.6271855724754;12893.742125157538;12976.286304253263;12985.285809280485;13001.154924929755;13030.674233144153;4425.468943726773;4635.119327327797;4709.222978208557;4730.739809310452;4747.169245382044;9917.107460328605;9935;9942.652007179713;9945.254105942084;9949.154321882721;5233.031889100528;5238.476152384731;5267.868303292448;5276.5251127398715;5339.919901201485;4202.936955945664;4374.606285434326;4502.347159661831;4880.463149053601;4974;3885.203533275672;3897.395903634941;4007.979960100239;4010.258102251093;4015.678745700337;1184.3782014442315;1203.5196708049148;1205.584073494643;1213.120487646467;1221.7556488702296;998.5606333213362;1015.1269907879218;1016.7458135466134;1025.738436698637;1030.2067408095725;6309.432151106423;6395.20059992501;6439.774607888701;6473.514486413444;6641.169853768279;481.06673054275296;488.2578480709302;490.5854552902791;1028.359766172953;1077.8006068877282;4223.936640950388;4369.956300437018;4371.213181627274;4436.800343984529;4458.509563947963;10989;11371.886281137082;11377;11379.886201138048;11405.429728513542;11280.097592192606;11295.943520282346;11303.886961130447;11309.717257068474;11315.547378104948;8015.358771298283;8313;8324.542150181676;8466.449680770731;8488.320934325238;6371.426571608577;6417.8716425672155;6443.194600674916;6542.084108224947;6659.101021362054;10521.631742889269;10586.10018148466;10593.152547796311;10649.094826939487;10723.678289651323;9390.577424015799;9723.222142228464;10262.486875656337;10903.454827258764;10912.836307455236;7486.251374862471;7673.961630191813;7863.449558530848;7915.406344524068;8002.159773223728;7727.072751269883;7912.802179945547;7928.603569821371;8005.119436862057;8656.437331573428;7445.553266803792;7457.32884040439;7460.776176714708;7579.014728085313;7695.615219238904;7222.494425390172;7310.342069213796;7400.222976587381;7401.629918503945;7525.473216874766;6788.864222715617;6790.287019862843;6840.247572767091;6854.10896583441;6938.895916561357;4983.526564976321;5095.718208765813;5118.283440318432;5182.740862956913;5204.687718736888;5144.511271429208;5303.124984377689;5402.243685884058;5515.200295956984;5582.218489411567 02:16:17 INFO - PROCESS | 4371 | |4;prototype.html;322.4293001387544;334.01299160979306;336.25183965676365;337.868231389758;340.8193657361599;5214.983078299733;5234.371875374951;5251.474852514747;5251.818340873301;5270.919461510391;4903.436104847943;4997.975010124954;5122.974385128069;5124.487551244873;5207.921881171786;4083.7141400102005;4113.806995971165;4114.6296833285;4121.649659778915;4129.29801933672;4095.5290141633645;4111.218868415007;4118.794060296988;4123.402106694542;4124.216398884202;3867.57456679765;3897.7661340319673;4044.6562042226446;4068.8575899843513;4073.287174744423;4068.6948478864056;4072.5112986441522;4079.673626109904;4080.8369614659828;4083.7141400102005;3637.1452708613456;3640.9635903640888;3653.8903832885057;3658.140337020798;3662.688671462929;4807.6394270429855;5033.446320904697;5088.821891233826;5090.872728181788;5095.414027386861;4578.610818080467;4586.289125185602;4594.793234304464;4614.146382919171;4620.722756634613;5408.513233808976;5409.486098820606;5426.267453893753;5498.945010549884;5508.724563771795;3793.61533040441;3904.5509766376945;3907.5897030811925;3908.4332771748223;3913.5890731473355;5575.275214222125;5616.32604087508;5626.915596266059;5627.240322556443;5661.971690141523;4008.3586626139677;4017;4031.173609410064;4063;4063.2686116499312;3939.4484772131923;4107.240160570304;4115.794210289474;4120.651228799556;4122.237386083584;4609.847538115471;4611.469680986663;4652.55800698933;4673.018666080094;4684.414448193976;5434.91847622286;5438.456154384609;5448.291722076105;5449.155380915964;5453.727313634303;1377.937992790327;1387.1538361599619;1398.370897903951;1406.662401023747;1407.6269788506054;904.1320332480892;910.4476866941981;914.7895983923735;918.6049998500708;921.2675922641516;4688.765561721901;4695.483496815347;4707.458642256116;4716.3868697069165;4770.594499467515;4929.309896614477;4968.6025117990475;4979.203327467588;5045.772940217699;5053.823116190915;4777.546133117348;4797.112534181118;4882.26765985098;5258.631895767259;5310.4424035476495;2952.1586347890748;2953.379790244073;2959.955600665992;2960.2747326904614;2974.3159073413235;5610.775568977277;5733.483986441241;5742.827715168552;5744.655320680772;5815.534757219412;5713.457221563945;5718.542516598662;5722.2561067061015;5744.971275143597;5754.395788442153;5726.599138060295;5787.768489260382;5795.536357091422;5798.768049278066;5835.358110607915;5335.67985920846;5576.665400076008;5610.382857885711;5613.859653508695;5644.8306550803545;5546.256277013081;5546.334439867242;5547.556195504269;5547.556195504269;5548.944510554843;5791.870585235839;5801.375614827855;5803.506701930383;5822;5837;3839.9616003839606;4008.378701301303;4025.0943537703783;4048.817803198922;4050.67594592426;5256.369235691742;5360.65155764874;5548.056830338933;5616.943830561806;5624.128260119688;5385.434529374359;5395.541378982831;5430.67415955044;5439.918401223906;5442.156465747816;5397.973010134924;5411.134218525017;5427.701476418835;5449.23710680513;5458.908218356265;5206.817761378334;5417.702026388586;5418.322709661293;5421.783128674809;5447.101228297287;5409.269748583891;5464.726763661881;5474.974259524001;5478.780848766005;5494.478024587658;5159.638825282194;5234.740730769763;5345.572354211576;5346.304980352529;5352.625316227983 02:16:17 INFO - PROCESS | 4371 | |5;yui.html;741.3142842870346;750.2797314578006;780.2018821875357;781.6091954022988;873.0570983337993;16551;16953.152342382895;17393.304267829288;17448.56378590536;17502.29990800368;15520.068795872256;15542.68914621707;15662.530124096267;15688.76466852998;15691.529254122395;669.6685140855284;815.9836803263946;835.4611275727152;837.6984285657159;837.9413441059128;683.1221879884349;697.1007400453409;697.3061803505494;797.8404319136167;826.8801023851538;869.9956500217522;875.369733791669;875.382855087162;875.5972252763736;875.978100547485;869.4739682492096;872.1932212703256;873.6287077991828;874.6588830356167;875.3259989807844;508.6007484124944;613.187526527353;627.7645882793952;638.3138126513969;639.1818472355393;14507.202103884281;14550.854491455057;14557.490487832874;14606.561803145923;14609.415623375053;14460.49388271416;14944.701105977929;15159.253988168171;15259.847401525954;15569.688606227925;12756.80864787029;13099.803502947463;13126.934365328112;13321.933390333083;13689.178649281075;4501.707389019703;4503.324501324795;4547.295169248771;4738.573528382428;4756.857294281177;84420.07617029363;86792;86911.56544217301;87287;87707.56146219229;10486.26596138263;10989.890101098887;11098.61154859576;11269.267497612629;11589.884101158881;23029.193978211017;23067.307980760605;23130.65304020441;23205.651915221286;23646.527069458516;8365;8517.403781735344;8566.61450234741;8856.07011263808;8877.689280875138;4938.925916111261;4945.9258111128365;4977.850664480072;5002.349694539686;5180.145276029489;3325.0856014595697;3402;3436.7250619950346;3440.1571614954496;3452.913677158091;548.9039418101817;556.6020295488745;559.5299948043663;560.7840981222258;574.5346269521701;630.4326106504183;649.938255865692;669.6251683968592;678.1624693503519;703.4021082080191;9621.374610650286;9765.072318129767;9866.950665246628;9906;9987.250956178315;690.7099018412179;692.9826754331182;695.6904177641003;699.9195092564319;756.530950810501;4794.448638406628;5110.97444512775;5209.765560549784;5525.723713814293;5585.581081418829;114572.42713786378;127879;128263.35868320786;130508.3474582621;131436;65165;93387.53306233426;108852.45573772238;113005;115035.42482287703;94214.52892735493;95571;95588.52205738927;97652;98090;10129.848052279074;10394.428306442916;10413.791724165625;10423.895761042293;10581.62964296246;53941.730291349864;53974;55616;56459.43540564706;56890.715546422005;85385.57307213424;86610;86846.13153868381;88768;89496;12641.683957901127;12809.679758006125;13097.41061652247;13855.792163117763;13873.11455157723;15966.361345546047;16111;16152.192390380198;16462.25919833634;17053.48839534816;14361.497347592784;15318.387264509294;15563.844361556692;16060.196990150213;16083;11026.889731102587;14540.41838326455;14671.92664036673;14891.702165956403;15000.924995374953;13608.183508989492;13839.169649821042;14415.711685766017;14740.041897276642;15251.694966100838;11599.362035088152;11786.941065294619;12015.75968480608;12080.154389192672;12115.273083615011;11427;12211.26732396059;12339;12569.988801792035;12639.873601264237 02:16:17 INFO - PROCESS | 4371 | __end_tp_report 02:16:17 INFO - PROCESS | 4371 | __start_cc_report 02:16:17 INFO - PROCESS | 4371 | _x_x_mozilla_cycle_collect,1036 02:16:17 INFO - PROCESS | 4371 | __end_cc_report 02:16:17 INFO - PROCESS | 4371 | __startTimestamp1470820577386__endTimestamp 02:16:17 INFO - PROCESS | 4371 | 02:16:17 INFO - PROCESS | 4371 | ------- Summary: start ------- 02:16:17 INFO - PROCESS | 4371 | Number of tests: 6 02:16:17 INFO - PROCESS | 4371 | 02:16:17 INFO - PROCESS | 4371 | [#0] dojo.html Cycles:165 Average:5247.46 Median:5438.10 stddev:587.36 (10.8%) stddev-sans-first:562.47 02:16:17 INFO - PROCESS | 4371 | Values: 3016.2 3024.7 3029.0 3054.9 3077.6 5092.0 5177.5 5182.0 5244.2 5248.6 5186.7 5252.7 5365.8 5405.8 5453.3 4727.2 4732.4 4751.9 4752.4 4923.4 4830.4 4861.7 4867.4 4868.2 4899.7 4714.7 4728.0 4745.0 4781.8 4848.5 4782.7 4787.1 4790.3 4817.1 4892.2 4797.5 4833.2 4845.3 4882.0 4902.2 5160.7 5191.8 5352.8 5353.8 5376.1 5556.3 5580.5 5621.1 5626.2 5645.2 5639.0 5639.9 5671.8 5679.6 5694.2 5171.9 5201.0 5215.5 5230.3 5297.6 5736.7 5739.5 5773.4 5782.5 5798.0 5514.9 5559.3 5561.6 5562.6 5562.8 5496.3 5580.5 5593.0 5633.4 5662.3 5653.0 5668.0 5691.8 5693.1 5695.8 5641.7 5684.4 5686.5 5691.7 5697.4 4260.7 4286.2 4337.3 4374.0 4400.6 3925.9 3951.0 3961.7 3962.3 3962.8 5417.3 5418.1 5420.2 5425.8 5429.9 5630.5 5672.6 5696.9 5728.8 5781.3 5348.2 5371.6 5372.5 5386.8 5398.6 4758.9 4933.3 4938.5 4945.0 4946.9 5790.9 5846.7 5857.0 5890.6 5952.0 5630.1 5680.6 5682.5 5684.5 5685.9 5654.1 5889.4 5894.7 5904.0 5904.6 5406.2 5427.2 5428.6 5464.3 5527.1 5519.5 5529.8 5539.2 5540.3 5543.7 5308.3 5428.8 5442.0 5447.8 5488.1 5442.9 5495.9 5498.7 5521.4 5600.3 5478.4 5514.2 5521.9 5523.0 5530.5 5479.5 5583.6 5640.0 5644.3 5644.5 5296.5 5317.0 5344.6 5438.1 5442.9 02:16:17 INFO - PROCESS | 4371 | 02:16:17 INFO - PROCESS | 4371 | [#1] ext.html Cycles:180 Average:63770.19 Median:44983.16 stddev:124304.88 (276.3%) stddev-sans-first:124563.00 02:16:17 INFO - PROCESS | 4371 | Values: 564.1 590.7 591.1 600.3 601.3 33079.3 45058.0 46081.8 46243.0 46300.1 47297.5 47364.5 47757.3 47792.5 47888.3 9035.7 9181.2 9185.7 9192.1 9192.4 8945.1 9039.4 9042.6 9043.5 9047.2 9075.7 9116.9 9117.4 9124.6 9126.7 9042.1 9074.6 9082.1 9090.1 9090.5 8993.3 9072.4 9086.0 9088.5 9089.9 44577.6 44972.0 44994.8 45162.5 45199.1 3639.7 3828.4 3954.2 4084.6 4402.2 34227.5 34250.3 34676.3 35786.3 35791.5 4159.9 4381.2 4423.6 4452.8 4505.9 379139.0 381070.0 381245.0 382761.0 382899.0 54188.5 60618.7 63289.4 63649.0 63699.4 66882.7 67309.7 67398.7 67401.0 67411.3 17857.6 17892.2 17925.9 18104.5 18121.0 13851.4 13858.4 13879.9 13888.9 13892.6 18676.6 18853.7 18863.9 18870.8 18875.2 5434.3 6218.6 6278.5 6325.3 6665.6 1026.3 1063.7 1098.9 1121.8 1177.1 33189.7 33474.8 33550.7 33777.5 33879.0 1102.3 1130.2 1164.8 1177.8 1284.8 17475.5 17703.1 17794.9 17806.0 17831.2 530697.0 534123.0 535052.0 535395.0 535603.0 61647.4 61676.0 62011.4 62199.4 62200.7 1325.8 1372.6 1374.0 1377.8 1389.4 32141.7 32176.8 33223.5 33250.0 33837.3 55664.2 56033.0 56072.4 56203.4 56231.7 477896.0 479467.0 480472.0 480701.0 480845.0 28831.7 29570.9 29697.7 31438.4 44994.3 48995.8 49741.8 50082.2 51899.7 54696.5 41643.0 43570.8 44424.6 45377.8 45675.0 43696.6 43828.6 44428.6 45301.3 45426.5 41795.2 43313.4 43468.3 44249.3 46156.3 34728.0 38315.6 38644.4 38711.6 39532.8 28111.0 29294.0 29410.4 29580.6 30759.2 02:16:17 INFO - PROCESS | 4371 | 02:16:17 INFO - PROCESS | 4371 | [#2] jquery.html Cycles:180 Average:28475.90 Median:23956.08 stddev:76495.80 (319.3%) stddev-sans-first:76681.26 02:16:17 INFO - PROCESS | 4371 | Values: 361.3 369.6 386.2 389.8 407.0 17660.0 19396.7 19604.1 20289.8 20441.1 19867.2 20004.7 20177.3 20206.5 20399.9 5340.2 5645.9 5751.7 5804.9 5928.1 5683.8 5756.3 5765.4 5766.7 5775.0 5673.8 5735.5 5766.2 5794.6 5804.7 5525.6 5632.2 5655.0 5656.3 5658.6 4800.9 5100.4 5174.4 5178.8 5178.9 23880.0 24032.2 24312.0 24415.3 24457.8 2329.7 2343.3 2373.5 2495.2 2518.5 14541.6 14859.2 15033.8 15091.8 15474.8 1864.2 1939.8 1944.9 1964.5 1977.2 78990.2 81763.0 82286.0 83271.2 83705.6 9278.5 9404.0 10208.3 10347.6 10347.6 14913.6 14927.6 14943.3 14959.3 14971.1 8450.8 8555.5 8629.4 8727.3 8797.3 8500.6 8504.3 8559.2 8757.1 8805.6 6534.0 6594.3 6628.8 6651.5 6790.9 1754.3 1789.7 1794.2 1807.8 1810.4 937.2 1005.3 1016.1 1084.0 1091.0 20600.8 20795.5 20872.5 21098.7 21104.0 1034.1 1053.2 1076.0 1088.0 1104.4 11267.7 11441.7 11786.6 11857.8 11977.8 444162.0 445964.0 453420.0 483057.0 491495.0 58520.0 75506.0 89486.0 90541.5 95371.5 1001.4 1011.2 1058.1 1061.5 1065.4 17696.3 17984.4 18462.6 18498.4 18859.9 41507.6 43259.9 43413.3 44182.1 44248.6 60638.4 60782.4 62111.0 62214.7 62741.2 8383.9 8643.6 8735.0 8791.0 8924.6 12176.8 13001.3 13114.9 13233.8 13238.7 11309.4 11403.1 11638.6 11693.7 12002.1 11272.9 11393.3 11657.4 11897.3 12063.8 11477.3 11559.9 11698.4 11708.6 12305.6 8296.5 8316.8 8331.8 8407.6 8738.9 10957.7 11548.5 11627.2 11652.3 11722.1 02:16:17 INFO - PROCESS | 4371 | 02:16:17 INFO - PROCESS | 4371 | [#3] mootools.html Cycles:180 Average:5885.81 Median:4738.95 stddev:3383.74 (71.4%) stddev-sans-first:3376.18 02:16:17 INFO - PROCESS | 4371 | Values: 1364.8 1425.2 1517.0 1600.9 1757.3 8415.6 8839.4 8892.4 9180.1 9183.9 9001.1 9059.9 9088.9 9150.3 9186.0 2374.0 2402.8 2407.1 2417.0 2426.4 2347.6 2366.2 2405.5 2407.3 2408.7 2362.7 2363.7 2370.6 2400.7 2403.8 2312.8 2325.7 2334.0 2335.7 2354.8 2288.2 2319.5 2319.6 2321.2 2323.3 8872.6 9058.9 9115.5 9141.3 9165.3 5120.4 5306.9 5328.6 5331.3 5338.5 3422.8 3486.8 3540.5 3548.4 3555.6 1146.8 1156.7 1177.1 1186.3 1202.6 12893.7 12976.3 12985.3 13001.2 13030.7 4425.5 4635.1 4709.2 4730.7 4747.2 9917.1 9935.0 9942.7 9945.3 9949.2 5233.0 5238.5 5267.9 5276.5 5339.9 4202.9 4374.6 4502.3 4880.5 4974.0 3885.2 3897.4 4008.0 4010.3 4015.7 1184.4 1203.5 1205.6 1213.1 1221.8 998.6 1015.1 1016.7 1025.7 1030.2 6309.4 6395.2 6439.8 6473.5 6641.2 481.1 488.3 490.6 1028.4 1077.8 4223.9 4370.0 4371.2 4436.8 4458.5 10989.0 11371.9 11377.0 11379.9 11405.4 11280.1 11295.9 11303.9 11309.7 11315.5 8015.4 8313.0 8324.5 8466.4 8488.3 6371.4 6417.9 6443.2 6542.1 6659.1 10521.6 10586.1 10593.2 10649.1 10723.7 9390.6 9723.2 10262.5 10903.5 10912.8 7486.3 7674.0 7863.4 7915.4 8002.2 7727.1 7912.8 7928.6 8005.1 8656.4 7445.6 7457.3 7460.8 7579.0 7695.6 7222.5 7310.3 7400.2 7401.6 7525.5 6788.9 6790.3 6840.2 6854.1 6938.9 4983.5 5095.7 5118.3 5182.7 5204.7 5144.5 5303.1 5402.2 5515.2 5582.2 02:16:17 INFO - PROCESS | 4371 | 02:16:17 INFO - PROCESS | 4371 | [#4] prototype.html Cycles:180 Average:4555.32 Median:5123.73 stddev:1328.28 (25.9%) stddev-sans-first:1293.46 02:16:17 INFO - PROCESS | 4371 | Values: 322.4 334.0 336.3 337.9 340.8 5215.0 5234.4 5251.5 5251.8 5270.9 4903.4 4998.0 5123.0 5124.5 5207.9 4083.7 4113.8 4114.6 4121.6 4129.3 4095.5 4111.2 4118.8 4123.4 4124.2 3867.6 3897.8 4044.7 4068.9 4073.3 4068.7 4072.5 4079.7 4080.8 4083.7 3637.1 3641.0 3653.9 3658.1 3662.7 4807.6 5033.4 5088.8 5090.9 5095.4 4578.6 4586.3 4594.8 4614.1 4620.7 5408.5 5409.5 5426.3 5498.9 5508.7 3793.6 3904.6 3907.6 3908.4 3913.6 5575.3 5616.3 5626.9 5627.2 5662.0 4008.4 4017.0 4031.2 4063.0 4063.3 3939.4 4107.2 4115.8 4120.7 4122.2 4609.8 4611.5 4652.6 4673.0 4684.4 5434.9 5438.5 5448.3 5449.2 5453.7 1377.9 1387.2 1398.4 1406.7 1407.6 904.1 910.4 914.8 918.6 921.3 4688.8 4695.5 4707.5 4716.4 4770.6 4929.3 4968.6 4979.2 5045.8 5053.8 4777.5 4797.1 4882.3 5258.6 5310.4 2952.2 2953.4 2960.0 2960.3 2974.3 5610.8 5733.5 5742.8 5744.7 5815.5 5713.5 5718.5 5722.3 5745.0 5754.4 5726.6 5787.8 5795.5 5798.8 5835.4 5335.7 5576.7 5610.4 5613.9 5644.8 5546.3 5546.3 5547.6 5547.6 5548.9 5791.9 5801.4 5803.5 5822.0 5837.0 3840.0 4008.4 4025.1 4048.8 4050.7 5256.4 5360.7 5548.1 5616.9 5624.1 5385.4 5395.5 5430.7 5439.9 5442.2 5398.0 5411.1 5427.7 5449.2 5458.9 5206.8 5417.7 5418.3 5421.8 5447.1 5409.3 5464.7 5475.0 5478.8 5494.5 5159.6 5234.7 5345.6 5346.3 5352.6 02:16:17 INFO - PROCESS | 4371 | 02:16:17 INFO - PROCESS | 4371 | [#5] yui.html Cycles:180 Average:22571.68 Median:4642.93 stddev:32969.99 (710.1%) stddev-sans-first:33021.74 02:16:17 INFO - PROCESS | 4371 | Values: 741.3 750.3 780.2 781.6 873.1 16551.0 16953.2 17393.3 17448.6 17502.3 15520.1 15542.7 15662.5 15688.8 15691.5 669.7 816.0 835.5 837.7 837.9 683.1 697.1 697.3 797.8 826.9 870.0 875.4 875.4 875.6 876.0 869.5 872.2 873.6 874.7 875.3 508.6 613.2 627.8 638.3 639.2 14507.2 14550.9 14557.5 14606.6 14609.4 14460.5 14944.7 15159.3 15259.8 15569.7 12756.8 13099.8 13126.9 13321.9 13689.2 4501.7 4503.3 4547.3 4738.6 4756.9 84420.1 86792.0 86911.6 87287.0 87707.6 10486.3 10989.9 11098.6 11269.3 11589.9 23029.2 23067.3 23130.7 23205.7 23646.5 8365.0 8517.4 8566.6 8856.1 8877.7 4938.9 4945.9 4977.9 5002.3 5180.1 3325.1 3402.0 3436.7 3440.2 3452.9 548.9 556.6 559.5 560.8 574.5 630.4 649.9 669.6 678.2 703.4 9621.4 9765.1 9867.0 9906.0 9987.3 690.7 693.0 695.7 699.9 756.5 4794.4 5111.0 5209.8 5525.7 5585.6 114572.4 127879.0 128263.4 130508.3 131436.0 65165.0 93387.5 108852.5 113005.0 115035.4 94214.5 95571.0 95588.5 97652.0 98090.0 10129.8 10394.4 10413.8 10423.9 10581.6 53941.7 53974.0 55616.0 56459.4 56890.7 85385.6 86610.0 86846.1 88768.0 89496.0 12641.7 12809.7 13097.4 13855.8 13873.1 15966.4 16111.0 16152.2 16462.3 17053.5 14361.5 15318.4 15563.8 16060.2 16083.0 11026.9 14540.4 14671.9 14891.7 15000.9 13608.2 13839.2 14415.7 14740.0 15251.7 11599.4 11786.9 12015.8 12080.2 12115.3 11427.0 12211.3 12339.0 12570.0 12639.9 02:16:17 INFO - PROCESS | 4371 | -------- Summary: end -------- 02:16:17 INFO - PROCESS | 4371 | 02:16:18 INFO - TEST-INFO | 4371: exit 0 02:16:18 INFO - TEST-OK | dromaeo_css | took 1116345ms 02:16:18 INFO - TEST-START | kraken 02:16:18 INFO - operating with platform_type : linux_ 02:16:18 INFO - Initialising browser for kraken test... 02:16:18 INFO - TEST-INFO | started process 4566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi0akM8/profile http://localhost:39672/getInfo.html) 02:16:22 INFO - PROCESS | 4566 | __metrics Screen width/height:1600/1200 02:16:22 INFO - PROCESS | 4566 | colorDepth:24 02:16:22 INFO - PROCESS | 4566 | Browser inner width/height: 1024/697 02:16:22 INFO - PROCESS | 4566 | __metrics 02:16:23 INFO - PROCESS | 4566 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:16:23 INFO - PROCESS | 4566 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:16:23 INFO - PROCESS | 4566 | console.error: PushService: 02:16:23 INFO - PROCESS | 4566 | stateChangeProcessEnqueue: Error transitioning state 02:16:23 INFO - PROCESS | 4566 | UnknownError 02:16:24 INFO - TEST-INFO | 4566: exit 0 02:16:24 INFO - Browser initialized. 02:16:24 INFO - Running cycle 1/1 for kraken test... 02:16:24 INFO - TEST-INFO | started process 4649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi0akM8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:16:36 INFO - PROCESS | 4649 | RSS: Main: 156033024 02:16:36 INFO - PROCESS | 4649 | 02:16:38 INFO - PROCESS | 4649 | Cycle 1(1): loaded http://localhost:39672/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39672/tests/kraken/driver.html?testName=audio-beat-detection) 02:16:39 INFO - PROCESS | 4649 | RSS: Main: 212070400 02:16:39 INFO - PROCESS | 4649 | 02:16:42 INFO - PROCESS | 4649 | Cycle 1(1): loaded http://localhost:39672/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39672/tests/kraken/driver.html?testName=audio-dft) 02:16:42 INFO - PROCESS | 4649 | RSS: Main: 191012864 02:16:42 INFO - PROCESS | 4649 | 02:16:45 INFO - PROCESS | 4649 | Cycle 1(1): loaded http://localhost:39672/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39672/tests/kraken/driver.html?testName=audio-fft) 02:16:46 INFO - PROCESS | 4649 | RSS: Main: 268771328 02:16:46 INFO - PROCESS | 4649 | 02:16:48 INFO - PROCESS | 4649 | Cycle 1(1): loaded http://localhost:39672/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39672/tests/kraken/driver.html?testName=audio-oscillator) 02:16:48 INFO - PROCESS | 4649 | RSS: Main: 178012160 02:16:48 INFO - PROCESS | 4649 | 02:16:50 INFO - PROCESS | 4649 | Cycle 1(1): loaded http://localhost:39672/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39672/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:16:51 INFO - PROCESS | 4649 | RSS: Main: 183554048 02:16:51 INFO - PROCESS | 4649 | 02:16:54 INFO - PROCESS | 4649 | Cycle 1(1): loaded http://localhost:39672/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39672/tests/kraken/driver.html?testName=imaging-darkroom) 02:16:55 INFO - PROCESS | 4649 | RSS: Main: 219770880 02:16:55 INFO - PROCESS | 4649 | 02:16:58 INFO - PROCESS | 4649 | Cycle 1(1): loaded http://localhost:39672/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39672/tests/kraken/driver.html?testName=imaging-desaturate) 02:16:59 INFO - PROCESS | 4649 | RSS: Main: 218779648 02:16:59 INFO - PROCESS | 4649 | 02:17:01 INFO - PROCESS | 4649 | Cycle 1(1): loaded http://localhost:39672/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39672/tests/kraken/driver.html?testName=json-parse-financial) 02:17:02 INFO - PROCESS | 4649 | RSS: Main: 218562560 02:17:02 INFO - PROCESS | 4649 | 02:17:03 INFO - PROCESS | 4649 | Cycle 1(1): loaded http://localhost:39672/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39672/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:17:04 INFO - PROCESS | 4649 | RSS: Main: 180842496 02:17:04 INFO - PROCESS | 4649 | 02:17:06 INFO - PROCESS | 4649 | Cycle 1(1): loaded http://localhost:39672/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39672/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:17:06 INFO - PROCESS | 4649 | RSS: Main: 188567552 02:17:06 INFO - PROCESS | 4649 | 02:17:08 INFO - PROCESS | 4649 | Cycle 1(1): loaded http://localhost:39672/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39672/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:17:09 INFO - PROCESS | 4649 | RSS: Main: 193019904 02:17:09 INFO - PROCESS | 4649 | 02:17:12 INFO - PROCESS | 4649 | Cycle 1(1): loaded http://localhost:39672/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39672/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:17:12 INFO - PROCESS | 4649 | RSS: Main: 187793408 02:17:12 INFO - PROCESS | 4649 | 02:17:15 INFO - PROCESS | 4649 | Cycle 1(1): loaded http://localhost:39672/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39672/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:17:16 INFO - PROCESS | 4649 | RSS: Main: 191217664 02:17:16 INFO - PROCESS | 4649 | 02:17:17 INFO - PROCESS | 4649 | Cycle 1(1): loaded http://localhost:39672/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39672/tests/kraken/driver.html?testName=ai-astar) 02:17:17 INFO - PROCESS | 4649 | RSS: Main: 242192384 02:17:17 INFO - PROCESS | 4649 | 02:17:17 INFO - PROCESS | 4649 | __start_tp_report 02:17:17 INFO - PROCESS | 4649 | _x_x_mozilla_page_load 02:17:17 INFO - PROCESS | 4649 | _x_x_mozilla_page_load_details 02:17:17 INFO - PROCESS | 4649 | |i|pagename|runs| 02:17:17 INFO - PROCESS | 4649 | |0;ai-astar;102;113;112;110;111;113;111;111;110;111 02:17:17 INFO - PROCESS | 4649 | |1;audio-beat-detection;148;118;117;183;117;119;154;124;152;122 02:17:17 INFO - PROCESS | 4649 | |2;audio-dft;160;160;161;161;163;160;160;162;161;161 02:17:17 INFO - PROCESS | 4649 | |3;audio-fft;76;75;74;125;75;76;75;74;111;74 02:17:17 INFO - PROCESS | 4649 | |4;audio-oscillator;83;83;120;85;84;83;116;84;85;133 02:17:17 INFO - PROCESS | 4649 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;116;117;118 02:17:17 INFO - PROCESS | 4649 | |6;imaging-darkroom;146;146;146;147;147;147;146;146;146;146 02:17:17 INFO - PROCESS | 4649 | |7;imaging-desaturate;95;96;95;95;95;96;94;95;96;95 02:17:17 INFO - PROCESS | 4649 | |8;json-parse-financial;50;52;50;49;49;51;53;51;51;50 02:17:17 INFO - PROCESS | 4649 | |9;json-stringify-tinderbox;61;62;60;62;61;61;61;62;61;62 02:17:17 INFO - PROCESS | 4649 | |10;stanford-crypto-aes;80;76;76;74;76;77;75;79;78;76 02:17:17 INFO - PROCESS | 4649 | |11;stanford-crypto-ccm;121;128;120;123;121;129;121;119;147;128 02:17:17 INFO - PROCESS | 4649 | |12;stanford-crypto-pbkdf2;160;161;169;159;163;160;163;161;159;158 02:17:17 INFO - PROCESS | 4649 | |13;stanford-crypto-sha256-iterative;64;66;65;63;63;65;64;64;63;62 02:17:17 INFO - PROCESS | 4649 | __end_tp_report 02:17:17 INFO - PROCESS | 4649 | __start_cc_report 02:17:17 INFO - PROCESS | 4649 | _x_x_mozilla_cycle_collect,1664 02:17:17 INFO - PROCESS | 4649 | __end_cc_report 02:17:17 INFO - PROCESS | 4649 | __startTimestamp1470820637956__endTimestamp 02:17:17 INFO - PROCESS | 4649 | 02:17:17 INFO - PROCESS | 4649 | ------- Summary: start ------- 02:17:17 INFO - PROCESS | 4649 | Number of tests: 14 02:17:17 INFO - PROCESS | 4649 | 02:17:17 INFO - PROCESS | 4649 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:3.13 (2.8%) stddev-sans-first:1.12 02:17:17 INFO - PROCESS | 4649 | Values: 102.0 113.0 112.0 110.0 111.0 113.0 111.0 111.0 110.0 111.0 02:17:17 INFO - PROCESS | 4649 | 02:17:17 INFO - PROCESS | 4649 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:136.00 stddev:22.62 (16.6%) stddev-sans-first:23.53 02:17:17 INFO - PROCESS | 4649 | Values: 148.0 118.0 117.0 183.0 117.0 119.0 154.0 124.0 152.0 122.0 02:17:17 INFO - PROCESS | 4649 | 02:17:17 INFO - PROCESS | 4649 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.00 02:17:17 INFO - PROCESS | 4649 | Values: 160.0 160.0 161.0 161.0 163.0 160.0 160.0 162.0 161.0 161.0 02:17:17 INFO - PROCESS | 4649 | 02:17:17 INFO - PROCESS | 4649 | [#3] audio-fft Cycles:10 Average:83.50 Median:75.00 stddev:18.49 (24.7%) stddev-sans-first:19.42 02:17:17 INFO - PROCESS | 4649 | Values: 76.0 75.0 74.0 125.0 75.0 76.0 75.0 74.0 111.0 74.0 02:17:17 INFO - PROCESS | 4649 | 02:17:17 INFO - PROCESS | 4649 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:83.50 stddev:19.38 (23.2%) stddev-sans-first:20.01 02:17:17 INFO - PROCESS | 4649 | Values: 83.0 83.0 120.0 85.0 84.0 83.0 116.0 84.0 85.0 133.0 02:17:17 INFO - PROCESS | 4649 | 02:17:17 INFO - PROCESS | 4649 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 02:17:17 INFO - PROCESS | 4649 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 118.0 02:17:17 INFO - PROCESS | 4649 | 02:17:17 INFO - PROCESS | 4649 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 02:17:17 INFO - PROCESS | 4649 | Values: 146.0 146.0 146.0 147.0 147.0 147.0 146.0 146.0 146.0 146.0 02:17:17 INFO - PROCESS | 4649 | 02:17:17 INFO - PROCESS | 4649 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 02:17:17 INFO - PROCESS | 4649 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 94.0 95.0 96.0 95.0 02:17:17 INFO - PROCESS | 4649 | 02:17:17 INFO - PROCESS | 4649 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:51.00 stddev:1.26 (2.5%) stddev-sans-first:1.32 02:17:17 INFO - PROCESS | 4649 | Values: 50.0 52.0 50.0 49.0 49.0 51.0 53.0 51.0 51.0 50.0 02:17:17 INFO - PROCESS | 4649 | 02:17:17 INFO - PROCESS | 4649 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 02:17:17 INFO - PROCESS | 4649 | Values: 61.0 62.0 60.0 62.0 61.0 61.0 61.0 62.0 61.0 62.0 02:17:17 INFO - PROCESS | 4649 | 02:17:17 INFO - PROCESS | 4649 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:76.50 stddev:1.83 (2.4%) stddev-sans-first:1.50 02:17:17 INFO - PROCESS | 4649 | Values: 80.0 76.0 76.0 74.0 76.0 77.0 75.0 79.0 78.0 76.0 02:17:17 INFO - PROCESS | 4649 | 02:17:17 INFO - PROCESS | 4649 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:125.50 stddev:8.34 (6.6%) stddev-sans-first:8.67 02:17:17 INFO - PROCESS | 4649 | Values: 121.0 128.0 120.0 123.0 121.0 129.0 121.0 119.0 147.0 128.0 02:17:17 INFO - PROCESS | 4649 | 02:17:17 INFO - PROCESS | 4649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:161.00 stddev:3.16 (2.0%) stddev-sans-first:3.32 02:17:17 INFO - PROCESS | 4649 | Values: 160.0 161.0 169.0 159.0 163.0 160.0 163.0 161.0 159.0 158.0 02:17:17 INFO - PROCESS | 4649 | 02:17:17 INFO - PROCESS | 4649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.20 (1.9%) stddev-sans-first:1.27 02:17:17 INFO - PROCESS | 4649 | Values: 64.0 66.0 65.0 63.0 63.0 65.0 64.0 64.0 63.0 62.0 02:17:17 INFO - PROCESS | 4649 | -------- Summary: end -------- 02:17:17 INFO - PROCESS | 4649 | 02:17:18 INFO - TEST-INFO | 4649: exit 0 02:17:19 INFO - TEST-OK | kraken | took 60801ms 02:17:19 INFO - SUITE-END | took 1177s 02:17:19 INFO - Completed test suite (00:19:37) 02:17:19 INFO - javascript benchmark 02:17:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3016.2308611304115, 3024.652165001025, 3029.0307101727444, 3054.938901221977, 3077.553754705568, 5091.974540127303, 5177.482251774821, 5181.974090129549, 5244.239585260135, 5248.5538729207965, 5186.7147306898105, 5252.737363131847, 5365.812196573121, 5405.783768649259, 5453.345598528173, 4727.196376615983, 4732.432108147027, 4751.85744427666, 4752.429708434993, 4923.433805112404, 4830.420349558058, 4861.683990540621, 4867.367242258501, 4868.172410690174, 4899.730514821684, 4714.740689262089, 4727.952720472786, 4744.952550474485, 4781.8087276508895, 4848.539388758062, 4782.713037217778, 4787.114383839001, 4790.305405716152, 4817.108834865561, 4892.168331383673, 4797.472278049412, 4833.226683730586, 4845.3216549683075, 4882.0, 4902.240152776325, 5160.664556803796, 5191.844244672666, 5352.759125839347, 5353.812616558402, 5376.1398176291605, 5556.277683901108, 5580.525655319262, 5621.128725047624, 5626.184203290541, 5645.2096706461125, 5638.971805140948, 5639.887202255973, 5671.7731290748325, 5679.574031947579, 5694.202811606378, 5171.870703232449, 5201.011807756589, 5215.530602245816, 5230.320058392384, 5297.602679798992, 5736.741846616912, 5739.540836733051, 5773.39379365169, 5782.45066718661, 5798.0, 5514.862128446821, 5559.33288005442, 5561.555075593943, 5562.638428502134, 5562.805301814417, 5496.340439147328, 5580.469855363734, 5592.972035139798, 5633.352164501053, 5662.320521537442, 5653.038983372837, 5668.0, 5691.8292451226525, 5693.060644993612, 5695.772169113272, 5641.689707066069, 5684.403137670568, 5686.516646085046, 5691.658500489983, 5697.401772813795, 4260.68044896634, 4286.164197981364, 4337.306031035019, 4374.0, 4400.647948164139, 3925.9018524537114, 3950.9604903951167, 3961.7028722845903, 3962.306596345628, 3962.841486340572, 5417.26866872975, 5418.133098704188, 5420.159875219348, 5425.755840987165, 5429.918551221735, 5630.521405680481, 5672.631278966854, 5696.857578560486, 5728.828135155952, 5781.335146458211, 5348.224507446398, 5371.62398632092, 5372.516473517402, 5386.811461598825, 5398.62209645321, 4758.928616070762, 4933.28467372229, 4938.506149385033, 4945.0, 4946.9010619787405, 5790.913136302959, 5846.736896839568, 5857.033589457692, 5890.646561206341, 5952.0, 5630.127330263816, 5680.602357834912, 5682.516986056232, 5684.516816070515, 5685.914711279417, 5654.123610840326, 5889.38161493037, 5894.705264736832, 5903.970480147572, 5904.586678932434, 5406.189071639285, 5427.158790387496, 5428.647137936022, 5464.262324586289, 5527.115661494142, 5519.503244707996, 5529.806456773994, 5539.169124631338, 5540.335159780852, 5543.695096769717, 5308.25684404176, 5428.83713488596, 5441.972790136024, 5447.754851031792, 5488.121900495901, 5442.891142177055, 5495.890082198253, 5498.697571633598, 5521.3926468087675, 5600.299962504687, 5478.424765399575, 5514.228008078792, 5521.861953451035, 5522.972385138049, 5530.529904958124, 5479.506844384025, 5583.581231407579, 5640.0, 5644.322681278109, 5644.548436125182, 5296.523312901703, 5317.0, 5344.625876188629, 5438.102713052302, 5442.891142177214], "value": 5208.281873127567, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.1005621486571, 590.7282649981014, 591.0543130990415, 600.2796644027167, 601.3325209017992, 33079.33841323175, 45058.0, 46081.769591152, 46243.0, 46300.07399852005, 47297.527024729745, 47364.526354736445, 47757.283640745416, 47792.52207477924, 47888.28167577489, 9035.72892813215, 9181.173694367506, 9185.724428267162, 9192.080791920822, 9192.35653504255, 8945.0607686193, 9039.41243819153, 9042.593083311234, 9043.502607356593, 9047.23098536622, 9075.727728168133, 9116.8632470513, 9117.361784675075, 9124.589393477276, 9126.680566180185, 9042.095790420972, 9074.591643376063, 9082.09179082093, 9090.13643703847, 9090.454572725625, 8993.325500587416, 9072.36493445459, 9086.045965173627, 9088.50013249271, 9089.909100908972, 44577.554224457665, 44972.0, 44994.77502612499, 45162.54837451649, 45199.096018079785, 3639.70882329413, 3828.3874580067054, 3954.2486927483974, 4084.5711200323835, 4402.1855956647805, 34227.486587701205, 34250.31499370024, 34676.30647387063, 35786.284274314625, 35791.4631280531, 4159.896002599929, 4381.233284175257, 4423.5797599228345, 4452.777361131931, 4505.887352816173, 379138.99999999726, 381070.0, 381245.0, 382761.0, 382899.0, 54188.45811541913, 60618.696906515186, 63289.36710632835, 63649.0, 63699.36300637027, 66882.66558667175, 67309.66345168243, 67398.66300668563, 67401.0, 67411.32588674051, 17857.642847143245, 17892.194851231725, 17925.910370448324, 18104.456866294033, 18121.0, 13851.445942162201, 13858.4456621734, 13879.930600346934, 13888.861111388958, 13892.583222503341, 18676.626467470847, 18853.717194242097, 18863.90568047151, 18870.81129188718, 18875.244990200237, 5434.3207099112615, 6218.626882387071, 6278.497720182374, 6325.272593651697, 6665.633390163587, 1026.3431403901359, 1063.6596289187385, 1098.8846171151913, 1121.8205087186175, 1177.1348059176498, 33189.66810331914, 33474.832625836716, 33550.664493355245, 33777.49333759995, 33879.0, 1102.2945314998408, 1130.2032067392468, 1164.778692048508, 1177.8174382970653, 1284.78158713019, 17475.47573572795, 17703.114844257736, 17794.91102544505, 17806.0, 17831.197596108206, 530697.0, 534123.0, 535052.0, 535395.0, 535603.0, 61647.38352616506, 61676.0, 62011.37988620147, 62199.378006220264, 62200.68899655473, 1325.801129830514, 1372.6499742565782, 1373.9931300343635, 1377.8208832851865, 1389.3956129084083, 32141.67858321387, 32176.839115805207, 33223.501647474826, 33250.0, 33837.32325353529, 55664.16503752366, 56033.0, 56072.439275608354, 56203.43796562146, 56231.718841405534, 477896.0, 479467.0, 480472.0, 480701.0, 480845.0, 28831.711682883742, 29570.852145739133, 29697.703022969494, 31438.371232574762, 44994.3250851244, 48995.755021224664, 49741.75129124476, 50082.2487662678, 51899.74050129725, 54696.45303546914, 41643.0, 43570.78214608907, 44424.555754442044, 45377.77311113424, 45675.0, 43696.56303437052, 43828.56171438245, 44428.62830977478, 45301.32048019217, 45426.54573454223, 41795.1640967185, 43313.350299744896, 43468.347974781034, 44249.33625995548, 46156.30765538587, 34728.0, 38315.61684383232, 38644.420333694456, 38711.61288387193, 39532.80233598813, 28110.96904641489, 29293.974710885017, 29410.411791763618, 29580.556291656074, 30759.2310192247], "value": 21096.864082988464, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.2504054087768, 369.6488336080724, 386.1812956532152, 389.8382171398869, 407.0190840075417, 17660.02869842158, 19396.70904936427, 19604.117814698337, 20289.797102028977, 20441.080151393187, 19867.20531178751, 20004.69992950107, 20177.293794717152, 20206.49483762903, 20399.898000509977, 5340.172273297645, 5645.8588535286635, 5751.741171647286, 5804.854878628026, 5928.081147422135, 5683.8010669626365, 5756.338021127582, 5765.423457654243, 5766.711664416784, 5775.0, 5673.773049078052, 5735.541156707453, 5766.221560089397, 5794.565407594426, 5804.680742559158, 5525.557955363562, 5632.211490391349, 5655.0386434306265, 5656.2929633795775, 5658.603897727161, 4800.903981920377, 5100.362454693163, 5174.353205849269, 5178.844634660966, 5178.870528236786, 23880.0, 24032.158874439312, 24312.0, 24415.267541973593, 24457.755422445905, 2329.7087864017, 2343.320437073247, 2373.465970156701, 2495.151648439521, 2518.5214809186195, 14541.563753087425, 14859.182744949023, 15033.774493382609, 15091.849081509265, 15474.767878481833, 1864.1611274926338, 1939.7890280683134, 1944.9222031118738, 1964.5383334916282, 1977.2486455147096, 78990.21009789886, 81763.0, 82286.0, 83271.16728832755, 83705.58147209225, 9278.536073196448, 9403.952980235055, 10208.336458130198, 10347.586096556204, 10347.63783267582, 14913.627159321104, 14927.552173434815, 14943.252837358088, 14959.252037398086, 14971.101733896001, 8450.81445971731, 8555.529445880411, 8629.395942284105, 8727.334519501825, 8797.29621630268, 8500.617472213766, 8504.277136443348, 8559.22966932979, 8757.080506546848, 8805.559722013873, 6534.0, 6594.340565943463, 6628.801135965929, 6651.467882569383, 6790.860878823254, 1754.3421217043608, 1789.7225929980873, 1794.246416505071, 1807.8372946434883, 1810.384469280451, 937.2408349237004, 1005.2561104782409, 1016.1058268723476, 1083.978320433587, 1090.9618163364244, 20600.793992059887, 20795.480112996993, 20872.47818804542, 21098.738825031818, 21104.0, 1034.0590063042596, 1053.1890444357803, 1075.9946200268948, 1088.031651829872, 1104.4091411095026, 11267.661970140909, 11441.713957151138, 11786.58746943853, 11857.762844743056, 11977.760444791056, 444162.0, 445964.0, 453420.0, 483057.0, 491495.0, 58520.0, 75506.0, 89486.0, 90541.54729226312, 95371.52314238524, 1001.4291853643499, 1011.1607365886297, 1058.142904247562, 1061.4639606998571, 1065.4299949526967, 17696.29214831392, 17984.367503598085, 18462.630747385247, 18498.445046648623, 18859.90570047141, 41507.584924150375, 43259.918502037704, 43413.34879976866, 44182.11635767202, 44248.55751442573, 60638.39361606504, 60782.39217607767, 62111.0, 62214.68892655508, 62741.180329824936, 8383.874241886499, 8643.611037503202, 8735.0, 8791.0, 8924.553772311489, 12176.817347739614, 13001.349932503526, 13114.868851311365, 13233.80149297742, 13238.669033274246, 11309.434528273718, 11403.144764142888, 11638.592649257236, 11693.707657308296, 12002.099842511672, 11272.943635281772, 11393.316401015965, 11657.358845263592, 11897.286162830258, 12063.75872482563, 11477.253978491372, 11559.942200288944, 11698.35659038761, 11708.590199342982, 12305.630831075083, 8296.502209867427, 8316.792080198044, 8331.83336333282, 8407.621657025571, 8738.91261087381, 10957.671269861918, 11548.538058477567, 11627.244229125079, 11652.30086194831, 11722.120840936794], "value": 9455.986627339962, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.8089267502546, 1425.2374979386027, 1516.9924150379247, 1600.9199540022996, 1757.297081167532, 8415.621297041633, 8839.408906396846, 8892.421992570486, 9180.081991800816, 9183.862242066374, 9001.099890011012, 9059.864102038475, 9088.863667045, 9150.267978561717, 9185.954070229656, 2373.964390534143, 2402.783749462548, 2407.085307583116, 2417.02110645189, 2426.3570153909227, 2347.6126439137606, 2366.2428023032635, 2405.458771776354, 2407.2898494944034, 2408.7109546854313, 2362.692849929507, 2363.6927199464044, 2370.573296806574, 2400.6759087523224, 2403.831731778776, 2312.7571604981404, 2325.686032385623, 2333.9999999999914, 2335.719713634358, 2354.835161538693, 2288.21056735426, 2319.501307218956, 2319.6404557293645, 2321.152779235567, 2323.2913961241816, 8872.556372181365, 9058.864117038249, 9115.453072815651, 9141.31440141992, 9165.266778657691, 5120.385553733576, 5306.946930530722, 5328.573714102862, 5331.253624492574, 5338.519533242027, 3422.7946323220685, 3486.808225547594, 3540.4689296605457, 3548.414511605582, 3555.6266592007723, 1146.816509358507, 1156.7455159864817, 1177.146568737667, 1186.3060109835756, 1202.6271855724754, 12893.742125157538, 12976.286304253263, 12985.285809280485, 13001.154924929755, 13030.674233144153, 4425.468943726773, 4635.119327327797, 4709.222978208557, 4730.739809310452, 4747.169245382044, 9917.107460328605, 9935.0, 9942.652007179713, 9945.254105942084, 9949.154321882721, 5233.031889100528, 5238.476152384731, 5267.868303292448, 5276.5251127398715, 5339.919901201485, 4202.936955945664, 4374.606285434326, 4502.347159661831, 4880.463149053601, 4974.0, 3885.203533275672, 3897.395903634941, 4007.979960100239, 4010.258102251093, 4015.678745700337, 1184.3782014442315, 1203.5196708049148, 1205.584073494643, 1213.120487646467, 1221.7556488702296, 998.5606333213362, 1015.1269907879218, 1016.7458135466134, 1025.738436698637, 1030.2067408095725, 6309.432151106423, 6395.20059992501, 6439.774607888701, 6473.514486413444, 6641.169853768279, 481.06673054275296, 488.2578480709302, 490.5854552902791, 1028.359766172953, 1077.8006068877282, 4223.936640950388, 4369.956300437018, 4371.213181627274, 4436.800343984529, 4458.509563947963, 10989.0, 11371.886281137082, 11377.0, 11379.886201138048, 11405.429728513542, 11280.097592192606, 11295.943520282346, 11303.886961130447, 11309.717257068474, 11315.547378104948, 8015.358771298283, 8313.0, 8324.542150181676, 8466.449680770731, 8488.320934325238, 6371.426571608577, 6417.8716425672155, 6443.194600674916, 6542.084108224947, 6659.101021362054, 10521.631742889269, 10586.10018148466, 10593.152547796311, 10649.094826939487, 10723.678289651323, 9390.577424015799, 9723.222142228464, 10262.486875656337, 10903.454827258764, 10912.836307455236, 7486.251374862471, 7673.961630191813, 7863.449558530848, 7915.406344524068, 8002.159773223728, 7727.072751269883, 7912.802179945547, 7928.603569821371, 8005.119436862057, 8656.437331573428, 7445.553266803792, 7457.32884040439, 7460.776176714708, 7579.014728085313, 7695.615219238904, 7222.494425390172, 7310.342069213796, 7400.222976587381, 7401.629918503945, 7525.473216874766, 6788.864222715617, 6790.287019862843, 6840.247572767091, 6854.10896583441, 6938.895916561357, 4983.526564976321, 5095.718208765813, 5118.283440318432, 5182.740862956913, 5204.687718736888, 5144.511271429208, 5303.124984377689, 5402.243685884058, 5515.200295956984, 5582.218489411567], "value": 4672.096042383411, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.4293001387544, 334.01299160979306, 336.25183965676365, 337.868231389758, 340.8193657361599, 5214.983078299733, 5234.371875374951, 5251.474852514747, 5251.818340873301, 5270.919461510391, 4903.436104847943, 4997.975010124954, 5122.974385128069, 5124.487551244873, 5207.921881171786, 4083.7141400102005, 4113.806995971165, 4114.6296833285, 4121.649659778915, 4129.29801933672, 4095.5290141633645, 4111.218868415007, 4118.794060296988, 4123.402106694542, 4124.216398884202, 3867.57456679765, 3897.7661340319673, 4044.6562042226446, 4068.8575899843513, 4073.287174744423, 4068.6948478864056, 4072.5112986441522, 4079.673626109904, 4080.8369614659828, 4083.7141400102005, 3637.1452708613456, 3640.9635903640888, 3653.8903832885057, 3658.140337020798, 3662.688671462929, 4807.6394270429855, 5033.446320904697, 5088.821891233826, 5090.872728181788, 5095.414027386861, 4578.610818080467, 4586.289125185602, 4594.793234304464, 4614.146382919171, 4620.722756634613, 5408.513233808976, 5409.486098820606, 5426.267453893753, 5498.945010549884, 5508.724563771795, 3793.61533040441, 3904.5509766376945, 3907.5897030811925, 3908.4332771748223, 3913.5890731473355, 5575.275214222125, 5616.32604087508, 5626.915596266059, 5627.240322556443, 5661.971690141523, 4008.3586626139677, 4017.0, 4031.173609410064, 4063.0, 4063.2686116499312, 3939.4484772131923, 4107.240160570304, 4115.794210289474, 4120.651228799556, 4122.237386083584, 4609.847538115471, 4611.469680986663, 4652.55800698933, 4673.018666080094, 4684.414448193976, 5434.91847622286, 5438.456154384609, 5448.291722076105, 5449.155380915964, 5453.727313634303, 1377.937992790327, 1387.1538361599619, 1398.370897903951, 1406.662401023747, 1407.6269788506054, 904.1320332480892, 910.4476866941981, 914.7895983923735, 918.6049998500708, 921.2675922641516, 4688.765561721901, 4695.483496815347, 4707.458642256116, 4716.3868697069165, 4770.594499467515, 4929.309896614477, 4968.6025117990475, 4979.203327467588, 5045.772940217699, 5053.823116190915, 4777.546133117348, 4797.112534181118, 4882.26765985098, 5258.631895767259, 5310.4424035476495, 2952.1586347890748, 2953.379790244073, 2959.955600665992, 2960.2747326904614, 2974.3159073413235, 5610.775568977277, 5733.483986441241, 5742.827715168552, 5744.655320680772, 5815.534757219412, 5713.457221563945, 5718.542516598662, 5722.2561067061015, 5744.971275143597, 5754.395788442153, 5726.599138060295, 5787.768489260382, 5795.536357091422, 5798.768049278066, 5835.358110607915, 5335.67985920846, 5576.665400076008, 5610.382857885711, 5613.859653508695, 5644.8306550803545, 5546.256277013081, 5546.334439867242, 5547.556195504269, 5547.556195504269, 5548.944510554843, 5791.870585235839, 5801.375614827855, 5803.506701930383, 5822.0, 5837.0, 3839.9616003839606, 4008.378701301303, 4025.0943537703783, 4048.817803198922, 4050.67594592426, 5256.369235691742, 5360.65155764874, 5548.056830338933, 5616.943830561806, 5624.128260119688, 5385.434529374359, 5395.541378982831, 5430.67415955044, 5439.918401223906, 5442.156465747816, 5397.973010134924, 5411.134218525017, 5427.701476418835, 5449.23710680513, 5458.908218356265, 5206.817761378334, 5417.702026388586, 5418.322709661293, 5421.783128674809, 5447.101228297287, 5409.269748583891, 5464.726763661881, 5474.974259524001, 5478.780848766005, 5494.478024587658, 5159.638825282194, 5234.740730769763, 5345.572354211576, 5346.304980352529, 5352.625316227983], "value": 4134.955763408104, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.3142842870346, 750.2797314578006, 780.2018821875357, 781.6091954022988, 873.0570983337993, 16551.0, 16953.152342382895, 17393.304267829288, 17448.56378590536, 17502.29990800368, 15520.068795872256, 15542.68914621707, 15662.530124096267, 15688.76466852998, 15691.529254122395, 669.6685140855284, 815.9836803263946, 835.4611275727152, 837.6984285657159, 837.9413441059128, 683.1221879884349, 697.1007400453409, 697.3061803505494, 797.8404319136167, 826.8801023851538, 869.9956500217522, 875.369733791669, 875.382855087162, 875.5972252763736, 875.978100547485, 869.4739682492096, 872.1932212703256, 873.6287077991828, 874.6588830356167, 875.3259989807844, 508.6007484124944, 613.187526527353, 627.7645882793952, 638.3138126513969, 639.1818472355393, 14507.202103884281, 14550.854491455057, 14557.490487832874, 14606.561803145923, 14609.415623375053, 14460.49388271416, 14944.701105977929, 15159.253988168171, 15259.847401525954, 15569.688606227925, 12756.80864787029, 13099.803502947463, 13126.934365328112, 13321.933390333083, 13689.178649281075, 4501.707389019703, 4503.324501324795, 4547.295169248771, 4738.573528382428, 4756.857294281177, 84420.07617029363, 86792.0, 86911.56544217301, 87287.0, 87707.56146219229, 10486.26596138263, 10989.890101098887, 11098.61154859576, 11269.267497612629, 11589.884101158881, 23029.193978211017, 23067.307980760605, 23130.65304020441, 23205.651915221286, 23646.527069458516, 8365.0, 8517.403781735344, 8566.61450234741, 8856.07011263808, 8877.689280875138, 4938.925916111261, 4945.9258111128365, 4977.850664480072, 5002.349694539686, 5180.145276029489, 3325.0856014595697, 3402.0, 3436.7250619950346, 3440.1571614954496, 3452.913677158091, 548.9039418101817, 556.6020295488745, 559.5299948043663, 560.7840981222258, 574.5346269521701, 630.4326106504183, 649.938255865692, 669.6251683968592, 678.1624693503519, 703.4021082080191, 9621.374610650286, 9765.072318129767, 9866.950665246628, 9906.0, 9987.250956178315, 690.7099018412179, 692.9826754331182, 695.6904177641003, 699.9195092564319, 756.530950810501, 4794.448638406628, 5110.97444512775, 5209.765560549784, 5525.723713814293, 5585.581081418829, 114572.42713786378, 127879.0, 128263.35868320786, 130508.3474582621, 131436.0, 65165.0, 93387.53306233426, 108852.45573772238, 113005.0, 115035.42482287703, 94214.52892735493, 95571.0, 95588.52205738927, 97652.0, 98090.0, 10129.848052279074, 10394.428306442916, 10413.791724165625, 10423.895761042293, 10581.62964296246, 53941.730291349864, 53974.0, 55616.0, 56459.43540564706, 56890.715546422005, 85385.57307213424, 86610.0, 86846.13153868381, 88768.0, 89496.0, 12641.683957901127, 12809.679758006125, 13097.41061652247, 13855.792163117763, 13873.11455157723, 15966.361345546047, 16111.0, 16152.192390380198, 16462.25919833634, 17053.48839534816, 14361.497347592784, 15318.387264509294, 15563.844361556692, 16060.196990150213, 16083.0, 11026.889731102587, 14540.41838326455, 14671.92664036673, 14891.702165956403, 15000.924995374953, 13608.183508989492, 13839.169649821042, 14415.711685766017, 14740.041897276642, 15251.694966100838, 11599.362035088152, 11786.941065294619, 12015.75968480608, 12080.154389192672, 12115.273083615011, 11427.0, 12211.26732396059, 12339.0, 12569.988801792035, 12639.873601264237], "value": 7902.176949487758, "unit": "score"}], "name": "dromaeo_css", "value": 7357.544209068745, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 112.0, 110.0, 111.0, 113.0, 111.0, 111.0, 110.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 117.0, 183.0, 117.0, 119.0, 154.0, 124.0, 152.0, 122.0], "value": 135.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 163.0, 160.0, 160.0, 162.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 125.0, 75.0, 76.0, 75.0, 74.0, 111.0, 74.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 120.0, 85.0, 84.0, 83.0, 116.0, 84.0, 85.0, 133.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 50.0, 49.0, 49.0, 51.0, 53.0, 51.0, 51.0, 50.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 60.0, 62.0, 61.0, 61.0, 61.0, 62.0, 61.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 76.0, 74.0, 76.0, 77.0, 75.0, 79.0, 78.0, 76.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 128.0, 120.0, 123.0, 121.0, 129.0, 121.0, 119.0, 147.0, 128.0], "value": 125.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 169.0, 159.0, 163.0, 160.0, 163.0, 161.0, 159.0, 158.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 63.0, 63.0, 65.0, 64.0, 64.0, 63.0, 62.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1483.6000000000004, "alertThreshold": 2.0}]} 02:17:19 INFO - Return code: 0 02:17:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:17:19 INFO - # TBPL SUCCESS # 02:17:19 INFO - Running post-action listener: _resource_record_post_action 02:17:19 INFO - [mozharness: 2016-08-10 09:17:19.282325Z] Finished run-tests step (success) 02:17:19 INFO - Running post-run listener: _resource_record_post_run 02:17:19 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 304336896; Read time: 0; Write time: 296220 02:17:19 INFO - TinderboxPrint: CPU usage
13.0% 02:17:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 0 02:17:19 INFO - TinderboxPrint: I/O write bytes / time
304,336,896 / 296,220 02:17:19 INFO - TinderboxPrint: CPU idle
8,286.9 (87.0%) 02:17:19 INFO - TinderboxPrint: CPU user
1,197.0 (12.6%) 02:17:19 INFO - TinderboxPrint: Swap in / out
0 / 0 02:17:19 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13901824; Read time: 0; Write time: 3452 02:17:19 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 289955840; Read time: 0; Write time: 292696 02:17:19 INFO - Running post-run listener: _upload_blobber_files 02:17:19 INFO - Blob upload gear active. 02:17:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:17:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:17:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:17:20 INFO - (blobuploader) - INFO - Open directory for files ... 02:17:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:17:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:17:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:17:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:17:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:17:21 INFO - (blobuploader) - INFO - Done attempting. 02:17:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:17:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:17:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:17:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:17:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:17:24 INFO - (blobuploader) - INFO - Done attempting. 02:17:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:17:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:17:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:17:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:17:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:17:25 INFO - (blobuploader) - INFO - Done attempting. 02:17:25 INFO - (blobuploader) - INFO - Iteration through files over. 02:17:25 INFO - Return code: 0 02:17:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:17:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:17:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1da57240e90aad5846fbfdf58a5b8acaa0abde941f77844d0fa4fd53af061b366c9c2a75b2c79584c0b783798251497db6118d444ad874d04fe2c6881726764f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f22021124f8ac57efcb7ab68d3887e73cb1d95950fb116cd4ade82596cdcd22d036f4cdf658f78afd759a9e1a5c91b71428117ba6809ce20625dbbde87c4b1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b770707c243979c77045e67a7868db2c67d856fd307344418c5eb6edd4fb9d8388c447a080e7d087c1de48b9b0fbf09acd533014ce089f86a0ac43bb827e22ce"} 02:17:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:17:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:17:25 INFO - Contents: 02:17:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1da57240e90aad5846fbfdf58a5b8acaa0abde941f77844d0fa4fd53af061b366c9c2a75b2c79584c0b783798251497db6118d444ad874d04fe2c6881726764f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f22021124f8ac57efcb7ab68d3887e73cb1d95950fb116cd4ade82596cdcd22d036f4cdf658f78afd759a9e1a5c91b71428117ba6809ce20625dbbde87c4b1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b770707c243979c77045e67a7868db2c67d856fd307344418c5eb6edd4fb9d8388c447a080e7d087c1de48b9b0fbf09acd533014ce089f86a0ac43bb827e22ce"} 02:17:25 INFO - Running post-run listener: copy_logs_to_upload_dir 02:17:25 INFO - Copying logs to upload dir... 02:17:25 INFO - mkdir: /builds/slave/test/build/upload/logs 02:17:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.692793 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-10 02:17:25.498071) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 02:17:25.501543) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1da57240e90aad5846fbfdf58a5b8acaa0abde941f77844d0fa4fd53af061b366c9c2a75b2c79584c0b783798251497db6118d444ad874d04fe2c6881726764f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f22021124f8ac57efcb7ab68d3887e73cb1d95950fb116cd4ade82596cdcd22d036f4cdf658f78afd759a9e1a5c91b71428117ba6809ce20625dbbde87c4b1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b770707c243979c77045e67a7868db2c67d856fd307344418c5eb6edd4fb9d8388c447a080e7d087c1de48b9b0fbf09acd533014ce089f86a0ac43bb827e22ce"} build_url:https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1da57240e90aad5846fbfdf58a5b8acaa0abde941f77844d0fa4fd53af061b366c9c2a75b2c79584c0b783798251497db6118d444ad874d04fe2c6881726764f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f22021124f8ac57efcb7ab68d3887e73cb1d95950fb116cd4ade82596cdcd22d036f4cdf658f78afd759a9e1a5c91b71428117ba6809ce20625dbbde87c4b1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b770707c243979c77045e67a7868db2c67d856fd307344418c5eb6edd4fb9d8388c447a080e7d087c1de48b9b0fbf09acd533014ce089f86a0ac43bb827e22ce"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 02:17:25.526352) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 02:17:25.526653) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1470817739.867723-1569732895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 02:17:25.609762) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 02:17:25.610062) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 02:17:25.613382) ========= ========= Total master_lag: 0.18 =========