builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1468239265.74 results: success (0) buildid: 20160711043826 builduid: d424a2d0fa9f48fdb9cbe969dab7c27d revision: 8f80e6e64a015c1b112765bd39a208c962f46824 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 05:14:25.737786) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 05:14:25.738293) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 05:14:25.738610) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 05:14:25.754095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:14:25.754526) ========= 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=5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 05:14:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-07-11 05:14:26 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087861 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:14:25.857462) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:14:25.857892) ========= 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=5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020719 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:14:25.908408) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 05:14:25.908766) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8f80e6e64a015c1b112765bd39a208c962f46824 --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 8f80e6e64a015c1b112765bd39a208c962f46824 --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=5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 05:14:26,954 truncating revision to first 12 chars 2016-07-11 05:14:26,954 Setting DEBUG logging. 2016-07-11 05:14:26,954 attempt 1/10 2016-07-11 05:14:26,954 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8f80e6e64a01?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 05:14:27,842 unpacking tar archive at: fx-team-8f80e6e64a01/testing/mozharness/ program finished with exit code 0 elapsedTime=1.251469 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 05:14:27.174344) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 05:14:27.174854) ========= script_repo_revision: 8f80e6e64a015c1b112765bd39a208c962f46824 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 05:14:27.175571) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 05:14:27.175921) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 05:14:27.187140) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-07-11 05:14:27.187598) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:14:28 INFO - MultiFileLogger online at 20160711 05:14:28 in /builds/slave/test 05:14:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:14:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:14:28 INFO - {'append_to_log': False, 05:14:28 INFO - 'base_work_dir': '/builds/slave/test', 05:14:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:14:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:14:28 INFO - 'branch': 'Fx-Team-Non-PGO', 05:14:28 INFO - 'buildbot_json_path': 'buildprops.json', 05:14:28 INFO - 'config_files': ('talos/linux_config.py',), 05:14:28 INFO - 'default_actions': ('clobber', 05:14:28 INFO - 'read-buildbot-config', 05:14:28 INFO - 'download-and-extract', 05:14:28 INFO - 'populate-webroot', 05:14:28 INFO - 'create-virtualenv', 05:14:28 INFO - 'install', 05:14:28 INFO - 'run-tests'), 05:14:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:14:28 INFO - 'download_minidump_stackwalk': True, 05:14:28 INFO - 'download_symbols': 'ondemand', 05:14:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:14:28 INFO - 'tooltool.py': '/tools/tooltool.py', 05:14:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:14:28 INFO - '/tools/misc-python/virtualenv.py')}, 05:14:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:14:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:14:28 INFO - 'installer_path': 'installer.exe', 05:14:28 INFO - 'log_level': 'info', 05:14:28 INFO - 'log_name': 'talos', 05:14:28 INFO - 'log_to_console': True, 05:14:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:14:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:14:28 INFO - 'opt_config_files': (), 05:14:28 INFO - 'pip_index': False, 05:14:28 INFO - 'sps_profile': False, 05:14:28 INFO - 'sps_profile_interval': 0, 05:14:28 INFO - 'suite': 'dromaeojs', 05:14:28 INFO - 'system_bits': '32', 05:14:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:14:28 INFO - 'title': 'talos-linux64-ix-039', 05:14:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:14:28 INFO - 'use_talos_json': True, 05:14:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:14:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:14:28 INFO - 'work_dir': 'build'} 05:14:28 INFO - ##### 05:14:28 INFO - ##### Running clobber step. 05:14:28 INFO - ##### 05:14:28 INFO - Running pre-action listener: _resource_record_pre_action 05:14:28 INFO - Running main action method: clobber 05:14:28 INFO - rmtree: /builds/slave/test/build 05:14:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:14:28 INFO - Running post-action listener: _resource_record_post_action 05:14:28 INFO - ##### 05:14:28 INFO - ##### Finished clobber step (success) 05:14:28 INFO - ##### 05:14:28 INFO - ##### 05:14:28 INFO - ##### Running read-buildbot-config step. 05:14:28 INFO - ##### 05:14:28 INFO - Running pre-action listener: _resource_record_pre_action 05:14:28 INFO - Running main action method: read_buildbot_config 05:14:28 INFO - Using buildbot properties: 05:14:28 INFO - { 05:14:28 INFO - "project": "", 05:14:28 INFO - "product": "firefox", 05:14:28 INFO - "script_repo_revision": "production", 05:14:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:14:28 INFO - "repository": "", 05:14:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:14:28 INFO - "buildid": "20160711043826", 05:14:28 INFO - "pgo_build": "False", 05:14:28 INFO - "basedir": "/builds/slave/test", 05:14:28 INFO - "buildnumber": 1965, 05:14:28 INFO - "slavename": "talos-linux64-ix-039", 05:14:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:14:28 INFO - "platform": "ubuntu64_hw", 05:14:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:14:28 INFO - "branch": "fx-team", 05:14:28 INFO - "repo_path": "integration/fx-team", 05:14:28 INFO - "revision": "8f80e6e64a015c1b112765bd39a208c962f46824", 05:14:28 INFO - "stage_platform": "linux64", 05:14:28 INFO - "builduid": "d424a2d0fa9f48fdb9cbe969dab7c27d", 05:14:28 INFO - "slavebuilddir": "test" 05:14:28 INFO - } 05:14:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:14:28 INFO - Running post-action listener: _resource_record_post_action 05:14:28 INFO - ##### 05:14:28 INFO - ##### Finished read-buildbot-config step (success) 05:14:28 INFO - ##### 05:14:28 INFO - ##### 05:14:28 INFO - ##### Running download-and-extract step. 05:14:28 INFO - ##### 05:14:28 INFO - Running pre-action listener: _resource_record_pre_action 05:14:28 INFO - Running main action method: download_and_extract 05:14:28 INFO - mkdir: /builds/slave/test/build/tests 05:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:28 INFO - https://queue.taskcluster.net/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:14:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:14:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:14:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:14:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:14:29 INFO - Downloaded 1361 bytes. 05:14:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:14:29 INFO - Using the following test package requirements: 05:14:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:14:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:14:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:14:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'jsshell-linux-x86_64.zip'], 05:14:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:14:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:14:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:14:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:14:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:14:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:14:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:14:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:29 INFO - https://queue.taskcluster.net/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:14:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:14:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:14:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:14:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:14:30 INFO - Downloaded 22735150 bytes. 05:14:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:14:31 INFO - Return code: 0 05:14:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:31 INFO - https://queue.taskcluster.net/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:14:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:14:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:14:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:14:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:14:32 INFO - Downloaded 22735150 bytes. 05:14:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:14:34 INFO - Return code: 0 05:14:34 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:34 INFO - https://queue.taskcluster.net/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:14:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:14:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:14:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:14:35 INFO - Downloaded 14403333 bytes. 05:14:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:14:36 INFO - Return code: 0 05:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:36 INFO - https://queue.taskcluster.net/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:14:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:14:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:14:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:14:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:14:37 INFO - Downloaded 56661040 bytes. 05:14:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:14:37 INFO - mkdir: /builds/slave/test/properties 05:14:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:14:37 INFO - Writing to file /builds/slave/test/properties/build_url 05:14:37 INFO - Contents: 05:14:37 INFO - build_url:https://queue.taskcluster.net/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:14:38 INFO - Running post-action listener: _resource_record_post_action 05:14:38 INFO - Running post-action listener: set_extra_try_arguments 05:14:38 INFO - ##### 05:14:38 INFO - ##### Finished download-and-extract step (success) 05:14:38 INFO - ##### 05:14:38 INFO - ##### 05:14:38 INFO - ##### Running populate-webroot step. 05:14:38 INFO - ##### 05:14:38 INFO - Running pre-action listener: _resource_record_pre_action 05:14:38 INFO - Running main action method: populate_webroot 05:14:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:14:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:14:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:14:38 INFO - '--tppagecycles', 05:14:38 INFO - '7'], 05:14:38 INFO - 'tests': ['tsvgm']}}, 05:14:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:14:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:14:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:14:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:14:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:14:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:14:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:38 INFO - 'talos_options': ['--disable-e10s'], 05:14:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:38 INFO - 'talos_options': ['--disable-e10s'], 05:14:38 INFO - 'tests': ['damp', 'tps']}, 05:14:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:38 INFO - 'tests': ['damp', 'tps']}, 05:14:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:14:38 INFO - 'tests': ['dromaeo_dom']}, 05:14:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:14:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:14:38 INFO - 'tests': ['basic_compositor_video']}, 05:14:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:14:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:14:38 INFO - 'tests': ['a11yr', 05:14:38 INFO - 'ts_paint', 05:14:38 INFO - 'tpaint', 05:14:38 INFO - 'sessionrestore', 05:14:38 INFO - 'sessionrestore_no_auto_restore', 05:14:38 INFO - 'tabpaint']}, 05:14:38 INFO - 'other-e10s': {'tests': ['a11yr', 05:14:38 INFO - 'ts_paint', 05:14:38 INFO - 'tpaint', 05:14:38 INFO - 'sessionrestore', 05:14:38 INFO - 'sessionrestore_no_auto_restore', 05:14:38 INFO - 'tabpaint']}, 05:14:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:14:38 INFO - 'ts_paint', 05:14:38 INFO - 'tpaint', 05:14:38 INFO - 'sessionrestore', 05:14:38 INFO - 'sessionrestore_no_auto_restore', 05:14:38 INFO - 'tabpaint']}, 05:14:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:14:38 INFO - 'ts_paint', 05:14:38 INFO - 'tpaint', 05:14:38 INFO - 'sessionrestore', 05:14:38 INFO - 'sessionrestore_no_auto_restore', 05:14:38 INFO - 'tabpaint']}, 05:14:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:14:38 INFO - 'tests': ['a11yr', 05:14:38 INFO - 'ts_paint', 05:14:38 INFO - 'tpaint', 05:14:38 INFO - 'sessionrestore', 05:14:38 INFO - 'sessionrestore_no_auto_restore', 05:14:38 INFO - 'tabpaint']}, 05:14:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:14:38 INFO - 'tests': ['a11yr', 05:14:38 INFO - 'ts_paint', 05:14:38 INFO - 'tpaint', 05:14:38 INFO - 'sessionrestore', 05:14:38 INFO - 'sessionrestore_no_auto_restore', 05:14:38 INFO - 'tabpaint']}, 05:14:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:14:38 INFO - 'tests': ['tsvgx', 05:14:38 INFO - 'tsvgr_opacity', 05:14:38 INFO - 'tart', 05:14:38 INFO - 'tscrollx', 05:14:38 INFO - 'cart']}, 05:14:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:14:38 INFO - 'tsvgr_opacity', 05:14:38 INFO - 'tart', 05:14:38 INFO - 'tscrollx', 05:14:38 INFO - 'cart']}, 05:14:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:38 INFO - 'talos_options': ['--disable-e10s'], 05:14:38 INFO - 'tests': ['tp5o']}, 05:14:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:38 INFO - 'tests': ['tp5o']}, 05:14:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:38 INFO - 'talos_options': ['--disable-e10s', 05:14:38 INFO - '--xperf_path', 05:14:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:38 INFO - 'tests': ['tp5n']}, 05:14:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:38 INFO - 'talos_options': ['--xperf_path', 05:14:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:38 INFO - 'tests': ['tp5n']}}, 05:14:38 INFO - 'talos.zip': {'path': '', 05:14:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:14:38 INFO - Running post-action listener: _resource_record_post_action 05:14:38 INFO - ##### 05:14:38 INFO - ##### Finished populate-webroot step (success) 05:14:38 INFO - ##### 05:14:38 INFO - ##### 05:14:38 INFO - ##### Running create-virtualenv step. 05:14:38 INFO - ##### 05:14:38 INFO - Running pre-action listener: _resource_record_pre_action 05:14:38 INFO - Running main action method: create_virtualenv 05:14:38 INFO - Creating virtualenv /builds/slave/test/build/venv 05:14:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:14:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:14:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:14:38 INFO - Using real prefix '/usr' 05:14:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:14:39 INFO - Installing distribute.............................................................................................................................................................................................done. 05:14:40 INFO - Installing pip.................done. 05:14:40 INFO - Return code: 0 05:14:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1497030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1758180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17563b0>, '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 0x17572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1757740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487', '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 05:14:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:14:40 INFO - Using env: {'DISPLAY': ':0', 05:14:40 INFO - 'HOME': '/home/cltbld', 05:14:40 INFO - 'LANG': 'en_US.UTF-8', 05:14:40 INFO - 'LANGUAGE': 'en_US:en', 05:14:40 INFO - 'LOGNAME': 'cltbld', 05:14:40 INFO - 'MAIL': '/var/mail/cltbld', 05:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:40 INFO - 'MOZ_NO_REMOTE': '1', 05:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:40 INFO - 'NO_EM_RESTART': '1', 05:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:40 INFO - 'PWD': '/builds/slave/test', 05:14:40 INFO - 'SHELL': '/bin/bash', 05:14:40 INFO - 'SHLVL': '1', 05:14:40 INFO - 'TERM': 'linux', 05:14:40 INFO - 'TMOUT': '86400', 05:14:40 INFO - 'USER': 'cltbld', 05:14:40 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487', 05:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:40 INFO - '_': '/tools/buildbot/bin/python'} 05:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:14:41 INFO - Cleaning up... 05:14:41 INFO - Return code: 0 05:14:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1497030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1758180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17563b0>, '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 0x17572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1757740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487', '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 05:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:14:41 INFO - Using env: {'DISPLAY': ':0', 05:14:41 INFO - 'HOME': '/home/cltbld', 05:14:41 INFO - 'LANG': 'en_US.UTF-8', 05:14:41 INFO - 'LANGUAGE': 'en_US:en', 05:14:41 INFO - 'LOGNAME': 'cltbld', 05:14:41 INFO - 'MAIL': '/var/mail/cltbld', 05:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:41 INFO - 'MOZ_NO_REMOTE': '1', 05:14:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:41 INFO - 'NO_EM_RESTART': '1', 05:14:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:41 INFO - 'PWD': '/builds/slave/test', 05:14:41 INFO - 'SHELL': '/bin/bash', 05:14:41 INFO - 'SHLVL': '1', 05:14:41 INFO - 'TERM': 'linux', 05:14:41 INFO - 'TMOUT': '86400', 05:14:41 INFO - 'USER': 'cltbld', 05:14:41 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487', 05:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:41 INFO - '_': '/tools/buildbot/bin/python'} 05:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:41 INFO - Downloading/unpacking psutil>=3.1.1 05:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:14:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:43 INFO - Installing collected packages: psutil 05:14:43 INFO - Running setup.py install for psutil 05:14:43 INFO - building 'psutil._psutil_linux' extension 05:14:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:14:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:14:43 INFO - building 'psutil._psutil_posix' extension 05:14:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:14:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:14:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:44 INFO - Successfully installed psutil 05:14:44 INFO - Cleaning up... 05:14:44 INFO - Return code: 0 05:14:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1497030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1758180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17563b0>, '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 0x17572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1757740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487', '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 05:14:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:14:44 INFO - Using env: {'DISPLAY': ':0', 05:14:44 INFO - 'HOME': '/home/cltbld', 05:14:44 INFO - 'LANG': 'en_US.UTF-8', 05:14:44 INFO - 'LANGUAGE': 'en_US:en', 05:14:44 INFO - 'LOGNAME': 'cltbld', 05:14:44 INFO - 'MAIL': '/var/mail/cltbld', 05:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:44 INFO - 'MOZ_NO_REMOTE': '1', 05:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:44 INFO - 'NO_EM_RESTART': '1', 05:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:44 INFO - 'PWD': '/builds/slave/test', 05:14:44 INFO - 'SHELL': '/bin/bash', 05:14:44 INFO - 'SHLVL': '1', 05:14:44 INFO - 'TERM': 'linux', 05:14:44 INFO - 'TMOUT': '86400', 05:14:44 INFO - 'USER': 'cltbld', 05:14:44 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487', 05:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:44 INFO - '_': '/tools/buildbot/bin/python'} 05:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:14:46 INFO - Installing collected packages: mozsystemmonitor 05:14:46 INFO - Running setup.py install for mozsystemmonitor 05:14:46 INFO - Successfully installed mozsystemmonitor 05:14:46 INFO - Cleaning up... 05:14:46 INFO - Return code: 0 05:14:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1497030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1758180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17563b0>, '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 0x17572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1757740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487', '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 05:14:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:14:46 INFO - Using env: {'DISPLAY': ':0', 05:14:46 INFO - 'HOME': '/home/cltbld', 05:14:46 INFO - 'LANG': 'en_US.UTF-8', 05:14:46 INFO - 'LANGUAGE': 'en_US:en', 05:14:46 INFO - 'LOGNAME': 'cltbld', 05:14:46 INFO - 'MAIL': '/var/mail/cltbld', 05:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:46 INFO - 'MOZ_NO_REMOTE': '1', 05:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:46 INFO - 'NO_EM_RESTART': '1', 05:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:46 INFO - 'PWD': '/builds/slave/test', 05:14:46 INFO - 'SHELL': '/bin/bash', 05:14:46 INFO - 'SHLVL': '1', 05:14:46 INFO - 'TERM': 'linux', 05:14:46 INFO - 'TMOUT': '86400', 05:14:46 INFO - 'USER': 'cltbld', 05:14:46 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487', 05:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:46 INFO - '_': '/tools/buildbot/bin/python'} 05:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:46 INFO - Downloading/unpacking jsonschema==2.5.1 05:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:14:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:48 INFO - Downloading functools32-3.2.3-2.tar.gz 05:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:14:48 INFO - warning: no files found matching '*.txt' 05:14:48 INFO - no previously-included directories found matching 'build' 05:14:48 INFO - no previously-included directories found matching 'dist' 05:14:48 INFO - no previously-included directories found matching '.git*' 05:14:48 INFO - Installing collected packages: jsonschema, functools32 05:14:48 INFO - Running setup.py install for functools32 05:14:48 INFO - warning: no files found matching '*.txt' 05:14:48 INFO - no previously-included directories found matching 'build' 05:14:48 INFO - no previously-included directories found matching 'dist' 05:14:48 INFO - no previously-included directories found matching '.git*' 05:14:48 INFO - Successfully installed jsonschema functools32 05:14:48 INFO - Cleaning up... 05:14:48 INFO - Return code: 0 05:14:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1497030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1758180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17563b0>, '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 0x17572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1757740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487', '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 05:14:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:14:48 INFO - Using env: {'DISPLAY': ':0', 05:14:48 INFO - 'HOME': '/home/cltbld', 05:14:48 INFO - 'LANG': 'en_US.UTF-8', 05:14:48 INFO - 'LANGUAGE': 'en_US:en', 05:14:48 INFO - 'LOGNAME': 'cltbld', 05:14:48 INFO - 'MAIL': '/var/mail/cltbld', 05:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:48 INFO - 'MOZ_NO_REMOTE': '1', 05:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:48 INFO - 'NO_EM_RESTART': '1', 05:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:48 INFO - 'PWD': '/builds/slave/test', 05:14:48 INFO - 'SHELL': '/bin/bash', 05:14:48 INFO - 'SHLVL': '1', 05:14:48 INFO - 'TERM': 'linux', 05:14:48 INFO - 'TMOUT': '86400', 05:14:48 INFO - 'USER': 'cltbld', 05:14:48 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487', 05:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:48 INFO - '_': '/tools/buildbot/bin/python'} 05:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:14:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:14:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:14:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:51 INFO - Downloading docopt-0.6.1.tar.gz 05:14:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:14:51 INFO - Installing collected packages: blobuploader, requests, docopt 05:14:51 INFO - Running setup.py install for blobuploader 05:14:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:14:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:14:52 INFO - Running setup.py install for requests 05:14:52 INFO - Running setup.py install for docopt 05:14:52 INFO - Successfully installed blobuploader requests docopt 05:14:52 INFO - Cleaning up... 05:14:52 INFO - Return code: 0 05:14:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1497030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1758180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17563b0>, '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 0x17572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1757740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487', '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 05:14:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:14:52 INFO - Using env: {'DISPLAY': ':0', 05:14:52 INFO - 'HOME': '/home/cltbld', 05:14:52 INFO - 'LANG': 'en_US.UTF-8', 05:14:52 INFO - 'LANGUAGE': 'en_US:en', 05:14:52 INFO - 'LOGNAME': 'cltbld', 05:14:52 INFO - 'MAIL': '/var/mail/cltbld', 05:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:52 INFO - 'MOZ_NO_REMOTE': '1', 05:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:52 INFO - 'NO_EM_RESTART': '1', 05:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:52 INFO - 'PWD': '/builds/slave/test', 05:14:52 INFO - 'SHELL': '/bin/bash', 05:14:52 INFO - 'SHLVL': '1', 05:14:52 INFO - 'TERM': 'linux', 05:14:52 INFO - 'TMOUT': '86400', 05:14:52 INFO - 'USER': 'cltbld', 05:14:52 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487', 05:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:52 INFO - '_': '/tools/buildbot/bin/python'} 05:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:14:52 INFO - Running setup.py (path:/tmp/pip-z7eQss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:14:52 INFO - Running setup.py (path:/tmp/pip-0KV6jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:14:52 INFO - Running setup.py (path:/tmp/pip-Vs0U_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:14:53 INFO - Running setup.py (path:/tmp/pip-ooZoEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:14:53 INFO - Running setup.py (path:/tmp/pip-1VWuRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:14:53 INFO - Running setup.py (path:/tmp/pip-SrUBow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:14:53 INFO - Running setup.py (path:/tmp/pip-dM3a0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:14:53 INFO - Running setup.py (path:/tmp/pip-CwbVDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:14:53 INFO - Running setup.py (path:/tmp/pip-k0TFWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:14:53 INFO - Running setup.py (path:/tmp/pip-oW8_AC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:14:53 INFO - Running setup.py (path:/tmp/pip-y7S9rM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:14:53 INFO - Running setup.py (path:/tmp/pip-ZqPntE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:14:53 INFO - Running setup.py (path:/tmp/pip-rHimiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:14:53 INFO - Running setup.py (path:/tmp/pip-OfYiQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:53 INFO - Running setup.py (path:/tmp/pip-o7PccT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:14:53 INFO - Running setup.py (path:/tmp/pip-7aTM9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:14:53 INFO - Running setup.py (path:/tmp/pip-Wli9k8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:14:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:14:54 INFO - Running setup.py install for manifestparser 05:14:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Running setup.py install for mozcrash 05:14:54 INFO - Running setup.py install for mozdebug 05:14:54 INFO - Running setup.py install for mozdevice 05:14:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Running setup.py install for mozfile 05:14:54 INFO - Running setup.py install for mozhttpd 05:14:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Running setup.py install for mozinfo 05:14:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Running setup.py install for mozInstall 05:14:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Running setup.py install for mozleak 05:14:54 INFO - Running setup.py install for mozlog 05:14:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:14:55 INFO - Running setup.py install for moznetwork 05:14:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:14:55 INFO - Running setup.py install for mozprocess 05:14:55 INFO - Running setup.py install for mozprofile 05:14:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:14:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:14:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:14:55 INFO - Running setup.py install for mozrunner 05:14:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:14:55 INFO - Running setup.py install for mozscreenshot 05:14:55 INFO - Running setup.py install for moztest 05:14:55 INFO - Running setup.py install for mozversion 05:14:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:14:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:14:55 INFO - Cleaning up... 05:14:55 INFO - Return code: 0 05:14:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1497030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1758180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17563b0>, '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 0x17572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1757740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487', '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 05:14:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:14:55 INFO - Using env: {'DISPLAY': ':0', 05:14:55 INFO - 'HOME': '/home/cltbld', 05:14:55 INFO - 'LANG': 'en_US.UTF-8', 05:14:55 INFO - 'LANGUAGE': 'en_US:en', 05:14:55 INFO - 'LOGNAME': 'cltbld', 05:14:55 INFO - 'MAIL': '/var/mail/cltbld', 05:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:55 INFO - 'MOZ_NO_REMOTE': '1', 05:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:55 INFO - 'NO_EM_RESTART': '1', 05:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:55 INFO - 'PWD': '/builds/slave/test', 05:14:55 INFO - 'SHELL': '/bin/bash', 05:14:55 INFO - 'SHLVL': '1', 05:14:55 INFO - 'TERM': 'linux', 05:14:55 INFO - 'TMOUT': '86400', 05:14:55 INFO - 'USER': 'cltbld', 05:14:55 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487', 05:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:55 INFO - '_': '/tools/buildbot/bin/python'} 05:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:14:56 INFO - Running setup.py (path:/tmp/pip-2t0Y1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:14:56 INFO - Running setup.py (path:/tmp/pip-ckPbwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:14:56 INFO - Running setup.py (path:/tmp/pip-xlgBAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:14:56 INFO - Running setup.py (path:/tmp/pip-Ayti9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:14:56 INFO - Running setup.py (path:/tmp/pip-OXf4_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:14:56 INFO - Running setup.py (path:/tmp/pip-azkKWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:14:56 INFO - Running setup.py (path:/tmp/pip-QwSqxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:14:56 INFO - Running setup.py (path:/tmp/pip-HzZ1mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:14:56 INFO - Running setup.py (path:/tmp/pip-DrzgQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:14:56 INFO - Running setup.py (path:/tmp/pip-CFT8bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 05:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:14:56 INFO - Running setup.py (path:/tmp/pip-x0oJnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:14:56 INFO - Running setup.py (path:/tmp/pip-NrLgZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:14:56 INFO - Running setup.py (path:/tmp/pip-_7Wolm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:14:56 INFO - Running setup.py (path:/tmp/pip-LJU0jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:14:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:57 INFO - Running setup.py (path:/tmp/pip-C7kVhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:14:57 INFO - Running setup.py (path:/tmp/pip-U5miDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:14:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:14:57 INFO - Running setup.py (path:/tmp/pip-vSaX9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:14:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:14:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:14:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:14:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:14:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:14:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:14:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:59 INFO - Downloading blessings-1.6.tar.gz 05:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:14:59 INFO - Installing collected packages: blessings 05:14:59 INFO - Running setup.py install for blessings 05:14:59 INFO - Successfully installed blessings 05:14:59 INFO - Cleaning up... 05:14:59 INFO - Return code: 0 05:14:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:14:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:14:59 INFO - Reading from file tmpfile_stdout 05:14:59 INFO - Current package versions: 05:14:59 INFO - argparse == 1.2.1 05:14:59 INFO - blessings == 1.6 05:14:59 INFO - blobuploader == 1.2.4 05:14:59 INFO - docopt == 0.6.1 05:14:59 INFO - functools32 == 3.2.3-2 05:14:59 INFO - jsonschema == 2.5.1 05:14:59 INFO - manifestparser == 1.1 05:14:59 INFO - mozInstall == 1.12 05:14:59 INFO - mozcrash == 0.17 05:14:59 INFO - mozdebug == 0.1 05:14:59 INFO - mozdevice == 0.48 05:14:59 INFO - mozfile == 1.2 05:14:59 INFO - mozhttpd == 0.7 05:14:59 INFO - mozinfo == 0.9 05:14:59 INFO - mozleak == 0.1 05:14:59 INFO - mozlog == 3.2 05:14:59 INFO - moznetwork == 0.27 05:14:59 INFO - mozprocess == 0.23 05:14:59 INFO - mozprofile == 0.28 05:14:59 INFO - mozrunner == 6.12 05:14:59 INFO - mozscreenshot == 0.1 05:14:59 INFO - mozsystemmonitor == 0.3 05:14:59 INFO - moztest == 0.7 05:14:59 INFO - mozversion == 1.4 05:14:59 INFO - psutil == 3.1.1 05:14:59 INFO - requests == 1.2.3 05:14:59 INFO - wsgiref == 0.1.2 05:14:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1497030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1758180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17563b0>, '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 0x17572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1757740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487', '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 05:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:14:59 INFO - Using env: {'DISPLAY': ':0', 05:14:59 INFO - 'HOME': '/home/cltbld', 05:14:59 INFO - 'LANG': 'en_US.UTF-8', 05:14:59 INFO - 'LANGUAGE': 'en_US:en', 05:14:59 INFO - 'LOGNAME': 'cltbld', 05:14:59 INFO - 'MAIL': '/var/mail/cltbld', 05:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:59 INFO - 'MOZ_NO_REMOTE': '1', 05:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:59 INFO - 'NO_EM_RESTART': '1', 05:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:59 INFO - 'PWD': '/builds/slave/test', 05:14:59 INFO - 'SHELL': '/bin/bash', 05:14:59 INFO - 'SHLVL': '1', 05:14:59 INFO - 'TERM': 'linux', 05:14:59 INFO - 'TMOUT': '86400', 05:14:59 INFO - 'USER': 'cltbld', 05:14:59 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487', 05:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:59 INFO - '_': '/tools/buildbot/bin/python'} 05:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:14:59 INFO - Cleaning up... 05:14:59 INFO - Return code: 0 05:14:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1497030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1758180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17563b0>, '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 0x17572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1757740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487', '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 05:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:14:59 INFO - Using env: {'DISPLAY': ':0', 05:14:59 INFO - 'HOME': '/home/cltbld', 05:14:59 INFO - 'LANG': 'en_US.UTF-8', 05:14:59 INFO - 'LANGUAGE': 'en_US:en', 05:14:59 INFO - 'LOGNAME': 'cltbld', 05:14:59 INFO - 'MAIL': '/var/mail/cltbld', 05:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:59 INFO - 'MOZ_NO_REMOTE': '1', 05:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:59 INFO - 'NO_EM_RESTART': '1', 05:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:59 INFO - 'PWD': '/builds/slave/test', 05:14:59 INFO - 'SHELL': '/bin/bash', 05:14:59 INFO - 'SHLVL': '1', 05:14:59 INFO - 'TERM': 'linux', 05:14:59 INFO - 'TMOUT': '86400', 05:14:59 INFO - 'USER': 'cltbld', 05:14:59 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487', 05:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:59 INFO - '_': '/tools/buildbot/bin/python'} 05:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:15:00 INFO - Cleaning up... 05:15:00 INFO - Return code: 0 05:15:00 INFO - Running post-action listener: _resource_record_post_action 05:15:00 INFO - Running post-action listener: _start_resource_monitoring 05:15:00 INFO - Starting resource monitoring. 05:15:00 INFO - ##### 05:15:00 INFO - ##### Finished create-virtualenv step (success) 05:15:00 INFO - ##### 05:15:00 INFO - ##### 05:15:00 INFO - ##### Running install step. 05:15:00 INFO - ##### 05:15:00 INFO - Running pre-action listener: _resource_record_pre_action 05:15:00 INFO - Running main action method: install 05:15:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:00 INFO - Reading from file tmpfile_stdout 05:15:00 INFO - Detecting whether we're running mozinstall >=1.0... 05:15:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:15:00 INFO - Reading from file tmpfile_stdout 05:15:00 INFO - Output received: 05:15:00 INFO - Usage: mozinstall [options] installer 05:15:00 INFO - Options: 05:15:00 INFO - -h, --help show this help message and exit 05:15:00 INFO - -d DEST, --destination=DEST 05:15:00 INFO - Directory to install application into. [default: 05:15:00 INFO - "/builds/slave/test"] 05:15:00 INFO - --app=APP Application being installed. [default: firefox] 05:15:00 INFO - mkdir: /builds/slave/test/build/application 05:15:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:15:16 INFO - Reading from file tmpfile_stdout 05:15:16 INFO - Output received: 05:15:16 INFO - /builds/slave/test/build/application/firefox/firefox 05:15:16 INFO - Running post-action listener: _resource_record_post_action 05:15:16 INFO - ##### 05:15:16 INFO - ##### Finished install step (success) 05:15:16 INFO - ##### 05:15:16 INFO - ##### 05:15:16 INFO - ##### Running run-tests step. 05:15:16 INFO - ##### 05:15:16 INFO - Running pre-action listener: _resource_record_pre_action 05:15:16 INFO - Running main action method: run_tests 05:15:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:15:16 INFO - Python 2.7.3 05:15:16 INFO - Return code: 0 05:15:16 INFO - grabbing minidump binary from tooltool 05:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:16 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17563b0>, '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 0x17572b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1757740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:15:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:15:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:15:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:15:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:15:16 INFO - Return code: 0 05:15:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:15:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:15:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:15:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:15:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:15:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 05:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 05:15:16 INFO - Using env: {'DISPLAY': ':0', 05:15:16 INFO - 'HOME': '/home/cltbld', 05:15:16 INFO - 'LANG': 'en_US.UTF-8', 05:15:16 INFO - 'LANGUAGE': 'en_US:en', 05:15:16 INFO - 'LOGNAME': 'cltbld', 05:15:16 INFO - 'MAIL': '/var/mail/cltbld', 05:15:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:15:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:16 INFO - 'MOZ_NO_REMOTE': '1', 05:15:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:16 INFO - 'NO_EM_RESTART': '1', 05:15:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:16 INFO - 'PWD': '/builds/slave/test', 05:15:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:15:16 INFO - 'SHELL': '/bin/bash', 05:15:16 INFO - 'SHLVL': '1', 05:15:16 INFO - 'TERM': 'linux', 05:15:16 INFO - 'TMOUT': '86400', 05:15:16 INFO - 'USER': 'cltbld', 05:15:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487', 05:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:16 INFO - '_': '/tools/buildbot/bin/python'} 05:15:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 05:15:17 INFO - mozversion application_buildid: 20160711043826 05:15:17 INFO - mozversion application_changeset: 8f80e6e64a015c1b112765bd39a208c962f46824 05:15:17 INFO - mozversion application_display_name: Nightly 05:15:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:15:17 INFO - mozversion application_name: Firefox 05:15:17 INFO - mozversion application_remotingname: firefox 05:15:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:15:17 INFO - mozversion application_vendor: Mozilla 05:15:17 INFO - mozversion application_version: 50.0a1 05:15:17 INFO - mozversion platform_buildid: 20160711043826 05:15:17 INFO - mozversion platform_changeset: 8f80e6e64a015c1b112765bd39a208c962f46824 05:15:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:15:17 INFO - mozversion platform_version: 50.0a1 05:15:17 INFO - using testdate: 1468239317 05:15:17 INFO - actual date: 1468239317 05:15:17 INFO - starting webserver on 'localhost:56311' 05:15:17 INFO - SUITE-START | Running 2 tests 05:15:17 INFO - TEST-START | dromaeo_css 05:15:17 INFO - operating with platform_type : linux_ 05:15:17 INFO - Initialising browser for dromaeo_css test... 05:15:17 INFO - TEST-INFO | started process 16829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXJTE7N/profile http://localhost:56311/getInfo.html) 05:15:21 INFO - PROCESS | 16829 | __metrics Screen width/height:1600/1200 05:15:21 INFO - PROCESS | 16829 | colorDepth:24 05:15:21 INFO - PROCESS | 16829 | Browser inner width/height: 1024/697 05:15:21 INFO - PROCESS | 16829 | __metrics 05:15:22 INFO - PROCESS | 16829 | 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" 05:15:22 INFO - PROCESS | 16829 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:15:23 INFO - TEST-INFO | 16829: exit 0 05:15:23 INFO - Browser initialized. 05:15:23 INFO - Running cycle 1/1 for dromaeo_css test... 05:15:23 INFO - TEST-INFO | started process 16911 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXJTE7N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:35 INFO - PROCESS | 16911 | RSS: Main: 158998528 05:15:35 INFO - PROCESS | 16911 | 05:16:26 INFO - PROCESS | 16911 | 1468239386059 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] 05:18:38 INFO - PROCESS | 16911 | Cycle 1(1): loaded http://localhost:56311/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56311/tests/dromaeo/cssquery-ext.html) 05:18:39 INFO - PROCESS | 16911 | RSS: Main: 263925760 05:18:39 INFO - PROCESS | 16911 | 05:21:45 INFO - PROCESS | 16911 | Cycle 1(1): loaded http://localhost:56311/tests/dromaeo/cssquery-ext.html (next: http://localhost:56311/tests/dromaeo/cssquery-jquery.html) 05:21:46 INFO - PROCESS | 16911 | RSS: Main: 244514816 05:21:46 INFO - PROCESS | 16911 | 05:24:54 INFO - PROCESS | 16911 | Cycle 1(1): loaded http://localhost:56311/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56311/tests/dromaeo/cssquery-mootools.html) 05:24:55 INFO - PROCESS | 16911 | RSS: Main: 240701440 05:24:55 INFO - PROCESS | 16911 | 05:28:03 INFO - PROCESS | 16911 | Cycle 1(1): loaded http://localhost:56311/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56311/tests/dromaeo/cssquery-prototype.html) 05:28:04 INFO - PROCESS | 16911 | RSS: Main: 234905600 05:28:04 INFO - PROCESS | 16911 | 05:31:12 INFO - PROCESS | 16911 | Cycle 1(1): loaded http://localhost:56311/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56311/tests/dromaeo/cssquery-yui.html) 05:31:13 INFO - PROCESS | 16911 | RSS: Main: 208547840 05:31:13 INFO - PROCESS | 16911 | 05:34:19 INFO - PROCESS | 16911 | Cycle 1(1): loaded http://localhost:56311/tests/dromaeo/cssquery-yui.html (next: http://localhost:56311/tests/dromaeo/cssquery-dojo.html) 05:34:20 INFO - PROCESS | 16911 | RSS: Main: 276074496 05:34:20 INFO - PROCESS | 16911 | 05:34:20 INFO - PROCESS | 16911 | __start_tp_report 05:34:20 INFO - PROCESS | 16911 | _x_x_mozilla_page_load 05:34:20 INFO - PROCESS | 16911 | _x_x_mozilla_page_load_details 05:34:20 INFO - PROCESS | 16911 | |i|pagename|runs| 05:34:20 INFO - PROCESS | 16911 | |0;dojo.html;2575.703794063683;2586.8447893126427;2613.8823752931116;2618.515574618695;2637.0770230419357;4469.843555475559;4537.954620453795;4653.232216684247;4659.697119687218;4673;4577.656675749324;4626.074785042988;4638.97680511597;4665.953340466594;4672.953270467295;4219.092895027568;4252.170826688797;4289.785510724467;4320.805563749623;4407.49313828909;4360.672949528798;4369.475662920454;4381.298992161255;4412.1175764847;4423.469183697961;4215.894602634928;4247.299195632717;4253.149370125987;4299.613034826881;4322.697411181219;4263.637590804786;4265.637420819234;4267.637250833683;4323.697341186118;4351.9782401088105;4284.978575107136;4292.055747735493;4306.5478124796755;4339.262325404688;4348.086901750637;4533.818647254106;4597.287420449836;4613.953860461386;4696.9530304696855;4709.364235828154;5009.048280826668;5024.296598476216;5029.270755740397;5058.671186372911;5077.720725360104;5050.595952323805;5075.771590278447;5099.617528685363;5110.207917772751;5114.641975061747;4539.500654927955;4613.5386461354265;4663.044075964419;4667.556582124693;4747.264174053027;5150.48495150482;5155.793768249228;5161.845144645667;5167.328247327899;5169.198774190007;4905.068037072945;4917.631177661689;4925.064237794808;4969.428515720666;4970.080535101018;4861.1979023460735;4927.531884470969;4936.259561065869;4989.476105008922;4989.775460104304;4903.33804936329;4922.90154196914;4934.901301974012;4943.456219815817;4999.275105109738;4826.541478559531;4923.507649235119;4934.555889969848;4937.481564435754;4989.750512474362;4239.1521695660995;4258.957410425918;4286.849960251377;4301.462317210348;4327.978360108243;3695.260947810395;3717.5353080864893;3723.255348930225;3760.7743535387417;3766.6233376662663;4284.742915425085;4294.527601963781;4294.82820687169;4296.5273819879785;4339.544347843431;4841.176999910023;4892.706437613754;4926.088673595396;4941.258811178352;5042.142835717937;4267.061246525759;4283.914321713548;4287.356896465555;4319.352097185384;4329.805158767863;4503.347014682852;4509.503954564995;4510.458744950627;4512.435945506812;4560.657950653715;4479.350494178391;4574.748388838646;4603.838865639686;4625.907481850411;4644.558766917137;4947.48051454592;4958.7024778513405;4966.478519755374;4967.230079337708;5015.247712843103;4609.631229501699;4628.514006029319;4631.374764406897;4634.443866736014;4693.272542755878;4656.138614356355;4666.580007799314;4727.929081063718;4755.5719985201495;4769.4753577107185;4932.1122198004705;4941.530554597452;4947.529984651453;4949.752512374295;4998.775055122601;4605.263157894721;4659.767011649472;4679.064187162649;4697.882552936204;4708.270218116198;4646.581807637329;4678.461976872703;4703.153432382204;4707.411573553306;4708.223143181337;4621.907561848811;4654.278586818913;4658.231391820447;4699.718016918996;4710.317004034464;4688.0858232644305;4692.859214223578;4754.4532378776885;4755.762211889322;4794.928076078932;4630.58324750774;4633.536646335339;4666.533346665442;4668.509806470408;4710.057988402402 05:34:20 INFO - PROCESS | 16911 | |1;ext.html;546.0474995535758;571.2288410645629;578.407132688994;587.1369087441461;598.7245866901226;41128.588714112884;42342.57657423425;42356.788216058914;42368.788156059214;45459.77270113645;41616;42070;42115;42167.578324216745;42212;7546.320831125197;7779.7666070017995;7918.841623167533;10266.948665256701;10544.630937917174;10367;10452.216083793708;10472.2145839062;10474.109700675452;10477.685669429891;10542.525586348595;10574.312669676485;10585.311954722956;10587.15302775776;10589.205809564275;7606.315431611154;10226.897731022706;10469.84295235572;10482.58069677212;10817.945910270477;10346.793064138676;10367.22245831558;10367.48162591875;10367.79264414715;10419.531121099568;33057.173570660685;39432.80283598592;39824.40263396051;39841.203175936316;39849;2807.3823758773037;2872.9138125856257;2929.414117176573;3161.4783560712453;3184.586003819512;28469.57295640567;28852.855735721187;30859.38281234363;30912.690873091207;31641;3386.7459940504314;3531.823408829574;3551.485034669984;3583.8924832255075;3627;277463;279555;280058;280562;281379;48920;58206.70896645574;58863.41136588579;58937;58944;60432.39567604267;61924;61971.38028619746;67536.32463675301;67703.66148169228;11745.29528228309;12615.747685046248;12675.302858342695;12704.047196460302;12718.109732318833;9509.429434233969;9818.45998470091;9829.361091529028;9988.300818942604;10005.549750261256;19855;19999.10004049821;20041.198352066047;20131.39605811828;20225.898870505553;7230.783076507713;7329.963350183215;7348.448866335047;7438.330550250504;7582.582957937256;806.314632562329;926.5969303353063;931.5668214280392;939.1688355805162;1046.7016900183412;28079.71920280812;28824;28961.275968100967;29373.706262937525;29445.705542944725;993.6323560282742;996.8504724291414;998.6604554451521;1016.506994107857;1023.4166525080633;14882.404703811942;15184.544463666107;15384.461543845911;15486.845131548765;15651.686966260611;4235.647690639297;403838;407844;408489;409546;50866.237006444935;51103.744481277354;51749;51757.7412112937;51819;1089.7330154112294;1137.7269455330495;1176.2824676947228;1189.3102000839492;1197.9401029948294;28505.572416414187;29684.554731679473;30105.397892042474;30213.697863021087;30507;43829.34255986099;43919.56080439155;44307;44381.11237775162;44436;320615;323452;324968;325346;325585;32729.836350818092;38019.61980380161;38689.6131038686;38712.6128738709;41925;43452.130957381305;43655.345169823115;43831.561684382745;44654.10691786211;44862.775686121364;36509.63490365062;37643.62356376401;37718;37870.24259514739;38287.61712382841;37258.223635041744;37863;38158;38417.61582384141;38691.613083868804;36161;36234.818825906754;36628.81685591555;36882.44676329911;37146;32594.348113038082;32778.9313952562;33146.33707325888;33634.831825840716;33678.49482257719;25472.2358329243;25606.487870242865;25791.742082578934;25797.871010644827;26132.73867261303 05:34:20 INFO - PROCESS | 16911 | |2;jquery.html;343.1862606126621;365.5193420651843;369.25594926223664;371.83825036109295;388.74148691120405;13164.605061848137;14003.509877154302;17418.56453588661;17480.38818641348;17643.911780441078;16362.263698133584;16853.325866965308;17104.144792760344;17149.485515434524;17149.571260718487;4553.453585569736;4563.041761230145;4577.359169716226;4582;4887.780049897754;3707.8146092695392;5058.367704036977;5798.82603521895;6101.755929762827;6105.114758360035;6104.786332478342;6112;6114.266288045418;6128.96935515324;6135.815925522242;5143.5113664201845;5450.127979523258;5469.234307196995;5534.889302213933;5535.308086489189;3381.9830900845336;5331.44019877915;6259.342769009279;6672.399484046459;6679.699413526403;22249;22951.1967081153;23326.066957321855;24198;24267.63598546023;1985.3547597031022;1998.8400927925732;2014.1842553765603;2079.6048750737314;2104.7684754676975;14189.361478733379;14343.713125737531;14384.06503577264;14448.71102577953;14951.80464014634;1935.3129638978241;1987.6223517531623;2002.499375156211;2021.82814460771;2083.2500299892026;78601.60699196525;81086;82791.58604206941;82997;83738.16261837365;16494.17529123539;16610.837241392986;16675.166241687868;16689.24898379576;16915.915420422818;28843.711562884102;28964;29140.562891556645;29226.123216303546;29314;8020.398470114765;8244.83510329802;8376.916230837614;8494.915050849413;8516;6846.353701830599;6854.246032936473;6854.383105520527;6858.417034552019;7005.773989551808;8450.830983380298;8646.567671616394;8729.127087291346;8734.912650873537;8807.867881981776;3387.3733359328603;3397.1507123219194;3469.392856250146;3513.9121521962156;3560.8753693620597;810.8499927513311;827.5117680568494;845.1970627903517;846.95341756204;914.6341463414565;13923.310322764475;16220.188990550661;16381.0171389717;16669.49991500257;17175.828241717674;786.4455558831124;794.6384395100215;811.5005782190838;842.2419822160105;842.3387640702019;8757.992830824536;8877.866831997526;9511.90488095124;9513.381630194015;9757.658481953098;364223;415004;417835;419969;424493;82592.58703706563;85820;88269.55865220762;88594.55702721573;88608;939.2439086535404;948.5778828421562;955.6655170690203;991.801639672083;993.5529011944509;15689.921550392175;15714;15823.446179384127;15836.68326633484;16139.56609259664;37750.62249377471;37882.62117378901;38039.2392152161;38798.2240355197;39590.2081958365;53385.7330713344;55070.44929550653;55440.445595543526;55469.16796247979;55966.52267818483;7357.5217610855125;7491.812704682427;7538.170801211972;7612.657430415534;7631.084269887649;10088.495575221357;10475.947620262155;10952.397618131079;11493.597724079616;11794.115441342105;5084.466131056334;7327.8534429312185;9522.904770952202;9938.403695778277;9946.30375873711;9078.364514484187;9914.454704991294;10124.493775311057;10416.375017498975;10518.737031574272;10466.319689220481;10469.633562825264;10583.523741431809;10644.361338319726;10721.035106840422;7701.383889288955;7806;7829.96085019594;7922.920770792219;7923.7226697065325;10172.694819155437;10256.897431025594;10281.948590257001;10382.792344153226;10669.199810014125 05:34:20 INFO - PROCESS | 16911 | |3;mootools.html;1364.1405914274005;1420.4034305591651;1492.2837038221653;1704.5653358393608;1731.5238309464903;7360.815979600506;7865.528068315905;7902.52584844909;7913.12955574887;7925;6217.62694238346;6545.247296560897;6806.761763338284;6975.546589471694;7699.230076992312;1938.3797184900873;1968.4685135013538;1969.5962327722855;2185.5410363823617;2231.6764069209953;2194.444999101458;2209.2267706302828;2230.520438105807;2235.407616981501;2238.955220895581;1928.633559623667;1999.910004049814;2002.3792624286518;2017.092308461191;2141.807237348646;2141.4004078857943;2186.8797216153107;2187.147012665062;2189.0805861538033;2192.8465007449486;2199.14233448955;2204.481946742514;2217.068831090946;2241.641337386027;2246.663000549914;7850.2542258485355;7885.566293853835;7885.763427097197;7888.290053895177;7892.171322011221;4435.933460998088;4597;4628.09752098341;4641.048585040058;4641.396618439615;2815.296175956011;2848.344880677435;2926.5756465312625;2960.6595241547284;2965.4217427601625;897.8204359128135;904.3127223310265;919.8528235482357;922.7923717163652;929.832630126577;10292.794144117075;10319.84520232197;10329.535170917326;10344.069033786995;10377.636782712569;4060.573639767841;4101.5488296287385;4157.251694694924;4284.2930916398445;4296.2696341621995;8825.338099642553;8831.55842207887;8838.204561589488;8842.646294148291;8847.557622118868;4571.9085618287445;4583.2666773316105;4585.9312110317705;4586.2661974083985;4587.885302867455;4074.9796251018556;4180.184863951561;4180.205760905418;4188.895277618023;4190.685698572619;3594.7663401879317;3635.182084031072;3660.139867131222;3703.037210325335;3717.628237176315;1156.2831044752306;1167.486306025346;1168.059711931903;1190.7261329894172;1204.9698757531132;567.3135506037659;685.6982927511879;776.1307335783958;802.6227672993683;837.4012581004611;4954;5150.4334523202415;5219.634625576249;5221.765020574083;5233.293505376725;23.573871886942595;874.2394117118148;887.6138879587401;892.9241014513839;918.6279556779515;3468.722502199818;3583.496663110667;3614.8734794282072;3640.5995340512522;3671.2840996006057;9248.491332976751;9602.519874006271;9611.567479463301;9645.71062868115;9659.32384733076;8309.584520773937;8704.216620504185;9367.672131475365;9535.47554884474;9596.616135354647;7185.748498802726;7332.486725929347;7350.448716346188;7353.301436363537;7383.520071195355;5342.439043900335;5421.512063914267;5443.455654434525;5511.311086114236;5624.184493248375;8664.35017373687;8762.605682744419;8845.778855528662;8850.114988501098;8858.867116993379;8768.649254029768;8778.517181555077;8872;8946.776330591787;9194.908050919405;6327.810165695037;6374.904376434264;6392;6415.8716825662295;6427.807165785034;7057.788266352018;7060.682269297997;7106.218315985341;7146.571205727673;7176.892346614909;5083.822066227664;6456.257530384066;6527.477801775752;6707.932920670731;6708.865822683617;6553.115329430657;6563.04835798816;6629.270780214269;6641.169853768279;6851.280615535297;6148.9692551536955;6160.938390616216;6166.907496387647;6176.81469555914;6246.250449946036;4322.697411181187;4345.087531618269;4396.648268138477;4451.777411129496;4464.866054018385;4529;4558.111168322145;4603.953960460486;4615.26155815068;4623.0522742836965 05:34:20 INFO - PROCESS | 16911 | |4;prototype.html;294.8186865077976;297.06276697020894;304;305.5783019433182;309.64236307065346;4937.506249375061;4978.506448065584;4990.70055796652;5016.122178618741;5016.774245158972;4857.708537487753;4887.853364399065;4896.755162241891;4931.901361972758;4937.753112344386;3879.2241551689635;3881.10734531058;3883.6310550497656;3887.708421868357;3905.668018218455;3598.820058997053;3818.4463252828323;3907.902302442433;3925.1364699766004;3931.862384816532;3767.75509591877;3792.2984247914087;3794.4253134948963;3809.2762375148773;3813.656770890619;3802.69578433726;3813.6567708906055;3819.1406933439894;3830.578636349999;3850.5186851643543;3199.280161963563;3234.5633339499336;3271.1331497153274;3347.5313456116164;3358.277970236411;4790;4802.231642937113;4813.133635945528;4814.7351895645725;4817.470078291385;4357.586029327209;4369.230461663;4376.452943382077;4391.991485832184;4403.3174857897075;4912.901741965141;4959.776810043557;5124.385073791132;5135.101357262464;5144.768485418165;3652.3243200008083;3654.26914617075;3658.4695219193068;3667.15655399257;3668;5346;5353.170258609922;5399.919001214985;5400.702961337125;5435.347758268994;3541.1678255609913;3726.9813650931574;3727.7698359541287;3741.812909354576;3748;3781.621837816196;3794.2736055094865;3797.582265950743;3829.942550861739;3830.9233815323537;4355.1725172217175;4367.27939889921;4385.429894113745;4394.450693663292;4402.361657559636;5055.545000949932;5200;5210.53105220532;5225.608079394061;5240.187770895517;1313.1661395014235;1315.1911574381686;1320.9273489958146;1323.7948118041718;1333.2200662612286;814.7270664327398;843.5149788871423;848.3128665780737;858.1289990659485;859.2181115185276;4044.251813414469;4062.8171732272117;4066;4073.816678249427;4095;4621.098885717252;4653.767311634405;4655.348251244828;4657.69724967876;4680.368150299734;4046.6964977626794;4060.8223615151865;4065.3168908520233;4070.5115386153852;4079.4492743479846;2512.9371765705637;2616.869156542203;2692.623032775413;2778.763805076551;2823.717628237201;4883.731394773322;4956.77694503741;4965.790223350575;4971.328870602422;4979.875503112378;5431.560636431349;5441.564674826004;5451.781928722807;5483.8080667177255;5485.807996720096;4732.550407711262;4915.926261106015;4965.32968049316;4974.477679843709;4981.875453113774;5321.7227865312825;5339.665083729068;5340.2256672783005;5344.545713614386;5356.410794812646;5253.290805741176;5291.100512912737;5303.920441193308;5323.893522129613;5362.276092727432;4837.200039828653;4891.9755401222765;4956.918094400433;4962;4978.775955081957;3635.818209089482;3651.689606383487;3657.213699054716;3658.689011434058;3683.50272713191;3960.821763020613;4112.77379744105;5355.973220133875;5379.757910894097;5390.838274851761;3766.924661506809;4722.409698787652;4934.76772713873;4982.4768399319;4988.251762235694;4938.16051271292;4945.085159245551;4955.950440495693;4958.2810492477665;4980.477049909852;4868.513148685103;4905.302083853938;4905.386826646669;4910.901781964412;4943.505649435027;4895.16782147043;4930.975345123252;4950.529699678525;5010.624203184703;5040.949590504048;4915.26271059344;4917.238312690866;4920.926186107283;4921.50784921505;4926.852194434173 05:34:20 INFO - PROCESS | 16911 | |5;yui.html;626.3548544998647;635.4916067146282;639.2041907824758;669.986600267995;746.5856449670438;12260.877391226086;13169.407376668049;13214.735705285888;13227.537036203736;13231.735365292689;12693.365331733423;12949.352532373367;12950.740985180291;12974.54589089382;12980.221186728779;620.2587907450599;635.6567453575063;757.0990521279659;757.7726681995407;785.305005070511;763.2100775697155;772.2933515833006;774.6359211170741;774.8682723936917;776.0454640791829;824.1346586084617;824.9752507424757;824.983500329993;825.335604838105;825.5211977053294;652.1619718661498;667.4827009067963;667.512715717529;668.0446960845989;819.2340161948538;588.9646621202742;606.2936678769273;607.2015299880643;607.259143844509;608.3703367015119;12948;12982.350882455934;12983.610491685264;13007.739845203138;13020.34898255093;11416.657500275005;11566.47950842214;11935.820962685566;11944.969355209549;12167.574134905235;11021.669349919515;11209.831852522218;11472.827907581393;11636.941815290955;11935.462904169333;4043.465515271054;4106.938395924063;4107.363358679409;4108.424820525129;4112.84755846232;62683;64685.67657161778;65529;65838.67080664662;65844;9691.660791872251;10111.292209545261;10128.139108175741;10276.743081423025;10318.1745460363;17697.203625836868;17796;17820;17855.642887142443;17972.820271797376;6341.968290158612;6616.933830661728;6678.83302917431;6707.295733947963;6914.654267286615;3678.282734866675;3690.095926498025;3707.8146092695256;3714.591394946554;3834.0606551395085;2767.778577713778;2861.656601207827;2863.3557449574096;2877.7122287771476;2886.888547909028;458.94033775608955;469.04783289921517;472.06295503425673;528.9523942845162;563.8449426407689;530.3635637235333;582.6416753696446;587.3011116771029;623.5603899251017;637.8915584350672;8629.956850215709;8753.431026983226;9112.316576256808;9137.918187914489;9209.493477858648;602.9336772954971;632.4308122689524;640.7405000974612;657.9243387010555;658.6410406328563;4223.303154979394;4543.613792827647;4629.930551041737;4680.321353403806;4683.227267500824;100239;101206;101358.49320753496;105183;107743;70582.64708676423;79662.6016869912;83957;91018.54490727636;94662.52668736612;44753.77623111864;55077;71601;72621.27378726251;73962;8418.536980466133;8794.252488538546;8803.471791692264;8822.426542274732;8981.101889810967;44400.555994439645;44434.77782611195;44556.331655025846;44902.77548612236;45410.77294613638;62495.375046248955;64613.67693161692;64833.67583162054;65158;65174.67412662906;11055.557777688802;11330.886691132982;11401.828972565583;11805.468753905923;12207.267563946192;13273;13366.599002029954;13575.253361065235;13688.31558422055;13896.861031389557;12308.323042232405;12681.492740290285;12884.935575322439;13055.34723263814;13306.201627902357;12055.758884822078;12089.57686480969;12315.75368492643;12671.493140274286;12673.366331683563;12336.198147120409;12352.814707779571;12369.752604948031;12565.811512827499;13057.28184949837;9659.178969787366;10196.490175491344;10383.029459982989;10384.584616615251;10441.68278191683;10244.64143754965;10851.40317282557;10885.23803333759;10937.671869843918;10964.890351096386 05:34:20 INFO - PROCESS | 16911 | __end_tp_report 05:34:20 INFO - PROCESS | 16911 | __start_cc_report 05:34:20 INFO - PROCESS | 16911 | _x_x_mozilla_cycle_collect,1047 05:34:20 INFO - PROCESS | 16911 | __end_cc_report 05:34:20 INFO - PROCESS | 16911 | __startTimestamp1468240460073__endTimestamp 05:34:20 INFO - PROCESS | 16911 | 05:34:20 INFO - PROCESS | 16911 | ------- Summary: start ------- 05:34:20 INFO - PROCESS | 16911 | Number of tests: 6 05:34:20 INFO - PROCESS | 16911 | 05:34:20 INFO - PROCESS | 16911 | [#0] dojo.html Cycles:165 Average:4577.85 Median:4658.23 stddev:465.31 (10.0%) stddev-sans-first:439.43 05:34:20 INFO - PROCESS | 16911 | Values: 2575.7 2586.8 2613.9 2618.5 2637.1 4469.8 4538.0 4653.2 4659.7 4673.0 4577.7 4626.1 4639.0 4666.0 4673.0 4219.1 4252.2 4289.8 4320.8 4407.5 4360.7 4369.5 4381.3 4412.1 4423.5 4215.9 4247.3 4253.1 4299.6 4322.7 4263.6 4265.6 4267.6 4323.7 4352.0 4285.0 4292.1 4306.5 4339.3 4348.1 4533.8 4597.3 4614.0 4697.0 4709.4 5009.0 5024.3 5029.3 5058.7 5077.7 5050.6 5075.8 5099.6 5110.2 5114.6 4539.5 4613.5 4663.0 4667.6 4747.3 5150.5 5155.8 5161.8 5167.3 5169.2 4905.1 4917.6 4925.1 4969.4 4970.1 4861.2 4927.5 4936.3 4989.5 4989.8 4903.3 4922.9 4934.9 4943.5 4999.3 4826.5 4923.5 4934.6 4937.5 4989.8 4239.2 4259.0 4286.8 4301.5 4328.0 3695.3 3717.5 3723.3 3760.8 3766.6 4284.7 4294.5 4294.8 4296.5 4339.5 4841.2 4892.7 4926.1 4941.3 5042.1 4267.1 4283.9 4287.4 4319.4 4329.8 4503.3 4509.5 4510.5 4512.4 4560.7 4479.4 4574.7 4603.8 4625.9 4644.6 4947.5 4958.7 4966.5 4967.2 5015.2 4609.6 4628.5 4631.4 4634.4 4693.3 4656.1 4666.6 4727.9 4755.6 4769.5 4932.1 4941.5 4947.5 4949.8 4998.8 4605.3 4659.8 4679.1 4697.9 4708.3 4646.6 4678.5 4703.2 4707.4 4708.2 4621.9 4654.3 4658.2 4699.7 4710.3 4688.1 4692.9 4754.5 4755.8 4794.9 4630.6 4633.5 4666.5 4668.5 4710.1 05:34:20 INFO - PROCESS | 16911 | 05:34:20 INFO - PROCESS | 16911 | [#1] ext.html Cycles:180 Average:48269.33 Median:19872.45 stddev:85659.83 (431.0%) stddev-sans-first:85825.19 05:34:20 INFO - PROCESS | 16911 | Values: 546.0 571.2 578.4 587.1 598.7 41128.6 42342.6 42356.8 42368.8 45459.8 41616.0 42070.0 42115.0 42167.6 42212.0 7546.3 7779.8 7918.8 10266.9 10544.6 10367.0 10452.2 10472.2 10474.1 10477.7 10542.5 10574.3 10585.3 10587.2 10589.2 7606.3 10226.9 10469.8 10482.6 10817.9 10346.8 10367.2 10367.5 10367.8 10419.5 33057.2 39432.8 39824.4 39841.2 39849.0 2807.4 2872.9 2929.4 3161.5 3184.6 28469.6 28852.9 30859.4 30912.7 31641.0 3386.7 3531.8 3551.5 3583.9 3627.0 277463.0 279555.0 280058.0 280562.0 281379.0 48920.0 58206.7 58863.4 58937.0 58944.0 60432.4 61924.0 61971.4 67536.3 67703.7 11745.3 12615.7 12675.3 12704.0 12718.1 9509.4 9818.5 9829.4 9988.3 10005.5 19855.0 19999.1 20041.2 20131.4 20225.9 7230.8 7330.0 7348.4 7438.3 7582.6 806.3 926.6 931.6 939.2 1046.7 28079.7 28824.0 28961.3 29373.7 29445.7 993.6 996.9 998.7 1016.5 1023.4 14882.4 15184.5 15384.5 15486.8 15651.7 4235.6 403838.0 407844.0 408489.0 409546.0 50866.2 51103.7 51749.0 51757.7 51819.0 1089.7 1137.7 1176.3 1189.3 1197.9 28505.6 29684.6 30105.4 30213.7 30507.0 43829.3 43919.6 44307.0 44381.1 44436.0 320615.0 323452.0 324968.0 325346.0 325585.0 32729.8 38019.6 38689.6 38712.6 41925.0 43452.1 43655.3 43831.6 44654.1 44862.8 36509.6 37643.6 37718.0 37870.2 38287.6 37258.2 37863.0 38158.0 38417.6 38691.6 36161.0 36234.8 36628.8 36882.4 37146.0 32594.3 32778.9 33146.3 33634.8 33678.5 25472.2 25606.5 25791.7 25797.9 26132.7 05:34:20 INFO - PROCESS | 16911 | 05:34:20 INFO - PROCESS | 16911 | [#2] jquery.html Cycles:180 Average:26536.80 Median:4558.25 stddev:67811.96 (1487.7%) stddev-sans-first:67973.67 05:34:20 INFO - PROCESS | 16911 | Values: 343.2 365.5 369.3 371.8 388.7 13164.6 14003.5 17418.6 17480.4 17643.9 16362.3 16853.3 17104.1 17149.5 17149.6 4553.5 4563.0 4577.4 4582.0 4887.8 3707.8 5058.4 5798.8 6101.8 6105.1 6104.8 6112.0 6114.3 6129.0 6135.8 5143.5 5450.1 5469.2 5534.9 5535.3 3382.0 5331.4 6259.3 6672.4 6679.7 22249.0 22951.2 23326.1 24198.0 24267.6 1985.4 1998.8 2014.2 2079.6 2104.8 14189.4 14343.7 14384.1 14448.7 14951.8 1935.3 1987.6 2002.5 2021.8 2083.3 78601.6 81086.0 82791.6 82997.0 83738.2 16494.2 16610.8 16675.2 16689.2 16915.9 28843.7 28964.0 29140.6 29226.1 29314.0 8020.4 8244.8 8376.9 8494.9 8516.0 6846.4 6854.2 6854.4 6858.4 7005.8 8450.8 8646.6 8729.1 8734.9 8807.9 3387.4 3397.2 3469.4 3513.9 3560.9 810.8 827.5 845.2 847.0 914.6 13923.3 16220.2 16381.0 16669.5 17175.8 786.4 794.6 811.5 842.2 842.3 8758.0 8877.9 9511.9 9513.4 9757.7 364223.0 415004.0 417835.0 419969.0 424493.0 82592.6 85820.0 88269.6 88594.6 88608.0 939.2 948.6 955.7 991.8 993.6 15689.9 15714.0 15823.4 15836.7 16139.6 37750.6 37882.6 38039.2 38798.2 39590.2 53385.7 55070.4 55440.4 55469.2 55966.5 7357.5 7491.8 7538.2 7612.7 7631.1 10088.5 10475.9 10952.4 11493.6 11794.1 5084.5 7327.9 9522.9 9938.4 9946.3 9078.4 9914.5 10124.5 10416.4 10518.7 10466.3 10469.6 10583.5 10644.4 10721.0 7701.4 7806.0 7830.0 7922.9 7923.7 10172.7 10256.9 10281.9 10382.8 10669.2 05:34:20 INFO - PROCESS | 16911 | 05:34:20 INFO - PROCESS | 16911 | [#3] mootools.html Cycles:180 Average:5029.73 Median:5227.53 stddev:2797.06 (53.5%) stddev-sans-first:2791.34 05:34:20 INFO - PROCESS | 16911 | Values: 1364.1 1420.4 1492.3 1704.6 1731.5 7360.8 7865.5 7902.5 7913.1 7925.0 6217.6 6545.2 6806.8 6975.5 7699.2 1938.4 1968.5 1969.6 2185.5 2231.7 2194.4 2209.2 2230.5 2235.4 2239.0 1928.6 1999.9 2002.4 2017.1 2141.8 2141.4 2186.9 2187.1 2189.1 2192.8 2199.1 2204.5 2217.1 2241.6 2246.7 7850.3 7885.6 7885.8 7888.3 7892.2 4435.9 4597.0 4628.1 4641.0 4641.4 2815.3 2848.3 2926.6 2960.7 2965.4 897.8 904.3 919.9 922.8 929.8 10292.8 10319.8 10329.5 10344.1 10377.6 4060.6 4101.5 4157.3 4284.3 4296.3 8825.3 8831.6 8838.2 8842.6 8847.6 4571.9 4583.3 4585.9 4586.3 4587.9 4075.0 4180.2 4180.2 4188.9 4190.7 3594.8 3635.2 3660.1 3703.0 3717.6 1156.3 1167.5 1168.1 1190.7 1205.0 567.3 685.7 776.1 802.6 837.4 4954.0 5150.4 5219.6 5221.8 5233.3 23.6 874.2 887.6 892.9 918.6 3468.7 3583.5 3614.9 3640.6 3671.3 9248.5 9602.5 9611.6 9645.7 9659.3 8309.6 8704.2 9367.7 9535.5 9596.6 7185.7 7332.5 7350.4 7353.3 7383.5 5342.4 5421.5 5443.5 5511.3 5624.2 8664.4 8762.6 8845.8 8850.1 8858.9 8768.6 8778.5 8872.0 8946.8 9194.9 6327.8 6374.9 6392.0 6415.9 6427.8 7057.8 7060.7 7106.2 7146.6 7176.9 5083.8 6456.3 6527.5 6707.9 6708.9 6553.1 6563.0 6629.3 6641.2 6851.3 6149.0 6160.9 6166.9 6176.8 6246.3 4322.7 4345.1 4396.6 4451.8 4464.9 4529.0 4558.1 4604.0 4615.3 4623.1 05:34:20 INFO - PROCESS | 16911 | 05:34:20 INFO - PROCESS | 16911 | [#4] prototype.html Cycles:180 Average:4184.39 Median:4796.12 stddev:1223.05 (25.5%) stddev-sans-first:1191.13 05:34:20 INFO - PROCESS | 16911 | Values: 294.8 297.1 304.0 305.6 309.6 4937.5 4978.5 4990.7 5016.1 5016.8 4857.7 4887.9 4896.8 4931.9 4937.8 3879.2 3881.1 3883.6 3887.7 3905.7 3598.8 3818.4 3907.9 3925.1 3931.9 3767.8 3792.3 3794.4 3809.3 3813.7 3802.7 3813.7 3819.1 3830.6 3850.5 3199.3 3234.6 3271.1 3347.5 3358.3 4790.0 4802.2 4813.1 4814.7 4817.5 4357.6 4369.2 4376.5 4392.0 4403.3 4912.9 4959.8 5124.4 5135.1 5144.8 3652.3 3654.3 3658.5 3667.2 3668.0 5346.0 5353.2 5399.9 5400.7 5435.3 3541.2 3727.0 3727.8 3741.8 3748.0 3781.6 3794.3 3797.6 3829.9 3830.9 4355.2 4367.3 4385.4 4394.5 4402.4 5055.5 5200.0 5210.5 5225.6 5240.2 1313.2 1315.2 1320.9 1323.8 1333.2 814.7 843.5 848.3 858.1 859.2 4044.3 4062.8 4066.0 4073.8 4095.0 4621.1 4653.8 4655.3 4657.7 4680.4 4046.7 4060.8 4065.3 4070.5 4079.4 2512.9 2616.9 2692.6 2778.8 2823.7 4883.7 4956.8 4965.8 4971.3 4979.9 5431.6 5441.6 5451.8 5483.8 5485.8 4732.6 4915.9 4965.3 4974.5 4981.9 5321.7 5339.7 5340.2 5344.5 5356.4 5253.3 5291.1 5303.9 5323.9 5362.3 4837.2 4892.0 4956.9 4962.0 4978.8 3635.8 3651.7 3657.2 3658.7 3683.5 3960.8 4112.8 5356.0 5379.8 5390.8 3766.9 4722.4 4934.8 4982.5 4988.3 4938.2 4945.1 4956.0 4958.3 4980.5 4868.5 4905.3 4905.4 4910.9 4943.5 4895.2 4931.0 4950.5 5010.6 5040.9 4915.3 4917.2 4920.9 4921.5 4926.9 05:34:20 INFO - PROCESS | 16911 | 05:34:20 INFO - PROCESS | 16911 | [#5] yui.html Cycles:180 Average:17900.43 Median:44495.55 stddev:25492.58 (57.3%) stddev-sans-first:25531.09 05:34:20 INFO - PROCESS | 16911 | Values: 626.4 635.5 639.2 670.0 746.6 12260.9 13169.4 13214.7 13227.5 13231.7 12693.4 12949.4 12950.7 12974.5 12980.2 620.3 635.7 757.1 757.8 785.3 763.2 772.3 774.6 774.9 776.0 824.1 825.0 825.0 825.3 825.5 652.2 667.5 667.5 668.0 819.2 589.0 606.3 607.2 607.3 608.4 12948.0 12982.4 12983.6 13007.7 13020.3 11416.7 11566.5 11935.8 11945.0 12167.6 11021.7 11209.8 11472.8 11636.9 11935.5 4043.5 4106.9 4107.4 4108.4 4112.8 62683.0 64685.7 65529.0 65838.7 65844.0 9691.7 10111.3 10128.1 10276.7 10318.2 17697.2 17796.0 17820.0 17855.6 17972.8 6342.0 6616.9 6678.8 6707.3 6914.7 3678.3 3690.1 3707.8 3714.6 3834.1 2767.8 2861.7 2863.4 2877.7 2886.9 458.9 469.0 472.1 529.0 563.8 530.4 582.6 587.3 623.6 637.9 8630.0 8753.4 9112.3 9137.9 9209.5 602.9 632.4 640.7 657.9 658.6 4223.3 4543.6 4629.9 4680.3 4683.2 100239.0 101206.0 101358.5 105183.0 107743.0 70582.6 79662.6 83957.0 91018.5 94662.5 44753.8 55077.0 71601.0 72621.3 73962.0 8418.5 8794.3 8803.5 8822.4 8981.1 44400.6 44434.8 44556.3 44902.8 45410.8 62495.4 64613.7 64833.7 65158.0 65174.7 11055.6 11330.9 11401.8 11805.5 12207.3 13273.0 13366.6 13575.3 13688.3 13896.9 12308.3 12681.5 12884.9 13055.3 13306.2 12055.8 12089.6 12315.8 12671.5 12673.4 12336.2 12352.8 12369.8 12565.8 13057.3 9659.2 10196.5 10383.0 10384.6 10441.7 10244.6 10851.4 10885.2 10937.7 10964.9 05:34:20 INFO - PROCESS | 16911 | -------- Summary: end -------- 05:34:20 INFO - PROCESS | 16911 | 05:34:20 INFO - TEST-INFO | 16911: exit 0 05:34:20 INFO - TEST-OK | dromaeo_css | took 1143980ms 05:34:20 INFO - TEST-START | kraken 05:34:20 INFO - operating with platform_type : linux_ 05:34:20 INFO - Initialising browser for kraken test... 05:34:20 INFO - TEST-INFO | started process 17128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppxbd9M/profile http://localhost:56311/getInfo.html) 05:34:29 INFO - PROCESS | 17128 | __metrics Screen width/height:1600/1200 05:34:29 INFO - PROCESS | 17128 | colorDepth:24 05:34:29 INFO - PROCESS | 17128 | Browser inner width/height: 1024/697 05:34:29 INFO - PROCESS | 17128 | __metrics 05:34:29 INFO - PROCESS | 17128 | 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" 05:34:29 INFO - PROCESS | 17128 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:34:30 INFO - TEST-INFO | 17128: exit 0 05:34:30 INFO - Browser initialized. 05:34:30 INFO - Running cycle 1/1 for kraken test... 05:34:30 INFO - TEST-INFO | started process 17209 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppxbd9M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:42 INFO - PROCESS | 17209 | RSS: Main: 159256576 05:34:42 INFO - PROCESS | 17209 | 05:34:45 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:56311/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56311/tests/kraken/driver.html?testName=audio-beat-detection) 05:34:46 INFO - PROCESS | 17209 | RSS: Main: 216231936 05:34:46 INFO - PROCESS | 17209 | 05:34:49 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:56311/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56311/tests/kraken/driver.html?testName=audio-dft) 05:34:49 INFO - PROCESS | 17209 | RSS: Main: 202797056 05:34:49 INFO - PROCESS | 17209 | 05:34:53 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:56311/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56311/tests/kraken/driver.html?testName=audio-fft) 05:34:53 INFO - PROCESS | 17209 | RSS: Main: 271626240 05:34:53 INFO - PROCESS | 17209 | 05:34:55 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:56311/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56311/tests/kraken/driver.html?testName=audio-oscillator) 05:34:56 INFO - PROCESS | 17209 | RSS: Main: 181829632 05:34:56 INFO - PROCESS | 17209 | 05:34:58 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:56311/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56311/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:34:59 INFO - PROCESS | 17209 | RSS: Main: 186490880 05:34:59 INFO - PROCESS | 17209 | 05:35:02 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:56311/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56311/tests/kraken/driver.html?testName=imaging-darkroom) 05:35:03 INFO - PROCESS | 17209 | RSS: Main: 222056448 05:35:03 INFO - PROCESS | 17209 | 05:35:06 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:56311/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56311/tests/kraken/driver.html?testName=imaging-desaturate) 05:35:07 INFO - PROCESS | 17209 | RSS: Main: 222466048 05:35:07 INFO - PROCESS | 17209 | 05:35:10 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:56311/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56311/tests/kraken/driver.html?testName=json-parse-financial) 05:35:10 INFO - PROCESS | 17209 | RSS: Main: 222334976 05:35:10 INFO - PROCESS | 17209 | 05:35:12 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:56311/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56311/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:35:13 INFO - PROCESS | 17209 | RSS: Main: 210354176 05:35:13 INFO - PROCESS | 17209 | 05:35:14 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:56311/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56311/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:35:15 INFO - PROCESS | 17209 | RSS: Main: 213372928 05:35:15 INFO - PROCESS | 17209 | 05:35:17 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:56311/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56311/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:35:18 INFO - PROCESS | 17209 | RSS: Main: 213966848 05:35:18 INFO - PROCESS | 17209 | 05:35:21 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:56311/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56311/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:35:21 INFO - PROCESS | 17209 | RSS: Main: 226586624 05:35:21 INFO - PROCESS | 17209 | 05:35:24 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:56311/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56311/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:35:25 INFO - PROCESS | 17209 | RSS: Main: 228626432 05:35:25 INFO - PROCESS | 17209 | 05:35:27 INFO - PROCESS | 17209 | Cycle 1(1): loaded http://localhost:56311/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56311/tests/kraken/driver.html?testName=ai-astar) 05:35:27 INFO - PROCESS | 17209 | RSS: Main: 271384576 05:35:27 INFO - PROCESS | 17209 | 05:35:27 INFO - PROCESS | 17209 | __start_tp_report 05:35:27 INFO - PROCESS | 17209 | _x_x_mozilla_page_load 05:35:27 INFO - PROCESS | 17209 | _x_x_mozilla_page_load_details 05:35:27 INFO - PROCESS | 17209 | |i|pagename|runs| 05:35:27 INFO - PROCESS | 17209 | |0;ai-astar;106;115;115;115;114;116;114;114;115;114 05:35:27 INFO - PROCESS | 17209 | |1;audio-beat-detection;149;129;132;180;130;125;144;124;160;125 05:35:27 INFO - PROCESS | 17209 | |2;audio-dft;161;162;160;169;163;162;161;161;160;162 05:35:27 INFO - PROCESS | 17209 | |3;audio-fft;76;75;75;130;77;76;76;75;98;76 05:35:27 INFO - PROCESS | 17209 | |4;audio-oscillator;84;86;118;84;85;85;124;85;85;121 05:35:27 INFO - PROCESS | 17209 | |5;imaging-gaussian-blur;117;116;117;117;117;117;118;117;119;117 05:35:27 INFO - PROCESS | 17209 | |6;imaging-darkroom;147;146;147;146;146;146;146;146;146;147 05:35:27 INFO - PROCESS | 17209 | |7;imaging-desaturate;95;95;96;95;95;95;95;96;95;94 05:35:27 INFO - PROCESS | 17209 | |8;json-parse-financial;63;64;64;63;64;63;64;63;64;64 05:35:27 INFO - PROCESS | 17209 | |9;json-stringify-tinderbox;64;64;63;65;64;64;65;65;64;65 05:35:27 INFO - PROCESS | 17209 | |10;stanford-crypto-aes;78;79;88;79;79;89;79;80;80;83 05:35:27 INFO - PROCESS | 17209 | |11;stanford-crypto-ccm;126;133;127;128;143;129;135;128;203;144 05:35:27 INFO - PROCESS | 17209 | |12;stanford-crypto-pbkdf2;167;166;165;166;164;167;167;168;167;167 05:35:27 INFO - PROCESS | 17209 | |13;stanford-crypto-sha256-iterative;68;67;70;66;69;67;66;67;67;66 05:35:27 INFO - PROCESS | 17209 | __end_tp_report 05:35:27 INFO - PROCESS | 17209 | __start_cc_report 05:35:27 INFO - PROCESS | 17209 | _x_x_mozilla_cycle_collect,1888 05:35:27 INFO - PROCESS | 17209 | __end_cc_report 05:35:27 INFO - PROCESS | 17209 | __startTimestamp1468240527336__endTimestamp 05:35:27 INFO - PROCESS | 17209 | 05:35:27 INFO - PROCESS | 17209 | ------- Summary: start ------- 05:35:27 INFO - PROCESS | 17209 | Number of tests: 14 05:35:27 INFO - PROCESS | 17209 | 05:35:27 INFO - PROCESS | 17209 | [#0] ai-astar Cycles:10 Average:113.80 Median:115.00 stddev:2.82 (2.5%) stddev-sans-first:0.71 05:35:27 INFO - PROCESS | 17209 | Values: 106.0 115.0 115.0 115.0 114.0 116.0 114.0 114.0 115.0 114.0 05:35:27 INFO - PROCESS | 17209 | 05:35:27 INFO - PROCESS | 17209 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:138.00 stddev:18.52 (13.4%) stddev-sans-first:19.34 05:35:27 INFO - PROCESS | 17209 | Values: 149.0 129.0 132.0 180.0 130.0 125.0 144.0 124.0 160.0 125.0 05:35:27 INFO - PROCESS | 17209 | 05:35:27 INFO - PROCESS | 17209 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:2.60 (1.6%) stddev-sans-first:2.73 05:35:27 INFO - PROCESS | 17209 | Values: 161.0 162.0 160.0 169.0 163.0 162.0 161.0 161.0 160.0 162.0 05:35:27 INFO - PROCESS | 17209 | 05:35:27 INFO - PROCESS | 17209 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.00 stddev:17.82 (23.4%) stddev-sans-first:18.69 05:35:27 INFO - PROCESS | 17209 | Values: 76.0 75.0 75.0 130.0 77.0 76.0 76.0 75.0 98.0 76.0 05:35:27 INFO - PROCESS | 17209 | 05:35:27 INFO - PROCESS | 17209 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:85.00 stddev:17.52 (20.6%) stddev-sans-first:18.07 05:35:27 INFO - PROCESS | 17209 | Values: 84.0 86.0 118.0 84.0 85.0 85.0 124.0 85.0 85.0 121.0 05:35:27 INFO - PROCESS | 17209 | 05:35:27 INFO - PROCESS | 17209 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 05:35:27 INFO - PROCESS | 17209 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 118.0 117.0 119.0 117.0 05:35:27 INFO - PROCESS | 17209 | 05:35:27 INFO - PROCESS | 17209 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 05:35:27 INFO - PROCESS | 17209 | Values: 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 05:35:27 INFO - PROCESS | 17209 | 05:35:27 INFO - PROCESS | 17209 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:35:27 INFO - PROCESS | 17209 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 94.0 05:35:27 INFO - PROCESS | 17209 | 05:35:27 INFO - PROCESS | 17209 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:64.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 05:35:27 INFO - PROCESS | 17209 | Values: 63.0 64.0 64.0 63.0 64.0 63.0 64.0 63.0 64.0 64.0 05:35:27 INFO - PROCESS | 17209 | 05:35:27 INFO - PROCESS | 17209 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 05:35:27 INFO - PROCESS | 17209 | Values: 64.0 64.0 63.0 65.0 64.0 64.0 65.0 65.0 64.0 65.0 05:35:27 INFO - PROCESS | 17209 | 05:35:27 INFO - PROCESS | 17209 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:80.00 stddev:3.98 (5.0%) stddev-sans-first:4.02 05:35:27 INFO - PROCESS | 17209 | Values: 78.0 79.0 88.0 79.0 79.0 89.0 79.0 80.0 80.0 83.0 05:35:27 INFO - PROCESS | 17209 | 05:35:27 INFO - PROCESS | 17209 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:134.00 stddev:23.19 (17.3%) stddev-sans-first:24.07 05:35:27 INFO - PROCESS | 17209 | Values: 126.0 133.0 127.0 128.0 143.0 129.0 135.0 128.0 203.0 144.0 05:35:27 INFO - PROCESS | 17209 | 05:35:27 INFO - PROCESS | 17209 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:167.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 05:35:27 INFO - PROCESS | 17209 | Values: 167.0 166.0 165.0 166.0 164.0 167.0 167.0 168.0 167.0 167.0 05:35:27 INFO - PROCESS | 17209 | 05:35:27 INFO - PROCESS | 17209 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.34 (2.0%) stddev-sans-first:1.39 05:35:27 INFO - PROCESS | 17209 | Values: 68.0 67.0 70.0 66.0 69.0 67.0 66.0 67.0 67.0 66.0 05:35:27 INFO - PROCESS | 17209 | -------- Summary: end -------- 05:35:27 INFO - PROCESS | 17209 | 05:35:28 INFO - TEST-INFO | 17209: exit 0 05:35:28 INFO - TEST-OK | kraken | took 67452ms 05:35:28 INFO - SUITE-END | took 1211s 05:35:28 INFO - Completed test suite (00:20:11) 05:35:28 INFO - javascript benchmark 05:35:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2575.703794063683, 2586.8447893126427, 2613.8823752931116, 2618.515574618695, 2637.0770230419357, 4469.843555475559, 4537.954620453795, 4653.232216684247, 4659.697119687218, 4673.0, 4577.656675749324, 4626.074785042988, 4638.97680511597, 4665.953340466594, 4672.953270467295, 4219.092895027568, 4252.170826688797, 4289.785510724467, 4320.805563749623, 4407.49313828909, 4360.672949528798, 4369.475662920454, 4381.298992161255, 4412.1175764847, 4423.469183697961, 4215.894602634928, 4247.299195632717, 4253.149370125987, 4299.613034826881, 4322.697411181219, 4263.637590804786, 4265.637420819234, 4267.637250833683, 4323.697341186118, 4351.9782401088105, 4284.978575107136, 4292.055747735493, 4306.5478124796755, 4339.262325404688, 4348.086901750637, 4533.818647254106, 4597.287420449836, 4613.953860461386, 4696.9530304696855, 4709.364235828154, 5009.048280826668, 5024.296598476216, 5029.270755740397, 5058.671186372911, 5077.720725360104, 5050.595952323805, 5075.771590278447, 5099.617528685363, 5110.207917772751, 5114.641975061747, 4539.500654927955, 4613.5386461354265, 4663.044075964419, 4667.556582124693, 4747.264174053027, 5150.48495150482, 5155.793768249228, 5161.845144645667, 5167.328247327899, 5169.198774190007, 4905.068037072945, 4917.631177661689, 4925.064237794808, 4969.428515720666, 4970.080535101018, 4861.1979023460735, 4927.531884470969, 4936.259561065869, 4989.476105008922, 4989.775460104304, 4903.33804936329, 4922.90154196914, 4934.901301974012, 4943.456219815817, 4999.275105109738, 4826.541478559531, 4923.507649235119, 4934.555889969848, 4937.481564435754, 4989.750512474362, 4239.1521695660995, 4258.957410425918, 4286.849960251377, 4301.462317210348, 4327.978360108243, 3695.260947810395, 3717.5353080864893, 3723.255348930225, 3760.7743535387417, 3766.6233376662663, 4284.742915425085, 4294.527601963781, 4294.82820687169, 4296.5273819879785, 4339.544347843431, 4841.176999910023, 4892.706437613754, 4926.088673595396, 4941.258811178352, 5042.142835717937, 4267.061246525759, 4283.914321713548, 4287.356896465555, 4319.352097185384, 4329.805158767863, 4503.347014682852, 4509.503954564995, 4510.458744950627, 4512.435945506812, 4560.657950653715, 4479.350494178391, 4574.748388838646, 4603.838865639686, 4625.907481850411, 4644.558766917137, 4947.48051454592, 4958.7024778513405, 4966.478519755374, 4967.230079337708, 5015.247712843103, 4609.631229501699, 4628.514006029319, 4631.374764406897, 4634.443866736014, 4693.272542755878, 4656.138614356355, 4666.580007799314, 4727.929081063718, 4755.5719985201495, 4769.4753577107185, 4932.1122198004705, 4941.530554597452, 4947.529984651453, 4949.752512374295, 4998.775055122601, 4605.263157894721, 4659.767011649472, 4679.064187162649, 4697.882552936204, 4708.270218116198, 4646.581807637329, 4678.461976872703, 4703.153432382204, 4707.411573553306, 4708.223143181337, 4621.907561848811, 4654.278586818913, 4658.231391820447, 4699.718016918996, 4710.317004034464, 4688.0858232644305, 4692.859214223578, 4754.4532378776885, 4755.762211889322, 4794.928076078932, 4630.58324750774, 4633.536646335339, 4666.533346665442, 4668.509806470408, 4710.057988402402], "value": 4549.018144135503, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.0474995535758, 571.2288410645629, 578.407132688994, 587.1369087441461, 598.7245866901226, 41128.588714112884, 42342.57657423425, 42356.788216058914, 42368.788156059214, 45459.77270113645, 41616.0, 42070.0, 42115.0, 42167.578324216745, 42212.0, 7546.320831125197, 7779.7666070017995, 7918.841623167533, 10266.948665256701, 10544.630937917174, 10367.0, 10452.216083793708, 10472.2145839062, 10474.109700675452, 10477.685669429891, 10542.525586348595, 10574.312669676485, 10585.311954722956, 10587.15302775776, 10589.205809564275, 7606.315431611154, 10226.897731022706, 10469.84295235572, 10482.58069677212, 10817.945910270477, 10346.793064138676, 10367.22245831558, 10367.48162591875, 10367.79264414715, 10419.531121099568, 33057.173570660685, 39432.80283598592, 39824.40263396051, 39841.203175936316, 39849.0, 2807.3823758773037, 2872.9138125856257, 2929.414117176573, 3161.4783560712453, 3184.586003819512, 28469.57295640567, 28852.855735721187, 30859.38281234363, 30912.690873091207, 31641.0, 3386.7459940504314, 3531.823408829574, 3551.485034669984, 3583.8924832255075, 3627.0, 277463.0, 279555.0, 280058.0, 280562.0, 281379.0, 48920.0, 58206.70896645574, 58863.41136588579, 58937.0, 58944.0, 60432.39567604267, 61924.0, 61971.38028619746, 67536.32463675301, 67703.66148169228, 11745.29528228309, 12615.747685046248, 12675.302858342695, 12704.047196460302, 12718.109732318833, 9509.429434233969, 9818.45998470091, 9829.361091529028, 9988.300818942604, 10005.549750261256, 19855.0, 19999.10004049821, 20041.198352066047, 20131.39605811828, 20225.898870505553, 7230.783076507713, 7329.963350183215, 7348.448866335047, 7438.330550250504, 7582.582957937256, 806.314632562329, 926.5969303353063, 931.5668214280392, 939.1688355805162, 1046.7016900183412, 28079.71920280812, 28824.0, 28961.275968100967, 29373.706262937525, 29445.705542944725, 993.6323560282742, 996.8504724291414, 998.6604554451521, 1016.506994107857, 1023.4166525080633, 14882.404703811942, 15184.544463666107, 15384.461543845911, 15486.845131548765, 15651.686966260611, 4235.647690639297, 403838.0, 407844.0, 408489.0, 409546.0, 50866.237006444935, 51103.744481277354, 51749.0, 51757.7412112937, 51819.0, 1089.7330154112294, 1137.7269455330495, 1176.2824676947228, 1189.3102000839492, 1197.9401029948294, 28505.572416414187, 29684.554731679473, 30105.397892042474, 30213.697863021087, 30507.0, 43829.34255986099, 43919.56080439155, 44307.0, 44381.11237775162, 44436.0, 320615.0, 323452.0, 324968.0, 325346.0, 325585.0, 32729.836350818092, 38019.61980380161, 38689.6131038686, 38712.6128738709, 41925.0, 43452.130957381305, 43655.345169823115, 43831.561684382745, 44654.10691786211, 44862.775686121364, 36509.63490365062, 37643.62356376401, 37718.0, 37870.24259514739, 38287.61712382841, 37258.223635041744, 37863.0, 38158.0, 38417.61582384141, 38691.613083868804, 36161.0, 36234.818825906754, 36628.81685591555, 36882.44676329911, 37146.0, 32594.348113038082, 32778.9313952562, 33146.33707325888, 33634.831825840716, 33678.49482257719, 25472.2358329243, 25606.487870242865, 25791.742082578934, 25797.871010644827, 26132.73867261303], "value": 18698.353996788836, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.1862606126621, 365.5193420651843, 369.25594926223664, 371.83825036109295, 388.74148691120405, 13164.605061848137, 14003.509877154302, 17418.56453588661, 17480.38818641348, 17643.911780441078, 16362.263698133584, 16853.325866965308, 17104.144792760344, 17149.485515434524, 17149.571260718487, 4553.453585569736, 4563.041761230145, 4577.359169716226, 4582.0, 4887.780049897754, 3707.8146092695392, 5058.367704036977, 5798.82603521895, 6101.755929762827, 6105.114758360035, 6104.786332478342, 6112.0, 6114.266288045418, 6128.96935515324, 6135.815925522242, 5143.5113664201845, 5450.127979523258, 5469.234307196995, 5534.889302213933, 5535.308086489189, 3381.9830900845336, 5331.44019877915, 6259.342769009279, 6672.399484046459, 6679.699413526403, 22249.0, 22951.1967081153, 23326.066957321855, 24198.0, 24267.63598546023, 1985.3547597031022, 1998.8400927925732, 2014.1842553765603, 2079.6048750737314, 2104.7684754676975, 14189.361478733379, 14343.713125737531, 14384.06503577264, 14448.71102577953, 14951.80464014634, 1935.3129638978241, 1987.6223517531623, 2002.499375156211, 2021.82814460771, 2083.2500299892026, 78601.60699196525, 81086.0, 82791.58604206941, 82997.0, 83738.16261837365, 16494.17529123539, 16610.837241392986, 16675.166241687868, 16689.24898379576, 16915.915420422818, 28843.711562884102, 28964.0, 29140.562891556645, 29226.123216303546, 29314.0, 8020.398470114765, 8244.83510329802, 8376.916230837614, 8494.915050849413, 8516.0, 6846.353701830599, 6854.246032936473, 6854.383105520527, 6858.417034552019, 7005.773989551808, 8450.830983380298, 8646.567671616394, 8729.127087291346, 8734.912650873537, 8807.867881981776, 3387.3733359328603, 3397.1507123219194, 3469.392856250146, 3513.9121521962156, 3560.8753693620597, 810.8499927513311, 827.5117680568494, 845.1970627903517, 846.95341756204, 914.6341463414565, 13923.310322764475, 16220.188990550661, 16381.0171389717, 16669.49991500257, 17175.828241717674, 786.4455558831124, 794.6384395100215, 811.5005782190838, 842.2419822160105, 842.3387640702019, 8757.992830824536, 8877.866831997526, 9511.90488095124, 9513.381630194015, 9757.658481953098, 364223.0, 415004.0, 417835.0, 419969.0, 424493.0, 82592.58703706563, 85820.0, 88269.55865220762, 88594.55702721573, 88608.0, 939.2439086535404, 948.5778828421562, 955.6655170690203, 991.801639672083, 993.5529011944509, 15689.921550392175, 15714.0, 15823.446179384127, 15836.68326633484, 16139.56609259664, 37750.62249377471, 37882.62117378901, 38039.2392152161, 38798.2240355197, 39590.2081958365, 53385.7330713344, 55070.44929550653, 55440.445595543526, 55469.16796247979, 55966.52267818483, 7357.5217610855125, 7491.812704682427, 7538.170801211972, 7612.657430415534, 7631.084269887649, 10088.495575221357, 10475.947620262155, 10952.397618131079, 11493.597724079616, 11794.115441342105, 5084.466131056334, 7327.8534429312185, 9522.904770952202, 9938.403695778277, 9946.30375873711, 9078.364514484187, 9914.454704991294, 10124.493775311057, 10416.375017498975, 10518.737031574272, 10466.319689220481, 10469.633562825264, 10583.523741431809, 10644.361338319726, 10721.035106840422, 7701.383889288955, 7806.0, 7829.96085019594, 7922.920770792219, 7923.7226697065325, 10172.694819155437, 10256.897431025594, 10281.948590257001, 10382.792344153226, 10669.199810014125], "value": 9079.815960258573, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.1405914274005, 1420.4034305591651, 1492.2837038221653, 1704.5653358393608, 1731.5238309464903, 7360.815979600506, 7865.528068315905, 7902.52584844909, 7913.12955574887, 7925.0, 6217.62694238346, 6545.247296560897, 6806.761763338284, 6975.546589471694, 7699.230076992312, 1938.3797184900873, 1968.4685135013538, 1969.5962327722855, 2185.5410363823617, 2231.6764069209953, 2194.444999101458, 2209.2267706302828, 2230.520438105807, 2235.407616981501, 2238.955220895581, 1928.633559623667, 1999.910004049814, 2002.3792624286518, 2017.092308461191, 2141.807237348646, 2141.4004078857943, 2186.8797216153107, 2187.147012665062, 2189.0805861538033, 2192.8465007449486, 2199.14233448955, 2204.481946742514, 2217.068831090946, 2241.641337386027, 2246.663000549914, 7850.2542258485355, 7885.566293853835, 7885.763427097197, 7888.290053895177, 7892.171322011221, 4435.933460998088, 4597.0, 4628.09752098341, 4641.048585040058, 4641.396618439615, 2815.296175956011, 2848.344880677435, 2926.5756465312625, 2960.6595241547284, 2965.4217427601625, 897.8204359128135, 904.3127223310265, 919.8528235482357, 922.7923717163652, 929.832630126577, 10292.794144117075, 10319.84520232197, 10329.535170917326, 10344.069033786995, 10377.636782712569, 4060.573639767841, 4101.5488296287385, 4157.251694694924, 4284.2930916398445, 4296.2696341621995, 8825.338099642553, 8831.55842207887, 8838.204561589488, 8842.646294148291, 8847.557622118868, 4571.9085618287445, 4583.2666773316105, 4585.9312110317705, 4586.2661974083985, 4587.885302867455, 4074.9796251018556, 4180.184863951561, 4180.205760905418, 4188.895277618023, 4190.685698572619, 3594.7663401879317, 3635.182084031072, 3660.139867131222, 3703.037210325335, 3717.628237176315, 1156.2831044752306, 1167.486306025346, 1168.059711931903, 1190.7261329894172, 1204.9698757531132, 567.3135506037659, 685.6982927511879, 776.1307335783958, 802.6227672993683, 837.4012581004611, 4954.0, 5150.4334523202415, 5219.634625576249, 5221.765020574083, 5233.293505376725, 23.573871886942595, 874.2394117118148, 887.6138879587401, 892.9241014513839, 918.6279556779515, 3468.722502199818, 3583.496663110667, 3614.8734794282072, 3640.5995340512522, 3671.2840996006057, 9248.491332976751, 9602.519874006271, 9611.567479463301, 9645.71062868115, 9659.32384733076, 8309.584520773937, 8704.216620504185, 9367.672131475365, 9535.47554884474, 9596.616135354647, 7185.748498802726, 7332.486725929347, 7350.448716346188, 7353.301436363537, 7383.520071195355, 5342.439043900335, 5421.512063914267, 5443.455654434525, 5511.311086114236, 5624.184493248375, 8664.35017373687, 8762.605682744419, 8845.778855528662, 8850.114988501098, 8858.867116993379, 8768.649254029768, 8778.517181555077, 8872.0, 8946.776330591787, 9194.908050919405, 6327.810165695037, 6374.904376434264, 6392.0, 6415.8716825662295, 6427.807165785034, 7057.788266352018, 7060.682269297997, 7106.218315985341, 7146.571205727673, 7176.892346614909, 5083.822066227664, 6456.257530384066, 6527.477801775752, 6707.932920670731, 6708.865822683617, 6553.115329430657, 6563.04835798816, 6629.270780214269, 6641.169853768279, 6851.280615535297, 6148.9692551536955, 6160.938390616216, 6166.907496387647, 6176.81469555914, 6246.250449946036, 4322.697411181187, 4345.087531618269, 4396.648268138477, 4451.777411129496, 4464.866054018385, 4529.0, 4558.111168322145, 4603.953960460486, 4615.26155815068, 4623.0522742836965], "value": 4044.7184523462474, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.8186865077976, 297.06276697020894, 304.0, 305.5783019433182, 309.64236307065346, 4937.506249375061, 4978.506448065584, 4990.70055796652, 5016.122178618741, 5016.774245158972, 4857.708537487753, 4887.853364399065, 4896.755162241891, 4931.901361972758, 4937.753112344386, 3879.2241551689635, 3881.10734531058, 3883.6310550497656, 3887.708421868357, 3905.668018218455, 3598.820058997053, 3818.4463252828323, 3907.902302442433, 3925.1364699766004, 3931.862384816532, 3767.75509591877, 3792.2984247914087, 3794.4253134948963, 3809.2762375148773, 3813.656770890619, 3802.69578433726, 3813.6567708906055, 3819.1406933439894, 3830.578636349999, 3850.5186851643543, 3199.280161963563, 3234.5633339499336, 3271.1331497153274, 3347.5313456116164, 3358.277970236411, 4790.0, 4802.231642937113, 4813.133635945528, 4814.7351895645725, 4817.470078291385, 4357.586029327209, 4369.230461663, 4376.452943382077, 4391.991485832184, 4403.3174857897075, 4912.901741965141, 4959.776810043557, 5124.385073791132, 5135.101357262464, 5144.768485418165, 3652.3243200008083, 3654.26914617075, 3658.4695219193068, 3667.15655399257, 3668.0, 5346.0, 5353.170258609922, 5399.919001214985, 5400.702961337125, 5435.347758268994, 3541.1678255609913, 3726.9813650931574, 3727.7698359541287, 3741.812909354576, 3748.0, 3781.621837816196, 3794.2736055094865, 3797.582265950743, 3829.942550861739, 3830.9233815323537, 4355.1725172217175, 4367.27939889921, 4385.429894113745, 4394.450693663292, 4402.361657559636, 5055.545000949932, 5200.0, 5210.53105220532, 5225.608079394061, 5240.187770895517, 1313.1661395014235, 1315.1911574381686, 1320.9273489958146, 1323.7948118041718, 1333.2200662612286, 814.7270664327398, 843.5149788871423, 848.3128665780737, 858.1289990659485, 859.2181115185276, 4044.251813414469, 4062.8171732272117, 4066.0, 4073.816678249427, 4095.0, 4621.098885717252, 4653.767311634405, 4655.348251244828, 4657.69724967876, 4680.368150299734, 4046.6964977626794, 4060.8223615151865, 4065.3168908520233, 4070.5115386153852, 4079.4492743479846, 2512.9371765705637, 2616.869156542203, 2692.623032775413, 2778.763805076551, 2823.717628237201, 4883.731394773322, 4956.77694503741, 4965.790223350575, 4971.328870602422, 4979.875503112378, 5431.560636431349, 5441.564674826004, 5451.781928722807, 5483.8080667177255, 5485.807996720096, 4732.550407711262, 4915.926261106015, 4965.32968049316, 4974.477679843709, 4981.875453113774, 5321.7227865312825, 5339.665083729068, 5340.2256672783005, 5344.545713614386, 5356.410794812646, 5253.290805741176, 5291.100512912737, 5303.920441193308, 5323.893522129613, 5362.276092727432, 4837.200039828653, 4891.9755401222765, 4956.918094400433, 4962.0, 4978.775955081957, 3635.818209089482, 3651.689606383487, 3657.213699054716, 3658.689011434058, 3683.50272713191, 3960.821763020613, 4112.77379744105, 5355.973220133875, 5379.757910894097, 5390.838274851761, 3766.924661506809, 4722.409698787652, 4934.76772713873, 4982.4768399319, 4988.251762235694, 4938.16051271292, 4945.085159245551, 4955.950440495693, 4958.2810492477665, 4980.477049909852, 4868.513148685103, 4905.302083853938, 4905.386826646669, 4910.901781964412, 4943.505649435027, 4895.16782147043, 4930.975345123252, 4950.529699678525, 5010.624203184703, 5040.949590504048, 4915.26271059344, 4917.238312690866, 4920.926186107283, 4921.50784921505, 4926.852194434173], "value": 3799.8154617622813, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.3548544998647, 635.4916067146282, 639.2041907824758, 669.986600267995, 746.5856449670438, 12260.877391226086, 13169.407376668049, 13214.735705285888, 13227.537036203736, 13231.735365292689, 12693.365331733423, 12949.352532373367, 12950.740985180291, 12974.54589089382, 12980.221186728779, 620.2587907450599, 635.6567453575063, 757.0990521279659, 757.7726681995407, 785.305005070511, 763.2100775697155, 772.2933515833006, 774.6359211170741, 774.8682723936917, 776.0454640791829, 824.1346586084617, 824.9752507424757, 824.983500329993, 825.335604838105, 825.5211977053294, 652.1619718661498, 667.4827009067963, 667.512715717529, 668.0446960845989, 819.2340161948538, 588.9646621202742, 606.2936678769273, 607.2015299880643, 607.259143844509, 608.3703367015119, 12948.0, 12982.350882455934, 12983.610491685264, 13007.739845203138, 13020.34898255093, 11416.657500275005, 11566.47950842214, 11935.820962685566, 11944.969355209549, 12167.574134905235, 11021.669349919515, 11209.831852522218, 11472.827907581393, 11636.941815290955, 11935.462904169333, 4043.465515271054, 4106.938395924063, 4107.363358679409, 4108.424820525129, 4112.84755846232, 62683.0, 64685.67657161778, 65529.0, 65838.67080664662, 65844.0, 9691.660791872251, 10111.292209545261, 10128.139108175741, 10276.743081423025, 10318.1745460363, 17697.203625836868, 17796.0, 17820.0, 17855.642887142443, 17972.820271797376, 6341.968290158612, 6616.933830661728, 6678.83302917431, 6707.295733947963, 6914.654267286615, 3678.282734866675, 3690.095926498025, 3707.8146092695256, 3714.591394946554, 3834.0606551395085, 2767.778577713778, 2861.656601207827, 2863.3557449574096, 2877.7122287771476, 2886.888547909028, 458.94033775608955, 469.04783289921517, 472.06295503425673, 528.9523942845162, 563.8449426407689, 530.3635637235333, 582.6416753696446, 587.3011116771029, 623.5603899251017, 637.8915584350672, 8629.956850215709, 8753.431026983226, 9112.316576256808, 9137.918187914489, 9209.493477858648, 602.9336772954971, 632.4308122689524, 640.7405000974612, 657.9243387010555, 658.6410406328563, 4223.303154979394, 4543.613792827647, 4629.930551041737, 4680.321353403806, 4683.227267500824, 100239.0, 101206.0, 101358.49320753496, 105183.0, 107743.0, 70582.64708676423, 79662.6016869912, 83957.0, 91018.54490727636, 94662.52668736612, 44753.77623111864, 55077.0, 71601.0, 72621.27378726251, 73962.0, 8418.536980466133, 8794.252488538546, 8803.471791692264, 8822.426542274732, 8981.101889810967, 44400.555994439645, 44434.77782611195, 44556.331655025846, 44902.77548612236, 45410.77294613638, 62495.375046248955, 64613.67693161692, 64833.67583162054, 65158.0, 65174.67412662906, 11055.557777688802, 11330.886691132982, 11401.828972565583, 11805.468753905923, 12207.267563946192, 13273.0, 13366.599002029954, 13575.253361065235, 13688.31558422055, 13896.861031389557, 12308.323042232405, 12681.492740290285, 12884.935575322439, 13055.34723263814, 13306.201627902357, 12055.758884822078, 12089.57686480969, 12315.75368492643, 12671.493140274286, 12673.366331683563, 12336.198147120409, 12352.814707779571, 12369.752604948031, 12565.811512827499, 13057.28184949837, 9659.178969787366, 10196.490175491344, 10383.029459982989, 10384.584616615251, 10441.68278191683, 10244.64143754965, 10851.40317282557, 10885.23803333759, 10937.671869843918, 10964.890351096386], "value": 6671.1962943905, "unit": "score"}], "name": "dromaeo_css", "value": 6553.169119969397, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 115.0, 115.0, 114.0, 116.0, 114.0, 114.0, 115.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 129.0, 132.0, 180.0, 130.0, 125.0, 144.0, 124.0, 160.0, 125.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 169.0, 163.0, 162.0, 161.0, 161.0, 160.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 130.0, 77.0, 76.0, 76.0, 75.0, 98.0, 76.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 118.0, 84.0, 85.0, 85.0, 124.0, 85.0, 85.0, 121.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 119.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 64.0, 63.0, 64.0, 63.0, 64.0, 64.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 88.0, 79.0, 79.0, 89.0, 79.0, 80.0, 80.0, 83.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 133.0, 127.0, 128.0, 143.0, 129.0, 135.0, 128.0, 203.0, 144.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 165.0, 166.0, 164.0, 167.0, 167.0, 168.0, 167.0, 167.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 70.0, 66.0, 69.0, 67.0, 66.0, 67.0, 67.0, 66.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1536.0000000000002, "alertThreshold": 2.0}]} 05:35:28 INFO - Return code: 0 05:35:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:35:28 INFO - # TBPL SUCCESS # 05:35:28 INFO - Running post-action listener: _resource_record_post_action 05:35:28 INFO - ##### 05:35:28 INFO - ##### Finished run-tests step (success) 05:35:28 INFO - ##### 05:35:28 INFO - Running post-run listener: _resource_record_post_run 05:35:28 INFO - Total resource usage - Wall time: 1228s; CPU: 14.0%; Read bytes: 4096; Write bytes: 546934784; Read time: 16; Write time: 803688 05:35:28 INFO - TinderboxPrint: CPU usage
13.8% 05:35:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 05:35:28 INFO - TinderboxPrint: I/O write bytes / time
546,934,784 / 803,688 05:35:28 INFO - TinderboxPrint: CPU idle
8,450.2 (86.2%) 05:35:28 INFO - TinderboxPrint: CPU user
1,224.7 (12.5%) 05:35:28 INFO - TinderboxPrint: Swap in / out
0 / 0 05:35:28 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 256897024; Read time: 0; Write time: 441332 05:35:28 INFO - run-tests - Wall time: 1212s; CPU: 14.0%; Read bytes: 0; Write bytes: 289849344; Read time: 0; Write time: 362324 05:35:29 INFO - Running post-run listener: _upload_blobber_files 05:35:29 INFO - Blob upload gear active. 05:35:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:35:29 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 05:35:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:35:29 INFO - (blobuploader) - INFO - Open directory for files ... 05:35:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:35:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:35:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:33 INFO - (blobuploader) - INFO - Done attempting. 05:35:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:35:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:35:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:34 INFO - (blobuploader) - INFO - Done attempting. 05:35:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:35:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:35:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:35 INFO - (blobuploader) - INFO - Done attempting. 05:35:35 INFO - (blobuploader) - INFO - Iteration through files over. 05:35:35 INFO - Return code: 0 05:35:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:35:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:35:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/61ded98bac457875efac840774f7ab9913347f15f86f0203bb09a45e2dc4476ecb598f2fe51310a074803e9ce4d02d65999b10ec3ad1da176ef470cd13afa8ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ca3ba8eab48057af0833d8690f3df2f0a598feb06564819acb1ea16ce4e143f75e23b185eee9cad3570f3936f605c84c48d73b55930036ae0d5f3de5e81d9b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/38c4e06521d96b3c0f10570bc3a81031239e7294d835afeb76b92a3103e3b41f549fd2c5f44216a2d586eea2b0b54f0f3b9538d24a521f201888ce3b087eac39"} 05:35:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:35:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:35:35 INFO - Contents: 05:35:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/61ded98bac457875efac840774f7ab9913347f15f86f0203bb09a45e2dc4476ecb598f2fe51310a074803e9ce4d02d65999b10ec3ad1da176ef470cd13afa8ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ca3ba8eab48057af0833d8690f3df2f0a598feb06564819acb1ea16ce4e143f75e23b185eee9cad3570f3936f605c84c48d73b55930036ae0d5f3de5e81d9b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/38c4e06521d96b3c0f10570bc3a81031239e7294d835afeb76b92a3103e3b41f549fd2c5f44216a2d586eea2b0b54f0f3b9538d24a521f201888ce3b087eac39"} 05:35:35 INFO - Running post-run listener: copy_logs_to_upload_dir 05:35:35 INFO - Copying logs to upload dir... 05:35:35 INFO - mkdir: /builds/slave/test/build/upload/logs 05:35:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.043319 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-07-11 05:35:34.239106) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 05:35:34.242945) ========= 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=5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/61ded98bac457875efac840774f7ab9913347f15f86f0203bb09a45e2dc4476ecb598f2fe51310a074803e9ce4d02d65999b10ec3ad1da176ef470cd13afa8ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ca3ba8eab48057af0833d8690f3df2f0a598feb06564819acb1ea16ce4e143f75e23b185eee9cad3570f3936f605c84c48d73b55930036ae0d5f3de5e81d9b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/38c4e06521d96b3c0f10570bc3a81031239e7294d835afeb76b92a3103e3b41f549fd2c5f44216a2d586eea2b0b54f0f3b9538d24a521f201888ce3b087eac39"} build_url:https://queue.taskcluster.net/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://queue.taskcluster.net/v1/task/HgVtQGKkQum6aLI006xUlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/61ded98bac457875efac840774f7ab9913347f15f86f0203bb09a45e2dc4476ecb598f2fe51310a074803e9ce4d02d65999b10ec3ad1da176ef470cd13afa8ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ca3ba8eab48057af0833d8690f3df2f0a598feb06564819acb1ea16ce4e143f75e23b185eee9cad3570f3936f605c84c48d73b55930036ae0d5f3de5e81d9b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/38c4e06521d96b3c0f10570bc3a81031239e7294d835afeb76b92a3103e3b41f549fd2c5f44216a2d586eea2b0b54f0f3b9538d24a521f201888ce3b087eac39"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 05:35:34.271008) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:35:34.271335) ========= 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=5bd038846534b2fdfa68eeae000001e2-1468239245.333513-878404487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004621 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 05:35:34.326553) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 05:35:34.326872) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 05:35:34.327163) ========= ========= Total master_lag: 0.13 =========