builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-005 starttime: 1471291190.98 results: success (0) buildid: 20160815114115 builduid: f22eb63a4d6a447eaf8f23dc25a18050 revision: 9e8fb23fc565df8b8f002941e7dc12bced5df054 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 12:59:50.981901) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 12:59:50.982373) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 12:59:50.982669) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 12:59:51.012731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 12:59:51.012997) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-15 12:59:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.5M=0s 2016-08-15 12:59:52 (83.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107845 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 12:59:51.134523) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 12:59:51.134843) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014694 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 12:59:51.184015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-15 12:59:51.184376) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9e8fb23fc565df8b8f002941e7dc12bced5df054 --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 9e8fb23fc565df8b8f002941e7dc12bced5df054 --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=7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-15 12:59:52,207 truncating revision to first 12 chars 2016-08-15 12:59:52,207 Setting DEBUG logging. 2016-08-15 12:59:52,207 attempt 1/10 2016-08-15 12:59:52,207 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9e8fb23fc565?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-15 12:59:52,885 unpacking tar archive at: fx-team-9e8fb23fc565/testing/mozharness/ program finished with exit code 0 elapsedTime=1.067828 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-15 12:59:52.265742) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 12:59:52.266071) ========= script_repo_revision: 9e8fb23fc565df8b8f002941e7dc12bced5df054 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 12:59:52.266465) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 12:59:52.266737) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 12:59:52.280381) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-15 12:59:52.280767) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:59:53 INFO - MultiFileLogger online at 20160815 12:59:53 in /builds/slave/test 12:59:53 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 12:59:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:59:53 INFO - {'append_to_log': False, 12:59:53 INFO - 'base_work_dir': '/builds/slave/test', 12:59:53 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:59:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:59:53 INFO - 'branch': 'Fx-Team-Non-PGO', 12:59:53 INFO - 'buildbot_json_path': 'buildprops.json', 12:59:53 INFO - 'config_files': ('talos/linux_config.py',), 12:59:53 INFO - 'default_actions': ('clobber', 12:59:53 INFO - 'read-buildbot-config', 12:59:53 INFO - 'download-and-extract', 12:59:53 INFO - 'populate-webroot', 12:59:53 INFO - 'create-virtualenv', 12:59:53 INFO - 'install', 12:59:53 INFO - 'run-tests'), 12:59:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:59:53 INFO - 'download_minidump_stackwalk': True, 12:59:53 INFO - 'download_symbols': 'ondemand', 12:59:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:59:53 INFO - 'tooltool.py': '/tools/tooltool.py', 12:59:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:59:53 INFO - '/tools/misc-python/virtualenv.py')}, 12:59:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:59:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:59:53 INFO - 'installer_path': 'installer.exe', 12:59:53 INFO - 'log_level': 'info', 12:59:53 INFO - 'log_name': 'talos', 12:59:53 INFO - 'log_to_console': True, 12:59:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:59:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:59:53 INFO - 'opt_config_files': (), 12:59:53 INFO - 'pip_index': False, 12:59:53 INFO - 'sps_profile': False, 12:59:53 INFO - 'sps_profile_interval': 0, 12:59:53 INFO - 'suite': 'dromaeojs', 12:59:53 INFO - 'system_bits': '32', 12:59:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:59:53 INFO - 'title': 'talos-linux64-ix-005', 12:59:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:59:53 INFO - 'use_talos_json': True, 12:59:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:59:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:59:53 INFO - 'work_dir': 'build'} 12:59:53 INFO - [mozharness: 2016-08-15 19:59:53.399916Z] Running clobber step. 12:59:53 INFO - Running pre-action listener: _resource_record_pre_action 12:59:53 INFO - Running main action method: clobber 12:59:53 INFO - rmtree: /builds/slave/test/build 12:59:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:59:54 INFO - Running post-action listener: _resource_record_post_action 12:59:54 INFO - [mozharness: 2016-08-15 19:59:54.387835Z] Finished clobber step (success) 12:59:54 INFO - [mozharness: 2016-08-15 19:59:54.387936Z] Running read-buildbot-config step. 12:59:54 INFO - Running pre-action listener: _resource_record_pre_action 12:59:54 INFO - Running main action method: read_buildbot_config 12:59:54 INFO - Using buildbot properties: 12:59:54 INFO - { 12:59:54 INFO - "project": "", 12:59:54 INFO - "product": "firefox", 12:59:54 INFO - "script_repo_revision": "production", 12:59:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:59:54 INFO - "repository": "", 12:59:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:59:54 INFO - "buildid": "20160815114115", 12:59:54 INFO - "pgo_build": "False", 12:59:54 INFO - "basedir": "/builds/slave/test", 12:59:54 INFO - "buildnumber": 1867, 12:59:54 INFO - "slavename": "talos-linux64-ix-005", 12:59:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:59:54 INFO - "platform": "ubuntu64_hw", 12:59:54 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 12:59:54 INFO - "branch": "fx-team", 12:59:54 INFO - "repo_path": "integration/fx-team", 12:59:54 INFO - "revision": "9e8fb23fc565df8b8f002941e7dc12bced5df054", 12:59:54 INFO - "stage_platform": "linux64", 12:59:54 INFO - "builduid": "f22eb63a4d6a447eaf8f23dc25a18050", 12:59:54 INFO - "slavebuilddir": "test" 12:59:54 INFO - } 12:59:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 12:59:54 INFO - Running post-action listener: _resource_record_post_action 12:59:54 INFO - [mozharness: 2016-08-15 19:59:54.390370Z] Finished read-buildbot-config step (success) 12:59:54 INFO - [mozharness: 2016-08-15 19:59:54.390457Z] Running download-and-extract step. 12:59:54 INFO - Running pre-action listener: _resource_record_pre_action 12:59:54 INFO - Running main action method: download_and_extract 12:59:54 INFO - mkdir: /builds/slave/test/build/tests 12:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:59:54 INFO - trying https://queue.taskcluster.net/v1/task/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:59:54 INFO - Downloading https://queue.taskcluster.net/v1/task/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:59:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:59:54 INFO - Downloaded 1361 bytes. 12:59:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:59:54 INFO - Using the following test package requirements: 12:59:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:59:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:59:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:59:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:54 INFO - u'jsshell-linux-x86_64.zip'], 12:59:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:59:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:59:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:59:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:59:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:59:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:59:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:59:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:59:54 INFO - trying https://queue.taskcluster.net/v1/task/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:59:54 INFO - Downloading https://queue.taskcluster.net/v1/task/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:59:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:59:55 INFO - Downloaded 20264486 bytes. 12:59:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 13:00:00 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:00 INFO - trying https://queue.taskcluster.net/v1/task/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:00:00 INFO - Downloading https://queue.taskcluster.net/v1/task/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:00:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:00:01 INFO - Downloaded 20264486 bytes. 13:00:01 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 13:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:05 INFO - trying https://queue.taskcluster.net/v1/task/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 13:00:05 INFO - Downloading https://queue.taskcluster.net/v1/task/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 13:00:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:00:06 INFO - Downloaded 14413719 bytes. 13:00:06 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 13:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:06 INFO - trying https://queue.taskcluster.net/v1/task/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:00:06 INFO - Downloading https://queue.taskcluster.net/v1/task/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:00:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:00:08 INFO - Downloaded 55611310 bytes. 13:00:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:00:08 INFO - mkdir: /builds/slave/test/properties 13:00:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:00:08 INFO - Writing to file /builds/slave/test/properties/build_url 13:00:08 INFO - Contents: 13:00:08 INFO - build_url:https://queue.taskcluster.net/v1/task/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:00:08 INFO - Running post-action listener: _resource_record_post_action 13:00:08 INFO - Running post-action listener: set_extra_try_arguments 13:00:08 INFO - [mozharness: 2016-08-15 20:00:08.710180Z] Finished download-and-extract step (success) 13:00:08 INFO - [mozharness: 2016-08-15 20:00:08.710404Z] Running populate-webroot step. 13:00:08 INFO - Running pre-action listener: _resource_record_pre_action 13:00:08 INFO - Running main action method: populate_webroot 13:00:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:00:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:00:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:00:08 INFO - '--tppagecycles', 13:00:08 INFO - '7'], 13:00:08 INFO - 'tests': ['tsvgm']}}, 13:00:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:00:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:00:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:00:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:00:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:00:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:00:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:08 INFO - 'talos_options': ['--disable-e10s'], 13:00:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:00:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:00:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:08 INFO - 'talos_options': ['--disable-e10s'], 13:00:08 INFO - 'tests': ['damp', 'tps']}, 13:00:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:08 INFO - 'tests': ['damp', 'tps']}, 13:00:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:00:08 INFO - 'tests': ['dromaeo_dom']}, 13:00:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:00:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:00:08 INFO - 'tests': ['basic_compositor_video']}, 13:00:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:00:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:00:08 INFO - 'tests': ['a11yr', 13:00:08 INFO - 'ts_paint', 13:00:08 INFO - 'tpaint', 13:00:08 INFO - 'sessionrestore', 13:00:08 INFO - 'sessionrestore_no_auto_restore', 13:00:08 INFO - 'tabpaint']}, 13:00:08 INFO - 'other-e10s': {'tests': ['a11yr', 13:00:08 INFO - 'ts_paint', 13:00:08 INFO - 'tpaint', 13:00:08 INFO - 'sessionrestore', 13:00:08 INFO - 'sessionrestore_no_auto_restore', 13:00:08 INFO - 'tabpaint']}, 13:00:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:00:08 INFO - 'ts_paint', 13:00:08 INFO - 'tpaint', 13:00:08 INFO - 'sessionrestore', 13:00:08 INFO - 'sessionrestore_no_auto_restore', 13:00:08 INFO - 'tabpaint']}, 13:00:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:00:08 INFO - 'ts_paint', 13:00:08 INFO - 'tpaint', 13:00:08 INFO - 'sessionrestore', 13:00:08 INFO - 'sessionrestore_no_auto_restore', 13:00:08 INFO - 'tabpaint']}, 13:00:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:00:08 INFO - 'tests': ['a11yr', 13:00:08 INFO - 'ts_paint', 13:00:08 INFO - 'tpaint', 13:00:08 INFO - 'sessionrestore', 13:00:08 INFO - 'sessionrestore_no_auto_restore', 13:00:08 INFO - 'tabpaint']}, 13:00:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:00:08 INFO - 'tests': ['a11yr', 13:00:08 INFO - 'ts_paint', 13:00:08 INFO - 'tpaint', 13:00:08 INFO - 'sessionrestore', 13:00:08 INFO - 'sessionrestore_no_auto_restore', 13:00:08 INFO - 'tabpaint']}, 13:00:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:00:08 INFO - 'tests': ['tsvgx', 13:00:08 INFO - 'tsvgr_opacity', 13:00:08 INFO - 'tart', 13:00:08 INFO - 'tscrollx', 13:00:08 INFO - 'cart']}, 13:00:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:00:08 INFO - 'tsvgr_opacity', 13:00:08 INFO - 'tart', 13:00:08 INFO - 'tscrollx', 13:00:08 INFO - 'cart']}, 13:00:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:08 INFO - 'talos_options': ['--disable-e10s'], 13:00:08 INFO - 'tests': ['tp5o']}, 13:00:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:08 INFO - 'tests': ['tp5o']}, 13:00:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:08 INFO - 'talos_options': ['--disable-e10s', 13:00:08 INFO - '--xperf_path', 13:00:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:00:08 INFO - 'tests': ['tp5n']}, 13:00:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:08 INFO - 'talos_options': ['--xperf_path', 13:00:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:00:08 INFO - 'tests': ['tp5n']}}, 13:00:08 INFO - 'talos.zip': {'path': '', 13:00:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:00:08 INFO - Running post-action listener: _resource_record_post_action 13:00:08 INFO - [mozharness: 2016-08-15 20:00:08.730764Z] Finished populate-webroot step (success) 13:00:08 INFO - [mozharness: 2016-08-15 20:00:08.730852Z] Running create-virtualenv step. 13:00:08 INFO - Running pre-action listener: _resource_record_pre_action 13:00:08 INFO - Running main action method: create_virtualenv 13:00:08 INFO - Creating virtualenv /builds/slave/test/build/venv 13:00:08 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 13:00:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:00:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:00:08 INFO - Using real prefix '/usr' 13:00:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:00:09 INFO - Installing distribute.............................................................................................................................................................................................done. 13:00:11 INFO - Installing pip.................done. 13:00:11 INFO - Return code: 0 13:00:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:11 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 0x7fa3fa0fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2418090>, '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 0x241b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241be40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', '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 13:00:11 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 13:00:11 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 13:00:11 INFO - Using env: {'DISPLAY': ':0', 13:00:11 INFO - 'HOME': '/home/cltbld', 13:00:11 INFO - 'LANG': 'en_US.UTF-8', 13:00:11 INFO - 'LANGUAGE': 'en_US:en', 13:00:11 INFO - 'LOGNAME': 'cltbld', 13:00:11 INFO - 'MAIL': '/var/mail/cltbld', 13:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:11 INFO - 'MOZ_NO_REMOTE': '1', 13:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:11 INFO - 'NO_EM_RESTART': '1', 13:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:11 INFO - 'PWD': '/builds/slave/test', 13:00:11 INFO - 'SHELL': '/bin/bash', 13:00:11 INFO - 'SHLVL': '1', 13:00:11 INFO - 'TERM': 'linux', 13:00:11 INFO - 'TMOUT': '86400', 13:00:11 INFO - 'USER': 'cltbld', 13:00:11 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', 13:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:11 INFO - '_': '/tools/buildbot/bin/python'} 13:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:11 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 13:00:11 INFO - Cleaning up... 13:00:11 INFO - Return code: 0 13:00:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:11 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 0x7fa3fa0fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2418090>, '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 0x241b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241be40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', '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 13:00:11 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 13:00:11 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 13:00:11 INFO - Using env: {'DISPLAY': ':0', 13:00:11 INFO - 'HOME': '/home/cltbld', 13:00:11 INFO - 'LANG': 'en_US.UTF-8', 13:00:11 INFO - 'LANGUAGE': 'en_US:en', 13:00:11 INFO - 'LOGNAME': 'cltbld', 13:00:11 INFO - 'MAIL': '/var/mail/cltbld', 13:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:11 INFO - 'MOZ_NO_REMOTE': '1', 13:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:11 INFO - 'NO_EM_RESTART': '1', 13:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:11 INFO - 'PWD': '/builds/slave/test', 13:00:11 INFO - 'SHELL': '/bin/bash', 13:00:11 INFO - 'SHLVL': '1', 13:00:11 INFO - 'TERM': 'linux', 13:00:11 INFO - 'TMOUT': '86400', 13:00:11 INFO - 'USER': 'cltbld', 13:00:11 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', 13:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:11 INFO - '_': '/tools/buildbot/bin/python'} 13:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:11 INFO - Downloading/unpacking psutil>=3.1.1 13:00:11 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 13:00:11 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 13:00:11 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 13:00:11 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 13:00:11 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 13:00:11 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 13:00:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:00:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:00:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:00:13 INFO - Installing collected packages: psutil 13:00:13 INFO - Running setup.py install for psutil 13:00:13 INFO - building 'psutil._psutil_linux' extension 13:00:13 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 13:00:13 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 13:00:13 INFO - building 'psutil._psutil_posix' extension 13:00:13 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 13:00:14 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 13:00:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:00:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:00:14 INFO - Successfully installed psutil 13:00:14 INFO - Cleaning up... 13:00:14 INFO - Return code: 0 13:00:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:14 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 0x7fa3fa0fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2418090>, '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 0x241b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241be40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', '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 13:00:14 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 13:00:14 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 13:00:14 INFO - Using env: {'DISPLAY': ':0', 13:00:14 INFO - 'HOME': '/home/cltbld', 13:00:14 INFO - 'LANG': 'en_US.UTF-8', 13:00:14 INFO - 'LANGUAGE': 'en_US:en', 13:00:14 INFO - 'LOGNAME': 'cltbld', 13:00:14 INFO - 'MAIL': '/var/mail/cltbld', 13:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:14 INFO - 'MOZ_NO_REMOTE': '1', 13:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:14 INFO - 'NO_EM_RESTART': '1', 13:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:14 INFO - 'PWD': '/builds/slave/test', 13:00:14 INFO - 'SHELL': '/bin/bash', 13:00:14 INFO - 'SHLVL': '1', 13:00:14 INFO - 'TERM': 'linux', 13:00:14 INFO - 'TMOUT': '86400', 13:00:14 INFO - 'USER': 'cltbld', 13:00:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', 13:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:14 INFO - '_': '/tools/buildbot/bin/python'} 13:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:00:14 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 13:00:14 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 13:00:14 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 13:00:14 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 13:00:14 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 13:00:14 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 13:00:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:00:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:00:16 INFO - Installing collected packages: mozsystemmonitor 13:00:16 INFO - Running setup.py install for mozsystemmonitor 13:00:16 INFO - Successfully installed mozsystemmonitor 13:00:16 INFO - Cleaning up... 13:00:16 INFO - Return code: 0 13:00:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:16 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 0x7fa3fa0fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2418090>, '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 0x241b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241be40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', '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 13:00:16 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 13:00:16 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 13:00:16 INFO - Using env: {'DISPLAY': ':0', 13:00:16 INFO - 'HOME': '/home/cltbld', 13:00:16 INFO - 'LANG': 'en_US.UTF-8', 13:00:16 INFO - 'LANGUAGE': 'en_US:en', 13:00:16 INFO - 'LOGNAME': 'cltbld', 13:00:16 INFO - 'MAIL': '/var/mail/cltbld', 13:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:16 INFO - 'MOZ_NO_REMOTE': '1', 13:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:16 INFO - 'NO_EM_RESTART': '1', 13:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:16 INFO - 'PWD': '/builds/slave/test', 13:00:16 INFO - 'SHELL': '/bin/bash', 13:00:16 INFO - 'SHLVL': '1', 13:00:16 INFO - 'TERM': 'linux', 13:00:16 INFO - 'TMOUT': '86400', 13:00:16 INFO - 'USER': 'cltbld', 13:00:16 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', 13:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:16 INFO - '_': '/tools/buildbot/bin/python'} 13:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:16 INFO - Downloading/unpacking jsonschema==2.5.1 13:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:00:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:00:18 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 13:00:18 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 13:00:18 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 13:00:18 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 13:00:18 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 13:00:18 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 13:00:18 INFO - Downloading functools32-3.2.3-2.tar.gz 13:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:00:18 INFO - warning: no files found matching '*.txt' 13:00:18 INFO - no previously-included directories found matching 'build' 13:00:18 INFO - no previously-included directories found matching 'dist' 13:00:18 INFO - no previously-included directories found matching '.git*' 13:00:18 INFO - Installing collected packages: jsonschema, functools32 13:00:18 INFO - Running setup.py install for functools32 13:00:19 INFO - warning: no files found matching '*.txt' 13:00:19 INFO - no previously-included directories found matching 'build' 13:00:19 INFO - no previously-included directories found matching 'dist' 13:00:19 INFO - no previously-included directories found matching '.git*' 13:00:19 INFO - Successfully installed jsonschema functools32 13:00:19 INFO - Cleaning up... 13:00:19 INFO - Return code: 0 13:00:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3fa0fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2418090>, '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 0x241b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241be40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', '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 13:00:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:00:19 INFO - Using env: {'DISPLAY': ':0', 13:00:19 INFO - 'HOME': '/home/cltbld', 13:00:19 INFO - 'LANG': 'en_US.UTF-8', 13:00:19 INFO - 'LANGUAGE': 'en_US:en', 13:00:19 INFO - 'LOGNAME': 'cltbld', 13:00:19 INFO - 'MAIL': '/var/mail/cltbld', 13:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:19 INFO - 'MOZ_NO_REMOTE': '1', 13:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:19 INFO - 'NO_EM_RESTART': '1', 13:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:19 INFO - 'PWD': '/builds/slave/test', 13:00:19 INFO - 'SHELL': '/bin/bash', 13:00:19 INFO - 'SHLVL': '1', 13:00:19 INFO - 'TERM': 'linux', 13:00:19 INFO - 'TMOUT': '86400', 13:00:19 INFO - 'USER': 'cltbld', 13:00:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', 13:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:19 INFO - '_': '/tools/buildbot/bin/python'} 13:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:00:19 INFO - Cleaning up... 13:00:19 INFO - Return code: 0 13:00:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:19 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 0x7fa3fa0fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2418090>, '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 0x241b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241be40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', '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 13:00:19 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 13:00:19 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 13:00:19 INFO - Using env: {'DISPLAY': ':0', 13:00:19 INFO - 'HOME': '/home/cltbld', 13:00:19 INFO - 'LANG': 'en_US.UTF-8', 13:00:19 INFO - 'LANGUAGE': 'en_US:en', 13:00:19 INFO - 'LOGNAME': 'cltbld', 13:00:19 INFO - 'MAIL': '/var/mail/cltbld', 13:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:19 INFO - 'MOZ_NO_REMOTE': '1', 13:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:19 INFO - 'NO_EM_RESTART': '1', 13:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:19 INFO - 'PWD': '/builds/slave/test', 13:00:19 INFO - 'SHELL': '/bin/bash', 13:00:19 INFO - 'SHLVL': '1', 13:00:19 INFO - 'TERM': 'linux', 13:00:19 INFO - 'TMOUT': '86400', 13:00:19 INFO - 'USER': 'cltbld', 13:00:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', 13:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:19 INFO - '_': '/tools/buildbot/bin/python'} 13:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:19 INFO - Downloading/unpacking blobuploader==1.2.4 13:00:19 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 13:00:19 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 13:00:19 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 13:00:19 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 13:00:19 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 13:00:19 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 13:00:21 INFO - Downloading blobuploader-1.2.4.tar.gz 13:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:00:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:00:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:22 INFO - Downloading docopt-0.6.1.tar.gz 13:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:00:22 INFO - Installing collected packages: blobuploader, requests, docopt 13:00:22 INFO - Running setup.py install for blobuploader 13:00:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:00:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:00:22 INFO - Running setup.py install for requests 13:00:22 INFO - Running setup.py install for docopt 13:00:22 INFO - Successfully installed blobuploader requests docopt 13:00:22 INFO - Cleaning up... 13:00:22 INFO - Return code: 0 13:00:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:22 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 0x7fa3fa0fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2418090>, '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 0x241b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241be40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', '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 13:00:22 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 13:00:22 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 13:00:22 INFO - Using env: {'DISPLAY': ':0', 13:00:22 INFO - 'HOME': '/home/cltbld', 13:00:22 INFO - 'LANG': 'en_US.UTF-8', 13:00:22 INFO - 'LANGUAGE': 'en_US:en', 13:00:22 INFO - 'LOGNAME': 'cltbld', 13:00:22 INFO - 'MAIL': '/var/mail/cltbld', 13:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:22 INFO - 'MOZ_NO_REMOTE': '1', 13:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:22 INFO - 'NO_EM_RESTART': '1', 13:00:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:22 INFO - 'PWD': '/builds/slave/test', 13:00:22 INFO - 'SHELL': '/bin/bash', 13:00:22 INFO - 'SHLVL': '1', 13:00:22 INFO - 'TERM': 'linux', 13:00:22 INFO - 'TMOUT': '86400', 13:00:22 INFO - 'USER': 'cltbld', 13:00:22 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', 13:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:22 INFO - '_': '/tools/buildbot/bin/python'} 13:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:00:23 INFO - Running setup.py (path:/tmp/pip-tXKr4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:00:23 INFO - Running setup.py (path:/tmp/pip-RJRPNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:00:23 INFO - Running setup.py (path:/tmp/pip-jMF5Um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:00:23 INFO - Running setup.py (path:/tmp/pip-nL2zwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:00:23 INFO - Running setup.py (path:/tmp/pip-kofk6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:00:23 INFO - Running setup.py (path:/tmp/pip-ruxgyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:00:23 INFO - Running setup.py (path:/tmp/pip-FtQLwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:00:23 INFO - Running setup.py (path:/tmp/pip-dmEYWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:00:23 INFO - Running setup.py (path:/tmp/pip-ISI72c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:00:23 INFO - Running setup.py (path:/tmp/pip-iSXY7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:00:23 INFO - Running setup.py (path:/tmp/pip-V2s_X9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:00:23 INFO - Running setup.py (path:/tmp/pip-Zkm65N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:00:23 INFO - Running setup.py (path:/tmp/pip-1P4BGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:00:23 INFO - Running setup.py (path:/tmp/pip-liaqYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:24 INFO - Running setup.py (path:/tmp/pip-5YY9Bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:00:24 INFO - Running setup.py (path:/tmp/pip-81sNsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:00:24 INFO - Running setup.py (path:/tmp/pip-Gud6IG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:00:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:00:24 INFO - Running setup.py install for manifestparser 13:00:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:00:24 INFO - Running setup.py install for mozcrash 13:00:24 INFO - Running setup.py install for mozdebug 13:00:24 INFO - Running setup.py install for mozdevice 13:00:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:00:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:00:24 INFO - Running setup.py install for mozfile 13:00:24 INFO - Running setup.py install for mozhttpd 13:00:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:00:24 INFO - Running setup.py install for mozinfo 13:00:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:00:24 INFO - Running setup.py install for mozInstall 13:00:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:00:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:00:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:00:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:00:25 INFO - Running setup.py install for mozleak 13:00:25 INFO - Running setup.py install for mozlog 13:00:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:00:25 INFO - Running setup.py install for moznetwork 13:00:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:00:25 INFO - Running setup.py install for mozprocess 13:00:25 INFO - Running setup.py install for mozprofile 13:00:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:00:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:00:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:00:25 INFO - Running setup.py install for mozrunner 13:00:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:00:25 INFO - Running setup.py install for mozscreenshot 13:00:25 INFO - Running setup.py install for moztest 13:00:25 INFO - Running setup.py install for mozversion 13:00:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:00:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:00:26 INFO - Cleaning up... 13:00:26 INFO - Return code: 0 13:00:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:26 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 0x7fa3fa0fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2418090>, '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 0x241b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241be40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', '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 13:00:26 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 13:00:26 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 13:00:26 INFO - Using env: {'DISPLAY': ':0', 13:00:26 INFO - 'HOME': '/home/cltbld', 13:00:26 INFO - 'LANG': 'en_US.UTF-8', 13:00:26 INFO - 'LANGUAGE': 'en_US:en', 13:00:26 INFO - 'LOGNAME': 'cltbld', 13:00:26 INFO - 'MAIL': '/var/mail/cltbld', 13:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:26 INFO - 'MOZ_NO_REMOTE': '1', 13:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:26 INFO - 'NO_EM_RESTART': '1', 13:00:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:26 INFO - 'PWD': '/builds/slave/test', 13:00:26 INFO - 'SHELL': '/bin/bash', 13:00:26 INFO - 'SHLVL': '1', 13:00:26 INFO - 'TERM': 'linux', 13:00:26 INFO - 'TMOUT': '86400', 13:00:26 INFO - 'USER': 'cltbld', 13:00:26 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', 13:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:26 INFO - '_': '/tools/buildbot/bin/python'} 13:00:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:00:26 INFO - Running setup.py (path:/tmp/pip-CnEoX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:00:26 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)) 13:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:00:26 INFO - Running setup.py (path:/tmp/pip-jdiXyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:00:26 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)) 13:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:00:26 INFO - Running setup.py (path:/tmp/pip-9F0VG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:00:26 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)) 13:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:00:26 INFO - Running setup.py (path:/tmp/pip-T8CpqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:00:26 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)) 13:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:00:26 INFO - Running setup.py (path:/tmp/pip-2OqFlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:00:26 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)) 13:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:00:26 INFO - Running setup.py (path:/tmp/pip-eJ_Zzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:00:26 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)) 13:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:00:26 INFO - Running setup.py (path:/tmp/pip-GV5OIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:00:26 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)) 13:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:00:26 INFO - Running setup.py (path:/tmp/pip-FReM7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:00:26 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)) 13:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:00:26 INFO - Running setup.py (path:/tmp/pip-zzmr7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:00:26 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)) 13:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:00:26 INFO - Running setup.py (path:/tmp/pip-jHyLBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:00:26 INFO - Running setup.py (path:/tmp/pip-7cPKsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:00:27 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)) 13:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:00:27 INFO - Running setup.py (path:/tmp/pip-eSDp_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:00:27 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)) 13:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:00:27 INFO - Running setup.py (path:/tmp/pip-UMHa0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:00:27 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)) 13:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:00:27 INFO - Running setup.py (path:/tmp/pip-kcgoft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:00:27 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)) 13:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:27 INFO - Running setup.py (path:/tmp/pip-6eqiin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:27 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)) 13:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:00:27 INFO - Running setup.py (path:/tmp/pip-hJcA4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:00:27 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)) 13:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:00:27 INFO - Running setup.py (path:/tmp/pip-RE8tMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:00:27 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)) 13:00:27 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)) 13:00:27 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)) 13:00:27 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)) 13:00:27 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)) 13:00:27 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)) 13:00:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:00:27 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 13:00:27 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 13:00:27 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 13:00:27 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 13:00:27 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 13:00:27 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 13:00:29 INFO - Downloading blessings-1.6.tar.gz 13:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:00:29 INFO - Installing collected packages: blessings 13:00:29 INFO - Running setup.py install for blessings 13:00:29 INFO - Successfully installed blessings 13:00:29 INFO - Cleaning up... 13:00:29 INFO - Return code: 0 13:00:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:00:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:00:29 INFO - Reading from file tmpfile_stdout 13:00:29 INFO - Current package versions: 13:00:29 INFO - argparse == 1.2.1 13:00:29 INFO - blessings == 1.6 13:00:29 INFO - blobuploader == 1.2.4 13:00:29 INFO - docopt == 0.6.1 13:00:29 INFO - functools32 == 3.2.3-2 13:00:29 INFO - jsonschema == 2.5.1 13:00:29 INFO - manifestparser == 1.1 13:00:29 INFO - mozInstall == 1.12 13:00:29 INFO - mozcrash == 0.17 13:00:29 INFO - mozdebug == 0.1 13:00:29 INFO - mozdevice == 0.48 13:00:29 INFO - mozfile == 1.2 13:00:29 INFO - mozhttpd == 0.7 13:00:29 INFO - mozinfo == 0.9 13:00:29 INFO - mozleak == 0.1 13:00:29 INFO - mozlog == 3.3 13:00:29 INFO - moznetwork == 0.27 13:00:29 INFO - mozprocess == 0.23 13:00:29 INFO - mozprofile == 0.28 13:00:29 INFO - mozrunner == 6.12 13:00:29 INFO - mozscreenshot == 0.1 13:00:29 INFO - mozsystemmonitor == 0.3 13:00:29 INFO - moztest == 0.7 13:00:29 INFO - mozversion == 1.4 13:00:29 INFO - psutil == 3.1.1 13:00:29 INFO - requests == 1.2.3 13:00:29 INFO - wsgiref == 0.1.2 13:00:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:29 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 0x7fa3fa0fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2418090>, '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 0x241b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241be40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', '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 13:00:29 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 13:00:29 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 13:00:29 INFO - Using env: {'DISPLAY': ':0', 13:00:29 INFO - 'HOME': '/home/cltbld', 13:00:29 INFO - 'LANG': 'en_US.UTF-8', 13:00:29 INFO - 'LANGUAGE': 'en_US:en', 13:00:29 INFO - 'LOGNAME': 'cltbld', 13:00:29 INFO - 'MAIL': '/var/mail/cltbld', 13:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:29 INFO - 'MOZ_NO_REMOTE': '1', 13:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:29 INFO - 'NO_EM_RESTART': '1', 13:00:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:29 INFO - 'PWD': '/builds/slave/test', 13:00:29 INFO - 'SHELL': '/bin/bash', 13:00:29 INFO - 'SHLVL': '1', 13:00:29 INFO - 'TERM': 'linux', 13:00:29 INFO - 'TMOUT': '86400', 13:00:29 INFO - 'USER': 'cltbld', 13:00:29 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', 13:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:29 INFO - '_': '/tools/buildbot/bin/python'} 13:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:30 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)) 13:00:30 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)) 13:00:30 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)) 13:00:30 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)) 13:00:30 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)) 13:00:30 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)) 13:00:30 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)) 13:00:30 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)) 13:00:30 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)) 13:00:30 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)) 13:00:30 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)) 13:00:30 INFO - Cleaning up... 13:00:30 INFO - Return code: 0 13:00:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:30 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 0x7fa3fa0fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2418090>, '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 0x241b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241be40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', '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 13:00:30 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 13:00:30 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 13:00:30 INFO - Using env: {'DISPLAY': ':0', 13:00:30 INFO - 'HOME': '/home/cltbld', 13:00:30 INFO - 'LANG': 'en_US.UTF-8', 13:00:30 INFO - 'LANGUAGE': 'en_US:en', 13:00:30 INFO - 'LOGNAME': 'cltbld', 13:00:30 INFO - 'MAIL': '/var/mail/cltbld', 13:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:30 INFO - 'MOZ_NO_REMOTE': '1', 13:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:30 INFO - 'NO_EM_RESTART': '1', 13:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:30 INFO - 'PWD': '/builds/slave/test', 13:00:30 INFO - 'SHELL': '/bin/bash', 13:00:30 INFO - 'SHLVL': '1', 13:00:30 INFO - 'TERM': 'linux', 13:00:30 INFO - 'TMOUT': '86400', 13:00:30 INFO - 'USER': 'cltbld', 13:00:30 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', 13:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:30 INFO - '_': '/tools/buildbot/bin/python'} 13:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:00:30 INFO - Cleaning up... 13:00:30 INFO - Return code: 0 13:00:30 INFO - Running post-action listener: _resource_record_post_action 13:00:30 INFO - Running post-action listener: _start_resource_monitoring 13:00:30 INFO - Starting resource monitoring. 13:00:30 INFO - [mozharness: 2016-08-15 20:00:30.336622Z] Finished create-virtualenv step (success) 13:00:30 INFO - [mozharness: 2016-08-15 20:00:30.337129Z] Running install step. 13:00:30 INFO - Running pre-action listener: _resource_record_pre_action 13:00:30 INFO - Running main action method: install 13:00:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:00:30 INFO - Reading from file tmpfile_stdout 13:00:30 INFO - Detecting whether we're running mozinstall >=1.0... 13:00:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:00:30 INFO - Reading from file tmpfile_stdout 13:00:30 INFO - Output received: 13:00:30 INFO - Usage: mozinstall [options] installer 13:00:30 INFO - Options: 13:00:30 INFO - -h, --help show this help message and exit 13:00:30 INFO - -d DEST, --destination=DEST 13:00:30 INFO - Directory to install application into. [default: 13:00:30 INFO - "/builds/slave/test"] 13:00:30 INFO - --app=APP Application being installed. [default: firefox] 13:00:30 INFO - mkdir: /builds/slave/test/build/application 13:00:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:00:46 INFO - Reading from file tmpfile_stdout 13:00:46 INFO - Output received: 13:00:46 INFO - /builds/slave/test/build/application/firefox/firefox 13:00:46 INFO - Running post-action listener: _resource_record_post_action 13:00:46 INFO - [mozharness: 2016-08-15 20:00:46.654892Z] Finished install step (success) 13:00:46 INFO - [mozharness: 2016-08-15 20:00:46.655226Z] Running run-tests step. 13:00:46 INFO - Running pre-action listener: _resource_record_pre_action 13:00:46 INFO - Running main action method: run_tests 13:00:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:00:46 INFO - Python 2.7.3 13:00:46 INFO - Return code: 0 13:00:46 INFO - grabbing minidump binary from tooltool 13:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:00:46 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 0x2418090>, '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 0x241b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241be40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:00:46 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 13:00:46 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 13:00:46 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 13:00:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:00:46 INFO - Return code: 0 13:00:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:00:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:00:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:00:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:00:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:00:46 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/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 13:00:46 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/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 13:00:46 INFO - Using env: {'DISPLAY': ':0', 13:00:46 INFO - 'HOME': '/home/cltbld', 13:00:46 INFO - 'LANG': 'en_US.UTF-8', 13:00:46 INFO - 'LANGUAGE': 'en_US:en', 13:00:46 INFO - 'LOGNAME': 'cltbld', 13:00:46 INFO - 'MAIL': '/var/mail/cltbld', 13:00:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:00:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:46 INFO - 'MOZ_NO_REMOTE': '1', 13:00:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:46 INFO - 'NO_EM_RESTART': '1', 13:00:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:46 INFO - 'PWD': '/builds/slave/test', 13:00:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:00:46 INFO - 'SHELL': '/bin/bash', 13:00:46 INFO - 'SHLVL': '1', 13:00:46 INFO - 'TERM': 'linux', 13:00:46 INFO - 'TMOUT': '86400', 13:00:46 INFO - 'USER': 'cltbld', 13:00:46 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854', 13:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:46 INFO - '_': '/tools/buildbot/bin/python'} 13:00:46 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/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 13:00:46 INFO - mozversion application_buildid: 20160815114115 13:00:46 INFO - mozversion application_changeset: 9e8fb23fc565df8b8f002941e7dc12bced5df054 13:00:46 INFO - mozversion application_display_name: Nightly 13:00:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:00:46 INFO - mozversion application_name: Firefox 13:00:46 INFO - mozversion application_remotingname: firefox 13:00:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:00:46 INFO - mozversion application_vendor: Mozilla 13:00:46 INFO - mozversion application_version: 51.0a1 13:00:46 INFO - mozversion platform_buildid: 20160815114115 13:00:46 INFO - mozversion platform_changeset: 9e8fb23fc565df8b8f002941e7dc12bced5df054 13:00:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:00:46 INFO - mozversion platform_version: 51.0a1 13:00:46 INFO - using testdate: 1471291246 13:00:46 INFO - actual date: 1471291246 13:00:46 INFO - starting webserver on 'localhost:45686' 13:00:46 INFO - SUITE-START | Running 2 tests 13:00:46 INFO - TEST-START | dromaeo_css 13:00:46 INFO - operating with platform_type : linux_ 13:00:46 INFO - Initialising browser for dromaeo_css test... 13:00:46 INFO - TEST-INFO | started process 16655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeT6qGN/profile http://localhost:45686/getInfo.html) 13:00:51 INFO - PROCESS | 16655 | __metrics Screen width/height:1600/1200 13:00:51 INFO - PROCESS | 16655 | colorDepth:24 13:00:51 INFO - PROCESS | 16655 | Browser inner width/height: 1024/697 13:00:51 INFO - PROCESS | 16655 | __metrics 13:00:51 INFO - PROCESS | 16655 | 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" 13:00:51 INFO - PROCESS | 16655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:00:52 INFO - PROCESS | 16655 | console.error: PushService: 13:00:52 INFO - PROCESS | 16655 | stateChangeProcessEnqueue: Error transitioning state 13:00:52 INFO - PROCESS | 16655 | UnknownError 13:00:52 INFO - TEST-INFO | 16655: exit 0 13:00:52 INFO - Browser initialized. 13:00:52 INFO - Running cycle 1/1 for dromaeo_css test... 13:00:52 INFO - TEST-INFO | started process 16736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeT6qGN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:01:04 INFO - PROCESS | 16736 | RSS: Main: 157233152 13:01:04 INFO - PROCESS | 16736 | 13:01:55 INFO - PROCESS | 16736 | 1471291315766 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] 13:04:08 INFO - PROCESS | 16736 | Cycle 1(1): loaded http://localhost:45686/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45686/tests/dromaeo/cssquery-ext.html) 13:04:09 INFO - PROCESS | 16736 | RSS: Main: 249040896 13:04:09 INFO - PROCESS | 16736 | 13:07:12 INFO - PROCESS | 16736 | Cycle 1(1): loaded http://localhost:45686/tests/dromaeo/cssquery-ext.html (next: http://localhost:45686/tests/dromaeo/cssquery-jquery.html) 13:07:13 INFO - PROCESS | 16736 | RSS: Main: 248942592 13:07:13 INFO - PROCESS | 16736 | 13:10:15 INFO - PROCESS | 16736 | Cycle 1(1): loaded http://localhost:45686/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45686/tests/dromaeo/cssquery-mootools.html) 13:10:16 INFO - PROCESS | 16736 | RSS: Main: 221646848 13:10:16 INFO - PROCESS | 16736 | 13:13:18 INFO - PROCESS | 16736 | Cycle 1(1): loaded http://localhost:45686/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45686/tests/dromaeo/cssquery-prototype.html) 13:13:18 INFO - PROCESS | 16736 | RSS: Main: 190537728 13:13:18 INFO - PROCESS | 16736 | 13:16:22 INFO - PROCESS | 16736 | Cycle 1(1): loaded http://localhost:45686/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45686/tests/dromaeo/cssquery-yui.html) 13:16:22 INFO - PROCESS | 16736 | RSS: Main: 189706240 13:16:22 INFO - PROCESS | 16736 | 13:19:25 INFO - PROCESS | 16736 | Cycle 1(1): loaded http://localhost:45686/tests/dromaeo/cssquery-yui.html (next: http://localhost:45686/tests/dromaeo/cssquery-dojo.html) 13:19:26 INFO - PROCESS | 16736 | RSS: Main: 278720512 13:19:26 INFO - PROCESS | 16736 | 13:19:26 INFO - PROCESS | 16736 | __start_tp_report 13:19:26 INFO - PROCESS | 16736 | _x_x_mozilla_page_load 13:19:26 INFO - PROCESS | 16736 | _x_x_mozilla_page_load_details 13:19:26 INFO - PROCESS | 16736 | |i|pagename|runs| 13:19:26 INFO - PROCESS | 16736 | |0;dojo.html;2650.9734902650976;2671.0384261665786;2682.9731702682975;2686.435848471821;2692.0981471207156;4619.237825758746;4702.670813043088;4774.331593576898;4814.735189564577;4827.806887724491;4750.596199323053;4759.738214398207;4769.976150119253;4786.473487916326;4822.421309442863;4334.284843000901;4336.284513055342;4414.3157810539415;4461.39771130898;4545.090981803636;4465.732056076629;4492.124035813002;4513.774311284439;4521.796519156645;4534.9773251133865;4309.547497512779;4354.891127721832;4356.085222103362;4362.323839804835;4363.934540981888;4340.110277393127;4350.825966961318;4354.390385346054;4372.803223854934;4474.82100715971;4377.627901628365;4382.693211475198;4391.956080439187;4402.911941761146;4419.071994881079;4596.080783843245;4727.030958653468;4774.259989701602;4779.187538118494;4806.447258565275;5131;5173.508516690908;5179.585633149339;5227.398849132361;5230.241614965808;5216.321878155815;5234.18870075139;5234.790608375661;5238.214267859814;5263.499967503081;4623.930641040387;4724.433068031858;4750.5249475052215;4838.6371022173125;4891.9755401222765;5254.13306804373;5271.156614941668;5306.389765177054;5316.548093412026;5318.813841515528;5010.849674509771;5056.06462804375;5060.898782024339;5061.72160531167;5064.366954130734;5054.393472783289;5077.746112694351;5111.5655169310285;5133.563647090039;5183.663061900965;5113.207452844815;5119.283300337956;5119.334486516804;5139.743012849342;5157.510036546522;5096.847094587169;5106.514881086291;5108.131617625013;5108.642395032312;5114.590832733373;4200.936985945214;4243.554426785205;4272.487301523837;4324.567543245713;4372.322290045048;3749.9062523436587;3770.453284273765;3800;3820.4842346283453;3840.7695538267794;4461.219286624828;4464.464264288306;4466;4470.061287129674;4506.662000349987;4957.281194226817;5078.339815823919;5163.7676304566385;5175.637705360664;5230.189320655304;4410.184115938561;4429.49060857999;4477.686561940633;4480.9103817924115;4482.081173359518;4590.196715574761;4602.125596136723;4604.677672562889;4607.3319368691355;4656.16189085961;4709.0817290628;4841.8547443576745;4844.46710861812;4860.119047619048;4921.114199444134;5107.284980102714;5152.227165925141;5153.098207813543;5203.24552939814;5222.7127507987425;4905.043516514245;4908.410990681141;4918.778654960607;4923.753812309298;4967.279744437109;4923.286123511999;5098.260752190986;5101.413337466239;5106.336176297058;5109.131447653834;5095.643304968765;5132.79468821243;5150.0987327216835;5178.818741344035;5213.061648903234;5026.572741317029;5044.167712327425;5044.520770526794;5047.772850221822;5084.8220312288895;4821.228603423436;5030.6730062547285;5040.042391945519;5041.571466425395;5045.672031317952;4882.829100981448;4898.093852637274;4947.802087916443;5026.748662566784;5026.798928042837;5083.466236045162;5086.567641750345;5094.719790411563;5095.464976177448;5133.153029750049;4793.976030119967;4989.451160372429;4989.900201996013;4991.975040124777;5023.422306434807 13:19:26 INFO - PROCESS | 16736 | |1;ext.html;550.5320477594045;571.2716286734416;578.3869098755317;585.9003969325214;587.541717460381;27993;37006;38222.617773822254;38277.04307392317;42445.151096978116;38645.42031869524;39127.60872391275;39129.21741565167;39134.608653913456;39149;7180.28197180283;7532.585707786069;7653.043369578802;7664.540127592362;7676.961615191916;7230.27697230278;7452.366548843354;7461.664225109883;9660.468674222915;9894.703158905244;10033.548490317917;10068.14420774235;10079.244056695741;10081.546330415113;10092.444915529642;9869.062439068277;9918.008199180133;9931;9935.503224838729;9938.354006989595;9674.90325096747;9768.755781105529;9771.706848794547;9776.31565790395;9782.706518804447;34846.47730284023;35229;35264.647353526394;35306.11734706653;35322;3101.6278046634325;3161.462551366273;3168.984155079233;3224.1456014156265;3419.9658003419895;27364.863175684193;27809.860950695318;28094.43811123766;28116.718832811614;28175.71824281772;3281.261716113879;3402.336544373848;3430.9828450857585;3448.689617934398;3558.768680035789;242317.22924332198;242582;243141;243896;244635;27205.591916121273;49618;49816.75091624591;49817;49880.750596246784;32661.836690816395;32746.181345466553;32812.34375312528;32826.67173328284;32831.50752738711;12629.305388203737;12743.171693839871;12755.681107972376;12761.872381276255;12766;10371.94814025925;10483.895161048293;10484.056434920894;10484.895151048544;10486.580536778443;7160.641967901584;7504.924950750423;7701.191374905554;7765.068191816905;7904.051513818264;2997.6103106596;3079.276370053036;3095.520194369876;3114.065780265911;3138.074268090919;837.7486753973783;859.1880672764303;898.60910503931;917.3899356927568;941.5010044676333;25794.742052579233;27506.312342191606;28207;28208.717912820608;29346.706532934397;889.5818965086399;891.6567121658209;914.2457472585144;956.1232468599352;1023.698009087321;14872.851271487363;14890;14936;15081.924590377197;15117.244137793066;404718;411426;411962;413647;413918;46293.5370646296;46482.302765458546;46594.5340546597;46633.30050049184;46713.5328646716;1095.906847917936;1155.0528566575495;1173.23153334566;1204.4098391788136;1212.478634187308;26512.867435662698;28021.159365219075;28388.574171387034;29089;29166.562501562068;40265.396019060325;40740.1851962965;40820.79589602033;40851.18297633971;40874;249188;251174;251190;251488;251639;24705.629415558422;25905;25930.481390372464;26847.597286040334;26859.194224173305;41576;44313.77843110893;44893.55106448894;45967.54032459766;46005;35593;36158.09604759797;36236.63763362333;36540.90377288686;37172;34399.484007739404;35781.64218357887;36115.27769444544;36434.453483198304;36758;34887;34931;35651;36033.09917251985;36096.639033609325;30572.388552229277;32557.348853022333;32876.835615821765;32883.8355808229;32913.177170570925;24793.256202313958;25398.746012540378;25479;25759;25889.611655825556 13:19:26 INFO - PROCESS | 16736 | |2;jquery.html;345.5611373555586;363.34597724096636;371.90516418313337;379.22827046959435;387.4517557655917;12641.304728239955;15882;16415.261313240917;18207.18067686954;18446.538836529093;17035.318587256526;17182;17885.46343609694;18008.369707060254;18034.188461519232;4841.3222148899185;5027.698338099707;5103.438621751604;5121.5390614844655;5129.2562578426105;3740.1210715481975;5006.874828129307;5080.41575218849;5087.033463641915;5610.803621873235;5827.300723913137;5849.502792262663;5903.527717782588;5904.645721256738;5912.556558258127;5248.160294352923;5479.945200547983;5517.034518959166;5902.232709747748;5907.438793314628;5436.864078398072;5447;5449.209864569655;5449.83650490482;5462.508374246337;13976.161430314112;14518.709625807425;20477.692834607493;20622.484437889023;20672.58654826895;1951.3365455744972;1962.195499845071;1970.6551353513078;1990.3730324947596;2369.822263330257;9270.675526356545;9460.8580871287;9683;9770.36492627977;10873.728156796064;1711.8801683882134;1717.6736420080144;1731.6450127723785;1753.1584839277218;1764.4001039646453;65023.67488162576;65986.67006664984;67499.3250067498;67962.3203767961;69064.6546767268;9673.516324183904;9842.50787460624;9955.104040636377;10175.542100605491;10243.312407533282;13683.31583420825;13699.931500342434;13707.862921370857;13737.862621373859;13743;6803.93196068033;6894.620795856276;6908.032875397448;6908.689108990107;7130.536515126604;6463.224413070461;6490.156279683705;6692.899606505906;6699.43054840344;6716.261211266757;4254.29804082323;4321.373400856921;4346.065595896897;4413.470383553929;4463.888402789957;1724.2327164411715;1800.69388204003;1809.6018875847292;1809.9819001809813;1835.384861322028;819.6967122164838;827.6813426830713;834.4284165346756;872.2498651159997;904.3127223310331;16769.413070542472;16801.41195058167;16844.24200910962;17247;17795.19921603531;843.843888880559;850.7532815483564;855.6791203298762;869.9913000870037;882.571952602987;7063.71745130189;9481.620735170654;10086;10142.847857282146;10167.4916254187;370497;408914;409028;412248.32634204807;415310;76137.23862761301;77359.61320193476;79205;80194.59902700449;83402.16597834065;413.977231252278;437.27194221620647;437.68049323993665;438.4147163536714;438.54391432909415;9973.60105595768;10158.492075396349;10234.385936843813;10325.690229293134;10394.532246048795;33858.49212261867;35994.8200258997;36199.63800361963;38204.41547014376;39577.406338905515;43018;51523.22715159201;51902.221466678784;52053.21920171125;54090.72954635201;7692;7791.883121753292;7825.530468171928;7833.216678332349;8221.876671850046;11299.661010169708;12392.380380981096;12416.627501174979;12639.304838233986;12669.239845609292;10724;10791.298565593212;10792;10878.347299162075;11285.266457680225;10398.740031499274;10740.140788736726;10743.946280268548;10854.29447085937;10969.286996345212;10641.148708103488;11133.832992504957;11147.108231341635;11167.72080697989;11171.608993685182;7568.886466702894;7856.921430785619;7995.440319177835;8025.197480251928;8104.379124175306;9426.340156189;10857.077148442471;10860.891391086305;10916.672499825017;11114.888851111386 13:19:26 INFO - PROCESS | 16736 | |3;mootools.html;1242.2049888071642;1330.554264321452;1358.7554240236757;1402.2357814990828;1661.4683301343575;6667.499937504688;7365.742199023029;7776.416768742339;7778.338841198498;7974.082980457235;7694.384449244061;7787.9221207787905;7799.961000195005;7803.531788092719;7814.374850012;2178.673199020144;2201.5486825200796;2205.40454077399;2206.3270702435752;2208.6576580630026;2132.648113061343;2178.891055447229;2184.5740080684272;2188.9452763680874;2197.373748481683;2155.6766485027215;2173.1959175105153;2182.4107490977426;2182.443476913385;2183.2031308572414;2123.7132987046784;2126.5853158634072;2131.6482780341225;2134.5090629155225;2135.1032566322183;2057.7942205779304;2111.102781317934;2113.3342996955907;2113.640681084204;2114.809667129966;7578.924210757932;7664.233576642347;7755.8448831023625;7763.068431788165;7821.608919554056;4370.8033138508845;4560.429946256718;4561.612262957653;4564.8402305919135;4584.885377865547;2764.3365592257915;2849.928751781222;2885.7402833745064;2888.494513460157;2899.753520950722;875.1379890807549;882.7925437522177;893.4014210478995;899.8155378147464;905.1491597897955;10663.280863379867;10791.78416431667;10799.514021869034;10801.13590912733;10822.08012318946;3759.3609086455367;3936.9606303937167;3959.8812035638975;4117.5882411758585;4118.4440100586635;8385.371097167737;8394.45436046655;8419.579021048923;8438.57807109642;8447.155284471626;4485.955140448619;4487.416635837386;4489.326601009875;4489.551044895549;4490.506044335186;3524.8237588121006;3933.645971862546;4106.650934670527;4166.041810383629;4167.270727622654;3357.4292370297107;3390.271091715293;3502.9824850876093;3518.40187168182;3533.9149901558203;1001.2840818814583;1001.5693251901606;1002.5588740953957;1021.7701017271055;1032.6798692405227;716.2694052066863;811.5090370325868;815.09524427885;828.9544075075808;838.8196537744415;5009.5491405773655;5056.544910958031;5114.897702045938;5136.5377116059735;5225.869353266199;393.4688170969169;394.07589203318173;408.79151632667555;408.9959100408958;421.91983523130506;3286.4248756467523;3397.8980630580627;3418.880339188166;3421.7433692473164;3512.5082488451635;9169.174774270348;9554.092361225812;9624.470654113951;9625.181859541877;9627.422354658604;9425.245980321695;9447.102525260227;9479.620815167455;9485.4782986935;9504.334696571173;7040.2607726189035;7199.424046076406;7224.349808517259;7269.563826170447;7280.41756659466;4774.259989701602;4894.657373983787;4907.337509436323;4984.152694041949;5147.897042059213;8525;8678.956605216934;8736;8769.693060742844;8882.689105881263;8866.379353445454;8881.156290152425;8941.150590693873;9044.41211321262;9046.502442365732;5785.161151633074;5881.588288819741;6380.425761681471;6449.12936753551;6468.708908099241;7400.962995184989;7644.579548124907;7646.388288936983;7653.846923061619;7655.61721913891;6727.697253623501;6765.357291057342;6864.24493305746;6930.168379794457;7104.360607545345;6405.807825765234;6624.171978502687;6714.227863795726;6735.360140786617;6796.184457865088;5612.045952188057;5665.631733937281;5673.716314184192;5674.092145256905;5698.287714035746;4321.438213032286;4537.5008749036915;4599.1721490132095;4640.443146822403;4644.86065418038;4472.239719247671;4498.977505112453;4586.747728874944;4620.5148459411275;4644.047970166175 13:19:26 INFO - PROCESS | 16736 | |4;prototype.html;295.52420602829443;297.27168437328544;305.978581499295;307.0634564578036;307.15379130495484;4868.488808675087;4879.634027447938;4893.877653058676;4910.828121015765;4916.557509824115;4798.808047678098;4838.879028024301;4857.975710121454;4859.58693511052;4863.902721945559;3581.2658405027037;3675.356812557805;3710.610385909481;3777.490038844748;3824.388097904322;3806.5622453417795;3820.6752426043818;3822.2737679840743;3828.4831547741114;3844.6539811416965;3792.620737926199;3798.8670396536127;3801.980990095046;3805;3809.923801523968;3610.205754733954;3655.5613326400735;3755.9812200939095;3791.9810400948095;3792.867249646249;3362.7982321060813;3367.3938691035605;3368.511565822942;3379.307242015381;3386.2888793353427;4672.929906051412;4687.22660760974;4696.87275053988;4698.154332220199;4705.494241842612;4208;4311.655067594585;4332;4348.826046958118;4353;4998;5030.446650868402;5041.470645582234;5050.399044492053;5050.924236136461;3673.6142705016123;3678.1976831352713;3680.7055435565358;3687.2625474905126;3691.0990839717565;5044.798208071673;5274.156135018378;5279.980821863079;5281.841544753625;5285.154375299933;3649.1424515238896;3661.23114146027;3663.413853783382;3671.8714844980295;3684.465752465931;3725.6646901778427;3727.105494681257;3729.9369679641713;3730.0861288984374;3730.552333719971;4079.8164082616354;4227.260229459832;4254.595813397722;4264.6801489888385;4269.316909294498;5063.531575843038;5076.949230507647;5082.475257422759;5083.2375143727995;5093.490650934951;1263.3746295583744;1285.1517998121194;1288.948442062307;1298;1299.8310219671382;825.3603457320504;825.8389614025327;838.3795990966763;839.3285371702614;847.546562589012;4472.552744725502;4491.550844915482;4503.684742068024;4522.163399771053;4522.977385113119;5084.669496482717;5143.27994080829;5182.274481572583;5183.663061900965;5196.32447781786;4346.2828633275785;4475.657302809144;4478.305862591304;4480.678199931028;4487.932681009787;2738.2332946774936;2750.642416485884;2754.187514683173;2757.9172624821285;2767.5710264908566;4897.534734200245;4904.632152588499;4923.433805112386;4927.5811556017425;4927.827526036572;5045.293658887758;5232.1628539433505;5258.894822103536;5262.578993680573;5289.523942845162;4874.147024270667;4909.68087074339;4911.705297682151;4913.533214344631;4928.753562321869;5135.204043373283;5143.228515722672;5159.613029022763;5161.483851614958;5178.61160412963;4933;5055.848324550269;5058.570021548062;5062.861026163802;5075.873103172303;4916.3362946001835;4917.975410123069;4918.5819205366515;4921.3356196912955;4935.555799978019;3655.5065066216785;3661.7367008382066;3664.6885014774043;3665.376885929452;3668.559772827171;4891.461939186758;5123.23151527259;5141.7686204120155;5154.819581314636;5173.611979101658;5015.899682006412;5017.222330538772;5041.495850415075;5044.419891712353;5048.823291184791;4984.280423253972;5017.874553136055;5053.31780209667;5054.444011158843;5056.64603477753;4696.201645720167;4956.578690811321;4976.178930476431;4988.428644976821;4996.975015125046;4859.2954021667365;4976.576990955809;5100.719460429712;5125.231215317732;5127.948720512896;5012.523810238022;5028.270900719302;5036;5036.424138861303;5046.697198168122 13:19:26 INFO - PROCESS | 16736 | |5;yui.html;628.8930881750102;633.8527265649176;641.5028353026405;681.3765404654741;725.4812808841679;12885.613431597056;13460.865391346084;13477.865221347784;13478.797818032714;13480.730385392299;12957.61127166184;13071.869281307185;13105.082644214908;13174.670633234175;13197.80203296949;611.3763960760023;731.7000029987706;750.5271678842322;767.6085196549744;776.5884081436848;776.0454640791829;776.9184235655259;777.8522080804657;780.3133242746376;781.0354212547528;820.3560205238889;820.7660816667251;821.5112008355019;822.1490757066438;824.4929368438397;655.0632595388616;775.7556369743513;812.553095797315;816.6896579299887;822.6092606012156;599.4724642314735;600.9609375390629;601.8675891303906;603.7615142018922;604.0486234181183;12207.145499815017;12209.45057472407;12234.877651223464;12247.632571022883;12259.509619615204;12379.876201238052;12645.810312845315;13066.150700204456;13186.07697461178;13290.54368605082;11352.489137988729;11451;11620.477078531487;11723.824142637868;11898.524059037629;3240.416724989501;4057.9391309130388;4094.263032654121;4137.8758637240935;4146.502419709624;59168;59277.703611481666;59761.40238597602;59979.800403992114;60664.696676516774;10233.744156396;10276.588936442608;10449.68650940473;10627.84058239127;10711.73220669474;18619;18866.71699924502;18903.3383831568;18987.905060474885;18990.430287091134;7030.402415794612;7105.25394833535;7144.428445724329;7342.70629174827;7456.701731930662;3749.4563288323584;3755.267722794029;3792.089898424358;3848.230353929225;3899.3760998240145;2899.6230490036583;2989.6113505244616;3018.170003249124;3023.3953209358215;3026.9545956810666;522.6506703885726;525.6767088240781;526.8024490815944;527.8785879247718;537.6612733977569;490.02589003184147;521.2389910730376;553.8559974406684;556.7049463784201;568.883378907323;7378.483506154625;7695.730649427243;7935.246151615587;8016.438849280495;8083.221342889828;549.5576061270635;573.9282589676291;579.1168468086119;587.0607028753959;588.2646691635456;3625.546806649169;3647.343478173901;3679.9448008279896;3778.8677396290996;3917.4319723640483;58337;59266;101225.49387253165;102309.48845255726;103136.48431757944;51286.48713512892;69296.30703693;84775.15224847796;85319;85912;65137;77239.61380193062;78248.30654635416;79204.60397697975;80478.59760701393;6982.581045137308;7282.6722797473185;7285.562866228043;7342;7391.704331826882;45468.54531454775;45961.77019114883;46369.304460432446;47290;47415.52584474111;38427.615723842406;38904;39100;52202.73898630482;64380.67809660922;9377.484238366955;9786.657466988621;9927.751806204902;9952.900470995197;10072.143867771321;11282;11454.885451145716;11471.827922581;12186.329751863732;12198.878011219775;10149.289549731448;10200;10207.132393746615;11073.889261107608;11088.168387370819;9705.6603018894;9809.55856986423;9985.1512621428;10494.632687855888;10716.89283107159;9508.429494230368;9753.902460975583;10003.449810260505;10064.144547713526;10419.010194031554;8621.568921553771;8816.426932249384;8894.822103558023;8960.417572857743;9136.862947055666;8219.383546233938;8443.366747494085;8772.385932984886;8778.297736180963;8933.374663773473 13:19:26 INFO - PROCESS | 16736 | __end_tp_report 13:19:26 INFO - PROCESS | 16736 | __start_cc_report 13:19:26 INFO - PROCESS | 16736 | _x_x_mozilla_cycle_collect,1052 13:19:26 INFO - PROCESS | 16736 | __end_cc_report 13:19:26 INFO - PROCESS | 16736 | __startTimestamp1471292366076__endTimestamp 13:19:26 INFO - PROCESS | 16736 | 13:19:26 INFO - PROCESS | 16736 | ------- Summary: start ------- 13:19:26 INFO - PROCESS | 16736 | Number of tests: 6 13:19:26 INFO - PROCESS | 16736 | 13:19:26 INFO - PROCESS | 16736 | [#0] dojo.html Cycles:165 Average:4752.13 Median:4898.09 stddev:508.40 (10.4%) stddev-sans-first:482.50 13:19:26 INFO - PROCESS | 16736 | Values: 2651.0 2671.0 2683.0 2686.4 2692.1 4619.2 4702.7 4774.3 4814.7 4827.8 4750.6 4759.7 4770.0 4786.5 4822.4 4334.3 4336.3 4414.3 4461.4 4545.1 4465.7 4492.1 4513.8 4521.8 4535.0 4309.5 4354.9 4356.1 4362.3 4363.9 4340.1 4350.8 4354.4 4372.8 4474.8 4377.6 4382.7 4392.0 4402.9 4419.1 4596.1 4727.0 4774.3 4779.2 4806.4 5131.0 5173.5 5179.6 5227.4 5230.2 5216.3 5234.2 5234.8 5238.2 5263.5 4623.9 4724.4 4750.5 4838.6 4892.0 5254.1 5271.2 5306.4 5316.5 5318.8 5010.8 5056.1 5060.9 5061.7 5064.4 5054.4 5077.7 5111.6 5133.6 5183.7 5113.2 5119.3 5119.3 5139.7 5157.5 5096.8 5106.5 5108.1 5108.6 5114.6 4200.9 4243.6 4272.5 4324.6 4372.3 3749.9 3770.5 3800.0 3820.5 3840.8 4461.2 4464.5 4466.0 4470.1 4506.7 4957.3 5078.3 5163.8 5175.6 5230.2 4410.2 4429.5 4477.7 4480.9 4482.1 4590.2 4602.1 4604.7 4607.3 4656.2 4709.1 4841.9 4844.5 4860.1 4921.1 5107.3 5152.2 5153.1 5203.2 5222.7 4905.0 4908.4 4918.8 4923.8 4967.3 4923.3 5098.3 5101.4 5106.3 5109.1 5095.6 5132.8 5150.1 5178.8 5213.1 5026.6 5044.2 5044.5 5047.8 5084.8 4821.2 5030.7 5040.0 5041.6 5045.7 4882.8 4898.1 4947.8 5026.7 5026.8 5083.5 5086.6 5094.7 5095.5 5133.2 4794.0 4989.5 4989.9 4992.0 5023.4 13:19:26 INFO - PROCESS | 16736 | 13:19:26 INFO - PROCESS | 16736 | [#1] ext.html Cycles:180 Average:44626.22 Median:35080.00 stddev:82266.66 (234.5%) stddev-sans-first:82430.88 13:19:26 INFO - PROCESS | 16736 | Values: 550.5 571.3 578.4 585.9 587.5 27993.0 37006.0 38222.6 38277.0 42445.2 38645.4 39127.6 39129.2 39134.6 39149.0 7180.3 7532.6 7653.0 7664.5 7677.0 7230.3 7452.4 7461.7 9660.5 9894.7 10033.5 10068.1 10079.2 10081.5 10092.4 9869.1 9918.0 9931.0 9935.5 9938.4 9674.9 9768.8 9771.7 9776.3 9782.7 34846.5 35229.0 35264.6 35306.1 35322.0 3101.6 3161.5 3169.0 3224.1 3420.0 27364.9 27809.9 28094.4 28116.7 28175.7 3281.3 3402.3 3431.0 3448.7 3558.8 242317.2 242582.0 243141.0 243896.0 244635.0 27205.6 49618.0 49816.8 49817.0 49880.8 32661.8 32746.2 32812.3 32826.7 32831.5 12629.3 12743.2 12755.7 12761.9 12766.0 10371.9 10483.9 10484.1 10484.9 10486.6 7160.6 7504.9 7701.2 7765.1 7904.1 2997.6 3079.3 3095.5 3114.1 3138.1 837.7 859.2 898.6 917.4 941.5 25794.7 27506.3 28207.0 28208.7 29346.7 889.6 891.7 914.2 956.1 1023.7 14872.9 14890.0 14936.0 15081.9 15117.2 404718.0 411426.0 411962.0 413647.0 413918.0 46293.5 46482.3 46594.5 46633.3 46713.5 1095.9 1155.1 1173.2 1204.4 1212.5 26512.9 28021.2 28388.6 29089.0 29166.6 40265.4 40740.2 40820.8 40851.2 40874.0 249188.0 251174.0 251190.0 251488.0 251639.0 24705.6 25905.0 25930.5 26847.6 26859.2 41576.0 44313.8 44893.6 45967.5 46005.0 35593.0 36158.1 36236.6 36540.9 37172.0 34399.5 35781.6 36115.3 36434.5 36758.0 34887.0 34931.0 35651.0 36033.1 36096.6 30572.4 32557.3 32876.8 32883.8 32913.2 24793.3 25398.7 25479.0 25759.0 25889.6 13:19:26 INFO - PROCESS | 16736 | 13:19:26 INFO - PROCESS | 16736 | [#2] jquery.html Cycles:180 Average:24536.91 Median:209782.15 stddev:66577.77 (31.7%) stddev-sans-first:66739.76 13:19:26 INFO - PROCESS | 16736 | Values: 345.6 363.3 371.9 379.2 387.5 12641.3 15882.0 16415.3 18207.2 18446.5 17035.3 17182.0 17885.5 18008.4 18034.2 4841.3 5027.7 5103.4 5121.5 5129.3 3740.1 5006.9 5080.4 5087.0 5610.8 5827.3 5849.5 5903.5 5904.6 5912.6 5248.2 5479.9 5517.0 5902.2 5907.4 5436.9 5447.0 5449.2 5449.8 5462.5 13976.2 14518.7 20477.7 20622.5 20672.6 1951.3 1962.2 1970.7 1990.4 2369.8 9270.7 9460.9 9683.0 9770.4 10873.7 1711.9 1717.7 1731.6 1753.2 1764.4 65023.7 65986.7 67499.3 67962.3 69064.7 9673.5 9842.5 9955.1 10175.5 10243.3 13683.3 13699.9 13707.9 13737.9 13743.0 6803.9 6894.6 6908.0 6908.7 7130.5 6463.2 6490.2 6692.9 6699.4 6716.3 4254.3 4321.4 4346.1 4413.5 4463.9 1724.2 1800.7 1809.6 1810.0 1835.4 819.7 827.7 834.4 872.2 904.3 16769.4 16801.4 16844.2 17247.0 17795.2 843.8 850.8 855.7 870.0 882.6 7063.7 9481.6 10086.0 10142.8 10167.5 370497.0 408914.0 409028.0 412248.3 415310.0 76137.2 77359.6 79205.0 80194.6 83402.2 414.0 437.3 437.7 438.4 438.5 9973.6 10158.5 10234.4 10325.7 10394.5 33858.5 35994.8 36199.6 38204.4 39577.4 43018.0 51523.2 51902.2 52053.2 54090.7 7692.0 7791.9 7825.5 7833.2 8221.9 11299.7 12392.4 12416.6 12639.3 12669.2 10724.0 10791.3 10792.0 10878.3 11285.3 10398.7 10740.1 10743.9 10854.3 10969.3 10641.1 11133.8 11147.1 11167.7 11171.6 7568.9 7856.9 7995.4 8025.2 8104.4 9426.3 10857.1 10860.9 10916.7 11114.9 13:19:26 INFO - PROCESS | 16736 | 13:19:26 INFO - PROCESS | 16736 | [#3] mootools.html Cycles:180 Average:5006.05 Median:4834.46 stddev:2865.90 (59.3%) stddev-sans-first:2859.98 13:19:26 INFO - PROCESS | 16736 | Values: 1242.2 1330.6 1358.8 1402.2 1661.5 6667.5 7365.7 7776.4 7778.3 7974.1 7694.4 7787.9 7800.0 7803.5 7814.4 2178.7 2201.5 2205.4 2206.3 2208.7 2132.6 2178.9 2184.6 2188.9 2197.4 2155.7 2173.2 2182.4 2182.4 2183.2 2123.7 2126.6 2131.6 2134.5 2135.1 2057.8 2111.1 2113.3 2113.6 2114.8 7578.9 7664.2 7755.8 7763.1 7821.6 4370.8 4560.4 4561.6 4564.8 4584.9 2764.3 2849.9 2885.7 2888.5 2899.8 875.1 882.8 893.4 899.8 905.1 10663.3 10791.8 10799.5 10801.1 10822.1 3759.4 3937.0 3959.9 4117.6 4118.4 8385.4 8394.5 8419.6 8438.6 8447.2 4486.0 4487.4 4489.3 4489.6 4490.5 3524.8 3933.6 4106.7 4166.0 4167.3 3357.4 3390.3 3503.0 3518.4 3533.9 1001.3 1001.6 1002.6 1021.8 1032.7 716.3 811.5 815.1 829.0 838.8 5009.5 5056.5 5114.9 5136.5 5225.9 393.5 394.1 408.8 409.0 421.9 3286.4 3397.9 3418.9 3421.7 3512.5 9169.2 9554.1 9624.5 9625.2 9627.4 9425.2 9447.1 9479.6 9485.5 9504.3 7040.3 7199.4 7224.3 7269.6 7280.4 4774.3 4894.7 4907.3 4984.2 5147.9 8525.0 8679.0 8736.0 8769.7 8882.7 8866.4 8881.2 8941.2 9044.4 9046.5 5785.2 5881.6 6380.4 6449.1 6468.7 7401.0 7644.6 7646.4 7653.8 7655.6 6727.7 6765.4 6864.2 6930.2 7104.4 6405.8 6624.2 6714.2 6735.4 6796.2 5612.0 5665.6 5673.7 5674.1 5698.3 4321.4 4537.5 4599.2 4640.4 4644.9 4472.2 4499.0 4586.7 4620.5 4644.0 13:19:26 INFO - PROCESS | 16736 | 13:19:26 INFO - PROCESS | 16736 | [#4] prototype.html Cycles:180 Average:4196.87 Median:4861.74 stddev:1213.78 (25.0%) stddev-sans-first:1181.33 13:19:26 INFO - PROCESS | 16736 | Values: 295.5 297.3 306.0 307.1 307.2 4868.5 4879.6 4893.9 4910.8 4916.6 4798.8 4838.9 4858.0 4859.6 4863.9 3581.3 3675.4 3710.6 3777.5 3824.4 3806.6 3820.7 3822.3 3828.5 3844.7 3792.6 3798.9 3802.0 3805.0 3809.9 3610.2 3655.6 3756.0 3792.0 3792.9 3362.8 3367.4 3368.5 3379.3 3386.3 4672.9 4687.2 4696.9 4698.2 4705.5 4208.0 4311.7 4332.0 4348.8 4353.0 4998.0 5030.4 5041.5 5050.4 5050.9 3673.6 3678.2 3680.7 3687.3 3691.1 5044.8 5274.2 5280.0 5281.8 5285.2 3649.1 3661.2 3663.4 3671.9 3684.5 3725.7 3727.1 3729.9 3730.1 3730.6 4079.8 4227.3 4254.6 4264.7 4269.3 5063.5 5076.9 5082.5 5083.2 5093.5 1263.4 1285.2 1288.9 1298.0 1299.8 825.4 825.8 838.4 839.3 847.5 4472.6 4491.6 4503.7 4522.2 4523.0 5084.7 5143.3 5182.3 5183.7 5196.3 4346.3 4475.7 4478.3 4480.7 4487.9 2738.2 2750.6 2754.2 2757.9 2767.6 4897.5 4904.6 4923.4 4927.6 4927.8 5045.3 5232.2 5258.9 5262.6 5289.5 4874.1 4909.7 4911.7 4913.5 4928.8 5135.2 5143.2 5159.6 5161.5 5178.6 4933.0 5055.8 5058.6 5062.9 5075.9 4916.3 4918.0 4918.6 4921.3 4935.6 3655.5 3661.7 3664.7 3665.4 3668.6 4891.5 5123.2 5141.8 5154.8 5173.6 5015.9 5017.2 5041.5 5044.4 5048.8 4984.3 5017.9 5053.3 5054.4 5056.6 4696.2 4956.6 4976.2 4988.4 4997.0 4859.3 4976.6 5100.7 5125.2 5127.9 5012.5 5028.3 5036.0 5036.4 5046.7 13:19:26 INFO - PROCESS | 16736 | 13:19:26 INFO - PROCESS | 16736 | [#5] yui.html Cycles:180 Average:16503.31 Median:543.61 stddev:23473.14 (4318.0%) stddev-sans-first:23508.73 13:19:26 INFO - PROCESS | 16736 | Values: 628.9 633.9 641.5 681.4 725.5 12885.6 13460.9 13477.9 13478.8 13480.7 12957.6 13071.9 13105.1 13174.7 13197.8 611.4 731.7 750.5 767.6 776.6 776.0 776.9 777.9 780.3 781.0 820.4 820.8 821.5 822.1 824.5 655.1 775.8 812.6 816.7 822.6 599.5 601.0 601.9 603.8 604.0 12207.1 12209.5 12234.9 12247.6 12259.5 12379.9 12645.8 13066.2 13186.1 13290.5 11352.5 11451.0 11620.5 11723.8 11898.5 3240.4 4057.9 4094.3 4137.9 4146.5 59168.0 59277.7 59761.4 59979.8 60664.7 10233.7 10276.6 10449.7 10627.8 10711.7 18619.0 18866.7 18903.3 18987.9 18990.4 7030.4 7105.3 7144.4 7342.7 7456.7 3749.5 3755.3 3792.1 3848.2 3899.4 2899.6 2989.6 3018.2 3023.4 3027.0 522.7 525.7 526.8 527.9 537.7 490.0 521.2 553.9 556.7 568.9 7378.5 7695.7 7935.2 8016.4 8083.2 549.6 573.9 579.1 587.1 588.3 3625.5 3647.3 3679.9 3778.9 3917.4 58337.0 59266.0 101225.5 102309.5 103136.5 51286.5 69296.3 84775.2 85319.0 85912.0 65137.0 77239.6 78248.3 79204.6 80478.6 6982.6 7282.7 7285.6 7342.0 7391.7 45468.5 45961.8 46369.3 47290.0 47415.5 38427.6 38904.0 39100.0 52202.7 64380.7 9377.5 9786.7 9927.8 9952.9 10072.1 11282.0 11454.9 11471.8 12186.3 12198.9 10149.3 10200.0 10207.1 11073.9 11088.2 9705.7 9809.6 9985.2 10494.6 10716.9 9508.4 9753.9 10003.4 10064.1 10419.0 8621.6 8816.4 8894.8 8960.4 9136.9 8219.4 8443.4 8772.4 8778.3 8933.4 13:19:26 INFO - PROCESS | 16736 | -------- Summary: end -------- 13:19:26 INFO - PROCESS | 16736 | 13:19:26 INFO - TEST-INFO | 16736: exit 0 13:19:26 INFO - TEST-OK | dromaeo_css | took 1119947ms 13:19:26 INFO - TEST-START | kraken 13:19:26 INFO - operating with platform_type : linux_ 13:19:26 INFO - Initialising browser for kraken test... 13:19:26 INFO - TEST-INFO | started process 17040 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEqNNRT/profile http://localhost:45686/getInfo.html) 13:19:30 INFO - PROCESS | 17040 | __metrics Screen width/height:1600/1200 13:19:30 INFO - PROCESS | 17040 | colorDepth:24 13:19:30 INFO - PROCESS | 17040 | Browser inner width/height: 1024/697 13:19:30 INFO - PROCESS | 17040 | __metrics 13:19:31 INFO - PROCESS | 17040 | 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" 13:19:31 INFO - PROCESS | 17040 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:19:31 INFO - PROCESS | 17040 | console.error: PushService: 13:19:31 INFO - PROCESS | 17040 | stateChangeProcessEnqueue: Error transitioning state 13:19:31 INFO - PROCESS | 17040 | UnknownError 13:19:32 INFO - TEST-INFO | 17040: exit 0 13:19:32 INFO - Browser initialized. 13:19:32 INFO - Running cycle 1/1 for kraken test... 13:19:32 INFO - TEST-INFO | started process 17121 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEqNNRT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:19:44 INFO - PROCESS | 17121 | RSS: Main: 157356032 13:19:44 INFO - PROCESS | 17121 | 13:19:47 INFO - PROCESS | 17121 | Cycle 1(1): loaded http://localhost:45686/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45686/tests/kraken/driver.html?testName=audio-beat-detection) 13:19:48 INFO - PROCESS | 17121 | RSS: Main: 205225984 13:19:48 INFO - PROCESS | 17121 | 13:19:50 INFO - PROCESS | 17121 | Cycle 1(1): loaded http://localhost:45686/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45686/tests/kraken/driver.html?testName=audio-dft) 13:19:51 INFO - PROCESS | 17121 | RSS: Main: 196886528 13:19:51 INFO - PROCESS | 17121 | 13:19:54 INFO - PROCESS | 17121 | Cycle 1(1): loaded http://localhost:45686/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45686/tests/kraken/driver.html?testName=audio-fft) 13:19:55 INFO - PROCESS | 17121 | RSS: Main: 277860352 13:19:55 INFO - PROCESS | 17121 | 13:19:57 INFO - PROCESS | 17121 | Cycle 1(1): loaded http://localhost:45686/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45686/tests/kraken/driver.html?testName=audio-oscillator) 13:19:58 INFO - PROCESS | 17121 | RSS: Main: 187248640 13:19:58 INFO - PROCESS | 17121 | 13:20:00 INFO - PROCESS | 17121 | Cycle 1(1): loaded http://localhost:45686/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45686/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:20:00 INFO - PROCESS | 17121 | RSS: Main: 191709184 13:20:00 INFO - PROCESS | 17121 | 13:20:04 INFO - PROCESS | 17121 | Cycle 1(1): loaded http://localhost:45686/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45686/tests/kraken/driver.html?testName=imaging-darkroom) 13:20:04 INFO - PROCESS | 17121 | RSS: Main: 228646912 13:20:04 INFO - PROCESS | 17121 | 13:20:08 INFO - PROCESS | 17121 | Cycle 1(1): loaded http://localhost:45686/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45686/tests/kraken/driver.html?testName=imaging-desaturate) 13:20:08 INFO - PROCESS | 17121 | RSS: Main: 222089216 13:20:08 INFO - PROCESS | 17121 | 13:20:11 INFO - PROCESS | 17121 | Cycle 1(1): loaded http://localhost:45686/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45686/tests/kraken/driver.html?testName=json-parse-financial) 13:20:12 INFO - PROCESS | 17121 | RSS: Main: 225538048 13:20:12 INFO - PROCESS | 17121 | 13:20:14 INFO - PROCESS | 17121 | Cycle 1(1): loaded http://localhost:45686/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45686/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:20:14 INFO - PROCESS | 17121 | RSS: Main: 188923904 13:20:14 INFO - PROCESS | 17121 | 13:20:16 INFO - PROCESS | 17121 | Cycle 1(1): loaded http://localhost:45686/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45686/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:20:17 INFO - PROCESS | 17121 | RSS: Main: 196333568 13:20:17 INFO - PROCESS | 17121 | 13:20:19 INFO - PROCESS | 17121 | Cycle 1(1): loaded http://localhost:45686/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45686/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:20:20 INFO - PROCESS | 17121 | RSS: Main: 193458176 13:20:20 INFO - PROCESS | 17121 | 13:20:22 INFO - PROCESS | 17121 | Cycle 1(1): loaded http://localhost:45686/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45686/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:20:23 INFO - PROCESS | 17121 | RSS: Main: 188596224 13:20:23 INFO - PROCESS | 17121 | 13:20:26 INFO - PROCESS | 17121 | Cycle 1(1): loaded http://localhost:45686/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45686/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:20:27 INFO - PROCESS | 17121 | RSS: Main: 192417792 13:20:27 INFO - PROCESS | 17121 | 13:20:28 INFO - PROCESS | 17121 | Cycle 1(1): loaded http://localhost:45686/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45686/tests/kraken/driver.html?testName=ai-astar) 13:20:29 INFO - PROCESS | 17121 | RSS: Main: 242487296 13:20:29 INFO - PROCESS | 17121 | 13:20:29 INFO - PROCESS | 17121 | __start_tp_report 13:20:29 INFO - PROCESS | 17121 | _x_x_mozilla_page_load 13:20:29 INFO - PROCESS | 17121 | _x_x_mozilla_page_load_details 13:20:29 INFO - PROCESS | 17121 | |i|pagename|runs| 13:20:29 INFO - PROCESS | 17121 | |0;ai-astar;105;115;114;115;109;114;114;114;113;113 13:20:29 INFO - PROCESS | 17121 | |1;audio-beat-detection;148;120;122;184;122;122;148;120;154;122 13:20:29 INFO - PROCESS | 17121 | |2;audio-dft;161;161;161;161;162;162;161;160;162;161 13:20:29 INFO - PROCESS | 17121 | |3;audio-fft;77;78;76;114;77;77;75;76;114;75 13:20:29 INFO - PROCESS | 17121 | |4;audio-oscillator;87;86;141;87;86;86;115;91;87;134 13:20:29 INFO - PROCESS | 17121 | |5;imaging-gaussian-blur;118;117;117;117;116;117;117;116;116;116 13:20:29 INFO - PROCESS | 17121 | |6;imaging-darkroom;147;148;147;146;147;146;146;147;147;147 13:20:29 INFO - PROCESS | 17121 | |7;imaging-desaturate;94;94;95;95;96;95;95;94;94;94 13:20:29 INFO - PROCESS | 17121 | |8;json-parse-financial;62;60;63;62;62;65;64;63;64;63 13:20:29 INFO - PROCESS | 17121 | |9;json-stringify-tinderbox;65;66;66;66;66;67;66;66;67;69 13:20:29 INFO - PROCESS | 17121 | |10;stanford-crypto-aes;84;89;82;84;83;83;82;81;81;82 13:20:29 INFO - PROCESS | 17121 | |11;stanford-crypto-ccm;135;148;145;131;142;142;129;132;152;132 13:20:29 INFO - PROCESS | 17121 | |12;stanford-crypto-pbkdf2;175;172;176;173;172;173;172;176;170;172 13:20:29 INFO - PROCESS | 17121 | |13;stanford-crypto-sha256-iterative;68;72;67;71;68;68;67;68;68;67 13:20:29 INFO - PROCESS | 17121 | __end_tp_report 13:20:29 INFO - PROCESS | 17121 | __start_cc_report 13:20:29 INFO - PROCESS | 17121 | _x_x_mozilla_cycle_collect,1951 13:20:29 INFO - PROCESS | 17121 | __end_cc_report 13:20:29 INFO - PROCESS | 17121 | __startTimestamp1471292429189__endTimestamp 13:20:29 INFO - PROCESS | 17121 | 13:20:29 INFO - PROCESS | 17121 | ------- Summary: start ------- 13:20:29 INFO - PROCESS | 17121 | Number of tests: 14 13:20:29 INFO - PROCESS | 17121 | 13:20:29 INFO - PROCESS | 17121 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:3.17 (2.8%) stddev-sans-first:1.81 13:20:29 INFO - PROCESS | 17121 | Values: 105.0 115.0 114.0 115.0 109.0 114.0 114.0 114.0 113.0 113.0 13:20:29 INFO - PROCESS | 17121 | 13:20:29 INFO - PROCESS | 17121 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:135.00 stddev:21.63 (16.0%) stddev-sans-first:22.52 13:20:29 INFO - PROCESS | 17121 | Values: 148.0 120.0 122.0 184.0 122.0 122.0 148.0 120.0 154.0 122.0 13:20:29 INFO - PROCESS | 17121 | 13:20:29 INFO - PROCESS | 17121 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 13:20:29 INFO - PROCESS | 17121 | Values: 161.0 161.0 161.0 161.0 162.0 162.0 161.0 160.0 162.0 161.0 13:20:29 INFO - PROCESS | 17121 | 13:20:29 INFO - PROCESS | 17121 | [#3] audio-fft Cycles:10 Average:83.90 Median:76.50 stddev:15.89 (20.8%) stddev-sans-first:16.66 13:20:29 INFO - PROCESS | 17121 | Values: 77.0 78.0 76.0 114.0 77.0 77.0 75.0 76.0 114.0 75.0 13:20:29 INFO - PROCESS | 17121 | 13:20:29 INFO - PROCESS | 17121 | [#4] audio-oscillator Cycles:10 Average:100.00 Median:86.50 stddev:21.70 (25.1%) stddev-sans-first:22.50 13:20:29 INFO - PROCESS | 17121 | Values: 87.0 86.0 141.0 87.0 86.0 86.0 115.0 91.0 87.0 134.0 13:20:29 INFO - PROCESS | 17121 | 13:20:29 INFO - PROCESS | 17121 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 13:20:29 INFO - PROCESS | 17121 | Values: 118.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 116.0 13:20:29 INFO - PROCESS | 17121 | 13:20:29 INFO - PROCESS | 17121 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 13:20:29 INFO - PROCESS | 17121 | Values: 147.0 148.0 147.0 146.0 147.0 146.0 146.0 147.0 147.0 147.0 13:20:29 INFO - PROCESS | 17121 | 13:20:29 INFO - PROCESS | 17121 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 13:20:29 INFO - PROCESS | 17121 | Values: 94.0 94.0 95.0 95.0 96.0 95.0 95.0 94.0 94.0 94.0 13:20:29 INFO - PROCESS | 17121 | 13:20:29 INFO - PROCESS | 17121 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.00 stddev:1.40 (2.2%) stddev-sans-first:1.45 13:20:29 INFO - PROCESS | 17121 | Values: 62.0 60.0 63.0 62.0 62.0 65.0 64.0 63.0 64.0 63.0 13:20:29 INFO - PROCESS | 17121 | 13:20:29 INFO - PROCESS | 17121 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.00 stddev:1.07 (1.6%) stddev-sans-first:1.01 13:20:29 INFO - PROCESS | 17121 | Values: 65.0 66.0 66.0 66.0 66.0 67.0 66.0 66.0 67.0 69.0 13:20:29 INFO - PROCESS | 17121 | 13:20:29 INFO - PROCESS | 17121 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:2.33 (2.8%) stddev-sans-first:2.45 13:20:29 INFO - PROCESS | 17121 | Values: 84.0 89.0 82.0 84.0 83.0 83.0 82.0 81.0 81.0 82.0 13:20:29 INFO - PROCESS | 17121 | 13:20:29 INFO - PROCESS | 17121 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:142.00 stddev:8.04 (5.7%) stddev-sans-first:8.41 13:20:29 INFO - PROCESS | 17121 | Values: 135.0 148.0 145.0 131.0 142.0 142.0 129.0 132.0 152.0 132.0 13:20:29 INFO - PROCESS | 17121 | 13:20:29 INFO - PROCESS | 17121 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:173.00 stddev:1.97 (1.1%) stddev-sans-first:1.96 13:20:29 INFO - PROCESS | 17121 | Values: 175.0 172.0 176.0 173.0 172.0 173.0 172.0 176.0 170.0 172.0 13:20:29 INFO - PROCESS | 17121 | 13:20:29 INFO - PROCESS | 17121 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.00 stddev:1.71 (2.5%) stddev-sans-first:1.81 13:20:29 INFO - PROCESS | 17121 | Values: 68.0 72.0 67.0 71.0 68.0 68.0 67.0 68.0 68.0 67.0 13:20:29 INFO - PROCESS | 17121 | -------- Summary: end -------- 13:20:29 INFO - PROCESS | 17121 | 13:20:30 INFO - TEST-INFO | 17121: exit 0 13:20:30 INFO - TEST-OK | kraken | took 63381ms 13:20:30 INFO - SUITE-END | took 1183s 13:20:30 INFO - Completed test suite (00:19:43) 13:20:30 INFO - javascript benchmark 13:20:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2650.9734902650976, 2671.0384261665786, 2682.9731702682975, 2686.435848471821, 2692.0981471207156, 4619.237825758746, 4702.670813043088, 4774.331593576898, 4814.735189564577, 4827.806887724491, 4750.596199323053, 4759.738214398207, 4769.976150119253, 4786.473487916326, 4822.421309442863, 4334.284843000901, 4336.284513055342, 4414.3157810539415, 4461.39771130898, 4545.090981803636, 4465.732056076629, 4492.124035813002, 4513.774311284439, 4521.796519156645, 4534.9773251133865, 4309.547497512779, 4354.891127721832, 4356.085222103362, 4362.323839804835, 4363.934540981888, 4340.110277393127, 4350.825966961318, 4354.390385346054, 4372.803223854934, 4474.82100715971, 4377.627901628365, 4382.693211475198, 4391.956080439187, 4402.911941761146, 4419.071994881079, 4596.080783843245, 4727.030958653468, 4774.259989701602, 4779.187538118494, 4806.447258565275, 5131.0, 5173.508516690908, 5179.585633149339, 5227.398849132361, 5230.241614965808, 5216.321878155815, 5234.18870075139, 5234.790608375661, 5238.214267859814, 5263.499967503081, 4623.930641040387, 4724.433068031858, 4750.5249475052215, 4838.6371022173125, 4891.9755401222765, 5254.13306804373, 5271.156614941668, 5306.389765177054, 5316.548093412026, 5318.813841515528, 5010.849674509771, 5056.06462804375, 5060.898782024339, 5061.72160531167, 5064.366954130734, 5054.393472783289, 5077.746112694351, 5111.5655169310285, 5133.563647090039, 5183.663061900965, 5113.207452844815, 5119.283300337956, 5119.334486516804, 5139.743012849342, 5157.510036546522, 5096.847094587169, 5106.514881086291, 5108.131617625013, 5108.642395032312, 5114.590832733373, 4200.936985945214, 4243.554426785205, 4272.487301523837, 4324.567543245713, 4372.322290045048, 3749.9062523436587, 3770.453284273765, 3800.0, 3820.4842346283453, 3840.7695538267794, 4461.219286624828, 4464.464264288306, 4466.0, 4470.061287129674, 4506.662000349987, 4957.281194226817, 5078.339815823919, 5163.7676304566385, 5175.637705360664, 5230.189320655304, 4410.184115938561, 4429.49060857999, 4477.686561940633, 4480.9103817924115, 4482.081173359518, 4590.196715574761, 4602.125596136723, 4604.677672562889, 4607.3319368691355, 4656.16189085961, 4709.0817290628, 4841.8547443576745, 4844.46710861812, 4860.119047619048, 4921.114199444134, 5107.284980102714, 5152.227165925141, 5153.098207813543, 5203.24552939814, 5222.7127507987425, 4905.043516514245, 4908.410990681141, 4918.778654960607, 4923.753812309298, 4967.279744437109, 4923.286123511999, 5098.260752190986, 5101.413337466239, 5106.336176297058, 5109.131447653834, 5095.643304968765, 5132.79468821243, 5150.0987327216835, 5178.818741344035, 5213.061648903234, 5026.572741317029, 5044.167712327425, 5044.520770526794, 5047.772850221822, 5084.8220312288895, 4821.228603423436, 5030.6730062547285, 5040.042391945519, 5041.571466425395, 5045.672031317952, 4882.829100981448, 4898.093852637274, 4947.802087916443, 5026.748662566784, 5026.798928042837, 5083.466236045162, 5086.567641750345, 5094.719790411563, 5095.464976177448, 5133.153029750049, 4793.976030119967, 4989.451160372429, 4989.900201996013, 4991.975040124777, 5023.422306434807], "value": 4719.175872175944, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.5320477594045, 571.2716286734416, 578.3869098755317, 585.9003969325214, 587.541717460381, 27993.0, 37006.0, 38222.617773822254, 38277.04307392317, 42445.151096978116, 38645.42031869524, 39127.60872391275, 39129.21741565167, 39134.608653913456, 39149.0, 7180.28197180283, 7532.585707786069, 7653.043369578802, 7664.540127592362, 7676.961615191916, 7230.27697230278, 7452.366548843354, 7461.664225109883, 9660.468674222915, 9894.703158905244, 10033.548490317917, 10068.14420774235, 10079.244056695741, 10081.546330415113, 10092.444915529642, 9869.062439068277, 9918.008199180133, 9931.0, 9935.503224838729, 9938.354006989595, 9674.90325096747, 9768.755781105529, 9771.706848794547, 9776.31565790395, 9782.706518804447, 34846.47730284023, 35229.0, 35264.647353526394, 35306.11734706653, 35322.0, 3101.6278046634325, 3161.462551366273, 3168.984155079233, 3224.1456014156265, 3419.9658003419895, 27364.863175684193, 27809.860950695318, 28094.43811123766, 28116.718832811614, 28175.71824281772, 3281.261716113879, 3402.336544373848, 3430.9828450857585, 3448.689617934398, 3558.768680035789, 242317.22924332198, 242582.0, 243141.0, 243896.0, 244635.0, 27205.591916121273, 49618.0, 49816.75091624591, 49817.0, 49880.750596246784, 32661.836690816395, 32746.181345466553, 32812.34375312528, 32826.67173328284, 32831.50752738711, 12629.305388203737, 12743.171693839871, 12755.681107972376, 12761.872381276255, 12766.0, 10371.94814025925, 10483.895161048293, 10484.056434920894, 10484.895151048544, 10486.580536778443, 7160.641967901584, 7504.924950750423, 7701.191374905554, 7765.068191816905, 7904.051513818264, 2997.6103106596, 3079.276370053036, 3095.520194369876, 3114.065780265911, 3138.074268090919, 837.7486753973783, 859.1880672764303, 898.60910503931, 917.3899356927568, 941.5010044676333, 25794.742052579233, 27506.312342191606, 28207.0, 28208.717912820608, 29346.706532934397, 889.5818965086399, 891.6567121658209, 914.2457472585144, 956.1232468599352, 1023.698009087321, 14872.851271487363, 14890.0, 14936.0, 15081.924590377197, 15117.244137793066, 404718.0, 411426.0, 411962.0, 413647.0, 413918.0, 46293.5370646296, 46482.302765458546, 46594.5340546597, 46633.30050049184, 46713.5328646716, 1095.906847917936, 1155.0528566575495, 1173.23153334566, 1204.4098391788136, 1212.478634187308, 26512.867435662698, 28021.159365219075, 28388.574171387034, 29089.0, 29166.562501562068, 40265.396019060325, 40740.1851962965, 40820.79589602033, 40851.18297633971, 40874.0, 249188.0, 251174.0, 251190.0, 251488.0, 251639.0, 24705.629415558422, 25905.0, 25930.481390372464, 26847.597286040334, 26859.194224173305, 41576.0, 44313.77843110893, 44893.55106448894, 45967.54032459766, 46005.0, 35593.0, 36158.09604759797, 36236.63763362333, 36540.90377288686, 37172.0, 34399.484007739404, 35781.64218357887, 36115.27769444544, 36434.453483198304, 36758.0, 34887.0, 34931.0, 35651.0, 36033.09917251985, 36096.639033609325, 30572.388552229277, 32557.348853022333, 32876.835615821765, 32883.8355808229, 32913.177170570925, 24793.256202313958, 25398.746012540378, 25479.0, 25759.0, 25889.611655825556], "value": 16457.45195762148, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.5611373555586, 363.34597724096636, 371.90516418313337, 379.22827046959435, 387.4517557655917, 12641.304728239955, 15882.0, 16415.261313240917, 18207.18067686954, 18446.538836529093, 17035.318587256526, 17182.0, 17885.46343609694, 18008.369707060254, 18034.188461519232, 4841.3222148899185, 5027.698338099707, 5103.438621751604, 5121.5390614844655, 5129.2562578426105, 3740.1210715481975, 5006.874828129307, 5080.41575218849, 5087.033463641915, 5610.803621873235, 5827.300723913137, 5849.502792262663, 5903.527717782588, 5904.645721256738, 5912.556558258127, 5248.160294352923, 5479.945200547983, 5517.034518959166, 5902.232709747748, 5907.438793314628, 5436.864078398072, 5447.0, 5449.209864569655, 5449.83650490482, 5462.508374246337, 13976.161430314112, 14518.709625807425, 20477.692834607493, 20622.484437889023, 20672.58654826895, 1951.3365455744972, 1962.195499845071, 1970.6551353513078, 1990.3730324947596, 2369.822263330257, 9270.675526356545, 9460.8580871287, 9683.0, 9770.36492627977, 10873.728156796064, 1711.8801683882134, 1717.6736420080144, 1731.6450127723785, 1753.1584839277218, 1764.4001039646453, 65023.67488162576, 65986.67006664984, 67499.3250067498, 67962.3203767961, 69064.6546767268, 9673.516324183904, 9842.50787460624, 9955.104040636377, 10175.542100605491, 10243.312407533282, 13683.31583420825, 13699.931500342434, 13707.862921370857, 13737.862621373859, 13743.0, 6803.93196068033, 6894.620795856276, 6908.032875397448, 6908.689108990107, 7130.536515126604, 6463.224413070461, 6490.156279683705, 6692.899606505906, 6699.43054840344, 6716.261211266757, 4254.29804082323, 4321.373400856921, 4346.065595896897, 4413.470383553929, 4463.888402789957, 1724.2327164411715, 1800.69388204003, 1809.6018875847292, 1809.9819001809813, 1835.384861322028, 819.6967122164838, 827.6813426830713, 834.4284165346756, 872.2498651159997, 904.3127223310331, 16769.413070542472, 16801.41195058167, 16844.24200910962, 17247.0, 17795.19921603531, 843.843888880559, 850.7532815483564, 855.6791203298762, 869.9913000870037, 882.571952602987, 7063.71745130189, 9481.620735170654, 10086.0, 10142.847857282146, 10167.4916254187, 370497.0, 408914.0, 409028.0, 412248.32634204807, 415310.0, 76137.23862761301, 77359.61320193476, 79205.0, 80194.59902700449, 83402.16597834065, 413.977231252278, 437.27194221620647, 437.68049323993665, 438.4147163536714, 438.54391432909415, 9973.60105595768, 10158.492075396349, 10234.385936843813, 10325.690229293134, 10394.532246048795, 33858.49212261867, 35994.8200258997, 36199.63800361963, 38204.41547014376, 39577.406338905515, 43018.0, 51523.22715159201, 51902.221466678784, 52053.21920171125, 54090.72954635201, 7692.0, 7791.883121753292, 7825.530468171928, 7833.216678332349, 8221.876671850046, 11299.661010169708, 12392.380380981096, 12416.627501174979, 12639.304838233986, 12669.239845609292, 10724.0, 10791.298565593212, 10792.0, 10878.347299162075, 11285.266457680225, 10398.740031499274, 10740.140788736726, 10743.946280268548, 10854.29447085937, 10969.286996345212, 10641.148708103488, 11133.832992504957, 11147.108231341635, 11167.72080697989, 11171.608993685182, 7568.886466702894, 7856.921430785619, 7995.440319177835, 8025.197480251928, 8104.379124175306, 9426.340156189, 10857.077148442471, 10860.891391086305, 10916.672499825017, 11114.888851111386], "value": 7997.839606876488, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1242.2049888071642, 1330.554264321452, 1358.7554240236757, 1402.2357814990828, 1661.4683301343575, 6667.499937504688, 7365.742199023029, 7776.416768742339, 7778.338841198498, 7974.082980457235, 7694.384449244061, 7787.9221207787905, 7799.961000195005, 7803.531788092719, 7814.374850012, 2178.673199020144, 2201.5486825200796, 2205.40454077399, 2206.3270702435752, 2208.6576580630026, 2132.648113061343, 2178.891055447229, 2184.5740080684272, 2188.9452763680874, 2197.373748481683, 2155.6766485027215, 2173.1959175105153, 2182.4107490977426, 2182.443476913385, 2183.2031308572414, 2123.7132987046784, 2126.5853158634072, 2131.6482780341225, 2134.5090629155225, 2135.1032566322183, 2057.7942205779304, 2111.102781317934, 2113.3342996955907, 2113.640681084204, 2114.809667129966, 7578.924210757932, 7664.233576642347, 7755.8448831023625, 7763.068431788165, 7821.608919554056, 4370.8033138508845, 4560.429946256718, 4561.612262957653, 4564.8402305919135, 4584.885377865547, 2764.3365592257915, 2849.928751781222, 2885.7402833745064, 2888.494513460157, 2899.753520950722, 875.1379890807549, 882.7925437522177, 893.4014210478995, 899.8155378147464, 905.1491597897955, 10663.280863379867, 10791.78416431667, 10799.514021869034, 10801.13590912733, 10822.08012318946, 3759.3609086455367, 3936.9606303937167, 3959.8812035638975, 4117.5882411758585, 4118.4440100586635, 8385.371097167737, 8394.45436046655, 8419.579021048923, 8438.57807109642, 8447.155284471626, 4485.955140448619, 4487.416635837386, 4489.326601009875, 4489.551044895549, 4490.506044335186, 3524.8237588121006, 3933.645971862546, 4106.650934670527, 4166.041810383629, 4167.270727622654, 3357.4292370297107, 3390.271091715293, 3502.9824850876093, 3518.40187168182, 3533.9149901558203, 1001.2840818814583, 1001.5693251901606, 1002.5588740953957, 1021.7701017271055, 1032.6798692405227, 716.2694052066863, 811.5090370325868, 815.09524427885, 828.9544075075808, 838.8196537744415, 5009.5491405773655, 5056.544910958031, 5114.897702045938, 5136.5377116059735, 5225.869353266199, 393.4688170969169, 394.07589203318173, 408.79151632667555, 408.9959100408958, 421.91983523130506, 3286.4248756467523, 3397.8980630580627, 3418.880339188166, 3421.7433692473164, 3512.5082488451635, 9169.174774270348, 9554.092361225812, 9624.470654113951, 9625.181859541877, 9627.422354658604, 9425.245980321695, 9447.102525260227, 9479.620815167455, 9485.4782986935, 9504.334696571173, 7040.2607726189035, 7199.424046076406, 7224.349808517259, 7269.563826170447, 7280.41756659466, 4774.259989701602, 4894.657373983787, 4907.337509436323, 4984.152694041949, 5147.897042059213, 8525.0, 8678.956605216934, 8736.0, 8769.693060742844, 8882.689105881263, 8866.379353445454, 8881.156290152425, 8941.150590693873, 9044.41211321262, 9046.502442365732, 5785.161151633074, 5881.588288819741, 6380.425761681471, 6449.12936753551, 6468.708908099241, 7400.962995184989, 7644.579548124907, 7646.388288936983, 7653.846923061619, 7655.61721913891, 6727.697253623501, 6765.357291057342, 6864.24493305746, 6930.168379794457, 7104.360607545345, 6405.807825765234, 6624.171978502687, 6714.227863795726, 6735.360140786617, 6796.184457865088, 5612.045952188057, 5665.631733937281, 5673.716314184192, 5674.092145256905, 5698.287714035746, 4321.438213032286, 4537.5008749036915, 4599.1721490132095, 4640.443146822403, 4644.86065418038, 4472.239719247671, 4498.977505112453, 4586.747728874944, 4620.5148459411275, 4644.047970166175], "value": 3941.023762991736, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.52420602829443, 297.27168437328544, 305.978581499295, 307.0634564578036, 307.15379130495484, 4868.488808675087, 4879.634027447938, 4893.877653058676, 4910.828121015765, 4916.557509824115, 4798.808047678098, 4838.879028024301, 4857.975710121454, 4859.58693511052, 4863.902721945559, 3581.2658405027037, 3675.356812557805, 3710.610385909481, 3777.490038844748, 3824.388097904322, 3806.5622453417795, 3820.6752426043818, 3822.2737679840743, 3828.4831547741114, 3844.6539811416965, 3792.620737926199, 3798.8670396536127, 3801.980990095046, 3805.0, 3809.923801523968, 3610.205754733954, 3655.5613326400735, 3755.9812200939095, 3791.9810400948095, 3792.867249646249, 3362.7982321060813, 3367.3938691035605, 3368.511565822942, 3379.307242015381, 3386.2888793353427, 4672.929906051412, 4687.22660760974, 4696.87275053988, 4698.154332220199, 4705.494241842612, 4208.0, 4311.655067594585, 4332.0, 4348.826046958118, 4353.0, 4998.0, 5030.446650868402, 5041.470645582234, 5050.399044492053, 5050.924236136461, 3673.6142705016123, 3678.1976831352713, 3680.7055435565358, 3687.2625474905126, 3691.0990839717565, 5044.798208071673, 5274.156135018378, 5279.980821863079, 5281.841544753625, 5285.154375299933, 3649.1424515238896, 3661.23114146027, 3663.413853783382, 3671.8714844980295, 3684.465752465931, 3725.6646901778427, 3727.105494681257, 3729.9369679641713, 3730.0861288984374, 3730.552333719971, 4079.8164082616354, 4227.260229459832, 4254.595813397722, 4264.6801489888385, 4269.316909294498, 5063.531575843038, 5076.949230507647, 5082.475257422759, 5083.2375143727995, 5093.490650934951, 1263.3746295583744, 1285.1517998121194, 1288.948442062307, 1298.0, 1299.8310219671382, 825.3603457320504, 825.8389614025327, 838.3795990966763, 839.3285371702614, 847.546562589012, 4472.552744725502, 4491.550844915482, 4503.684742068024, 4522.163399771053, 4522.977385113119, 5084.669496482717, 5143.27994080829, 5182.274481572583, 5183.663061900965, 5196.32447781786, 4346.2828633275785, 4475.657302809144, 4478.305862591304, 4480.678199931028, 4487.932681009787, 2738.2332946774936, 2750.642416485884, 2754.187514683173, 2757.9172624821285, 2767.5710264908566, 4897.534734200245, 4904.632152588499, 4923.433805112386, 4927.5811556017425, 4927.827526036572, 5045.293658887758, 5232.1628539433505, 5258.894822103536, 5262.578993680573, 5289.523942845162, 4874.147024270667, 4909.68087074339, 4911.705297682151, 4913.533214344631, 4928.753562321869, 5135.204043373283, 5143.228515722672, 5159.613029022763, 5161.483851614958, 5178.61160412963, 4933.0, 5055.848324550269, 5058.570021548062, 5062.861026163802, 5075.873103172303, 4916.3362946001835, 4917.975410123069, 4918.5819205366515, 4921.3356196912955, 4935.555799978019, 3655.5065066216785, 3661.7367008382066, 3664.6885014774043, 3665.376885929452, 3668.559772827171, 4891.461939186758, 5123.23151527259, 5141.7686204120155, 5154.819581314636, 5173.611979101658, 5015.899682006412, 5017.222330538772, 5041.495850415075, 5044.419891712353, 5048.823291184791, 4984.280423253972, 5017.874553136055, 5053.31780209667, 5054.444011158843, 5056.64603477753, 4696.201645720167, 4956.578690811321, 4976.178930476431, 4988.428644976821, 4996.975015125046, 4859.2954021667365, 4976.576990955809, 5100.719460429712, 5125.231215317732, 5127.948720512896, 5012.523810238022, 5028.270900719302, 5036.0, 5036.424138861303, 5046.697198168122], "value": 3809.5641122675343, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.8930881750102, 633.8527265649176, 641.5028353026405, 681.3765404654741, 725.4812808841679, 12885.613431597056, 13460.865391346084, 13477.865221347784, 13478.797818032714, 13480.730385392299, 12957.61127166184, 13071.869281307185, 13105.082644214908, 13174.670633234175, 13197.80203296949, 611.3763960760023, 731.7000029987706, 750.5271678842322, 767.6085196549744, 776.5884081436848, 776.0454640791829, 776.9184235655259, 777.8522080804657, 780.3133242746376, 781.0354212547528, 820.3560205238889, 820.7660816667251, 821.5112008355019, 822.1490757066438, 824.4929368438397, 655.0632595388616, 775.7556369743513, 812.553095797315, 816.6896579299887, 822.6092606012156, 599.4724642314735, 600.9609375390629, 601.8675891303906, 603.7615142018922, 604.0486234181183, 12207.145499815017, 12209.45057472407, 12234.877651223464, 12247.632571022883, 12259.509619615204, 12379.876201238052, 12645.810312845315, 13066.150700204456, 13186.07697461178, 13290.54368605082, 11352.489137988729, 11451.0, 11620.477078531487, 11723.824142637868, 11898.524059037629, 3240.416724989501, 4057.9391309130388, 4094.263032654121, 4137.8758637240935, 4146.502419709624, 59168.0, 59277.703611481666, 59761.40238597602, 59979.800403992114, 60664.696676516774, 10233.744156396, 10276.588936442608, 10449.68650940473, 10627.84058239127, 10711.73220669474, 18619.0, 18866.71699924502, 18903.3383831568, 18987.905060474885, 18990.430287091134, 7030.402415794612, 7105.25394833535, 7144.428445724329, 7342.70629174827, 7456.701731930662, 3749.4563288323584, 3755.267722794029, 3792.089898424358, 3848.230353929225, 3899.3760998240145, 2899.6230490036583, 2989.6113505244616, 3018.170003249124, 3023.3953209358215, 3026.9545956810666, 522.6506703885726, 525.6767088240781, 526.8024490815944, 527.8785879247718, 537.6612733977569, 490.02589003184147, 521.2389910730376, 553.8559974406684, 556.7049463784201, 568.883378907323, 7378.483506154625, 7695.730649427243, 7935.246151615587, 8016.438849280495, 8083.221342889828, 549.5576061270635, 573.9282589676291, 579.1168468086119, 587.0607028753959, 588.2646691635456, 3625.546806649169, 3647.343478173901, 3679.9448008279896, 3778.8677396290996, 3917.4319723640483, 58337.0, 59266.0, 101225.49387253165, 102309.48845255726, 103136.48431757944, 51286.48713512892, 69296.30703693, 84775.15224847796, 85319.0, 85912.0, 65137.0, 77239.61380193062, 78248.30654635416, 79204.60397697975, 80478.59760701393, 6982.581045137308, 7282.6722797473185, 7285.562866228043, 7342.0, 7391.704331826882, 45468.54531454775, 45961.77019114883, 46369.304460432446, 47290.0, 47415.52584474111, 38427.615723842406, 38904.0, 39100.0, 52202.73898630482, 64380.67809660922, 9377.484238366955, 9786.657466988621, 9927.751806204902, 9952.900470995197, 10072.143867771321, 11282.0, 11454.885451145716, 11471.827922581, 12186.329751863732, 12198.878011219775, 10149.289549731448, 10200.0, 10207.132393746615, 11073.889261107608, 11088.168387370819, 9705.6603018894, 9809.55856986423, 9985.1512621428, 10494.632687855888, 10716.89283107159, 9508.429494230368, 9753.902460975583, 10003.449810260505, 10064.144547713526, 10419.010194031554, 8621.568921553771, 8816.426932249384, 8894.822103558023, 8960.417572857743, 9136.862947055666, 8219.383546233938, 8443.366747494085, 8772.385932984886, 8778.297736180963, 8933.374663773473], "value": 6304.136787826869, "unit": "score"}], "name": "dromaeo_css", "value": 6235.815012406266, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 114.0, 115.0, 109.0, 114.0, 114.0, 114.0, 113.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 120.0, 122.0, 184.0, 122.0, 122.0, 148.0, 120.0, 154.0, 122.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 162.0, 162.0, 161.0, 160.0, 162.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 114.0, 77.0, 77.0, 75.0, 76.0, 114.0, 75.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 141.0, 87.0, 86.0, 86.0, 115.0, 91.0, 87.0, 134.0], "value": 100.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 63.0, 62.0, 62.0, 65.0, 64.0, 63.0, 64.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0, 69.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 89.0, 82.0, 84.0, 83.0, 83.0, 82.0, 81.0, 81.0, 82.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 148.0, 145.0, 131.0, 142.0, 142.0, 129.0, 132.0, 152.0, 132.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 172.0, 176.0, 173.0, 172.0, 173.0, 172.0, 176.0, 170.0, 172.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 67.0, 71.0, 68.0, 68.0, 67.0, 68.0, 68.0, 67.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1544.6, "alertThreshold": 2.0}]} 13:20:30 INFO - Return code: 0 13:20:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:20:30 INFO - # TBPL SUCCESS # 13:20:30 INFO - Running post-action listener: _resource_record_post_action 13:20:30 INFO - [mozharness: 2016-08-15 20:20:30.483432Z] Finished run-tests step (success) 13:20:30 INFO - Running post-run listener: _resource_record_post_run 13:20:30 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 412364800; Read time: 4; Write time: 264220 13:20:30 INFO - TinderboxPrint: CPU usage
13.0% 13:20:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 13:20:30 INFO - TinderboxPrint: I/O write bytes / time
412,364,800 / 264,220 13:20:30 INFO - TinderboxPrint: CPU idle
8,335.5 (87.0%) 13:20:30 INFO - TinderboxPrint: CPU user
1,198.8 (12.5%) 13:20:30 INFO - TinderboxPrint: Swap in / out
0 / 0 13:20:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 130084864; Read time: 0; Write time: 93244 13:20:30 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 281153536; Read time: 0; Write time: 170944 13:20:31 INFO - Running post-run listener: _upload_blobber_files 13:20:31 INFO - Blob upload gear active. 13:20:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:20:31 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 13:20:31 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'] 13:20:31 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 13:20:31 INFO - (blobuploader) - INFO - Open directory for files ... 13:20:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:20:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:20:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:32 INFO - (blobuploader) - INFO - Done attempting. 13:20:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:20:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:20:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:33 INFO - (blobuploader) - INFO - Done attempting. 13:20:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:20:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:20:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:20:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:20:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:20:36 INFO - (blobuploader) - INFO - Done attempting. 13:20:36 INFO - (blobuploader) - INFO - Iteration through files over. 13:20:36 INFO - Return code: 0 13:20:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:20:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:20:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dfb4a4e72750fbb629aa62df7814ba5ceaaea1e19d382edf389284b2063ac7a442852ab3f22fcf30ef24837c2a36e762a61f56cccb71ffed0c45d1f0177b2e79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/442550abc8b4f0cf4d2727a3a04d276014721ba5bdd7472d1aef59f6d8683c60128ddc3ca3bebf4619dc3f849bc72365722fa90a0d2364ada67ea38fd7083284", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8175c943629fff58a55f909374dacec49dc8b6fecc660b6e7b1b17fef14e0f6d703bbebccd8b1f443e9a6ce32d075cfa32da4a59813a40da0e2c7a38f2366988"} 13:20:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:20:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:20:36 INFO - Contents: 13:20:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dfb4a4e72750fbb629aa62df7814ba5ceaaea1e19d382edf389284b2063ac7a442852ab3f22fcf30ef24837c2a36e762a61f56cccb71ffed0c45d1f0177b2e79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/442550abc8b4f0cf4d2727a3a04d276014721ba5bdd7472d1aef59f6d8683c60128ddc3ca3bebf4619dc3f849bc72365722fa90a0d2364ada67ea38fd7083284", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8175c943629fff58a55f909374dacec49dc8b6fecc660b6e7b1b17fef14e0f6d703bbebccd8b1f443e9a6ce32d075cfa32da4a59813a40da0e2c7a38f2366988"} 13:20:36 INFO - Running post-run listener: copy_logs_to_upload_dir 13:20:36 INFO - Copying logs to upload dir... 13:20:36 INFO - mkdir: /builds/slave/test/build/upload/logs 13:20:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.708646 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-15 13:20:36.001129) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 13:20:36.004510) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854 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/dfb4a4e72750fbb629aa62df7814ba5ceaaea1e19d382edf389284b2063ac7a442852ab3f22fcf30ef24837c2a36e762a61f56cccb71ffed0c45d1f0177b2e79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/442550abc8b4f0cf4d2727a3a04d276014721ba5bdd7472d1aef59f6d8683c60128ddc3ca3bebf4619dc3f849bc72365722fa90a0d2364ada67ea38fd7083284", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8175c943629fff58a55f909374dacec49dc8b6fecc660b6e7b1b17fef14e0f6d703bbebccd8b1f443e9a6ce32d075cfa32da4a59813a40da0e2c7a38f2366988"} build_url:https://queue.taskcluster.net/v1/task/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011413 build_url: 'https://queue.taskcluster.net/v1/task/QVhbc1_nQv23Q5odZQpAMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dfb4a4e72750fbb629aa62df7814ba5ceaaea1e19d382edf389284b2063ac7a442852ab3f22fcf30ef24837c2a36e762a61f56cccb71ffed0c45d1f0177b2e79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/442550abc8b4f0cf4d2727a3a04d276014721ba5bdd7472d1aef59f6d8683c60128ddc3ca3bebf4619dc3f849bc72365722fa90a0d2364ada67ea38fd7083284", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8175c943629fff58a55f909374dacec49dc8b6fecc660b6e7b1b17fef14e0f6d703bbebccd8b1f443e9a6ce32d075cfa32da4a59813a40da0e2c7a38f2366988"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 13:20:36.030265) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 13:20:36.030588) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1471290121.206668-1509297854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004403 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 13:20:36.116314) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 13:20:36.116625) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 13:20:36.116914) ========= ========= Total master_lag: 0.17 =========