builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1468449198.34 results: success (0) buildid: 20160713141046 builduid: f56c373fb50a40f583c4b414d4dcca39 revision: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 15:33:18.338959) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 15:33:18.339489) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 15:33:18.339820) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 15:33:18.373137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:33:18.373489) ========= 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=8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 15:33:18-- 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% 42.7M=0s 2016-07-13 15:33:18 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085605 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:33:18.475150) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:33:18.475518) ========= 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=8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022562 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:33:18.526040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:33:18.526428) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5fd14a66be3191e5628af3cfb0a456dd70f179b8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5fd14a66be3191e5628af3cfb0a456dd70f179b8 --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=8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 15:33:18,583 truncating revision to first 12 chars 2016-07-13 15:33:18,583 Setting DEBUG logging. 2016-07-13 15:33:18,583 attempt 1/10 2016-07-13 15:33:18,583 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5fd14a66be31?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 15:33:18,906 unpacking tar archive at: mozilla-central-5fd14a66be31/testing/mozharness/ program finished with exit code 0 elapsedTime=0.730666 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:33:19.271130) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 15:33:19.271495) ========= script_repo_revision: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 15:33:19.271948) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 15:33:19.272282) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 15:33:19.281981) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-13 15:33:19.282328) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:33:19 INFO - MultiFileLogger online at 20160713 15:33:19 in /builds/slave/test 15:33:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:33:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:33:19 INFO - {'append_to_log': False, 15:33:19 INFO - 'base_work_dir': '/builds/slave/test', 15:33:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:33:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:33:19 INFO - 'branch': 'Firefox-Non-PGO', 15:33:19 INFO - 'buildbot_json_path': 'buildprops.json', 15:33:19 INFO - 'config_files': ('talos/linux_config.py',), 15:33:19 INFO - 'default_actions': ('clobber', 15:33:19 INFO - 'read-buildbot-config', 15:33:19 INFO - 'download-and-extract', 15:33:19 INFO - 'populate-webroot', 15:33:19 INFO - 'create-virtualenv', 15:33:19 INFO - 'install', 15:33:19 INFO - 'run-tests'), 15:33:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:33:19 INFO - 'download_minidump_stackwalk': True, 15:33:19 INFO - 'download_symbols': 'ondemand', 15:33:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:33:19 INFO - 'tooltool.py': '/tools/tooltool.py', 15:33:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:33:19 INFO - '/tools/misc-python/virtualenv.py')}, 15:33:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:33:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:33:19 INFO - 'installer_path': 'installer.exe', 15:33:19 INFO - 'log_level': 'info', 15:33:19 INFO - 'log_name': 'talos', 15:33:19 INFO - 'log_to_console': True, 15:33:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:33:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:33:19 INFO - 'opt_config_files': (), 15:33:19 INFO - 'pip_index': False, 15:33:19 INFO - 'sps_profile': False, 15:33:19 INFO - 'sps_profile_interval': 0, 15:33:19 INFO - 'suite': 'dromaeojs', 15:33:19 INFO - 'system_bits': '32', 15:33:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:33:19 INFO - 'title': 'talos-linux64-ix-038', 15:33:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:33:19 INFO - 'use_talos_json': True, 15:33:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:33:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:33:19 INFO - 'work_dir': 'build'} 15:33:19 INFO - ##### 15:33:19 INFO - ##### Running clobber step. 15:33:19 INFO - ##### 15:33:19 INFO - Running pre-action listener: _resource_record_pre_action 15:33:19 INFO - Running main action method: clobber 15:33:19 INFO - rmtree: /builds/slave/test/build 15:33:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:33:20 INFO - Running post-action listener: _resource_record_post_action 15:33:20 INFO - ##### 15:33:20 INFO - ##### Finished clobber step (success) 15:33:20 INFO - ##### 15:33:20 INFO - ##### 15:33:20 INFO - ##### Running read-buildbot-config step. 15:33:20 INFO - ##### 15:33:20 INFO - Running pre-action listener: _resource_record_pre_action 15:33:20 INFO - Running main action method: read_buildbot_config 15:33:20 INFO - Using buildbot properties: 15:33:20 INFO - { 15:33:20 INFO - "project": "", 15:33:20 INFO - "product": "firefox", 15:33:20 INFO - "script_repo_revision": "production", 15:33:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:33:20 INFO - "repository": "", 15:33:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:33:20 INFO - "buildid": "20160713141046", 15:33:20 INFO - "pgo_build": "False", 15:33:20 INFO - "basedir": "/builds/slave/test", 15:33:20 INFO - "buildnumber": 561, 15:33:20 INFO - "slavename": "talos-linux64-ix-038", 15:33:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:33:20 INFO - "platform": "ubuntu64_hw", 15:33:20 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:33:20 INFO - "branch": "mozilla-central", 15:33:20 INFO - "repo_path": "mozilla-central", 15:33:20 INFO - "revision": "5fd14a66be3191e5628af3cfb0a456dd70f179b8", 15:33:20 INFO - "stage_platform": "linux64", 15:33:20 INFO - "builduid": "f56c373fb50a40f583c4b414d4dcca39", 15:33:20 INFO - "slavebuilddir": "test" 15:33:20 INFO - } 15:33:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:33:20 INFO - Running post-action listener: _resource_record_post_action 15:33:20 INFO - ##### 15:33:20 INFO - ##### Finished read-buildbot-config step (success) 15:33:20 INFO - ##### 15:33:20 INFO - ##### 15:33:20 INFO - ##### Running download-and-extract step. 15:33:20 INFO - ##### 15:33:20 INFO - Running pre-action listener: _resource_record_pre_action 15:33:20 INFO - Running main action method: download_and_extract 15:33:20 INFO - mkdir: /builds/slave/test/build/tests 15:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:20 INFO - https://queue.taskcluster.net/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:33:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:33:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:33:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:33:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:33:25 INFO - Downloaded 1361 bytes. 15:33:25 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:33:25 INFO - Using the following test package requirements: 15:33:25 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:33:25 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:33:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:33:25 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:33:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:33:25 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:33:25 INFO - u'jsshell-linux-x86_64.zip'], 15:33:25 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:33:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:33:25 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:33:25 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:33:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:33:25 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:33:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:33:25 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:33:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:33:25 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:33:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:33:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:25 INFO - https://queue.taskcluster.net/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:33:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:33:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:33:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:33:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:33:29 INFO - Downloaded 22755361 bytes. 15:33:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:33:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:33:30 INFO - Return code: 0 15:33:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:33: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:30 INFO - https://queue.taskcluster.net/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:33:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:33:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:33:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:33:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:33:31 INFO - Downloaded 22755361 bytes. 15:33:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:33:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:33:32 INFO - Return code: 0 15:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:32 INFO - https://queue.taskcluster.net/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:33:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:33:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:33:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:33:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:33:33 INFO - Downloaded 14403317 bytes. 15:33:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:33:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:33:34 INFO - Return code: 0 15:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:34 INFO - https://queue.taskcluster.net/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:33:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:33:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:33:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:33:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:33:37 INFO - Downloaded 57049613 bytes. 15:33:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:33:37 INFO - mkdir: /builds/slave/test/properties 15:33:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:33:37 INFO - Writing to file /builds/slave/test/properties/build_url 15:33:37 INFO - Contents: 15:33:37 INFO - build_url:https://queue.taskcluster.net/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:33:38 INFO - Running post-action listener: _resource_record_post_action 15:33:38 INFO - Running post-action listener: set_extra_try_arguments 15:33:38 INFO - ##### 15:33:38 INFO - ##### Finished download-and-extract step (success) 15:33:38 INFO - ##### 15:33:38 INFO - ##### 15:33:38 INFO - ##### Running populate-webroot step. 15:33:38 INFO - ##### 15:33:38 INFO - Running pre-action listener: _resource_record_pre_action 15:33:38 INFO - Running main action method: populate_webroot 15:33:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:33:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:33:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:33:38 INFO - '--tppagecycles', 15:33:38 INFO - '7'], 15:33:38 INFO - 'tests': ['tsvgm']}}, 15:33:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:33:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:33:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:33:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:33:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:33:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:33:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:38 INFO - 'talos_options': ['--disable-e10s'], 15:33:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:33:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:33:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:38 INFO - 'talos_options': ['--disable-e10s'], 15:33:38 INFO - 'tests': ['damp', 'tps']}, 15:33:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:38 INFO - 'tests': ['damp', 'tps']}, 15:33:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:33:38 INFO - 'tests': ['dromaeo_dom']}, 15:33:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:33:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:33:38 INFO - 'tests': ['basic_compositor_video']}, 15:33:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:33:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:33:38 INFO - 'tests': ['a11yr', 15:33:38 INFO - 'ts_paint', 15:33:38 INFO - 'tpaint', 15:33:38 INFO - 'sessionrestore', 15:33:38 INFO - 'sessionrestore_no_auto_restore', 15:33:38 INFO - 'tabpaint']}, 15:33:38 INFO - 'other-e10s': {'tests': ['a11yr', 15:33:38 INFO - 'ts_paint', 15:33:38 INFO - 'tpaint', 15:33:38 INFO - 'sessionrestore', 15:33:38 INFO - 'sessionrestore_no_auto_restore', 15:33:38 INFO - 'tabpaint']}, 15:33:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:33:38 INFO - 'ts_paint', 15:33:38 INFO - 'tpaint', 15:33:38 INFO - 'sessionrestore', 15:33:38 INFO - 'sessionrestore_no_auto_restore', 15:33:38 INFO - 'tabpaint']}, 15:33:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:33:38 INFO - 'ts_paint', 15:33:38 INFO - 'tpaint', 15:33:38 INFO - 'sessionrestore', 15:33:38 INFO - 'sessionrestore_no_auto_restore', 15:33:38 INFO - 'tabpaint']}, 15:33:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:33:38 INFO - 'tests': ['a11yr', 15:33:38 INFO - 'ts_paint', 15:33:38 INFO - 'tpaint', 15:33:38 INFO - 'sessionrestore', 15:33:38 INFO - 'sessionrestore_no_auto_restore', 15:33:38 INFO - 'tabpaint']}, 15:33:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:33:38 INFO - 'tests': ['a11yr', 15:33:38 INFO - 'ts_paint', 15:33:38 INFO - 'tpaint', 15:33:38 INFO - 'sessionrestore', 15:33:38 INFO - 'sessionrestore_no_auto_restore', 15:33:38 INFO - 'tabpaint']}, 15:33:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:33:38 INFO - 'tests': ['tsvgx', 15:33:38 INFO - 'tsvgr_opacity', 15:33:38 INFO - 'tart', 15:33:38 INFO - 'tscrollx', 15:33:38 INFO - 'cart']}, 15:33:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:33:38 INFO - 'tsvgr_opacity', 15:33:38 INFO - 'tart', 15:33:38 INFO - 'tscrollx', 15:33:38 INFO - 'cart']}, 15:33:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:38 INFO - 'talos_options': ['--disable-e10s'], 15:33:38 INFO - 'tests': ['tp5o']}, 15:33:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:38 INFO - 'tests': ['tp5o']}, 15:33:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:38 INFO - 'talos_options': ['--disable-e10s', 15:33:38 INFO - '--xperf_path', 15:33:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:33:38 INFO - 'tests': ['tp5n']}, 15:33:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:38 INFO - 'talos_options': ['--xperf_path', 15:33:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:33:38 INFO - 'tests': ['tp5n']}}, 15:33:38 INFO - 'talos.zip': {'path': '', 15:33:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:33:38 INFO - Running post-action listener: _resource_record_post_action 15:33:38 INFO - ##### 15:33:38 INFO - ##### Finished populate-webroot step (success) 15:33:38 INFO - ##### 15:33:38 INFO - ##### 15:33:38 INFO - ##### Running create-virtualenv step. 15:33:38 INFO - ##### 15:33:38 INFO - Running pre-action listener: _resource_record_pre_action 15:33:38 INFO - Running main action method: create_virtualenv 15:33:38 INFO - Creating virtualenv /builds/slave/test/build/venv 15:33:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:33:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:33:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:33:38 INFO - Using real prefix '/usr' 15:33:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:33:39 INFO - Installing distribute.............................................................................................................................................................................................done. 15:33:41 INFO - Installing pip.................done. 15:33:41 INFO - Return code: 0 15:33:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b3b0>, '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 0x2a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c740>, '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': '8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291', '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 15:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:33:41 INFO - Using env: {'DISPLAY': ':0', 15:33:41 INFO - 'HOME': '/home/cltbld', 15:33:41 INFO - 'LANG': 'en_US.UTF-8', 15:33:41 INFO - 'LANGUAGE': 'en_US:en', 15:33:41 INFO - 'LOGNAME': 'cltbld', 15:33:41 INFO - 'MAIL': '/var/mail/cltbld', 15:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:41 INFO - 'MOZ_NO_REMOTE': '1', 15:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:41 INFO - 'NO_EM_RESTART': '1', 15:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:41 INFO - 'PWD': '/builds/slave/test', 15:33:41 INFO - 'SHELL': '/bin/bash', 15:33:41 INFO - 'SHLVL': '1', 15:33:41 INFO - 'TERM': 'linux', 15:33:41 INFO - 'TMOUT': '86400', 15:33:41 INFO - 'USER': 'cltbld', 15:33:41 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291', 15:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:41 INFO - '_': '/tools/buildbot/bin/python'} 15:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:33:41 INFO - Cleaning up... 15:33:41 INFO - Return code: 0 15:33:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b3b0>, '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 0x2a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c740>, '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': '8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291', '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 15:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:33:41 INFO - Using env: {'DISPLAY': ':0', 15:33:41 INFO - 'HOME': '/home/cltbld', 15:33:41 INFO - 'LANG': 'en_US.UTF-8', 15:33:41 INFO - 'LANGUAGE': 'en_US:en', 15:33:41 INFO - 'LOGNAME': 'cltbld', 15:33:41 INFO - 'MAIL': '/var/mail/cltbld', 15:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:41 INFO - 'MOZ_NO_REMOTE': '1', 15:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:41 INFO - 'NO_EM_RESTART': '1', 15:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:41 INFO - 'PWD': '/builds/slave/test', 15:33:41 INFO - 'SHELL': '/bin/bash', 15:33:41 INFO - 'SHLVL': '1', 15:33:41 INFO - 'TERM': 'linux', 15:33:41 INFO - 'TMOUT': '86400', 15:33:41 INFO - 'USER': 'cltbld', 15:33:41 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291', 15:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:41 INFO - '_': '/tools/buildbot/bin/python'} 15:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:41 INFO - Downloading/unpacking psutil>=3.1.1 15:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:33:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:33:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:33:43 INFO - Installing collected packages: psutil 15:33:43 INFO - Running setup.py install for psutil 15:33:43 INFO - building 'psutil._psutil_linux' extension 15:33:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:33:44 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 15:33:44 INFO - building 'psutil._psutil_posix' extension 15:33:44 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 15:33:44 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 15:33:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:33:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:33:44 INFO - Successfully installed psutil 15:33:44 INFO - Cleaning up... 15:33:44 INFO - Return code: 0 15:33:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b3b0>, '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 0x2a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c740>, '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': '8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291', '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 15:33:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:33:44 INFO - Using env: {'DISPLAY': ':0', 15:33:44 INFO - 'HOME': '/home/cltbld', 15:33:44 INFO - 'LANG': 'en_US.UTF-8', 15:33:44 INFO - 'LANGUAGE': 'en_US:en', 15:33:44 INFO - 'LOGNAME': 'cltbld', 15:33:44 INFO - 'MAIL': '/var/mail/cltbld', 15:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:44 INFO - 'MOZ_NO_REMOTE': '1', 15:33:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:44 INFO - 'NO_EM_RESTART': '1', 15:33:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:44 INFO - 'PWD': '/builds/slave/test', 15:33:44 INFO - 'SHELL': '/bin/bash', 15:33:44 INFO - 'SHLVL': '1', 15:33:44 INFO - 'TERM': 'linux', 15:33:44 INFO - 'TMOUT': '86400', 15:33:44 INFO - 'USER': 'cltbld', 15:33:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291', 15:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:44 INFO - '_': '/tools/buildbot/bin/python'} 15:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:33:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:33:46 INFO - Installing collected packages: mozsystemmonitor 15:33:46 INFO - Running setup.py install for mozsystemmonitor 15:33:46 INFO - Successfully installed mozsystemmonitor 15:33:46 INFO - Cleaning up... 15:33:46 INFO - Return code: 0 15:33:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b3b0>, '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 0x2a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c740>, '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': '8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291', '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 15:33:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:33:46 INFO - Using env: {'DISPLAY': ':0', 15:33:46 INFO - 'HOME': '/home/cltbld', 15:33:46 INFO - 'LANG': 'en_US.UTF-8', 15:33:46 INFO - 'LANGUAGE': 'en_US:en', 15:33:46 INFO - 'LOGNAME': 'cltbld', 15:33:46 INFO - 'MAIL': '/var/mail/cltbld', 15:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:46 INFO - 'MOZ_NO_REMOTE': '1', 15:33:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:46 INFO - 'NO_EM_RESTART': '1', 15:33:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:46 INFO - 'PWD': '/builds/slave/test', 15:33:46 INFO - 'SHELL': '/bin/bash', 15:33:46 INFO - 'SHLVL': '1', 15:33:46 INFO - 'TERM': 'linux', 15:33:46 INFO - 'TMOUT': '86400', 15:33:46 INFO - 'USER': 'cltbld', 15:33:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291', 15:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:46 INFO - '_': '/tools/buildbot/bin/python'} 15:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:46 INFO - Downloading/unpacking jsonschema==2.5.1 15:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:33:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:49 INFO - Downloading functools32-3.2.3-2.tar.gz 15:33:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:33:49 INFO - warning: no files found matching '*.txt' 15:33:49 INFO - no previously-included directories found matching 'build' 15:33:49 INFO - no previously-included directories found matching 'dist' 15:33:49 INFO - no previously-included directories found matching '.git*' 15:33:49 INFO - Installing collected packages: jsonschema, functools32 15:33:49 INFO - Running setup.py install for functools32 15:33:49 INFO - warning: no files found matching '*.txt' 15:33:49 INFO - no previously-included directories found matching 'build' 15:33:49 INFO - no previously-included directories found matching 'dist' 15:33:49 INFO - no previously-included directories found matching '.git*' 15:33:49 INFO - Successfully installed jsonschema functools32 15:33:49 INFO - Cleaning up... 15:33:49 INFO - Return code: 0 15:33:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b3b0>, '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 0x2a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c740>, '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': '8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291', '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 15:33:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:33:49 INFO - Using env: {'DISPLAY': ':0', 15:33:49 INFO - 'HOME': '/home/cltbld', 15:33:49 INFO - 'LANG': 'en_US.UTF-8', 15:33:49 INFO - 'LANGUAGE': 'en_US:en', 15:33:49 INFO - 'LOGNAME': 'cltbld', 15:33:49 INFO - 'MAIL': '/var/mail/cltbld', 15:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:49 INFO - 'MOZ_NO_REMOTE': '1', 15:33:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:49 INFO - 'NO_EM_RESTART': '1', 15:33:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:49 INFO - 'PWD': '/builds/slave/test', 15:33:49 INFO - 'SHELL': '/bin/bash', 15:33:49 INFO - 'SHLVL': '1', 15:33:49 INFO - 'TERM': 'linux', 15:33:49 INFO - 'TMOUT': '86400', 15:33:49 INFO - 'USER': 'cltbld', 15:33:49 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291', 15:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:49 INFO - '_': '/tools/buildbot/bin/python'} 15:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:49 INFO - Downloading/unpacking blobuploader==1.2.4 15:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:51 INFO - Downloading blobuploader-1.2.4.tar.gz 15:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:33:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:33:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:52 INFO - Downloading docopt-0.6.1.tar.gz 15:33:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:33:52 INFO - Installing collected packages: blobuploader, requests, docopt 15:33:52 INFO - Running setup.py install for blobuploader 15:33:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:33:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:33:52 INFO - Running setup.py install for requests 15:33:52 INFO - Running setup.py install for docopt 15:33:52 INFO - Successfully installed blobuploader requests docopt 15:33:52 INFO - Cleaning up... 15:33:52 INFO - Return code: 0 15:33:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b3b0>, '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 0x2a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c740>, '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': '8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291', '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 15:33:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:33:52 INFO - Using env: {'DISPLAY': ':0', 15:33:52 INFO - 'HOME': '/home/cltbld', 15:33:52 INFO - 'LANG': 'en_US.UTF-8', 15:33:52 INFO - 'LANGUAGE': 'en_US:en', 15:33:52 INFO - 'LOGNAME': 'cltbld', 15:33:52 INFO - 'MAIL': '/var/mail/cltbld', 15:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:52 INFO - 'MOZ_NO_REMOTE': '1', 15:33:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:52 INFO - 'NO_EM_RESTART': '1', 15:33:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:52 INFO - 'PWD': '/builds/slave/test', 15:33:52 INFO - 'SHELL': '/bin/bash', 15:33:52 INFO - 'SHLVL': '1', 15:33:52 INFO - 'TERM': 'linux', 15:33:52 INFO - 'TMOUT': '86400', 15:33:52 INFO - 'USER': 'cltbld', 15:33:52 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291', 15:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:52 INFO - '_': '/tools/buildbot/bin/python'} 15:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:33:53 INFO - Running setup.py (path:/tmp/pip-VlNshg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:33:53 INFO - Running setup.py (path:/tmp/pip-AgwNaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:33:53 INFO - Running setup.py (path:/tmp/pip-JnydTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:33:53 INFO - Running setup.py (path:/tmp/pip-gQaiwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:33:53 INFO - Running setup.py (path:/tmp/pip-KkXzkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:33:53 INFO - Running setup.py (path:/tmp/pip-atl5rM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:33:53 INFO - Running setup.py (path:/tmp/pip-PFo4Q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:33:53 INFO - Running setup.py (path:/tmp/pip-Aeq7Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:33:53 INFO - Running setup.py (path:/tmp/pip-fGFpgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:33:53 INFO - Running setup.py (path:/tmp/pip-GUpNlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:33:53 INFO - Running setup.py (path:/tmp/pip-JDkP7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:33:53 INFO - Running setup.py (path:/tmp/pip-yWaHDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:33:53 INFO - Running setup.py (path:/tmp/pip-xIAD9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:33:53 INFO - Running setup.py (path:/tmp/pip-KgOOqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:54 INFO - Running setup.py (path:/tmp/pip-fltJWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:33:54 INFO - Running setup.py (path:/tmp/pip-8f3ivj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:33:54 INFO - Running setup.py (path:/tmp/pip-sxKAUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:33:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:33:54 INFO - Running setup.py install for manifestparser 15:33:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:33:54 INFO - Running setup.py install for mozcrash 15:33:54 INFO - Running setup.py install for mozdebug 15:33:54 INFO - Running setup.py install for mozdevice 15:33:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:33:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:33:54 INFO - Running setup.py install for mozfile 15:33:54 INFO - Running setup.py install for mozhttpd 15:33:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:33:54 INFO - Running setup.py install for mozinfo 15:33:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:33:54 INFO - Running setup.py install for mozInstall 15:33:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:33:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:33:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:33:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:33:55 INFO - Running setup.py install for mozleak 15:33:55 INFO - Running setup.py install for mozlog 15:33:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:33:55 INFO - Running setup.py install for moznetwork 15:33:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:33:55 INFO - Running setup.py install for mozprocess 15:33:55 INFO - Running setup.py install for mozprofile 15:33:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:33:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:33:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:33:55 INFO - Running setup.py install for mozrunner 15:33:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:33:55 INFO - Running setup.py install for mozscreenshot 15:33:55 INFO - Running setup.py install for moztest 15:33:55 INFO - Running setup.py install for mozversion 15:33:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:33:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:33:56 INFO - Cleaning up... 15:33:56 INFO - Return code: 0 15:33:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:56 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 0x274c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b3b0>, '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 0x2a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c740>, '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': '8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291', '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 15:33:56 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 15:33:56 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 15:33:56 INFO - Using env: {'DISPLAY': ':0', 15:33:56 INFO - 'HOME': '/home/cltbld', 15:33:56 INFO - 'LANG': 'en_US.UTF-8', 15:33:56 INFO - 'LANGUAGE': 'en_US:en', 15:33:56 INFO - 'LOGNAME': 'cltbld', 15:33:56 INFO - 'MAIL': '/var/mail/cltbld', 15:33:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:56 INFO - 'MOZ_NO_REMOTE': '1', 15:33:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:56 INFO - 'NO_EM_RESTART': '1', 15:33:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:56 INFO - 'PWD': '/builds/slave/test', 15:33:56 INFO - 'SHELL': '/bin/bash', 15:33:56 INFO - 'SHLVL': '1', 15:33:56 INFO - 'TERM': 'linux', 15:33:56 INFO - 'TMOUT': '86400', 15:33:56 INFO - 'USER': 'cltbld', 15:33:56 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291', 15:33:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:56 INFO - '_': '/tools/buildbot/bin/python'} 15:33:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:33:56 INFO - Running setup.py (path:/tmp/pip-YKgOxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:33:56 INFO - Running setup.py (path:/tmp/pip-Ref3at-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:33:56 INFO - Running setup.py (path:/tmp/pip-fl5F3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:33:56 INFO - Running setup.py (path:/tmp/pip-vLVRTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:33:56 INFO - Running setup.py (path:/tmp/pip-PBwj6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:33:56 INFO - Running setup.py (path:/tmp/pip-Al9r0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:33:56 INFO - Running setup.py (path:/tmp/pip-wqwv2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:33:56 INFO - Running setup.py (path:/tmp/pip-YgsTvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:33:56 INFO - Running setup.py (path:/tmp/pip-PG5_vH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:33:56 INFO - Running setup.py (path:/tmp/pip-oAS1QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:33:57 INFO - Running setup.py (path:/tmp/pip-NHFw6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:33:57 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)) 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:33:57 INFO - Running setup.py (path:/tmp/pip-jxmhsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:33:57 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)) 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:33:57 INFO - Running setup.py (path:/tmp/pip-yMY7nU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:33:57 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)) 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:33:57 INFO - Running setup.py (path:/tmp/pip-T3SzrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:33:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:57 INFO - Running setup.py (path:/tmp/pip-IbDxa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:33:57 INFO - Running setup.py (path:/tmp/pip-UdBRLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:33:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:33:57 INFO - Running setup.py (path:/tmp/pip-Imzwut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:33:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:33:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:33:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:33:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:33:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:33:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:33:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:59 INFO - Downloading blessings-1.6.tar.gz 15:33:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:33:59 INFO - Installing collected packages: blessings 15:33:59 INFO - Running setup.py install for blessings 15:33:59 INFO - Successfully installed blessings 15:33:59 INFO - Cleaning up... 15:33:59 INFO - Return code: 0 15:33:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:33:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:33:59 INFO - Reading from file tmpfile_stdout 15:33:59 INFO - Current package versions: 15:33:59 INFO - argparse == 1.2.1 15:33:59 INFO - blessings == 1.6 15:33:59 INFO - blobuploader == 1.2.4 15:33:59 INFO - docopt == 0.6.1 15:33:59 INFO - functools32 == 3.2.3-2 15:33:59 INFO - jsonschema == 2.5.1 15:33:59 INFO - manifestparser == 1.1 15:33:59 INFO - mozInstall == 1.12 15:33:59 INFO - mozcrash == 0.17 15:33:59 INFO - mozdebug == 0.1 15:33:59 INFO - mozdevice == 0.48 15:33:59 INFO - mozfile == 1.2 15:33:59 INFO - mozhttpd == 0.7 15:33:59 INFO - mozinfo == 0.9 15:33:59 INFO - mozleak == 0.1 15:33:59 INFO - mozlog == 3.2 15:33:59 INFO - moznetwork == 0.27 15:33:59 INFO - mozprocess == 0.23 15:33:59 INFO - mozprofile == 0.28 15:33:59 INFO - mozrunner == 6.12 15:33:59 INFO - mozscreenshot == 0.1 15:33:59 INFO - mozsystemmonitor == 0.3 15:33:59 INFO - moztest == 0.7 15:33:59 INFO - mozversion == 1.4 15:33:59 INFO - psutil == 3.1.1 15:33:59 INFO - requests == 1.2.3 15:33:59 INFO - wsgiref == 0.1.2 15:33:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b3b0>, '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 0x2a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c740>, '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': '8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291', '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 15:33:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:33:59 INFO - Using env: {'DISPLAY': ':0', 15:33:59 INFO - 'HOME': '/home/cltbld', 15:33:59 INFO - 'LANG': 'en_US.UTF-8', 15:33:59 INFO - 'LANGUAGE': 'en_US:en', 15:33:59 INFO - 'LOGNAME': 'cltbld', 15:33:59 INFO - 'MAIL': '/var/mail/cltbld', 15:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:59 INFO - 'MOZ_NO_REMOTE': '1', 15:33:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:59 INFO - 'NO_EM_RESTART': '1', 15:33:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:59 INFO - 'PWD': '/builds/slave/test', 15:33:59 INFO - 'SHELL': '/bin/bash', 15:33:59 INFO - 'SHLVL': '1', 15:33:59 INFO - 'TERM': 'linux', 15:33:59 INFO - 'TMOUT': '86400', 15:33:59 INFO - 'USER': 'cltbld', 15:33:59 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291', 15:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:59 INFO - '_': '/tools/buildbot/bin/python'} 15:34:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:00 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)) 15:34:00 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)) 15:34:00 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)) 15:34:00 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)) 15:34:00 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)) 15:34:00 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)) 15:34:00 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)) 15:34:00 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)) 15:34:00 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)) 15:34:00 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)) 15:34:00 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)) 15:34:00 INFO - Cleaning up... 15:34:00 INFO - Return code: 0 15:34:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:34: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:00 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 0x274c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b3b0>, '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 0x2a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c740>, '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': '8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291', '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 15:34:00 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 15:34:00 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 15:34:00 INFO - Using env: {'DISPLAY': ':0', 15:34:00 INFO - 'HOME': '/home/cltbld', 15:34:00 INFO - 'LANG': 'en_US.UTF-8', 15:34:00 INFO - 'LANGUAGE': 'en_US:en', 15:34:00 INFO - 'LOGNAME': 'cltbld', 15:34:00 INFO - 'MAIL': '/var/mail/cltbld', 15:34:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:00 INFO - 'MOZ_NO_REMOTE': '1', 15:34:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:00 INFO - 'NO_EM_RESTART': '1', 15:34:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:00 INFO - 'PWD': '/builds/slave/test', 15:34:00 INFO - 'SHELL': '/bin/bash', 15:34:00 INFO - 'SHLVL': '1', 15:34:00 INFO - 'TERM': 'linux', 15:34:00 INFO - 'TMOUT': '86400', 15:34:00 INFO - 'USER': 'cltbld', 15:34:00 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291', 15:34:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:00 INFO - '_': '/tools/buildbot/bin/python'} 15:34:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:34:00 INFO - Cleaning up... 15:34:00 INFO - Return code: 0 15:34:00 INFO - Running post-action listener: _resource_record_post_action 15:34:00 INFO - Running post-action listener: _start_resource_monitoring 15:34:00 INFO - Starting resource monitoring. 15:34:00 INFO - ##### 15:34:00 INFO - ##### Finished create-virtualenv step (success) 15:34:00 INFO - ##### 15:34:00 INFO - ##### 15:34:00 INFO - ##### Running install step. 15:34:00 INFO - ##### 15:34:00 INFO - Running pre-action listener: _resource_record_pre_action 15:34:00 INFO - Running main action method: install 15:34:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:00 INFO - Reading from file tmpfile_stdout 15:34:00 INFO - Detecting whether we're running mozinstall >=1.0... 15:34:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:34:00 INFO - Reading from file tmpfile_stdout 15:34:00 INFO - Output received: 15:34:00 INFO - Usage: mozinstall [options] installer 15:34:00 INFO - Options: 15:34:00 INFO - -h, --help show this help message and exit 15:34:00 INFO - -d DEST, --destination=DEST 15:34:00 INFO - Directory to install application into. [default: 15:34:00 INFO - "/builds/slave/test"] 15:34:00 INFO - --app=APP Application being installed. [default: firefox] 15:34:00 INFO - mkdir: /builds/slave/test/build/application 15:34:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:34:17 INFO - Reading from file tmpfile_stdout 15:34:17 INFO - Output received: 15:34:17 INFO - /builds/slave/test/build/application/firefox/firefox 15:34:17 INFO - Running post-action listener: _resource_record_post_action 15:34:17 INFO - ##### 15:34:17 INFO - ##### Finished install step (success) 15:34:17 INFO - ##### 15:34:17 INFO - ##### 15:34:17 INFO - ##### Running run-tests step. 15:34:17 INFO - ##### 15:34:17 INFO - Running pre-action listener: _resource_record_pre_action 15:34:17 INFO - Running main action method: run_tests 15:34:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:34:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:34:17 INFO - Python 2.7.3 15:34:17 INFO - Return code: 0 15:34:17 INFO - grabbing minidump binary from tooltool 15:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:17 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 0x2a0b3b0>, '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 0x2a0c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:34:17 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 15:34:17 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 15:34:17 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 15:34:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:34:17 INFO - Return code: 0 15:34:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:34:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:34:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:34:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:34:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:34:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 15:34:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 15:34:17 INFO - Using env: {'DISPLAY': ':0', 15:34:17 INFO - 'HOME': '/home/cltbld', 15:34:17 INFO - 'LANG': 'en_US.UTF-8', 15:34:17 INFO - 'LANGUAGE': 'en_US:en', 15:34:17 INFO - 'LOGNAME': 'cltbld', 15:34:17 INFO - 'MAIL': '/var/mail/cltbld', 15:34:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:34:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:17 INFO - 'MOZ_NO_REMOTE': '1', 15:34:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:34:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:17 INFO - 'NO_EM_RESTART': '1', 15:34:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:17 INFO - 'PWD': '/builds/slave/test', 15:34:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:34:17 INFO - 'SHELL': '/bin/bash', 15:34:17 INFO - 'SHLVL': '1', 15:34:17 INFO - 'TERM': 'linux', 15:34:17 INFO - 'TMOUT': '86400', 15:34:17 INFO - 'USER': 'cltbld', 15:34:17 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291', 15:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:17 INFO - '_': '/tools/buildbot/bin/python'} 15:34:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 15:34:17 INFO - mozversion application_buildid: 20160713141046 15:34:17 INFO - mozversion application_changeset: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 15:34:17 INFO - mozversion application_display_name: Nightly 15:34:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:34:17 INFO - mozversion application_name: Firefox 15:34:17 INFO - mozversion application_remotingname: firefox 15:34:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:34:17 INFO - mozversion application_vendor: Mozilla 15:34:17 INFO - mozversion application_version: 50.0a1 15:34:17 INFO - mozversion platform_buildid: 20160713141046 15:34:17 INFO - mozversion platform_changeset: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 15:34:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:34:17 INFO - mozversion platform_version: 50.0a1 15:34:17 INFO - using testdate: 1468449257 15:34:17 INFO - actual date: 1468449257 15:34:17 INFO - starting webserver on 'localhost:46363' 15:34:17 INFO - SUITE-START | Running 2 tests 15:34:17 INFO - TEST-START | dromaeo_css 15:34:17 INFO - operating with platform_type : linux_ 15:34:17 INFO - Initialising browser for dromaeo_css test... 15:34:17 INFO - TEST-INFO | started process 15376 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjoC8Hn/profile http://localhost:46363/getInfo.html) 15:34:22 INFO - PROCESS | 15376 | __metrics Screen width/height:1600/1200 15:34:22 INFO - PROCESS | 15376 | colorDepth:24 15:34:22 INFO - PROCESS | 15376 | Browser inner width/height: 1024/697 15:34:22 INFO - PROCESS | 15376 | __metrics 15:34:23 INFO - PROCESS | 15376 | 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" 15:34:23 INFO - PROCESS | 15376 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:34:24 INFO - TEST-INFO | 15376: exit 0 15:34:24 INFO - Browser initialized. 15:34:24 INFO - Running cycle 1/1 for dromaeo_css test... 15:34:24 INFO - TEST-INFO | started process 15458 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjoC8Hn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:34:36 INFO - PROCESS | 15458 | RSS: Main: 159432704 15:34:36 INFO - PROCESS | 15458 | 15:35:27 INFO - PROCESS | 15458 | 1468449327498 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] 15:37:40 INFO - PROCESS | 15458 | Cycle 1(1): loaded http://localhost:46363/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46363/tests/dromaeo/cssquery-ext.html) 15:37:41 INFO - PROCESS | 15458 | RSS: Main: 239661056 15:37:41 INFO - PROCESS | 15458 | 15:40:44 INFO - PROCESS | 15458 | Cycle 1(1): loaded http://localhost:46363/tests/dromaeo/cssquery-ext.html (next: http://localhost:46363/tests/dromaeo/cssquery-jquery.html) 15:40:44 INFO - PROCESS | 15458 | RSS: Main: 242167808 15:40:44 INFO - PROCESS | 15458 | 15:43:46 INFO - PROCESS | 15458 | Cycle 1(1): loaded http://localhost:46363/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46363/tests/dromaeo/cssquery-mootools.html) 15:43:47 INFO - PROCESS | 15458 | RSS: Main: 244731904 15:43:47 INFO - PROCESS | 15458 | 15:46:49 INFO - PROCESS | 15458 | Cycle 1(1): loaded http://localhost:46363/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46363/tests/dromaeo/cssquery-prototype.html) 15:46:50 INFO - PROCESS | 15458 | RSS: Main: 232796160 15:46:50 INFO - PROCESS | 15458 | 15:49:53 INFO - PROCESS | 15458 | Cycle 1(1): loaded http://localhost:46363/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46363/tests/dromaeo/cssquery-yui.html) 15:49:54 INFO - PROCESS | 15458 | RSS: Main: 227610624 15:49:54 INFO - PROCESS | 15458 | 15:52:56 INFO - PROCESS | 15458 | Cycle 1(1): loaded http://localhost:46363/tests/dromaeo/cssquery-yui.html (next: http://localhost:46363/tests/dromaeo/cssquery-dojo.html) 15:52:57 INFO - PROCESS | 15458 | RSS: Main: 316133376 15:52:57 INFO - PROCESS | 15458 | 15:52:57 INFO - PROCESS | 15458 | __start_tp_report 15:52:57 INFO - PROCESS | 15458 | _x_x_mozilla_page_load 15:52:57 INFO - PROCESS | 15458 | _x_x_mozilla_page_load_details 15:52:57 INFO - PROCESS | 15458 | |i|pagename|runs| 15:52:57 INFO - PROCESS | 15458 | |0;dojo.html;2592.46854394849;2614.7908167346613;2643.088134593565;2649.483350746605;2652.734726527346;4473.105378924212;4571.291449825274;4644.047970166116;4658.673892827504;4674.415698037746;4629.444466664005;4630.490646028942;4636.142313671973;4668.369770081038;4685.062987402524;4035.9394609080887;4198.223328684196;4274.7435153890865;4296.248156572603;4415.845445409412;4279.101388708359;4351.412559304501;4352.956470435287;4356.4990026146925;4390.2536568783225;4097.078157414573;4106.917861642781;4113.958860411418;4218.987443013654;4231.534531201565;4224.577542245782;4228.725132866354;4229.70392072555;4278.807453664593;4287;4259.8509052183335;4264.573542645741;4267.061246525759;4303.634191093761;4313.15893400787;4420.248557745191;4539.886502837456;4573.771311434415;4583.358329833826;4689.835855745033;4909.975450122726;4945;4965.776540055706;4969.304297398367;4969.975150124226;4811.639127065484;4970.329005584272;4984.6261530385;4988.625853060998;5000.249962505617;4621.445426548836;4640.443146822336;4646.814127434933;4651.37206477128;4694.131585656664;5108.029474399852;5128.794848206105;5134.486551344836;5139.563137133311;5146.665466744649;4699.906001880012;4846.636502262344;4889.242167464049;4889.3888263967;4892.730899800474;4967.130752118437;4972.179590367549;4976.2038073908;5016.874578135576;5021.271915572222;4925.876853078702;4929.87675308113;4949.430815456197;4959.776810043557;5006.949930500648;4765.451973023147;4867.415910090741;4876.487968763229;4877.536634019833;4926.359573255454;4249.702520823575;4250.022494826146;4251.553586873334;4276.978615106967;4292.978535107304;3696.075981004749;3713.814309284525;3714.220013797079;3746.662800347982;3756.3614185587967;4169.1661667666585;4195.035141917376;4204.642605378516;4229.111886503807;4258.74447533149;4930.630202734737;4936.851894443173;4944.60443164546;4945.184044632667;5004.549590536869;4236.830526778895;4243.575642435731;4249.617534421855;4281.785910704452;4290.2921018031675;4304.978475107604;4415.337699345124;4440.844570440019;4453.576910193527;4490.528494508095;4669.7431641260055;4686.835960741358;4696.60078893291;4702.294655801657;4731.858044258678;4990.126727822544;4991.276264941635;4991.80032798684;5006.224035274538;5036.924446133385;4497.302918047708;4670.719756814602;4693.24908014716;4702.177119004092;4727.290906364073;4917.311576379381;4920.114379411597;4939.43196532389;4942.085714142895;4951.480094590161;4819.542143496362;4968.577670898014;4998.750062496788;5003.399592048978;5057.924131137962;4800.66395352322;4850.854474365775;4857.198562237191;4863.610911127172;4864.221724524059;4818.229083346648;4840.056189043244;4840.080384726891;4843.2735089736825;4890.070886531547;4621.029583787442;4697.412823397075;4783.067301876101;4834.347363105936;4836.298736683231;4796.424429068534;4815.061063092663;4815.277708343777;4831.299461578122;4877.780499877585;4734.360861283682;4735.715857048588;4737.052589482187;4743.810247590058;4773.737444440589 15:52:57 INFO - PROCESS | 15458 | |1;ext.html;549.615269311482;578.6730497269043;580.1442871764151;586.4458087107683;599.4874382403044;27252.591211131825;39843.20313593726;40822.18355632893;40828;41006.74462904539;40444;40560.79719601405;40657;40682;40754;7548.5848278344665;7910.457460795133;8052.5973701315;8066.314363279128;10266.178705703564;10306.278560500768;10469.214808889365;10471.109955653741;10476.842847357295;10483.475826208698;10482.842757358607;10525.6316028939;10528.578856845717;10532.315399499008;10553.314034587765;7635.69457221716;10247.487625618764;10433.113185379252;10482.26624136307;10542.262041657086;10311.43287119208;10372.585096596127;10373.170146388271;10377.169826413869;10399.948000260027;39351.40972885409;39658.20683586312;39814.40278395826;39933.20133597312;40015.79992100021;2799.930001749952;2819.873105710248;2848.4160747046803;2876.7123287671275;2954.9556756648667;27501.491943505032;29305.267368315748;29667.851660741773;30004.54947681023;30897.691023089705;2918.285020170072;2973.717496837797;3003.714647108521;3019.5470679398045;3064.4637188492147;261547;262370;263018;263060.73878522514;263329;29119.56320655192;29876;29939.550906736415;52783.736081319345;53236.46763532393;32780.34439311248;32794.67205327916;32897.342053158805;32968;32990.50514242288;12978.935105324414;13201.801972970414;13206.471741130246;13212.819884719105;13223.206607603575;9987.700368988943;10171.389716617026;10207.285490015776;10391.948040259751;10832.133429325635;7759.107702614158;7936.047674279123;7963.044434667877;8101.918980810235;8112.18878112184;3106.7359274461924;3131.698201821705;3142.9371412572077;3142.9528557071662;3211.454052811028;784.4935431296951;833.3083540661237;964.0793042644258;974.4932635029745;1027.305215166696;25771.226863194133;26850.5972410414;27836.02573909944;27997.58003629947;28795.712042879302;950.6482601437513;953.7901661634429;970.2722957781664;972.7908499672604;1001.4291853643499;14142.858571414154;14736.705265894836;14883.925580372028;14909.478168264059;15107.4712385066;386278;389850;390768;392453;392836;50296.74851625792;50685.23972140421;50818.49181508212;50823.745881270355;50838.949663020336;1034.5292891734393;1081.8377243413552;1119.0488085127738;1163.7963356412424;1197.700574856286;28037.43925121527;29111.417771644024;29536.409271814875;30303.545446817876;30329.545056823725;41959.160816784104;42338.788306059505;42471.3629295567;42637.36043959281;42694.78652606717;258164;259204;260389;260649;260827;37248.255034899696;39171.21657566776;39274.41088383619;39340.803295983336;39344;41604;41896.162076758905;41941.37087943744;42800.1439971205;43024.56975430206;36527.634723653486;36651.816740916125;36676.26647466982;36780.44829327616;36941.815290923376;35713.46429803607;35919.28161436704;36129.096772580895;36302.636973629924;36775.26449470942;32469.675303246666;32789.83605081959;32854.178645534055;32870.178245544055;32902.50646240356;30432.543511847784;30677.53983690202;32243.677563224068;35004.64995350014;35528.111797205274;25663.871680641478;25850.224493265232;25913.352166195997;25949.610755839054;26427.471450571265 15:52:57 INFO - PROCESS | 15458 | |2;jquery.html;344.5365982753196;366.15783697495755;370.0415922760051;378.8238469111863;391.3073859269094;12366.454193225847;16612.750808737877;17334.913325433372;19120.90439547804;19129;17201.311947522114;17266.913665431653;17510.299588016496;17668.911655441705;17823;4903.436104847943;5215.791368345262;5220.138677118271;5225.843224703265;5228.660137091096;3754.1553150541044;5042.647014708972;5749;6035.939640603582;6057.273127224739;5994.1608174855555;6068.453839154476;6078.544109191828;6081.604695694788;6082.057281121433;5373.435789242132;5684.317881854204;5684.715764211794;5767.106098554731;5777.133429985493;5344.812931547377;5500.1749737539285;5540.556755459554;5547.306586676666;5550.500454959073;12682.492700291978;12899.484020639164;12940.223586584834;13145.342732863413;13145.934270328682;1844.2254253213682;1859.3771086685977;1879.351623689825;1907.418237437581;2079.3450063230034;9373.531323433801;9381.437113773127;9521.714348569554;9779;9937.254705897087;1684.2252563820657;1811.9637607247912;1856.3502774029116;1864.580469394389;1875.3342563389936;66737;68767.65616171937;70524;71069.28930710678;71742.92385614272;9081.364304498622;9741.220702343795;10114.696559103239;10270;10339.327943683636;12662.556810511587;13477.326133693472;13493.055486115878;14012.509562165274;14099.224542650252;6258.311585725566;7299.379552738077;7419.220981796833;7421.851562968711;7445.441591880631;6808.523403361717;6824.317568243236;6835.598702266024;6840.555363901331;6977.755778547828;4359.280718681445;4389.582989615981;4392;4440.866773996785;4534.342520334599;1781.714925611922;1827.6162005978892;1854.5178253654146;1892.337681811355;1922.5962547865106;793.6150966781106;836.8075342671219;841.5707988925569;895.9104089590988;934.8504239321812;16730.330786768638;17337.306507739548;17401.738973915402;17472.17457214677;17671.204795784222;830.6386721775926;840.4831028917295;844.8943882014748;857.6869442653511;884.4914174349775;8925.553722313858;9298;9622.9037709622;9733.367331123454;9870.111689947938;361183;363778;365530;365552;368111;72165.6391718038;74852;79394.20605793867;86706.56646716726;87404.12595874087;930.6510058727977;930.930180236485;951.2722767083187;986.4673076538733;990.1830989433746;16447.09540975258;16485.91757041207;16704.747143964007;16954.406595769087;17052.829471705125;39040.41439378468;39050.804745976086;39446.60553394429;40205.39691904682;41702;53730;54219.72890135524;54255.18617220666;54332;54615.18077228924;7155.141383034069;7278.454115941431;7285.344319011315;7454.739084132029;7460.477766556289;10343.741406464598;11308.151888608552;11494.655160345203;11545.48045337945;11588.072954163816;9849.901500984899;9973.451460169761;10066.396016239049;10066.798664026532;10161.644342447978;9942.204623629948;10052.346597471142;10107.19142468586;10109.747256318651;10330.121939634915;10024.398536087858;10044.54799534008;10251;10305.896941030494;10528.315659482108;7434.665440055102;7457.962710186414;7507.962460187882;7759.30166285037;7784.649690764042;9714.174295184988;9779.559919803769;9902.405855648683;10149.797004060025;10265.846012309672 15:52:57 INFO - PROCESS | 15458 | |3;mootools.html;1275.5089290623107;1370.7669696151654;1426.2868565717142;1467.442371898679;1704.6931552320584;6591.4180596656815;7594.5822979736095;7795.33739632132;7800.960995195031;8047.557384343859;7768.06783186017;7907.327877130451;7928.326092282163;7932.801679958004;7943.960280198606;1814;2130.084063852543;2198.307533127068;2221.7778222177735;2256.311824893407;2233.6649502574664;2254.301166638339;2254.357508110189;2255.255765597357;2258;2167.089822274648;2172.3374370816896;2227.509947811479;2231.9776802232013;2236.1502629000956;1756.9385071522436;2078.6674132138787;2149.7527784304693;2149.7850214978457;2150.2366659835848;2072.720182775336;2091.1217288738767;2093.204582258747;2096;2098.2970704813906;7918.485298455582;7960.721374751856;7967.3626109911065;7973.08309544404;7974.3620510359615;4424.557544245582;4537.478190008158;4539.0921815637;4541.046380260149;4547.090581883604;2638.630591717161;2724.8910043598235;2739.8356098633944;2744.5608702607688;2753.187809596154;814.8655471847138;833.2750507058897;856.2850020233113;862.7282406042077;864.14018052038;10845.0781683557;10875.510602022849;10903.400312982783;10916.945415272872;10932;3960.089179488734;4098.262312783728;4224;4227.239096962577;4232.619064284229;9122.224610908148;9142.360034797633;9170.037146099698;9176.632934682671;9181.035991220959;4535.229011068126;4540.341650460665;4540.77296135192;4551.590356867898;4557.658175636774;3589.3180295743723;4040.1515681706583;4159.313713237282;4195.727277726999;4252.107057517894;3660.4875317455044;3703.5555733312176;3765.171662234304;3808.8666896658483;3812.294725475796;1085.451846817368;1173.3018853782157;1202.0864143251192;1221.267239656199;1223.4922507159606;660.0528241972785;751.751921865783;753.5629334985695;780.6096951524238;852.5353682243192;5297.894042119136;5347.679139251657;5374.91937620936;5408.591923275038;5501.834944951658;849.7705619482829;850.5619605902965;857.1942374168262;900.1808354397467;907.1744712311764;3582.5880023797076;3610.187707765784;3614.584322802911;3619.6561326673923;3676.209614932802;9579.233661307078;9874.111329980336;9988.900110998942;9989.950050249703;9993.700188994342;9902.356346837432;9911.108000279864;9911.405315681082;9916.057974492413;9920.603175873028;7038.331358520933;7399.630018499053;7401.740939067106;7556.24437556251;7577.924220757722;5287.339082614673;5435.537979271806;5449;5502.58730595199;5750.760662930767;8974.14745599167;8986.460812351279;9204.677836275698;9207.079292070739;9218.400803947721;8914.643414263617;9227.861582076408;9249.676261330822;9293.86059209126;9437.631543426302;6740.730370785113;6799.728010879708;6846.520743547904;6876.140482439695;6877.415419689182;7405.518641288299;7506.28690274423;7581.166071731995;7586.734464293723;7601;5119.798486650627;6726.495512836459;6830.282820303796;6840.076589660531;6990.370866621825;6747.190337159573;6794.524383293122;6834.487413443912;6891.517593768388;6955.374016338352;6371.426571608577;6400.359964003748;6429.132067170872;6430.421262086435;6432.839179020375;4441.578050085237;4519.864404067883;4574.862754117382;4589.311603259538;4641.280601506772;4649.604783593432;4670.9766451167525;4676.392069031004;4684.929726054043;4757.881052973703 15:52:57 INFO - PROCESS | 15458 | |4;prototype.html;288.7011942639368;293.6036350926249;299.6538997457937;308.3878501175167;309.48470796124457;4875.219964805628;4908.97545512272;4920.581750551208;4934.703917764937;4938.777755001024;4540.3189521571785;4692.296155576665;4713.363695901053;4714.457837348706;4820.662553621248;3641.1989362340373;3732.4401339798974;3744.382176940808;3816.656500914917;3843.385058390658;3806.5622453417936;3813.7795905310313;3816.656500914917;3822.178231680188;3823.3882578787398;3665.1386924072954;3787.9810600947094;3790.4124860646507;3807.600201978794;3833.6358045985585;3616.330978768923;3713.554373475187;3752.8498860045565;3805.543334799842;3819.598942111066;3374.493825926106;3380.797152170878;3381.712554432876;3395.507651390559;3408.744344174172;4732.384789977315;4734.881627959294;4737.478877323526;4741.668083234175;4784.889821615942;4149.315362965107;4391.27543955247;4417.337399390085;4422.292433210703;4433.46798384196;5071.416787069497;5079.466656001141;5080.568151707109;5091.79632814687;5099.821506247301;3684.9263014739554;3704.4072948328408;3709.0541911812584;3732.104294969215;3734.3838266686234;5075.187969924795;5245.10833158364;5251.555822148902;5276.894462110775;5300.655457395257;3661.553686293899;3662.1760103976394;3667.8716244931297;3669.1377526281303;3689.206820533598;3721.423179407196;3739.364308067635;3740.326741186558;3748.3627783276906;3753.4557489163917;4257.87226383209;4282.550332215073;4298.333758267474;4308.91382172361;4313.158934007838;4879.121758083579;5104.4895510449405;5124.8206312778875;5132.948670513321;5141.640085194001;1334.5595953335376;1339.6583871112805;1350.4260689207047;1350.4800651749147;1351.7904724767677;831.4720152702956;863.8013256950811;864.7276108026077;869.6956065377194;873.1792115411492;3993.3061917725986;4015.8996025099605;4027.677785777131;4029.5768944261017;4058.553559108496;4619.769011549409;4645.256758918556;4664.766761661904;4679.3916790816975;4703.061785125673;4056.4320995060716;4056.7565946043333;4057.594240575978;4064;4278.4865816102265;2640.6567146271245;2770.171686686777;2770.6121143039586;2788.7490125888767;2813;4950.331705219821;4961.355023846877;4962.60299176065;4996.125678006334;4998.90002199954;5263.6841789492755;5394.352677678704;5406.972965135149;5428.75570599324;5445.455454454602;4965.3048573199785;4966.404031516241;4970.279309500174;4983.227599722049;4985.559963625087;5242.239875218148;5247.55395791362;5251.606129540376;5297.099493086108;5316.760745766527;5026.673266237683;5162.7351298932;5190.247414124855;5191.273221749034;5196.376434827694;4882.804687812448;4892.926606100982;4913.28757330178;4921.606271498343;4928.8767780805765;3798.772073675588;3804.771713697187;3814.218085292564;3815.2369526094335;3819.446180303785;5016.949830501649;5204.245384419314;5221.660592061504;5225.790968361223;5298.70857102863;5008.799648014038;5015.949840501548;5038.89144388234;5056.595472362275;5080.1363768160245;5040.521150490697;5069.020818657336;5070.670406423571;5082.796688132434;5084.593232541314;4844.370231869975;4982.55505903284;5006.623178625907;5017.473165317735;5022.397312322399;5062.519060689228;5077.669951453144;5094.592432605456;5095.87260318495;5115.769790359368;4970.900581988412;4985.202367621163;5012.77442515095;5025.145725226647;5040.899182016413 15:52:57 INFO - PROCESS | 15458 | |5;yui.html;598.3986093975554;632.0834789555145;645.3062957320878;646.8318237258311;722.1695050691704;13632.591022269335;14201.076929999543;14307.284635768196;14330.068545544533;14339.928300358497;12952.74094518109;13132.540361087364;13172.802407963864;13197.604071877859;13204.141730787493;612.4610342898243;739.7817643795066;769.415244414245;771.2634434115434;774.9690012399498;768.6579472134903;775.5114278004877;775.7827808213709;776.728145149196;776.8718161503346;812.7399232245684;813.3818298093462;813.772143799737;813.8819871118684;813.9511629302261;639.3159319528107;777.327611615951;793.8412317536515;797.9521228726295;801.3789313282194;596.4065754574183;597.5010865926956;597.5906504044743;597.8087012156112;598.5211830535554;13466.730665386734;13486.595402137951;13492.190468571916;13507.122037067558;13519.391627376792;12685.74628507434;12945.158564693265;12958.87041129586;13016.41426135826;13087.47650093995;11789.823152652718;11830.940845295718;11883.40582970848;12002.099842511847;12221.327826969513;3145.3552021835467;3258.266889949766;3260.6413294537583;3321.5848018997626;4197.853075142355;62117.6894115531;62561.687191564204;62721.37278627246;63599.36400635981;63765;10054.16149068323;10091.798164036678;10221.488925553693;10291.279610427348;10362.792744145076;17780.46658600244;17806.821931780774;17811.554711132067;17864.55338616545;17898.731519027224;6690.899636505456;6700.497462690318;6714.865702685919;6718.865622687519;6970.128733908262;3393.5079413484905;3507.105688049531;3569.94645080324;3596.3886139356373;3624.4744512045604;2908.578256152846;3008.849557522115;3023.5313526403443;3026.2131845720273;3027.5004624237195;468.39576945740293;472.3623108803157;495.1829481355792;501.1030255842075;514.1644827155872;463.1963543252454;478.26824957814597;481.98554043378755;499.40570720842084;506.87191850526574;7220.566765994057;7406.444516661272;7473.327400533978;7503;7893.447458677838;402.3441789882473;443.4656239231718;474.54680779855846;494.6364422149717;524.281734024389;3701.925961480755;3762.4385879860097;3770.2836461072307;3868.7678739275734;3916.8629097981434;99150.5042474783;103499.48250258851;104529.47735261427;104738;107519;89787;90542;91044.54477727569;91058;91729.54135229281;78697;79993.20006799974;80315.59842200752;80740.19259807444;80822.59588702019;7177.4520045385225;7340.657367835684;7361.705531778669;7468.850622987618;7584.8483030340185;44285;44932.550674492835;46213.30680039869;46619;46767;61797;68380.6580967092;70025.29974700187;70093;71173.64413177902;8505.277051450448;8520.403571749917;8950.731478055668;9057.909420905706;9386.15524602789;11222.38276894746;11280.09759219244;11311.208215424842;11557.24877882935;11750;9388.342816003087;9546.52267386614;9625.133737963617;9937.850932235877;10066.54700538463;11294.152938529807;11665.941670291595;12201.389930503618;12286;12581.496740130659;10962.177836662442;11208.439578020903;11315.830262545904;11321.943390282995;11713;9781.706548803548;9907.702768916944;10247.795044099226;10355.430451324948;10538.156947444339;9978.301518893608;10254.384736915808;10259.435731034864;10321.329113607591;10327.535260913428 15:52:57 INFO - PROCESS | 15458 | __end_tp_report 15:52:57 INFO - PROCESS | 15458 | __start_cc_report 15:52:57 INFO - PROCESS | 15458 | _x_x_mozilla_cycle_collect,881 15:52:57 INFO - PROCESS | 15458 | __end_cc_report 15:52:57 INFO - PROCESS | 15458 | __startTimestamp1468450377107__endTimestamp 15:52:57 INFO - PROCESS | 15458 | 15:52:57 INFO - PROCESS | 15458 | ------- Summary: start ------- 15:52:57 INFO - PROCESS | 15458 | Number of tests: 6 15:52:57 INFO - PROCESS | 15458 | 15:52:57 INFO - PROCESS | 15458 | [#0] dojo.html Cycles:165 Average:4581.09 Median:4697.41 stddev:476.53 (10.1%) stddev-sans-first:451.74 15:52:57 INFO - PROCESS | 15458 | Values: 2592.5 2614.8 2643.1 2649.5 2652.7 4473.1 4571.3 4644.0 4658.7 4674.4 4629.4 4630.5 4636.1 4668.4 4685.1 4035.9 4198.2 4274.7 4296.2 4415.8 4279.1 4351.4 4353.0 4356.5 4390.3 4097.1 4106.9 4114.0 4219.0 4231.5 4224.6 4228.7 4229.7 4278.8 4287.0 4259.9 4264.6 4267.1 4303.6 4313.2 4420.2 4539.9 4573.8 4583.4 4689.8 4910.0 4945.0 4965.8 4969.3 4970.0 4811.6 4970.3 4984.6 4988.6 5000.2 4621.4 4640.4 4646.8 4651.4 4694.1 5108.0 5128.8 5134.5 5139.6 5146.7 4699.9 4846.6 4889.2 4889.4 4892.7 4967.1 4972.2 4976.2 5016.9 5021.3 4925.9 4929.9 4949.4 4959.8 5006.9 4765.5 4867.4 4876.5 4877.5 4926.4 4249.7 4250.0 4251.6 4277.0 4293.0 3696.1 3713.8 3714.2 3746.7 3756.4 4169.2 4195.0 4204.6 4229.1 4258.7 4930.6 4936.9 4944.6 4945.2 5004.5 4236.8 4243.6 4249.6 4281.8 4290.3 4305.0 4415.3 4440.8 4453.6 4490.5 4669.7 4686.8 4696.6 4702.3 4731.9 4990.1 4991.3 4991.8 5006.2 5036.9 4497.3 4670.7 4693.2 4702.2 4727.3 4917.3 4920.1 4939.4 4942.1 4951.5 4819.5 4968.6 4998.8 5003.4 5057.9 4800.7 4850.9 4857.2 4863.6 4864.2 4818.2 4840.1 4840.1 4843.3 4890.1 4621.0 4697.4 4783.1 4834.3 4836.3 4796.4 4815.1 4815.3 4831.3 4877.8 4734.4 4735.7 4737.1 4743.8 4773.7 15:52:57 INFO - PROCESS | 15458 | 15:52:57 INFO - PROCESS | 15458 | [#1] ext.html Cycles:180 Average:45459.77 Median:3177.20 stddev:81660.32 (2570.2%) stddev-sans-first:81819.78 15:52:57 INFO - PROCESS | 15458 | Values: 549.6 578.7 580.1 586.4 599.5 27252.6 39843.2 40822.2 40828.0 41006.7 40444.0 40560.8 40657.0 40682.0 40754.0 7548.6 7910.5 8052.6 8066.3 10266.2 10306.3 10469.2 10471.1 10476.8 10483.5 10482.8 10525.6 10528.6 10532.3 10553.3 7635.7 10247.5 10433.1 10482.3 10542.3 10311.4 10372.6 10373.2 10377.2 10399.9 39351.4 39658.2 39814.4 39933.2 40015.8 2799.9 2819.9 2848.4 2876.7 2955.0 27501.5 29305.3 29667.9 30004.5 30897.7 2918.3 2973.7 3003.7 3019.5 3064.5 261547.0 262370.0 263018.0 263060.7 263329.0 29119.6 29876.0 29939.6 52783.7 53236.5 32780.3 32794.7 32897.3 32968.0 32990.5 12978.9 13201.8 13206.5 13212.8 13223.2 9987.7 10171.4 10207.3 10391.9 10832.1 7759.1 7936.0 7963.0 8101.9 8112.2 3106.7 3131.7 3142.9 3143.0 3211.5 784.5 833.3 964.1 974.5 1027.3 25771.2 26850.6 27836.0 27997.6 28795.7 950.6 953.8 970.3 972.8 1001.4 14142.9 14736.7 14883.9 14909.5 15107.5 386278.0 389850.0 390768.0 392453.0 392836.0 50296.7 50685.2 50818.5 50823.7 50838.9 1034.5 1081.8 1119.0 1163.8 1197.7 28037.4 29111.4 29536.4 30303.5 30329.5 41959.2 42338.8 42471.4 42637.4 42694.8 258164.0 259204.0 260389.0 260649.0 260827.0 37248.3 39171.2 39274.4 39340.8 39344.0 41604.0 41896.2 41941.4 42800.1 43024.6 36527.6 36651.8 36676.3 36780.4 36941.8 35713.5 35919.3 36129.1 36302.6 36775.3 32469.7 32789.8 32854.2 32870.2 32902.5 30432.5 30677.5 32243.7 35004.6 35528.1 25663.9 25850.2 25913.4 25949.6 26427.5 15:52:57 INFO - PROCESS | 15458 | 15:52:57 INFO - PROCESS | 15458 | [#2] jquery.html Cycles:180 Average:23724.09 Median:5217.97 stddev:60594.12 (1161.3%) stddev-sans-first:60738.68 15:52:57 INFO - PROCESS | 15458 | Values: 344.5 366.2 370.0 378.8 391.3 12366.5 16612.8 17334.9 19120.9 19129.0 17201.3 17266.9 17510.3 17668.9 17823.0 4903.4 5215.8 5220.1 5225.8 5228.7 3754.2 5042.6 5749.0 6035.9 6057.3 5994.2 6068.5 6078.5 6081.6 6082.1 5373.4 5684.3 5684.7 5767.1 5777.1 5344.8 5500.2 5540.6 5547.3 5550.5 12682.5 12899.5 12940.2 13145.3 13145.9 1844.2 1859.4 1879.4 1907.4 2079.3 9373.5 9381.4 9521.7 9779.0 9937.3 1684.2 1812.0 1856.4 1864.6 1875.3 66737.0 68767.7 70524.0 71069.3 71742.9 9081.4 9741.2 10114.7 10270.0 10339.3 12662.6 13477.3 13493.1 14012.5 14099.2 6258.3 7299.4 7419.2 7421.9 7445.4 6808.5 6824.3 6835.6 6840.6 6977.8 4359.3 4389.6 4392.0 4440.9 4534.3 1781.7 1827.6 1854.5 1892.3 1922.6 793.6 836.8 841.6 895.9 934.9 16730.3 17337.3 17401.7 17472.2 17671.2 830.6 840.5 844.9 857.7 884.5 8925.6 9298.0 9622.9 9733.4 9870.1 361183.0 363778.0 365530.0 365552.0 368111.0 72165.6 74852.0 79394.2 86706.6 87404.1 930.7 930.9 951.3 986.5 990.2 16447.1 16485.9 16704.7 16954.4 17052.8 39040.4 39050.8 39446.6 40205.4 41702.0 53730.0 54219.7 54255.2 54332.0 54615.2 7155.1 7278.5 7285.3 7454.7 7460.5 10343.7 11308.2 11494.7 11545.5 11588.1 9849.9 9973.5 10066.4 10066.8 10161.6 9942.2 10052.3 10107.2 10109.7 10330.1 10024.4 10044.5 10251.0 10305.9 10528.3 7434.7 7458.0 7508.0 7759.3 7784.6 9714.2 9779.6 9902.4 10149.8 10265.8 15:52:57 INFO - PROCESS | 15458 | 15:52:57 INFO - PROCESS | 15458 | [#3] mootools.html Cycles:180 Average:5178.69 Median:5422.06 stddev:2958.12 (54.6%) stddev-sans-first:2951.88 15:52:57 INFO - PROCESS | 15458 | Values: 1275.5 1370.8 1426.3 1467.4 1704.7 6591.4 7594.6 7795.3 7801.0 8047.6 7768.1 7907.3 7928.3 7932.8 7944.0 1814.0 2130.1 2198.3 2221.8 2256.3 2233.7 2254.3 2254.4 2255.3 2258.0 2167.1 2172.3 2227.5 2232.0 2236.2 1756.9 2078.7 2149.8 2149.8 2150.2 2072.7 2091.1 2093.2 2096.0 2098.3 7918.5 7960.7 7967.4 7973.1 7974.4 4424.6 4537.5 4539.1 4541.0 4547.1 2638.6 2724.9 2739.8 2744.6 2753.2 814.9 833.3 856.3 862.7 864.1 10845.1 10875.5 10903.4 10916.9 10932.0 3960.1 4098.3 4224.0 4227.2 4232.6 9122.2 9142.4 9170.0 9176.6 9181.0 4535.2 4540.3 4540.8 4551.6 4557.7 3589.3 4040.2 4159.3 4195.7 4252.1 3660.5 3703.6 3765.2 3808.9 3812.3 1085.5 1173.3 1202.1 1221.3 1223.5 660.1 751.8 753.6 780.6 852.5 5297.9 5347.7 5374.9 5408.6 5501.8 849.8 850.6 857.2 900.2 907.2 3582.6 3610.2 3614.6 3619.7 3676.2 9579.2 9874.1 9988.9 9990.0 9993.7 9902.4 9911.1 9911.4 9916.1 9920.6 7038.3 7399.6 7401.7 7556.2 7577.9 5287.3 5435.5 5449.0 5502.6 5750.8 8974.1 8986.5 9204.7 9207.1 9218.4 8914.6 9227.9 9249.7 9293.9 9437.6 6740.7 6799.7 6846.5 6876.1 6877.4 7405.5 7506.3 7581.2 7586.7 7601.0 5119.8 6726.5 6830.3 6840.1 6990.4 6747.2 6794.5 6834.5 6891.5 6955.4 6371.4 6400.4 6429.1 6430.4 6432.8 4441.6 4519.9 4574.9 4589.3 4641.3 4649.6 4671.0 4676.4 4684.9 4757.9 15:52:57 INFO - PROCESS | 15458 | 15:52:57 INFO - PROCESS | 15458 | [#4] prototype.html Cycles:180 Average:4192.00 Median:4736.18 stddev:1211.79 (25.6%) stddev-sans-first:1179.25 15:52:57 INFO - PROCESS | 15458 | Values: 288.7 293.6 299.7 308.4 309.5 4875.2 4909.0 4920.6 4934.7 4938.8 4540.3 4692.3 4713.4 4714.5 4820.7 3641.2 3732.4 3744.4 3816.7 3843.4 3806.6 3813.8 3816.7 3822.2 3823.4 3665.1 3788.0 3790.4 3807.6 3833.6 3616.3 3713.6 3752.8 3805.5 3819.6 3374.5 3380.8 3381.7 3395.5 3408.7 4732.4 4734.9 4737.5 4741.7 4784.9 4149.3 4391.3 4417.3 4422.3 4433.5 5071.4 5079.5 5080.6 5091.8 5099.8 3684.9 3704.4 3709.1 3732.1 3734.4 5075.2 5245.1 5251.6 5276.9 5300.7 3661.6 3662.2 3667.9 3669.1 3689.2 3721.4 3739.4 3740.3 3748.4 3753.5 4257.9 4282.6 4298.3 4308.9 4313.2 4879.1 5104.5 5124.8 5132.9 5141.6 1334.6 1339.7 1350.4 1350.5 1351.8 831.5 863.8 864.7 869.7 873.2 3993.3 4015.9 4027.7 4029.6 4058.6 4619.8 4645.3 4664.8 4679.4 4703.1 4056.4 4056.8 4057.6 4064.0 4278.5 2640.7 2770.2 2770.6 2788.7 2813.0 4950.3 4961.4 4962.6 4996.1 4998.9 5263.7 5394.4 5407.0 5428.8 5445.5 4965.3 4966.4 4970.3 4983.2 4985.6 5242.2 5247.6 5251.6 5297.1 5316.8 5026.7 5162.7 5190.2 5191.3 5196.4 4882.8 4892.9 4913.3 4921.6 4928.9 3798.8 3804.8 3814.2 3815.2 3819.4 5016.9 5204.2 5221.7 5225.8 5298.7 5008.8 5015.9 5038.9 5056.6 5080.1 5040.5 5069.0 5070.7 5082.8 5084.6 4844.4 4982.6 5006.6 5017.5 5022.4 5062.5 5077.7 5094.6 5095.9 5115.8 4970.9 4985.2 5012.8 5025.1 5040.9 15:52:57 INFO - PROCESS | 15458 | 15:52:57 INFO - PROCESS | 15458 | [#5] yui.html Cycles:180 Average:18346.56 Median:470.38 stddev:27138.41 (5769.5%) stddev-sans-first:27181.82 15:52:57 INFO - PROCESS | 15458 | Values: 598.4 632.1 645.3 646.8 722.2 13632.6 14201.1 14307.3 14330.1 14339.9 12952.7 13132.5 13172.8 13197.6 13204.1 612.5 739.8 769.4 771.3 775.0 768.7 775.5 775.8 776.7 776.9 812.7 813.4 813.8 813.9 814.0 639.3 777.3 793.8 798.0 801.4 596.4 597.5 597.6 597.8 598.5 13466.7 13486.6 13492.2 13507.1 13519.4 12685.7 12945.2 12958.9 13016.4 13087.5 11789.8 11830.9 11883.4 12002.1 12221.3 3145.4 3258.3 3260.6 3321.6 4197.9 62117.7 62561.7 62721.4 63599.4 63765.0 10054.2 10091.8 10221.5 10291.3 10362.8 17780.5 17806.8 17811.6 17864.6 17898.7 6690.9 6700.5 6714.9 6718.9 6970.1 3393.5 3507.1 3569.9 3596.4 3624.5 2908.6 3008.8 3023.5 3026.2 3027.5 468.4 472.4 495.2 501.1 514.2 463.2 478.3 482.0 499.4 506.9 7220.6 7406.4 7473.3 7503.0 7893.4 402.3 443.5 474.5 494.6 524.3 3701.9 3762.4 3770.3 3868.8 3916.9 99150.5 103499.5 104529.5 104738.0 107519.0 89787.0 90542.0 91044.5 91058.0 91729.5 78697.0 79993.2 80315.6 80740.2 80822.6 7177.5 7340.7 7361.7 7468.9 7584.8 44285.0 44932.6 46213.3 46619.0 46767.0 61797.0 68380.7 70025.3 70093.0 71173.6 8505.3 8520.4 8950.7 9057.9 9386.2 11222.4 11280.1 11311.2 11557.2 11750.0 9388.3 9546.5 9625.1 9937.9 10066.5 11294.2 11665.9 12201.4 12286.0 12581.5 10962.2 11208.4 11315.8 11321.9 11713.0 9781.7 9907.7 10247.8 10355.4 10538.2 9978.3 10254.4 10259.4 10321.3 10327.5 15:52:57 INFO - PROCESS | 15458 | -------- Summary: end -------- 15:52:57 INFO - PROCESS | 15458 | 15:52:57 INFO - TEST-INFO | 15458: exit 0 15:52:58 INFO - TEST-OK | dromaeo_css | took 1120666ms 15:52:58 INFO - TEST-START | kraken 15:52:58 INFO - operating with platform_type : linux_ 15:52:58 INFO - Initialising browser for kraken test... 15:52:58 INFO - TEST-INFO | started process 15649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy_6MM4/profile http://localhost:46363/getInfo.html) 15:53:02 INFO - PROCESS | 15649 | __metrics Screen width/height:1600/1200 15:53:02 INFO - PROCESS | 15649 | colorDepth:24 15:53:02 INFO - PROCESS | 15649 | Browser inner width/height: 1024/697 15:53:02 INFO - PROCESS | 15649 | __metrics 15:53:03 INFO - PROCESS | 15649 | 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" 15:53:03 INFO - PROCESS | 15649 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:53:05 INFO - TEST-INFO | 15649: exit 0 15:53:05 INFO - Browser initialized. 15:53:05 INFO - Running cycle 1/1 for kraken test... 15:53:05 INFO - TEST-INFO | started process 15730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy_6MM4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:53:17 INFO - PROCESS | 15730 | RSS: Main: 159625216 15:53:17 INFO - PROCESS | 15730 | 15:53:19 INFO - PROCESS | 15730 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46363/tests/kraken/driver.html?testName=audio-beat-detection) 15:53:20 INFO - PROCESS | 15730 | RSS: Main: 216817664 15:53:20 INFO - PROCESS | 15730 | 15:53:23 INFO - PROCESS | 15730 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46363/tests/kraken/driver.html?testName=audio-dft) 15:53:24 INFO - PROCESS | 15730 | RSS: Main: 203698176 15:53:24 INFO - PROCESS | 15730 | 15:53:27 INFO - PROCESS | 15730 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46363/tests/kraken/driver.html?testName=audio-fft) 15:53:27 INFO - PROCESS | 15730 | RSS: Main: 271093760 15:53:27 INFO - PROCESS | 15730 | 15:53:30 INFO - PROCESS | 15730 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46363/tests/kraken/driver.html?testName=audio-oscillator) 15:53:30 INFO - PROCESS | 15730 | RSS: Main: 181575680 15:53:30 INFO - PROCESS | 15730 | 15:53:32 INFO - PROCESS | 15730 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46363/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:53:33 INFO - PROCESS | 15730 | RSS: Main: 186003456 15:53:33 INFO - PROCESS | 15730 | 15:53:36 INFO - PROCESS | 15730 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46363/tests/kraken/driver.html?testName=imaging-darkroom) 15:53:37 INFO - PROCESS | 15730 | RSS: Main: 222162944 15:53:37 INFO - PROCESS | 15730 | 15:53:40 INFO - PROCESS | 15730 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46363/tests/kraken/driver.html?testName=imaging-desaturate) 15:53:41 INFO - PROCESS | 15730 | RSS: Main: 222846976 15:53:41 INFO - PROCESS | 15730 | 15:53:44 INFO - PROCESS | 15730 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46363/tests/kraken/driver.html?testName=json-parse-financial) 15:53:44 INFO - PROCESS | 15730 | RSS: Main: 222359552 15:53:44 INFO - PROCESS | 15730 | 15:53:46 INFO - PROCESS | 15730 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46363/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:53:47 INFO - PROCESS | 15730 | RSS: Main: 211169280 15:53:47 INFO - PROCESS | 15730 | 15:53:49 INFO - PROCESS | 15730 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46363/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:53:49 INFO - PROCESS | 15730 | RSS: Main: 215724032 15:53:49 INFO - PROCESS | 15730 | 15:53:51 INFO - PROCESS | 15730 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46363/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:53:52 INFO - PROCESS | 15730 | RSS: Main: 211439616 15:53:52 INFO - PROCESS | 15730 | 15:53:55 INFO - PROCESS | 15730 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46363/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:53:55 INFO - PROCESS | 15730 | RSS: Main: 222445568 15:53:55 INFO - PROCESS | 15730 | 15:53:58 INFO - PROCESS | 15730 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46363/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:53:59 INFO - PROCESS | 15730 | RSS: Main: 224481280 15:53:59 INFO - PROCESS | 15730 | 15:54:00 INFO - PROCESS | 15730 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46363/tests/kraken/driver.html?testName=ai-astar) 15:54:01 INFO - PROCESS | 15730 | RSS: Main: 266350592 15:54:01 INFO - PROCESS | 15730 | 15:54:01 INFO - PROCESS | 15730 | __start_tp_report 15:54:01 INFO - PROCESS | 15730 | _x_x_mozilla_page_load 15:54:01 INFO - PROCESS | 15730 | _x_x_mozilla_page_load_details 15:54:01 INFO - PROCESS | 15730 | |i|pagename|runs| 15:54:01 INFO - PROCESS | 15730 | |0;ai-astar;104;113;114;112;114;113;113;114;113;113 15:54:01 INFO - PROCESS | 15730 | |1;audio-beat-detection;144;121;129;175;122;156;146;121;183;121 15:54:01 INFO - PROCESS | 15730 | |2;audio-dft;162;163;162;161;163;161;164;162;163;159 15:54:01 INFO - PROCESS | 15730 | |3;audio-fft;75;76;76;123;76;79;74;74;99;74 15:54:01 INFO - PROCESS | 15730 | |4;audio-oscillator;86;85;116;85;85;85;120;85;85;129 15:54:01 INFO - PROCESS | 15730 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 15:54:01 INFO - PROCESS | 15730 | |6;imaging-darkroom;147;146;146;147;146;147;146;145;147;145 15:54:01 INFO - PROCESS | 15730 | |7;imaging-desaturate;95;96;95;95;95;95;95;96;96;95 15:54:01 INFO - PROCESS | 15730 | |8;json-parse-financial;65;67;65;65;66;73;65;64;67;66 15:54:01 INFO - PROCESS | 15730 | |9;json-stringify-tinderbox;65;67;65;65;66;66;65;66;65;65 15:54:01 INFO - PROCESS | 15730 | |10;stanford-crypto-aes;79;81;78;78;78;78;78;78;79;81 15:54:01 INFO - PROCESS | 15730 | |11;stanford-crypto-ccm;129;128;125;128;138;128;129;127;171;132 15:54:01 INFO - PROCESS | 15730 | |12;stanford-crypto-pbkdf2;164;163;168;164;162;164;160;166;163;164 15:54:01 INFO - PROCESS | 15730 | |13;stanford-crypto-sha256-iterative;69;66;65;67;67;65;66;66;64;65 15:54:01 INFO - PROCESS | 15730 | __end_tp_report 15:54:01 INFO - PROCESS | 15730 | __start_cc_report 15:54:01 INFO - PROCESS | 15730 | _x_x_mozilla_cycle_collect,1916 15:54:01 INFO - PROCESS | 15730 | __end_cc_report 15:54:01 INFO - PROCESS | 15730 | __startTimestamp1468450441230__endTimestamp 15:54:01 INFO - PROCESS | 15730 | 15:54:01 INFO - PROCESS | 15730 | ------- Summary: start ------- 15:54:01 INFO - PROCESS | 15730 | Number of tests: 14 15:54:01 INFO - PROCESS | 15730 | 15:54:01 INFO - PROCESS | 15730 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:2.98 (2.6%) stddev-sans-first:0.67 15:54:01 INFO - PROCESS | 15730 | Values: 104.0 113.0 114.0 112.0 114.0 113.0 113.0 114.0 113.0 113.0 15:54:01 INFO - PROCESS | 15730 | 15:54:01 INFO - PROCESS | 15730 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:145.00 stddev:23.28 (16.1%) stddev-sans-first:24.68 15:54:01 INFO - PROCESS | 15730 | Values: 144.0 121.0 129.0 175.0 122.0 156.0 146.0 121.0 183.0 121.0 15:54:01 INFO - PROCESS | 15730 | 15:54:01 INFO - PROCESS | 15730 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.41 (0.9%) stddev-sans-first:1.50 15:54:01 INFO - PROCESS | 15730 | Values: 162.0 163.0 162.0 161.0 163.0 161.0 164.0 162.0 163.0 159.0 15:54:01 INFO - PROCESS | 15730 | 15:54:01 INFO - PROCESS | 15730 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:16.07 (21.1%) stddev-sans-first:16.81 15:54:01 INFO - PROCESS | 15730 | Values: 75.0 76.0 76.0 123.0 76.0 79.0 74.0 74.0 99.0 74.0 15:54:01 INFO - PROCESS | 15730 | 15:54:01 INFO - PROCESS | 15730 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:85.00 stddev:17.92 (21.1%) stddev-sans-first:18.63 15:54:01 INFO - PROCESS | 15730 | Values: 86.0 85.0 116.0 85.0 85.0 85.0 120.0 85.0 85.0 129.0 15:54:01 INFO - PROCESS | 15730 | 15:54:01 INFO - PROCESS | 15730 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:54:01 INFO - PROCESS | 15730 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 15:54:01 INFO - PROCESS | 15730 | 15:54:01 INFO - PROCESS | 15730 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 15:54:01 INFO - PROCESS | 15730 | Values: 147.0 146.0 146.0 147.0 146.0 147.0 146.0 145.0 147.0 145.0 15:54:01 INFO - PROCESS | 15730 | 15:54:01 INFO - PROCESS | 15730 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 15:54:01 INFO - PROCESS | 15730 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 15:54:01 INFO - PROCESS | 15730 | 15:54:01 INFO - PROCESS | 15730 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.00 stddev:2.54 (3.8%) stddev-sans-first:2.65 15:54:01 INFO - PROCESS | 15730 | Values: 65.0 67.0 65.0 65.0 66.0 73.0 65.0 64.0 67.0 66.0 15:54:01 INFO - PROCESS | 15730 | 15:54:01 INFO - PROCESS | 15730 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 15:54:01 INFO - PROCESS | 15730 | Values: 65.0 67.0 65.0 65.0 66.0 66.0 65.0 66.0 65.0 65.0 15:54:01 INFO - PROCESS | 15730 | 15:54:01 INFO - PROCESS | 15730 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.50 stddev:1.23 (1.6%) stddev-sans-first:1.30 15:54:01 INFO - PROCESS | 15730 | Values: 79.0 81.0 78.0 78.0 78.0 78.0 78.0 78.0 79.0 81.0 15:54:01 INFO - PROCESS | 15730 | 15:54:01 INFO - PROCESS | 15730 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:129.00 stddev:13.64 (10.6%) stddev-sans-first:14.37 15:54:01 INFO - PROCESS | 15730 | Values: 129.0 128.0 125.0 128.0 138.0 128.0 129.0 127.0 171.0 132.0 15:54:01 INFO - PROCESS | 15730 | 15:54:01 INFO - PROCESS | 15730 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.80 Median:164.00 stddev:2.15 (1.3%) stddev-sans-first:2.28 15:54:01 INFO - PROCESS | 15730 | Values: 164.0 163.0 168.0 164.0 162.0 164.0 160.0 166.0 163.0 164.0 15:54:01 INFO - PROCESS | 15730 | 15:54:01 INFO - PROCESS | 15730 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.41 (2.1%) stddev-sans-first:1.00 15:54:01 INFO - PROCESS | 15730 | Values: 69.0 66.0 65.0 67.0 67.0 65.0 66.0 66.0 64.0 65.0 15:54:01 INFO - PROCESS | 15730 | -------- Summary: end -------- 15:54:01 INFO - PROCESS | 15730 | 15:54:02 INFO - TEST-INFO | 15730: exit 0 15:54:02 INFO - TEST-OK | kraken | took 64292ms 15:54:02 INFO - SUITE-END | took 1184s 15:54:02 INFO - Completed test suite (00:19:45) 15:54:02 INFO - javascript benchmark 15:54:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2592.46854394849, 2614.7908167346613, 2643.088134593565, 2649.483350746605, 2652.734726527346, 4473.105378924212, 4571.291449825274, 4644.047970166116, 4658.673892827504, 4674.415698037746, 4629.444466664005, 4630.490646028942, 4636.142313671973, 4668.369770081038, 4685.062987402524, 4035.9394609080887, 4198.223328684196, 4274.7435153890865, 4296.248156572603, 4415.845445409412, 4279.101388708359, 4351.412559304501, 4352.956470435287, 4356.4990026146925, 4390.2536568783225, 4097.078157414573, 4106.917861642781, 4113.958860411418, 4218.987443013654, 4231.534531201565, 4224.577542245782, 4228.725132866354, 4229.70392072555, 4278.807453664593, 4287.0, 4259.8509052183335, 4264.573542645741, 4267.061246525759, 4303.634191093761, 4313.15893400787, 4420.248557745191, 4539.886502837456, 4573.771311434415, 4583.358329833826, 4689.835855745033, 4909.975450122726, 4945.0, 4965.776540055706, 4969.304297398367, 4969.975150124226, 4811.639127065484, 4970.329005584272, 4984.6261530385, 4988.625853060998, 5000.249962505617, 4621.445426548836, 4640.443146822336, 4646.814127434933, 4651.37206477128, 4694.131585656664, 5108.029474399852, 5128.794848206105, 5134.486551344836, 5139.563137133311, 5146.665466744649, 4699.906001880012, 4846.636502262344, 4889.242167464049, 4889.3888263967, 4892.730899800474, 4967.130752118437, 4972.179590367549, 4976.2038073908, 5016.874578135576, 5021.271915572222, 4925.876853078702, 4929.87675308113, 4949.430815456197, 4959.776810043557, 5006.949930500648, 4765.451973023147, 4867.415910090741, 4876.487968763229, 4877.536634019833, 4926.359573255454, 4249.702520823575, 4250.022494826146, 4251.553586873334, 4276.978615106967, 4292.978535107304, 3696.075981004749, 3713.814309284525, 3714.220013797079, 3746.662800347982, 3756.3614185587967, 4169.1661667666585, 4195.035141917376, 4204.642605378516, 4229.111886503807, 4258.74447533149, 4930.630202734737, 4936.851894443173, 4944.60443164546, 4945.184044632667, 5004.549590536869, 4236.830526778895, 4243.575642435731, 4249.617534421855, 4281.785910704452, 4290.2921018031675, 4304.978475107604, 4415.337699345124, 4440.844570440019, 4453.576910193527, 4490.528494508095, 4669.7431641260055, 4686.835960741358, 4696.60078893291, 4702.294655801657, 4731.858044258678, 4990.126727822544, 4991.276264941635, 4991.80032798684, 5006.224035274538, 5036.924446133385, 4497.302918047708, 4670.719756814602, 4693.24908014716, 4702.177119004092, 4727.290906364073, 4917.311576379381, 4920.114379411597, 4939.43196532389, 4942.085714142895, 4951.480094590161, 4819.542143496362, 4968.577670898014, 4998.750062496788, 5003.399592048978, 5057.924131137962, 4800.66395352322, 4850.854474365775, 4857.198562237191, 4863.610911127172, 4864.221724524059, 4818.229083346648, 4840.056189043244, 4840.080384726891, 4843.2735089736825, 4890.070886531547, 4621.029583787442, 4697.412823397075, 4783.067301876101, 4834.347363105936, 4836.298736683231, 4796.424429068534, 4815.061063092663, 4815.277708343777, 4831.299461578122, 4877.780499877585, 4734.360861283682, 4735.715857048588, 4737.052589482187, 4743.810247590058, 4773.737444440589], "value": 4551.327216874596, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.615269311482, 578.6730497269043, 580.1442871764151, 586.4458087107683, 599.4874382403044, 27252.591211131825, 39843.20313593726, 40822.18355632893, 40828.0, 41006.74462904539, 40444.0, 40560.79719601405, 40657.0, 40682.0, 40754.0, 7548.5848278344665, 7910.457460795133, 8052.5973701315, 8066.314363279128, 10266.178705703564, 10306.278560500768, 10469.214808889365, 10471.109955653741, 10476.842847357295, 10483.475826208698, 10482.842757358607, 10525.6316028939, 10528.578856845717, 10532.315399499008, 10553.314034587765, 7635.69457221716, 10247.487625618764, 10433.113185379252, 10482.26624136307, 10542.262041657086, 10311.43287119208, 10372.585096596127, 10373.170146388271, 10377.169826413869, 10399.948000260027, 39351.40972885409, 39658.20683586312, 39814.40278395826, 39933.20133597312, 40015.79992100021, 2799.930001749952, 2819.873105710248, 2848.4160747046803, 2876.7123287671275, 2954.9556756648667, 27501.491943505032, 29305.267368315748, 29667.851660741773, 30004.54947681023, 30897.691023089705, 2918.285020170072, 2973.717496837797, 3003.714647108521, 3019.5470679398045, 3064.4637188492147, 261547.0, 262370.0, 263018.0, 263060.73878522514, 263329.0, 29119.56320655192, 29876.0, 29939.550906736415, 52783.736081319345, 53236.46763532393, 32780.34439311248, 32794.67205327916, 32897.342053158805, 32968.0, 32990.50514242288, 12978.935105324414, 13201.801972970414, 13206.471741130246, 13212.819884719105, 13223.206607603575, 9987.700368988943, 10171.389716617026, 10207.285490015776, 10391.948040259751, 10832.133429325635, 7759.107702614158, 7936.047674279123, 7963.044434667877, 8101.918980810235, 8112.18878112184, 3106.7359274461924, 3131.698201821705, 3142.9371412572077, 3142.9528557071662, 3211.454052811028, 784.4935431296951, 833.3083540661237, 964.0793042644258, 974.4932635029745, 1027.305215166696, 25771.226863194133, 26850.5972410414, 27836.02573909944, 27997.58003629947, 28795.712042879302, 950.6482601437513, 953.7901661634429, 970.2722957781664, 972.7908499672604, 1001.4291853643499, 14142.858571414154, 14736.705265894836, 14883.925580372028, 14909.478168264059, 15107.4712385066, 386278.0, 389850.0, 390768.0, 392453.0, 392836.0, 50296.74851625792, 50685.23972140421, 50818.49181508212, 50823.745881270355, 50838.949663020336, 1034.5292891734393, 1081.8377243413552, 1119.0488085127738, 1163.7963356412424, 1197.700574856286, 28037.43925121527, 29111.417771644024, 29536.409271814875, 30303.545446817876, 30329.545056823725, 41959.160816784104, 42338.788306059505, 42471.3629295567, 42637.36043959281, 42694.78652606717, 258164.0, 259204.0, 260389.0, 260649.0, 260827.0, 37248.255034899696, 39171.21657566776, 39274.41088383619, 39340.803295983336, 39344.0, 41604.0, 41896.162076758905, 41941.37087943744, 42800.1439971205, 43024.56975430206, 36527.634723653486, 36651.816740916125, 36676.26647466982, 36780.44829327616, 36941.815290923376, 35713.46429803607, 35919.28161436704, 36129.096772580895, 36302.636973629924, 36775.26449470942, 32469.675303246666, 32789.83605081959, 32854.178645534055, 32870.178245544055, 32902.50646240356, 30432.543511847784, 30677.53983690202, 32243.677563224068, 35004.64995350014, 35528.111797205274, 25663.871680641478, 25850.224493265232, 25913.352166195997, 25949.610755839054, 26427.471450571265], "value": 16880.237037346502, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.5365982753196, 366.15783697495755, 370.0415922760051, 378.8238469111863, 391.3073859269094, 12366.454193225847, 16612.750808737877, 17334.913325433372, 19120.90439547804, 19129.0, 17201.311947522114, 17266.913665431653, 17510.299588016496, 17668.911655441705, 17823.0, 4903.436104847943, 5215.791368345262, 5220.138677118271, 5225.843224703265, 5228.660137091096, 3754.1553150541044, 5042.647014708972, 5749.0, 6035.939640603582, 6057.273127224739, 5994.1608174855555, 6068.453839154476, 6078.544109191828, 6081.604695694788, 6082.057281121433, 5373.435789242132, 5684.317881854204, 5684.715764211794, 5767.106098554731, 5777.133429985493, 5344.812931547377, 5500.1749737539285, 5540.556755459554, 5547.306586676666, 5550.500454959073, 12682.492700291978, 12899.484020639164, 12940.223586584834, 13145.342732863413, 13145.934270328682, 1844.2254253213682, 1859.3771086685977, 1879.351623689825, 1907.418237437581, 2079.3450063230034, 9373.531323433801, 9381.437113773127, 9521.714348569554, 9779.0, 9937.254705897087, 1684.2252563820657, 1811.9637607247912, 1856.3502774029116, 1864.580469394389, 1875.3342563389936, 66737.0, 68767.65616171937, 70524.0, 71069.28930710678, 71742.92385614272, 9081.364304498622, 9741.220702343795, 10114.696559103239, 10270.0, 10339.327943683636, 12662.556810511587, 13477.326133693472, 13493.055486115878, 14012.509562165274, 14099.224542650252, 6258.311585725566, 7299.379552738077, 7419.220981796833, 7421.851562968711, 7445.441591880631, 6808.523403361717, 6824.317568243236, 6835.598702266024, 6840.555363901331, 6977.755778547828, 4359.280718681445, 4389.582989615981, 4392.0, 4440.866773996785, 4534.342520334599, 1781.714925611922, 1827.6162005978892, 1854.5178253654146, 1892.337681811355, 1922.5962547865106, 793.6150966781106, 836.8075342671219, 841.5707988925569, 895.9104089590988, 934.8504239321812, 16730.330786768638, 17337.306507739548, 17401.738973915402, 17472.17457214677, 17671.204795784222, 830.6386721775926, 840.4831028917295, 844.8943882014748, 857.6869442653511, 884.4914174349775, 8925.553722313858, 9298.0, 9622.9037709622, 9733.367331123454, 9870.111689947938, 361183.0, 363778.0, 365530.0, 365552.0, 368111.0, 72165.6391718038, 74852.0, 79394.20605793867, 86706.56646716726, 87404.12595874087, 930.6510058727977, 930.930180236485, 951.2722767083187, 986.4673076538733, 990.1830989433746, 16447.09540975258, 16485.91757041207, 16704.747143964007, 16954.406595769087, 17052.829471705125, 39040.41439378468, 39050.804745976086, 39446.60553394429, 40205.39691904682, 41702.0, 53730.0, 54219.72890135524, 54255.18617220666, 54332.0, 54615.18077228924, 7155.141383034069, 7278.454115941431, 7285.344319011315, 7454.739084132029, 7460.477766556289, 10343.741406464598, 11308.151888608552, 11494.655160345203, 11545.48045337945, 11588.072954163816, 9849.901500984899, 9973.451460169761, 10066.396016239049, 10066.798664026532, 10161.644342447978, 9942.204623629948, 10052.346597471142, 10107.19142468586, 10109.747256318651, 10330.121939634915, 10024.398536087858, 10044.54799534008, 10251.0, 10305.896941030494, 10528.315659482108, 7434.665440055102, 7457.962710186414, 7507.962460187882, 7759.30166285037, 7784.649690764042, 9714.174295184988, 9779.559919803769, 9902.405855648683, 10149.797004060025, 10265.846012309672], "value": 8184.428866872771, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1275.5089290623107, 1370.7669696151654, 1426.2868565717142, 1467.442371898679, 1704.6931552320584, 6591.4180596656815, 7594.5822979736095, 7795.33739632132, 7800.960995195031, 8047.557384343859, 7768.06783186017, 7907.327877130451, 7928.326092282163, 7932.801679958004, 7943.960280198606, 1814.0, 2130.084063852543, 2198.307533127068, 2221.7778222177735, 2256.311824893407, 2233.6649502574664, 2254.301166638339, 2254.357508110189, 2255.255765597357, 2258.0, 2167.089822274648, 2172.3374370816896, 2227.509947811479, 2231.9776802232013, 2236.1502629000956, 1756.9385071522436, 2078.6674132138787, 2149.7527784304693, 2149.7850214978457, 2150.2366659835848, 2072.720182775336, 2091.1217288738767, 2093.204582258747, 2096.0, 2098.2970704813906, 7918.485298455582, 7960.721374751856, 7967.3626109911065, 7973.08309544404, 7974.3620510359615, 4424.557544245582, 4537.478190008158, 4539.0921815637, 4541.046380260149, 4547.090581883604, 2638.630591717161, 2724.8910043598235, 2739.8356098633944, 2744.5608702607688, 2753.187809596154, 814.8655471847138, 833.2750507058897, 856.2850020233113, 862.7282406042077, 864.14018052038, 10845.0781683557, 10875.510602022849, 10903.400312982783, 10916.945415272872, 10932.0, 3960.089179488734, 4098.262312783728, 4224.0, 4227.239096962577, 4232.619064284229, 9122.224610908148, 9142.360034797633, 9170.037146099698, 9176.632934682671, 9181.035991220959, 4535.229011068126, 4540.341650460665, 4540.77296135192, 4551.590356867898, 4557.658175636774, 3589.3180295743723, 4040.1515681706583, 4159.313713237282, 4195.727277726999, 4252.107057517894, 3660.4875317455044, 3703.5555733312176, 3765.171662234304, 3808.8666896658483, 3812.294725475796, 1085.451846817368, 1173.3018853782157, 1202.0864143251192, 1221.267239656199, 1223.4922507159606, 660.0528241972785, 751.751921865783, 753.5629334985695, 780.6096951524238, 852.5353682243192, 5297.894042119136, 5347.679139251657, 5374.91937620936, 5408.591923275038, 5501.834944951658, 849.7705619482829, 850.5619605902965, 857.1942374168262, 900.1808354397467, 907.1744712311764, 3582.5880023797076, 3610.187707765784, 3614.584322802911, 3619.6561326673923, 3676.209614932802, 9579.233661307078, 9874.111329980336, 9988.900110998942, 9989.950050249703, 9993.700188994342, 9902.356346837432, 9911.108000279864, 9911.405315681082, 9916.057974492413, 9920.603175873028, 7038.331358520933, 7399.630018499053, 7401.740939067106, 7556.24437556251, 7577.924220757722, 5287.339082614673, 5435.537979271806, 5449.0, 5502.58730595199, 5750.760662930767, 8974.14745599167, 8986.460812351279, 9204.677836275698, 9207.079292070739, 9218.400803947721, 8914.643414263617, 9227.861582076408, 9249.676261330822, 9293.86059209126, 9437.631543426302, 6740.730370785113, 6799.728010879708, 6846.520743547904, 6876.140482439695, 6877.415419689182, 7405.518641288299, 7506.28690274423, 7581.166071731995, 7586.734464293723, 7601.0, 5119.798486650627, 6726.495512836459, 6830.282820303796, 6840.076589660531, 6990.370866621825, 6747.190337159573, 6794.524383293122, 6834.487413443912, 6891.517593768388, 6955.374016338352, 6371.426571608577, 6400.359964003748, 6429.132067170872, 6430.421262086435, 6432.839179020375, 4441.578050085237, 4519.864404067883, 4574.862754117382, 4589.311603259538, 4641.280601506772, 4649.604783593432, 4670.9766451167525, 4676.392069031004, 4684.929726054043, 4757.881052973703], "value": 4129.803646569878, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.7011942639368, 293.6036350926249, 299.6538997457937, 308.3878501175167, 309.48470796124457, 4875.219964805628, 4908.97545512272, 4920.581750551208, 4934.703917764937, 4938.777755001024, 4540.3189521571785, 4692.296155576665, 4713.363695901053, 4714.457837348706, 4820.662553621248, 3641.1989362340373, 3732.4401339798974, 3744.382176940808, 3816.656500914917, 3843.385058390658, 3806.5622453417936, 3813.7795905310313, 3816.656500914917, 3822.178231680188, 3823.3882578787398, 3665.1386924072954, 3787.9810600947094, 3790.4124860646507, 3807.600201978794, 3833.6358045985585, 3616.330978768923, 3713.554373475187, 3752.8498860045565, 3805.543334799842, 3819.598942111066, 3374.493825926106, 3380.797152170878, 3381.712554432876, 3395.507651390559, 3408.744344174172, 4732.384789977315, 4734.881627959294, 4737.478877323526, 4741.668083234175, 4784.889821615942, 4149.315362965107, 4391.27543955247, 4417.337399390085, 4422.292433210703, 4433.46798384196, 5071.416787069497, 5079.466656001141, 5080.568151707109, 5091.79632814687, 5099.821506247301, 3684.9263014739554, 3704.4072948328408, 3709.0541911812584, 3732.104294969215, 3734.3838266686234, 5075.187969924795, 5245.10833158364, 5251.555822148902, 5276.894462110775, 5300.655457395257, 3661.553686293899, 3662.1760103976394, 3667.8716244931297, 3669.1377526281303, 3689.206820533598, 3721.423179407196, 3739.364308067635, 3740.326741186558, 3748.3627783276906, 3753.4557489163917, 4257.87226383209, 4282.550332215073, 4298.333758267474, 4308.91382172361, 4313.158934007838, 4879.121758083579, 5104.4895510449405, 5124.8206312778875, 5132.948670513321, 5141.640085194001, 1334.5595953335376, 1339.6583871112805, 1350.4260689207047, 1350.4800651749147, 1351.7904724767677, 831.4720152702956, 863.8013256950811, 864.7276108026077, 869.6956065377194, 873.1792115411492, 3993.3061917725986, 4015.8996025099605, 4027.677785777131, 4029.5768944261017, 4058.553559108496, 4619.769011549409, 4645.256758918556, 4664.766761661904, 4679.3916790816975, 4703.061785125673, 4056.4320995060716, 4056.7565946043333, 4057.594240575978, 4064.0, 4278.4865816102265, 2640.6567146271245, 2770.171686686777, 2770.6121143039586, 2788.7490125888767, 2813.0, 4950.331705219821, 4961.355023846877, 4962.60299176065, 4996.125678006334, 4998.90002199954, 5263.6841789492755, 5394.352677678704, 5406.972965135149, 5428.75570599324, 5445.455454454602, 4965.3048573199785, 4966.404031516241, 4970.279309500174, 4983.227599722049, 4985.559963625087, 5242.239875218148, 5247.55395791362, 5251.606129540376, 5297.099493086108, 5316.760745766527, 5026.673266237683, 5162.7351298932, 5190.247414124855, 5191.273221749034, 5196.376434827694, 4882.804687812448, 4892.926606100982, 4913.28757330178, 4921.606271498343, 4928.8767780805765, 3798.772073675588, 3804.771713697187, 3814.218085292564, 3815.2369526094335, 3819.446180303785, 5016.949830501649, 5204.245384419314, 5221.660592061504, 5225.790968361223, 5298.70857102863, 5008.799648014038, 5015.949840501548, 5038.89144388234, 5056.595472362275, 5080.1363768160245, 5040.521150490697, 5069.020818657336, 5070.670406423571, 5082.796688132434, 5084.593232541314, 4844.370231869975, 4982.55505903284, 5006.623178625907, 5017.473165317735, 5022.397312322399, 5062.519060689228, 5077.669951453144, 5094.592432605456, 5095.87260318495, 5115.769790359368, 4970.900581988412, 4985.202367621163, 5012.77442515095, 5025.145725226647, 5040.899182016413], "value": 3809.63907733355, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.3986093975554, 632.0834789555145, 645.3062957320878, 646.8318237258311, 722.1695050691704, 13632.591022269335, 14201.076929999543, 14307.284635768196, 14330.068545544533, 14339.928300358497, 12952.74094518109, 13132.540361087364, 13172.802407963864, 13197.604071877859, 13204.141730787493, 612.4610342898243, 739.7817643795066, 769.415244414245, 771.2634434115434, 774.9690012399498, 768.6579472134903, 775.5114278004877, 775.7827808213709, 776.728145149196, 776.8718161503346, 812.7399232245684, 813.3818298093462, 813.772143799737, 813.8819871118684, 813.9511629302261, 639.3159319528107, 777.327611615951, 793.8412317536515, 797.9521228726295, 801.3789313282194, 596.4065754574183, 597.5010865926956, 597.5906504044743, 597.8087012156112, 598.5211830535554, 13466.730665386734, 13486.595402137951, 13492.190468571916, 13507.122037067558, 13519.391627376792, 12685.74628507434, 12945.158564693265, 12958.87041129586, 13016.41426135826, 13087.47650093995, 11789.823152652718, 11830.940845295718, 11883.40582970848, 12002.099842511847, 12221.327826969513, 3145.3552021835467, 3258.266889949766, 3260.6413294537583, 3321.5848018997626, 4197.853075142355, 62117.6894115531, 62561.687191564204, 62721.37278627246, 63599.36400635981, 63765.0, 10054.16149068323, 10091.798164036678, 10221.488925553693, 10291.279610427348, 10362.792744145076, 17780.46658600244, 17806.821931780774, 17811.554711132067, 17864.55338616545, 17898.731519027224, 6690.899636505456, 6700.497462690318, 6714.865702685919, 6718.865622687519, 6970.128733908262, 3393.5079413484905, 3507.105688049531, 3569.94645080324, 3596.3886139356373, 3624.4744512045604, 2908.578256152846, 3008.849557522115, 3023.5313526403443, 3026.2131845720273, 3027.5004624237195, 468.39576945740293, 472.3623108803157, 495.1829481355792, 501.1030255842075, 514.1644827155872, 463.1963543252454, 478.26824957814597, 481.98554043378755, 499.40570720842084, 506.87191850526574, 7220.566765994057, 7406.444516661272, 7473.327400533978, 7503.0, 7893.447458677838, 402.3441789882473, 443.4656239231718, 474.54680779855846, 494.6364422149717, 524.281734024389, 3701.925961480755, 3762.4385879860097, 3770.2836461072307, 3868.7678739275734, 3916.8629097981434, 99150.5042474783, 103499.48250258851, 104529.47735261427, 104738.0, 107519.0, 89787.0, 90542.0, 91044.54477727569, 91058.0, 91729.54135229281, 78697.0, 79993.20006799974, 80315.59842200752, 80740.19259807444, 80822.59588702019, 7177.4520045385225, 7340.657367835684, 7361.705531778669, 7468.850622987618, 7584.8483030340185, 44285.0, 44932.550674492835, 46213.30680039869, 46619.0, 46767.0, 61797.0, 68380.6580967092, 70025.29974700187, 70093.0, 71173.64413177902, 8505.277051450448, 8520.403571749917, 8950.731478055668, 9057.909420905706, 9386.15524602789, 11222.38276894746, 11280.09759219244, 11311.208215424842, 11557.24877882935, 11750.0, 9388.342816003087, 9546.52267386614, 9625.133737963617, 9937.850932235877, 10066.54700538463, 11294.152938529807, 11665.941670291595, 12201.389930503618, 12286.0, 12581.496740130659, 10962.177836662442, 11208.439578020903, 11315.830262545904, 11321.943390282995, 11713.0, 9781.706548803548, 9907.702768916944, 10247.795044099226, 10355.430451324948, 10538.156947444339, 9978.301518893608, 10254.384736915808, 10259.435731034864, 10321.329113607591, 10327.535260913428], "value": 6418.580085349227, "unit": "score"}], "name": "dromaeo_css", "value": 6316.370691966509, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 114.0, 112.0, 114.0, 113.0, 113.0, 114.0, 113.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 121.0, 129.0, 175.0, 122.0, 156.0, 146.0, 121.0, 183.0, 121.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 163.0, 161.0, 164.0, 162.0, 163.0, 159.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 123.0, 76.0, 79.0, 74.0, 74.0, 99.0, 74.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 116.0, 85.0, 85.0, 85.0, 120.0, 85.0, 85.0, 129.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 145.0, 147.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 65.0, 66.0, 73.0, 65.0, 64.0, 67.0, 66.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 65.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 78.0, 78.0, 78.0, 78.0, 78.0, 78.0, 79.0, 81.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 128.0, 125.0, 128.0, 138.0, 128.0, 129.0, 127.0, 171.0, 132.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 168.0, 164.0, 162.0, 164.0, 160.0, 166.0, 163.0, 164.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 65.0, 67.0, 67.0, 65.0, 66.0, 66.0, 64.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1527.1, "alertThreshold": 2.0}]} 15:54:02 INFO - Return code: 0 15:54:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:54:02 INFO - # TBPL SUCCESS # 15:54:02 INFO - Running post-action listener: _resource_record_post_action 15:54:02 INFO - ##### 15:54:02 INFO - ##### Finished run-tests step (success) 15:54:02 INFO - ##### 15:54:02 INFO - Running post-run listener: _resource_record_post_run 15:54:02 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 544182272; Read time: 524; Write time: 1246036 15:54:02 INFO - TinderboxPrint: CPU usage
13.1% 15:54:02 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 524 15:54:02 INFO - TinderboxPrint: I/O write bytes / time
544,182,272 / 1,246,036 15:54:02 INFO - TinderboxPrint: CPU idle
8,339.9 (86.9%) 15:54:02 INFO - TinderboxPrint: CPU user
1,202.1 (12.5%) 15:54:02 INFO - TinderboxPrint: Swap in / out
0 / 0 15:54:02 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 246956032; Read time: 0; Write time: 651700 15:54:02 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297226240; Read time: 516; Write time: 594336 15:54:03 INFO - Running post-run listener: _upload_blobber_files 15:54:03 INFO - Blob upload gear active. 15:54:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:54:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:54:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:54:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:54:03 INFO - (blobuploader) - INFO - Open directory for files ... 15:54:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:54:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:54:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:04 INFO - (blobuploader) - INFO - Done attempting. 15:54:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:54:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:54:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:07 INFO - (blobuploader) - INFO - Done attempting. 15:54:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:54:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:54:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:08 INFO - (blobuploader) - INFO - Done attempting. 15:54:08 INFO - (blobuploader) - INFO - Iteration through files over. 15:54:08 INFO - Return code: 0 15:54:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:54:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:54:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e83ebac82e960d8f6f03ef741c9c226e748bdf1cf117745d14348cb4f749e3b928e77d8efa22a6d5e0174d938d7503b9b60bcb820eab192c515754a924bd799a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62684c528c42520355955b3e91fbc9a2cc2f248e0073d1d005380207f44c05ede2731b014e8823e556a4be4a70318503a2455f61eb90b749642507d55f9fd5b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ae3fae25df47d9b8ee1d7535723c6f0f10330e1601a8c6284b27a58456a97e6be0835f01118718b18301fc0711c030b416851d117ac642b796ae3fc99de9b6f"} 15:54:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:54:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:54:08 INFO - Contents: 15:54:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e83ebac82e960d8f6f03ef741c9c226e748bdf1cf117745d14348cb4f749e3b928e77d8efa22a6d5e0174d938d7503b9b60bcb820eab192c515754a924bd799a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62684c528c42520355955b3e91fbc9a2cc2f248e0073d1d005380207f44c05ede2731b014e8823e556a4be4a70318503a2455f61eb90b749642507d55f9fd5b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ae3fae25df47d9b8ee1d7535723c6f0f10330e1601a8c6284b27a58456a97e6be0835f01118718b18301fc0711c030b416851d117ac642b796ae3fc99de9b6f"} 15:54:08 INFO - Running post-run listener: copy_logs_to_upload_dir 15:54:08 INFO - Copying logs to upload dir... 15:54:08 INFO - mkdir: /builds/slave/test/build/upload/logs 15:54:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.028775 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-13 15:54:08.442836) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 15:54:08.449656) ========= 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=8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e83ebac82e960d8f6f03ef741c9c226e748bdf1cf117745d14348cb4f749e3b928e77d8efa22a6d5e0174d938d7503b9b60bcb820eab192c515754a924bd799a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62684c528c42520355955b3e91fbc9a2cc2f248e0073d1d005380207f44c05ede2731b014e8823e556a4be4a70318503a2455f61eb90b749642507d55f9fd5b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ae3fae25df47d9b8ee1d7535723c6f0f10330e1601a8c6284b27a58456a97e6be0835f01118718b18301fc0711c030b416851d117ac642b796ae3fc99de9b6f"} build_url:https://queue.taskcluster.net/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011374 build_url: 'https://queue.taskcluster.net/v1/task/ZGtSWb2gRzuieahVyp337w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e83ebac82e960d8f6f03ef741c9c226e748bdf1cf117745d14348cb4f749e3b928e77d8efa22a6d5e0174d938d7503b9b60bcb820eab192c515754a924bd799a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62684c528c42520355955b3e91fbc9a2cc2f248e0073d1d005380207f44c05ede2731b014e8823e556a4be4a70318503a2455f61eb90b749642507d55f9fd5b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ae3fae25df47d9b8ee1d7535723c6f0f10330e1601a8c6284b27a58456a97e6be0835f01118718b18301fc0711c030b416851d117ac642b796ae3fc99de9b6f"}' ========= master_lag: 0.33 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 15:54:08.795896) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:54:08.796233) ========= 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=8783db0840cc980e80bb0bd400000236-1468448377.503196-1209058291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:54:08.817084) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 15:54:08.821470) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 15:54:08.821819) ========= ========= Total master_lag: 0.54 =========