builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1481688892.78 results: success (0) buildid: 20161213192606 builduid: ed8880dbdc7a4fa4996a31b9be17daf6 revision: 1ea0c60db5d25a7d522e2f252c1978ff4fc7538e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 20:14:52.783506) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 20:14:52.784721) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 20:14:52.785227) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 20:14:52.828251) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 20:14:52.828571) ========= 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=6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-13 20:14:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-12-13 20:14:53 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.167766 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 20:14:53.013460) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 20:14:53.014244) ========= 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=6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017632 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 20:14:53.071332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 20:14:53.071697) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1ea0c60db5d25a7d522e2f252c1978ff4fc7538e --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 1ea0c60db5d25a7d522e2f252c1978ff4fc7538e --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=6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-13 20:14:53,676 truncating revision to first 12 chars 2016-12-13 20:14:53,676 Setting DEBUG logging. 2016-12-13 20:14:53,676 attempt 1/10 2016-12-13 20:14:53,676 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1ea0c60db5d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-13 20:14:54,174 unpacking tar archive at: mozilla-central-1ea0c60db5d2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.817606 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 20:14:53.908298) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 20:14:53.909203) ========= script_repo_revision: 1ea0c60db5d25a7d522e2f252c1978ff4fc7538e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 20:14:53.910312) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 20:14:53.911072) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 20:14:53.925632) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-12-13 20:14:53.926420) ========= /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=6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:14:54 INFO - MultiFileLogger online at 20161213 20:14:54 in /builds/slave/test 20:14:54 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 20:14:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:14:54 INFO - {'append_to_log': False, 20:14:54 INFO - 'base_work_dir': '/builds/slave/test', 20:14:54 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 20:14:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:14:54 INFO - 'branch': 'Firefox-Non-PGO', 20:14:54 INFO - 'buildbot_json_path': 'buildprops.json', 20:14:54 INFO - 'config_files': ('talos/linux_config.py',), 20:14:54 INFO - 'default_actions': ('clobber', 20:14:54 INFO - 'read-buildbot-config', 20:14:54 INFO - 'download-and-extract', 20:14:54 INFO - 'populate-webroot', 20:14:54 INFO - 'create-virtualenv', 20:14:54 INFO - 'install', 20:14:54 INFO - 'run-tests'), 20:14:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:14:54 INFO - 'download_minidump_stackwalk': True, 20:14:54 INFO - 'download_symbols': 'ondemand', 20:14:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:14:54 INFO - 'tooltool.py': '/tools/tooltool.py', 20:14:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:14:54 INFO - '/tools/misc-python/virtualenv.py')}, 20:14:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:14:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:14:54 INFO - 'installer_path': 'installer.exe', 20:14:54 INFO - 'log_level': 'info', 20:14:54 INFO - 'log_name': 'talos', 20:14:54 INFO - 'log_to_console': True, 20:14:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:14:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:14:54 INFO - 'opt_config_files': (), 20:14:54 INFO - 'pip_index': False, 20:14:54 INFO - 'sps_profile': False, 20:14:54 INFO - 'sps_profile_interval': 0, 20:14:54 INFO - 'suite': 'dromaeojs', 20:14:54 INFO - 'system_bits': '32', 20:14:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:14:54 INFO - 'title': 'talos-linux64-ix-023', 20:14:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:14:54 INFO - 'use_talos_json': True, 20:14:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:14:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:14:54 INFO - 'work_dir': 'build'} 20:14:54 INFO - [mozharness: 2016-12-14 04:14:54.631079Z] Running clobber step. 20:14:54 INFO - Running pre-action listener: _resource_record_pre_action 20:14:54 INFO - Running main action method: clobber 20:14:54 INFO - rmtree: /builds/slave/test/build 20:14:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:14:55 INFO - Running post-action listener: _resource_record_post_action 20:14:55 INFO - [mozharness: 2016-12-14 04:14:55.087806Z] Finished clobber step (success) 20:14:55 INFO - [mozharness: 2016-12-14 04:14:55.087905Z] Running read-buildbot-config step. 20:14:55 INFO - Running pre-action listener: _resource_record_pre_action 20:14:55 INFO - Running main action method: read_buildbot_config 20:14:55 INFO - Using buildbot properties: 20:14:55 INFO - { 20:14:55 INFO - "project": "", 20:14:55 INFO - "product": "firefox", 20:14:55 INFO - "script_repo_revision": "production", 20:14:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 20:14:55 INFO - "repository": "", 20:14:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 20:14:55 INFO - "buildid": "20161213192606", 20:14:55 INFO - "pgo_build": "False", 20:14:55 INFO - "basedir": "/builds/slave/test", 20:14:55 INFO - "buildnumber": 341, 20:14:55 INFO - "slavename": "talos-linux64-ix-023", 20:14:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:14:55 INFO - "platform": "ubuntu64_hw", 20:14:55 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 20:14:55 INFO - "branch": "mozilla-central", 20:14:55 INFO - "repo_path": "mozilla-central", 20:14:55 INFO - "revision": "1ea0c60db5d25a7d522e2f252c1978ff4fc7538e", 20:14:55 INFO - "stage_platform": "linux64", 20:14:55 INFO - "builduid": "ed8880dbdc7a4fa4996a31b9be17daf6", 20:14:55 INFO - "slavebuilddir": "test" 20:14:55 INFO - } 20:14:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 20:14:55 INFO - Running post-action listener: _resource_record_post_action 20:14:55 INFO - [mozharness: 2016-12-14 04:14:55.090379Z] Finished read-buildbot-config step (success) 20:14:55 INFO - [mozharness: 2016-12-14 04:14:55.090465Z] Running download-and-extract step. 20:14:55 INFO - Running pre-action listener: _resource_record_pre_action 20:14:55 INFO - Running main action method: download_and_extract 20:14:55 INFO - mkdir: /builds/slave/test/build/tests 20:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:55 INFO - trying https://queue.taskcluster.net/v1/task/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:14:55 INFO - Downloading https://queue.taskcluster.net/v1/task/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:14:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:14:55 INFO - Downloaded 1361 bytes. 20:14:55 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:14:55 INFO - Using the following test package requirements: 20:14:55 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 20:14:55 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:14:55 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:14:55 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:55 INFO - u'jsshell-linux-x86_64.zip'], 20:14:55 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:14:55 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 20:14:55 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:14:55 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:14:55 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:14:55 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:14:55 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:14:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 20:14:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:14:55 INFO - Fetch https://queue.taskcluster.net/v1/task/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:14:57 INFO - Expected file size: 20212057 20:14:57 INFO - Obtained file size: 20212057 20:15:01 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:15:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 20:15:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:15:01 INFO - Fetch https://queue.taskcluster.net/v1/task/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:15:02 INFO - Expected file size: 20212057 20:15:02 INFO - Obtained file size: 20212057 20:15:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 20:15:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:15:07 INFO - Fetch https://queue.taskcluster.net/v1/task/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:15:08 INFO - Expected file size: 14409734 20:15:08 INFO - Obtained file size: 14409734 20:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:08 INFO - trying https://queue.taskcluster.net/v1/task/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:15:08 INFO - Downloading https://queue.taskcluster.net/v1/task/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:15:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:15:11 INFO - Downloaded 55776535 bytes. 20:15:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:15:11 INFO - mkdir: /builds/slave/test/properties 20:15:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:15:11 INFO - Writing to file /builds/slave/test/properties/build_url 20:15:11 INFO - Contents: 20:15:11 INFO - build_url:https://queue.taskcluster.net/v1/task/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:15:12 INFO - Running post-action listener: _resource_record_post_action 20:15:12 INFO - Running post-action listener: set_extra_try_arguments 20:15:12 INFO - [mozharness: 2016-12-14 04:15:12.346553Z] Finished download-and-extract step (success) 20:15:12 INFO - [mozharness: 2016-12-14 04:15:12.346779Z] Running populate-webroot step. 20:15:12 INFO - Running pre-action listener: _resource_record_pre_action 20:15:12 INFO - Running main action method: populate_webroot 20:15:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:15:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:15:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:15:12 INFO - '--tppagecycles', 20:15:12 INFO - '7'], 20:15:12 INFO - 'tests': ['tsvgm']}}, 20:15:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:15:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:15:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:15:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:15:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:15:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:15:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:15:12 INFO - 'talos_options': ['--disable-e10s'], 20:15:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:15:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:15:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:15:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:15:12 INFO - 'talos_options': ['--disable-e10s'], 20:15:12 INFO - 'tests': ['damp', 'tps']}, 20:15:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:15:12 INFO - 'tests': ['damp', 'tps']}, 20:15:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:15:12 INFO - 'tests': ['dromaeo_dom']}, 20:15:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:15:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:15:12 INFO - 'tests': ['basic_compositor_video']}, 20:15:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:15:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:15:12 INFO - 'tests': ['a11yr', 20:15:12 INFO - 'ts_paint', 20:15:12 INFO - 'tpaint', 20:15:12 INFO - 'sessionrestore', 20:15:12 INFO - 'sessionrestore_no_auto_restore', 20:15:12 INFO - 'tabpaint']}, 20:15:12 INFO - 'other-e10s': {'tests': ['a11yr', 20:15:12 INFO - 'ts_paint', 20:15:12 INFO - 'tpaint', 20:15:12 INFO - 'sessionrestore', 20:15:12 INFO - 'sessionrestore_no_auto_restore', 20:15:12 INFO - 'tabpaint']}, 20:15:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:15:12 INFO - 'ts_paint', 20:15:12 INFO - 'tpaint', 20:15:12 INFO - 'sessionrestore', 20:15:12 INFO - 'sessionrestore_no_auto_restore', 20:15:12 INFO - 'tabpaint']}, 20:15:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:15:12 INFO - 'ts_paint', 20:15:12 INFO - 'tpaint', 20:15:12 INFO - 'sessionrestore', 20:15:12 INFO - 'sessionrestore_no_auto_restore', 20:15:12 INFO - 'tabpaint']}, 20:15:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:15:12 INFO - 'tests': ['a11yr', 20:15:12 INFO - 'ts_paint', 20:15:12 INFO - 'tpaint', 20:15:12 INFO - 'sessionrestore', 20:15:12 INFO - 'sessionrestore_no_auto_restore', 20:15:12 INFO - 'tabpaint']}, 20:15:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:15:12 INFO - 'tests': ['a11yr', 20:15:12 INFO - 'ts_paint', 20:15:12 INFO - 'tpaint', 20:15:12 INFO - 'sessionrestore', 20:15:12 INFO - 'sessionrestore_no_auto_restore', 20:15:12 INFO - 'tabpaint']}, 20:15:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:15:12 INFO - 'tests': ['tsvgx', 20:15:12 INFO - 'tsvgr_opacity', 20:15:12 INFO - 'tart', 20:15:12 INFO - 'tscrollx', 20:15:12 INFO - 'cart', 20:15:12 INFO - 'tsvg_static']}, 20:15:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:15:12 INFO - 'tsvgr_opacity', 20:15:12 INFO - 'tart', 20:15:12 INFO - 'tscrollx', 20:15:12 INFO - 'cart', 20:15:12 INFO - 'tsvg_static']}, 20:15:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:15:12 INFO - 'talos_options': ['--disable-e10s'], 20:15:12 INFO - 'tests': ['tp5o']}, 20:15:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:15:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:15:12 INFO - 'talos_options': ['--disable-e10s', 20:15:12 INFO - '--xperf_path', 20:15:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:15:12 INFO - 'tests': ['tp5n']}, 20:15:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:15:12 INFO - 'talos_options': ['--xperf_path', 20:15:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:15:12 INFO - 'tests': ['tp5n']}}, 20:15:12 INFO - 'talos.zip': {'path': '', 20:15:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:15:12 INFO - Running post-action listener: _resource_record_post_action 20:15:12 INFO - [mozharness: 2016-12-14 04:15:12.361665Z] Finished populate-webroot step (success) 20:15:12 INFO - [mozharness: 2016-12-14 04:15:12.361769Z] Running create-virtualenv step. 20:15:12 INFO - Running pre-action listener: _resource_record_pre_action 20:15:12 INFO - Running main action method: create_virtualenv 20:15:12 INFO - Creating virtualenv /builds/slave/test/build/venv 20:15:12 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 20:15:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:15:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:15:12 INFO - Using real prefix '/usr' 20:15:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:15:12 INFO - Installing distribute.............................................................................................................................................................................................done. 20:15:14 INFO - Installing pip.................done. 20:15:14 INFO - Return code: 0 20:15:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:15:15 INFO - Reading from file tmpfile_stdout 20:15:15 INFO - Output received: 20:15:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 20:15:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:15 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 0x7f202ed48e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2113f20>, '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 0x2080c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2080f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', '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 20:15:15 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 20:15:15 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 20:15:15 INFO - Using env: {'DISPLAY': ':0', 20:15:15 INFO - 'HOME': '/home/cltbld', 20:15:15 INFO - 'LANG': 'en_US.UTF-8', 20:15:15 INFO - 'LANGUAGE': 'en_US:en', 20:15:15 INFO - 'LOGNAME': 'cltbld', 20:15:15 INFO - 'MAIL': '/var/mail/cltbld', 20:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:15 INFO - 'MOZ_NO_REMOTE': '1', 20:15:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:15 INFO - 'NO_EM_RESTART': '1', 20:15:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:15 INFO - 'PWD': '/builds/slave/test', 20:15:15 INFO - 'SHELL': '/bin/bash', 20:15:15 INFO - 'SHLVL': '1', 20:15:15 INFO - 'TERM': 'linux', 20:15:15 INFO - 'TMOUT': '86400', 20:15:15 INFO - 'USER': 'cltbld', 20:15:15 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', 20:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:15 INFO - '_': '/tools/buildbot/bin/python'} 20:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:15 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 20:15:15 INFO - Cleaning up... 20:15:15 INFO - Return code: 0 20:15:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:15 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 0x7f202ed48e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2113f20>, '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 0x2080c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2080f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', '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 20:15:15 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 20:15:15 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 20:15:15 INFO - Using env: {'DISPLAY': ':0', 20:15:15 INFO - 'HOME': '/home/cltbld', 20:15:15 INFO - 'LANG': 'en_US.UTF-8', 20:15:15 INFO - 'LANGUAGE': 'en_US:en', 20:15:15 INFO - 'LOGNAME': 'cltbld', 20:15:15 INFO - 'MAIL': '/var/mail/cltbld', 20:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:15 INFO - 'MOZ_NO_REMOTE': '1', 20:15:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:15 INFO - 'NO_EM_RESTART': '1', 20:15:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:15 INFO - 'PWD': '/builds/slave/test', 20:15:15 INFO - 'SHELL': '/bin/bash', 20:15:15 INFO - 'SHLVL': '1', 20:15:15 INFO - 'TERM': 'linux', 20:15:15 INFO - 'TMOUT': '86400', 20:15:15 INFO - 'USER': 'cltbld', 20:15:15 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', 20:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:15 INFO - '_': '/tools/buildbot/bin/python'} 20:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:15 INFO - Downloading/unpacking psutil>=3.1.1 20:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:15:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:15:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:15:17 INFO - Installing collected packages: psutil 20:15:17 INFO - Running setup.py install for psutil 20:15:17 INFO - building 'psutil._psutil_linux' extension 20:15:17 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 20:15:17 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 20:15:17 INFO - building 'psutil._psutil_posix' extension 20:15:17 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 20:15:18 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 20:15:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:15:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:15:18 INFO - Successfully installed psutil 20:15:18 INFO - Cleaning up... 20:15:18 INFO - Return code: 0 20:15:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:18 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 0x7f202ed48e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2113f20>, '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 0x2080c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2080f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', '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 20:15:18 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 20:15:18 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 20:15:18 INFO - Using env: {'DISPLAY': ':0', 20:15:18 INFO - 'HOME': '/home/cltbld', 20:15:18 INFO - 'LANG': 'en_US.UTF-8', 20:15:18 INFO - 'LANGUAGE': 'en_US:en', 20:15:18 INFO - 'LOGNAME': 'cltbld', 20:15:18 INFO - 'MAIL': '/var/mail/cltbld', 20:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:18 INFO - 'MOZ_NO_REMOTE': '1', 20:15:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:18 INFO - 'NO_EM_RESTART': '1', 20:15:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:18 INFO - 'PWD': '/builds/slave/test', 20:15:18 INFO - 'SHELL': '/bin/bash', 20:15:18 INFO - 'SHLVL': '1', 20:15:18 INFO - 'TERM': 'linux', 20:15:18 INFO - 'TMOUT': '86400', 20:15:18 INFO - 'USER': 'cltbld', 20:15:18 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', 20:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:18 INFO - '_': '/tools/buildbot/bin/python'} 20:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:15:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:15:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:15:20 INFO - Installing collected packages: mozsystemmonitor 20:15:20 INFO - Running setup.py install for mozsystemmonitor 20:15:20 INFO - Successfully installed mozsystemmonitor 20:15:20 INFO - Cleaning up... 20:15:20 INFO - Return code: 0 20:15:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:20 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 0x7f202ed48e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2113f20>, '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 0x2080c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2080f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', '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 20:15:20 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 20:15:20 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 20:15:20 INFO - Using env: {'DISPLAY': ':0', 20:15:20 INFO - 'HOME': '/home/cltbld', 20:15:20 INFO - 'LANG': 'en_US.UTF-8', 20:15:20 INFO - 'LANGUAGE': 'en_US:en', 20:15:20 INFO - 'LOGNAME': 'cltbld', 20:15:20 INFO - 'MAIL': '/var/mail/cltbld', 20:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:20 INFO - 'MOZ_NO_REMOTE': '1', 20:15:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:20 INFO - 'NO_EM_RESTART': '1', 20:15:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:20 INFO - 'PWD': '/builds/slave/test', 20:15:20 INFO - 'SHELL': '/bin/bash', 20:15:20 INFO - 'SHLVL': '1', 20:15:20 INFO - 'TERM': 'linux', 20:15:20 INFO - 'TMOUT': '86400', 20:15:20 INFO - 'USER': 'cltbld', 20:15:20 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', 20:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:20 INFO - '_': '/tools/buildbot/bin/python'} 20:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:20 INFO - Downloading/unpacking jsonschema==2.5.1 20:15:20 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 20:15:20 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 20:15:20 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 20:15:20 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 20:15:20 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 20:15:20 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 20:15:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:15:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:15:22 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 20:15:22 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 20:15:22 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 20:15:22 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 20:15:22 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 20:15:22 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 20:15:23 INFO - Downloading functools32-3.2.3-2.tar.gz 20:15:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:15:23 INFO - warning: no files found matching '*.txt' 20:15:23 INFO - no previously-included directories found matching 'build' 20:15:23 INFO - no previously-included directories found matching 'dist' 20:15:23 INFO - no previously-included directories found matching '.git*' 20:15:23 INFO - Installing collected packages: jsonschema, functools32 20:15:23 INFO - Running setup.py install for functools32 20:15:23 INFO - warning: no files found matching '*.txt' 20:15:23 INFO - no previously-included directories found matching 'build' 20:15:23 INFO - no previously-included directories found matching 'dist' 20:15:23 INFO - no previously-included directories found matching '.git*' 20:15:23 INFO - Successfully installed jsonschema functools32 20:15:23 INFO - Cleaning up... 20:15:23 INFO - Return code: 0 20:15:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f202ed48e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2113f20>, '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 0x2080c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2080f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', '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 20:15:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:15:23 INFO - Using env: {'DISPLAY': ':0', 20:15:23 INFO - 'HOME': '/home/cltbld', 20:15:23 INFO - 'LANG': 'en_US.UTF-8', 20:15:23 INFO - 'LANGUAGE': 'en_US:en', 20:15:23 INFO - 'LOGNAME': 'cltbld', 20:15:23 INFO - 'MAIL': '/var/mail/cltbld', 20:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:23 INFO - 'MOZ_NO_REMOTE': '1', 20:15:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:23 INFO - 'NO_EM_RESTART': '1', 20:15:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:23 INFO - 'PWD': '/builds/slave/test', 20:15:23 INFO - 'SHELL': '/bin/bash', 20:15:23 INFO - 'SHLVL': '1', 20:15:23 INFO - 'TERM': 'linux', 20:15:23 INFO - 'TMOUT': '86400', 20:15:23 INFO - 'USER': 'cltbld', 20:15:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', 20:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:23 INFO - '_': '/tools/buildbot/bin/python'} 20:15:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:15:23 INFO - Cleaning up... 20:15:23 INFO - Return code: 0 20:15:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:23 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 0x7f202ed48e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2113f20>, '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 0x2080c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2080f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', '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 20:15:23 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 20:15:23 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 20:15:23 INFO - Using env: {'DISPLAY': ':0', 20:15:23 INFO - 'HOME': '/home/cltbld', 20:15:23 INFO - 'LANG': 'en_US.UTF-8', 20:15:23 INFO - 'LANGUAGE': 'en_US:en', 20:15:23 INFO - 'LOGNAME': 'cltbld', 20:15:23 INFO - 'MAIL': '/var/mail/cltbld', 20:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:23 INFO - 'MOZ_NO_REMOTE': '1', 20:15:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:23 INFO - 'NO_EM_RESTART': '1', 20:15:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:23 INFO - 'PWD': '/builds/slave/test', 20:15:23 INFO - 'SHELL': '/bin/bash', 20:15:23 INFO - 'SHLVL': '1', 20:15:23 INFO - 'TERM': 'linux', 20:15:23 INFO - 'TMOUT': '86400', 20:15:23 INFO - 'USER': 'cltbld', 20:15:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', 20:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:23 INFO - '_': '/tools/buildbot/bin/python'} 20:15:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:23 INFO - Downloading/unpacking blobuploader==1.2.4 20:15:23 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 20:15:23 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 20:15:23 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 20:15:23 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 20:15:23 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 20:15:23 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 20:15:25 INFO - Downloading blobuploader-1.2.4.tar.gz 20:15:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:15:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:15:25 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 20:15:25 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 20:15:25 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 20:15:25 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 20:15:25 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 20:15:25 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 20:15:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:15:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:15:26 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 20:15:26 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 20:15:26 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 20:15:26 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 20:15:26 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 20:15:26 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 20:15:26 INFO - Downloading docopt-0.6.1.tar.gz 20:15:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:15:26 INFO - Installing collected packages: blobuploader, requests, docopt 20:15:26 INFO - Running setup.py install for blobuploader 20:15:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:15:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:15:26 INFO - Running setup.py install for requests 20:15:26 INFO - Running setup.py install for docopt 20:15:27 INFO - Successfully installed blobuploader requests docopt 20:15:27 INFO - Cleaning up... 20:15:27 INFO - Return code: 0 20:15:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:27 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 0x7f202ed48e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2113f20>, '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 0x2080c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2080f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', '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 20:15:27 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 20:15:27 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 20:15:27 INFO - Using env: {'DISPLAY': ':0', 20:15:27 INFO - 'HOME': '/home/cltbld', 20:15:27 INFO - 'LANG': 'en_US.UTF-8', 20:15:27 INFO - 'LANGUAGE': 'en_US:en', 20:15:27 INFO - 'LOGNAME': 'cltbld', 20:15:27 INFO - 'MAIL': '/var/mail/cltbld', 20:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:27 INFO - 'MOZ_NO_REMOTE': '1', 20:15:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:27 INFO - 'NO_EM_RESTART': '1', 20:15:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:27 INFO - 'PWD': '/builds/slave/test', 20:15:27 INFO - 'SHELL': '/bin/bash', 20:15:27 INFO - 'SHLVL': '1', 20:15:27 INFO - 'TERM': 'linux', 20:15:27 INFO - 'TMOUT': '86400', 20:15:27 INFO - 'USER': 'cltbld', 20:15:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', 20:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:27 INFO - '_': '/tools/buildbot/bin/python'} 20:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:15:27 INFO - Running setup.py (path:/tmp/pip-JahHd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:15:27 INFO - Running setup.py (path:/tmp/pip-Y4IHRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:15:27 INFO - Running setup.py (path:/tmp/pip-sUuv0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:15:27 INFO - Running setup.py (path:/tmp/pip-YG2dIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:15:27 INFO - Running setup.py (path:/tmp/pip-qVf7cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:15:27 INFO - Running setup.py (path:/tmp/pip-yzgKgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:15:27 INFO - Running setup.py (path:/tmp/pip-AERtHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:15:27 INFO - Running setup.py (path:/tmp/pip-iHapDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:15:27 INFO - Running setup.py (path:/tmp/pip-sWB0Wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:15:27 INFO - Running setup.py (path:/tmp/pip-v8m8hE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:15:28 INFO - Running setup.py (path:/tmp/pip-DbfNaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:15:28 INFO - Running setup.py (path:/tmp/pip-0mEnPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:15:28 INFO - Running setup.py (path:/tmp/pip-fD7gCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:15:28 INFO - Running setup.py (path:/tmp/pip-5TMYjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:28 INFO - Running setup.py (path:/tmp/pip-n2dEfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:15:28 INFO - Running setup.py (path:/tmp/pip-5lGSeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:15:28 INFO - Running setup.py (path:/tmp/pip-148GXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:15:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:15:28 INFO - Running setup.py install for manifestparser 20:15:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:15:28 INFO - Running setup.py install for mozcrash 20:15:28 INFO - Running setup.py install for mozdebug 20:15:28 INFO - Running setup.py install for mozdevice 20:15:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:15:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:15:28 INFO - Running setup.py install for mozfile 20:15:29 INFO - Running setup.py install for mozhttpd 20:15:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:15:29 INFO - Running setup.py install for mozinfo 20:15:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:15:29 INFO - Running setup.py install for mozInstall 20:15:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:15:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:15:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:15:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:15:29 INFO - Running setup.py install for mozleak 20:15:29 INFO - Running setup.py install for mozlog 20:15:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:15:29 INFO - Running setup.py install for moznetwork 20:15:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:15:29 INFO - Running setup.py install for mozprocess 20:15:29 INFO - Running setup.py install for mozprofile 20:15:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:15:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:15:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:15:29 INFO - Running setup.py install for mozrunner 20:15:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:15:30 INFO - Running setup.py install for mozscreenshot 20:15:30 INFO - Running setup.py install for moztest 20:15:30 INFO - Running setup.py install for mozversion 20:15:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:15:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:15:30 INFO - Cleaning up... 20:15:30 INFO - Return code: 0 20:15:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:30 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 0x7f202ed48e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2113f20>, '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 0x2080c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2080f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', '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 20:15:30 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 20:15:30 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 20:15:30 INFO - Using env: {'DISPLAY': ':0', 20:15:30 INFO - 'HOME': '/home/cltbld', 20:15:30 INFO - 'LANG': 'en_US.UTF-8', 20:15:30 INFO - 'LANGUAGE': 'en_US:en', 20:15:30 INFO - 'LOGNAME': 'cltbld', 20:15:30 INFO - 'MAIL': '/var/mail/cltbld', 20:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:30 INFO - 'MOZ_NO_REMOTE': '1', 20:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:30 INFO - 'NO_EM_RESTART': '1', 20:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:30 INFO - 'PWD': '/builds/slave/test', 20:15:30 INFO - 'SHELL': '/bin/bash', 20:15:30 INFO - 'SHLVL': '1', 20:15:30 INFO - 'TERM': 'linux', 20:15:30 INFO - 'TMOUT': '86400', 20:15:30 INFO - 'USER': 'cltbld', 20:15:30 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', 20:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:30 INFO - '_': '/tools/buildbot/bin/python'} 20:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:15:30 INFO - Running setup.py (path:/tmp/pip-6JjxWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:15:30 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)) 20:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:15:30 INFO - Running setup.py (path:/tmp/pip-SF_DqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:15:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 20:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:15:30 INFO - Running setup.py (path:/tmp/pip-Gcejxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:15:30 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)) 20:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:15:30 INFO - Running setup.py (path:/tmp/pip-srxJyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:15:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 20:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:15:30 INFO - Running setup.py (path:/tmp/pip-v986zL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:15:30 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)) 20:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:15:30 INFO - Running setup.py (path:/tmp/pip-q4CBWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:15:31 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)) 20:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:15:31 INFO - Running setup.py (path:/tmp/pip-tKVFDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:15:31 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)) 20:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:15:31 INFO - Running setup.py (path:/tmp/pip-9fsSFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:15:31 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)) 20:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:15:31 INFO - Running setup.py (path:/tmp/pip-qhElH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:15:31 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)) 20:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:15:31 INFO - Running setup.py (path:/tmp/pip-Oxw3Ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:15:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 20:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:15:31 INFO - Running setup.py (path:/tmp/pip-F_SPig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:15:31 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)) 20:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:15:31 INFO - Running setup.py (path:/tmp/pip-w5doi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:15:31 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)) 20:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:15:31 INFO - Running setup.py (path:/tmp/pip-FaZreI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:15:31 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)) 20:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:15:31 INFO - Running setup.py (path:/tmp/pip-4nGJ_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:15:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 20:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:31 INFO - Running setup.py (path:/tmp/pip-P8XmKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:15:31 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)) 20:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:15:31 INFO - Running setup.py (path:/tmp/pip-veMqA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:15:31 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)) 20:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:15:31 INFO - Running setup.py (path:/tmp/pip-PdNsU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:15:31 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)) 20:15:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:15:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:15:31 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)) 20:15:31 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:15:31 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:15:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:15:31 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 20:15:31 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 20:15:31 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 20:15:31 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 20:15:31 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 20:15:31 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 20:15:33 INFO - Downloading blessings-1.6.tar.gz 20:15:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:15:33 INFO - Installing collected packages: blessings 20:15:33 INFO - Running setup.py install for blessings 20:15:34 INFO - Successfully installed blessings 20:15:34 INFO - Cleaning up... 20:15:34 INFO - Return code: 0 20:15:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:15:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:15:34 INFO - Reading from file tmpfile_stdout 20:15:34 INFO - Current package versions: 20:15:34 INFO - argparse == 1.2.1 20:15:34 INFO - blessings == 1.6 20:15:34 INFO - blobuploader == 1.2.4 20:15:34 INFO - docopt == 0.6.1 20:15:34 INFO - functools32 == 3.2.3-2 20:15:34 INFO - jsonschema == 2.5.1 20:15:34 INFO - manifestparser == 1.1 20:15:34 INFO - mozInstall == 1.12 20:15:34 INFO - mozcrash == 1.0 20:15:34 INFO - mozdebug == 0.1 20:15:34 INFO - mozdevice == 0.49 20:15:34 INFO - mozfile == 1.2 20:15:34 INFO - mozhttpd == 0.7 20:15:34 INFO - mozinfo == 0.9 20:15:34 INFO - mozleak == 0.1 20:15:34 INFO - mozlog == 3.4 20:15:34 INFO - moznetwork == 0.27 20:15:34 INFO - mozprocess == 0.23 20:15:34 INFO - mozprofile == 0.28 20:15:34 INFO - mozrunner == 6.13 20:15:34 INFO - mozscreenshot == 0.1 20:15:34 INFO - mozsystemmonitor == 0.3 20:15:34 INFO - moztest == 0.7 20:15:34 INFO - mozversion == 1.4 20:15:34 INFO - psutil == 3.1.1 20:15:34 INFO - requests == 1.2.3 20:15:34 INFO - wsgiref == 0.1.2 20:15:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:34 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 0x7f202ed48e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2113f20>, '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 0x2080c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2080f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', '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 20:15:34 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 20:15:34 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 20:15:34 INFO - Using env: {'DISPLAY': ':0', 20:15:34 INFO - 'HOME': '/home/cltbld', 20:15:34 INFO - 'LANG': 'en_US.UTF-8', 20:15:34 INFO - 'LANGUAGE': 'en_US:en', 20:15:34 INFO - 'LOGNAME': 'cltbld', 20:15:34 INFO - 'MAIL': '/var/mail/cltbld', 20:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:34 INFO - 'MOZ_NO_REMOTE': '1', 20:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:34 INFO - 'NO_EM_RESTART': '1', 20:15:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:34 INFO - 'PWD': '/builds/slave/test', 20:15:34 INFO - 'SHELL': '/bin/bash', 20:15:34 INFO - 'SHLVL': '1', 20:15:34 INFO - 'TERM': 'linux', 20:15:34 INFO - 'TMOUT': '86400', 20:15:34 INFO - 'USER': 'cltbld', 20:15:34 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', 20:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:34 INFO - '_': '/tools/buildbot/bin/python'} 20:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:34 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)) 20:15:34 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)) 20:15:34 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)) 20:15:34 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)) 20:15:34 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)) 20:15:34 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)) 20:15:34 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)) 20:15:34 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)) 20:15:34 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)) 20:15:34 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)) 20:15:34 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)) 20:15:34 INFO - Cleaning up... 20:15:34 INFO - Return code: 0 20:15:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:15:34 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 0x7f202ed48e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2083120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2113f20>, '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 0x2080c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2080f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', '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 20:15:34 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 20:15:34 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 20:15:34 INFO - Using env: {'DISPLAY': ':0', 20:15:34 INFO - 'HOME': '/home/cltbld', 20:15:34 INFO - 'LANG': 'en_US.UTF-8', 20:15:34 INFO - 'LANGUAGE': 'en_US:en', 20:15:34 INFO - 'LOGNAME': 'cltbld', 20:15:34 INFO - 'MAIL': '/var/mail/cltbld', 20:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:34 INFO - 'MOZ_NO_REMOTE': '1', 20:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:34 INFO - 'NO_EM_RESTART': '1', 20:15:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:34 INFO - 'PWD': '/builds/slave/test', 20:15:34 INFO - 'SHELL': '/bin/bash', 20:15:34 INFO - 'SHLVL': '1', 20:15:34 INFO - 'TERM': 'linux', 20:15:34 INFO - 'TMOUT': '86400', 20:15:34 INFO - 'USER': 'cltbld', 20:15:34 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', 20:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:34 INFO - '_': '/tools/buildbot/bin/python'} 20:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:15:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:15:34 INFO - Cleaning up... 20:15:34 INFO - Return code: 0 20:15:34 INFO - Running post-action listener: _resource_record_post_action 20:15:34 INFO - Running post-action listener: _start_resource_monitoring 20:15:34 INFO - Starting resource monitoring. 20:15:34 INFO - [mozharness: 2016-12-14 04:15:34.817150Z] Finished create-virtualenv step (success) 20:15:34 INFO - [mozharness: 2016-12-14 04:15:34.817616Z] Running install step. 20:15:34 INFO - Running pre-action listener: _resource_record_pre_action 20:15:34 INFO - Running main action method: install 20:15:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:15:35 INFO - Reading from file tmpfile_stdout 20:15:35 INFO - Detecting whether we're running mozinstall >=1.0... 20:15:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:15:35 INFO - Reading from file tmpfile_stdout 20:15:35 INFO - Output received: 20:15:35 INFO - Usage: mozinstall [options] installer 20:15:35 INFO - Options: 20:15:35 INFO - -h, --help show this help message and exit 20:15:35 INFO - -d DEST, --destination=DEST 20:15:35 INFO - Directory to install application into. [default: 20:15:35 INFO - "/builds/slave/test"] 20:15:35 INFO - --app=APP Application being installed. [default: firefox] 20:15:35 INFO - mkdir: /builds/slave/test/build/application 20:15:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:15:51 INFO - Reading from file tmpfile_stdout 20:15:51 INFO - Output received: 20:15:51 INFO - /builds/slave/test/build/application/firefox/firefox 20:15:51 INFO - Running post-action listener: _resource_record_post_action 20:15:51 INFO - [mozharness: 2016-12-14 04:15:51.224484Z] Finished install step (success) 20:15:51 INFO - [mozharness: 2016-12-14 04:15:51.224725Z] Running run-tests step. 20:15:51 INFO - Running pre-action listener: _resource_record_pre_action 20:15:51 INFO - Running main action method: run_tests 20:15:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:15:51 INFO - Python 2.7.3 20:15:51 INFO - Return code: 0 20:15:51 INFO - grabbing minidump binary from tooltool 20:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:51 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 0x2113f20>, '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 0x2080c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2080f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:15:51 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 20:15:51 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 20:15:51 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 20:15:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:15:51 INFO - Return code: 0 20:15:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:15:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:15:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:15:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:15:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:15:51 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/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 20:15:51 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/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 20:15:51 INFO - Using env: {'DISPLAY': ':0', 20:15:51 INFO - 'HOME': '/home/cltbld', 20:15:51 INFO - 'LANG': 'en_US.UTF-8', 20:15:51 INFO - 'LANGUAGE': 'en_US:en', 20:15:51 INFO - 'LOGNAME': 'cltbld', 20:15:51 INFO - 'MAIL': '/var/mail/cltbld', 20:15:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:15:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:51 INFO - 'MOZ_NO_REMOTE': '1', 20:15:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:51 INFO - 'NO_EM_RESTART': '1', 20:15:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:51 INFO - 'PWD': '/builds/slave/test', 20:15:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:15:51 INFO - 'SHELL': '/bin/bash', 20:15:51 INFO - 'SHLVL': '1', 20:15:51 INFO - 'TERM': 'linux', 20:15:51 INFO - 'TMOUT': '86400', 20:15:51 INFO - 'USER': 'cltbld', 20:15:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857', 20:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:51 INFO - '_': '/tools/buildbot/bin/python'} 20:15:51 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/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 20:15:51 INFO - mozversion application_buildid: 20161213192606 20:15:51 INFO - mozversion application_changeset: 1ea0c60db5d25a7d522e2f252c1978ff4fc7538e 20:15:51 INFO - mozversion application_display_name: Nightly 20:15:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:15:51 INFO - mozversion application_name: Firefox 20:15:51 INFO - mozversion application_remotingname: firefox 20:15:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:15:51 INFO - mozversion application_vendor: Mozilla 20:15:51 INFO - mozversion application_version: 53.0a1 20:15:51 INFO - mozversion platform_buildid: 20161213192606 20:15:51 INFO - mozversion platform_changeset: 1ea0c60db5d25a7d522e2f252c1978ff4fc7538e 20:15:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:15:51 INFO - mozversion platform_version: 53.0a1 20:15:51 INFO - using testdate: 1481688951 20:15:51 INFO - actual date: 1481688951 20:15:51 INFO - starting webserver on 'localhost:46274' 20:15:51 INFO - SUITE-START | Running 2 tests 20:15:51 INFO - TEST-START | dromaeo_css 20:15:51 INFO - operating with platform_type : linux_ 20:15:51 INFO - Initialising browser for dromaeo_css test... 20:15:51 INFO - TEST-INFO | started process 5789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRmS5yV/profile http://localhost:46274/getInfo.html) 20:15:55 INFO - PROCESS | 5789 | __metrics Screen width/height:1600/1200 20:15:55 INFO - PROCESS | 5789 | colorDepth:24 20:15:55 INFO - PROCESS | 5789 | Browser inner width/height: 1024/697 20:15:55 INFO - PROCESS | 5789 | __metrics 20:15:56 INFO - PROCESS | 5789 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:15:56 INFO - PROCESS | 5789 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:15:57 INFO - TEST-INFO | 5789: exit 0 20:15:57 INFO - Browser initialized. 20:15:57 INFO - Running cycle 1/1 for dromaeo_css test... 20:15:57 INFO - TEST-INFO | started process 5869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRmS5yV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:16:09 INFO - PROCESS | 5869 | RSS: Main: 173613056 20:16:09 INFO - PROCESS | 5869 | 20:17:01 INFO - PROCESS | 5869 | 1481689021567 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] 20:19:14 INFO - PROCESS | 5869 | Cycle 1(1): loaded http://localhost:46274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46274/tests/dromaeo/cssquery-ext.html) 20:19:15 INFO - PROCESS | 5869 | RSS: Main: 304070656 20:19:15 INFO - PROCESS | 5869 | 20:22:18 INFO - PROCESS | 5869 | Cycle 1(1): loaded http://localhost:46274/tests/dromaeo/cssquery-ext.html (next: http://localhost:46274/tests/dromaeo/cssquery-jquery.html) 20:22:19 INFO - PROCESS | 5869 | RSS: Main: 284991488 20:22:19 INFO - PROCESS | 5869 | 20:25:21 INFO - PROCESS | 5869 | Cycle 1(1): loaded http://localhost:46274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46274/tests/dromaeo/cssquery-mootools.html) 20:25:21 INFO - PROCESS | 5869 | RSS: Main: 217776128 20:25:21 INFO - PROCESS | 5869 | 20:28:24 INFO - PROCESS | 5869 | Cycle 1(1): loaded http://localhost:46274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46274/tests/dromaeo/cssquery-prototype.html) 20:28:24 INFO - PROCESS | 5869 | RSS: Main: 238055424 20:28:24 INFO - PROCESS | 5869 | 20:31:28 INFO - PROCESS | 5869 | Cycle 1(1): loaded http://localhost:46274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46274/tests/dromaeo/cssquery-yui.html) 20:31:28 INFO - PROCESS | 5869 | RSS: Main: 224681984 20:31:28 INFO - PROCESS | 5869 | 20:34:31 INFO - PROCESS | 5869 | Cycle 1(1): loaded http://localhost:46274/tests/dromaeo/cssquery-yui.html (next: http://localhost:46274/tests/dromaeo/cssquery-dojo.html) 20:34:31 INFO - PROCESS | 5869 | RSS: Main: 315293696 20:34:31 INFO - PROCESS | 5869 | 20:34:31 INFO - PROCESS | 5869 | __start_tp_report 20:34:31 INFO - PROCESS | 5869 | _x_x_mozilla_page_load 20:34:31 INFO - PROCESS | 5869 | _x_x_mozilla_page_load_details 20:34:31 INFO - PROCESS | 5869 | |i|pagename|runs| 20:34:31 INFO - PROCESS | 5869 | |0;dojo.html;2526.4694414173027;2551.719310875802;2582.2511471673215;2585.3536615846037;2595.46792907454;4424.646028317735;4487.753173575452;4550.340200670905;4579.152856721509;4586.289125185597;4522.163399771045;4556.863294101182;4600.746958917258;4620.330052142437;4649.279361698934;4088.407180958759;4093;4134.400511925769;4154.729942553739;4223;4104.8973775655695;4174.20690068886;4195.139996300766;4241.448611680477;4277.080427708042;4030.3551431770775;4062.593740625943;4247.447831781848;4288.957110428887;4311.482622085354;4079.73481723687;4094.344904815245;4099.631033206996;4105.486814148231;4114.629683328515;4083.448734420845;4087.5299340575916;4087.8364865405347;4088.0393107619684;4095.89760255993;4532.29749388842;4548.295014272793;4556.726596404226;4575.633949284049;4582.839600613963;4882.048000639841;4883.34074899891;4893;4894.975525122387;4938.506149385069;4704.835330763407;4903.754812259408;4908.263760435928;4917.606591472673;4950.960298337353;4445.110977804452;4490.2142125127975;4560.4527456704745;4599.586037256596;4607.884802879955;4965.8013679452415;4987.251912213197;5020.874478138076;5029.597632189416;5037.899242015139;4728.881777955578;4741.193997020515;4779.665423420327;4783.976080119577;4848.757562121879;4665.6967297125575;4699.295105734167;4855;4865.56209941107;4914.975425122851;4686.859394218179;4693.6949098308505;4699.459562150328;4706.388169537938;4711.269753188261;4702.388689470347;4705.435347758291;4710.717356958594;4730.645201609893;4755.286706993909;3994.500687414073;3995.5205375355144;3997.540282867449;4034.9798251008556;4036.2936486114813;3482.4776283557667;3491.8428670709877;3492.022233774547;3512.5433693619666;3544.3442963051916;4127.09203975125;4147.315692910696;4150.128473020639;4158.9376159357635;4193.937090943638;4853.150698627796;4854.951450485521;4857.732824694605;4885.316055752198;4902;4046.9392959105635;4155.128785129391;4161.126163505698;4161.91676166481;4198.202341555156;4276.251655960256;4332.848350307724;4362.563743625612;4376.868693939187;4397.516273209944;4428.889277767953;4432.401625780607;4454.287314029804;4474.597286244254;4493.505714371482;4875.829345972874;4887.413510378778;4887.535684110004;4888.828890988798;4899.779509922133;4247.1505698860965;4294.055307832272;4352.717073390219;4429.734215947054;4439.489458712289;4721.457032441176;4765.380500534909;4767.427908650984;4809.927851082307;4814.422269327703;4825.4933232011535;4832.806687732592;4848.8302909398;4851.684640498356;4872.829450969199;4528.162289976365;4583.770811459481;4680.742559159143;4691.50739172382;4738.597219236403;4695.295705644044;4733.07704997536;4746.33551302811;4753.714777113384;4799.736014519235;4674.485806561208;4687.929681054855;4698.647601429838;4719.646026547954;4751.049790042074;4606.88482787933;4794.30482580017;4806.543378379049;4813.78337974785;4851.611871050237;4527.9547204527535;4623.398958135421;4668.066386722601;4680.110778951988;4746.43042834862 20:34:31 INFO - PROCESS | 5869 | |1;ext.html;517.9119549676554;542.2896006231837;544.2163284869787;547.8301726464795;557.5623135838367;27338.726612733866;35771.64228357716;38019.80990095049;38030.61969380312;40721.38917916234;39191.41212881802;39596.60403395965;39629.60370396295;39635.80182099093;39653;7516.774496765092;7739.845203095934;7740.419468539854;7743.6515356808795;7750.108737495176;7178.8564228715395;7384.704611815521;9672.274579406538;9959.950200248988;9964.601415943354;9931.106200441995;10016.148627366683;10018.098371146596;10026.949865250663;10035.749106272366;9961.053699898534;10001.749956251078;10027.89972100277;10043.899561004442;10044.84932726006;9814.852777208347;9876.82709803842;9877.654282100164;9885.802283954352;9888.307818452711;36178.63821361779;36418.08954776125;36465.27069458622;36509.63490365089;36512.634873651456;2908.43285559316;3041.0876736978817;3087.38252349531;3266.5426840242385;3323.850426730803;24571.877140614182;24684.629730554057;25300.367490812692;26097.359160194897;28755;3405.8297085145646;3437.157896315419;3462.3248466549035;3493.807840568768;3513.4554144107706;233147;234278;234404.82797586074;234516;234809;51272.74363628158;51669.74165129226;51726.48273517217;51737.482625174016;51769.22346164811;52821.2076818848;53269;53277.46722532725;53327;53404.73297633487;11751.353675547927;12097.57658481949;12113.39433028345;12127.878721212852;12134.878651213552;8232.62953167109;8480.109588493242;9137.543122843832;9179.265658747285;9240.075992400707;14425.393651587103;15748.448804291795;15864.841351586336;16236.350545978265;16753.1623418831;5727.136431784108;5767.279090113736;5821.825345239649;5882.3529411764675;5894.823155305347;753.6796861333911;805.85970851246;866.2333834556463;891.6477991193442;1004.1213937804421;25910.222693319232;26887.86556067207;26905.461890762468;27369.315767105585;27791.44417111687;936.4007035497287;938.2634631813993;981.33173604872;1029.0378496106164;1036.1969473657975;14022.789658155136;14505.637359066108;14634.707305853823;14724.484643037442;14776.852231477547;325563;326326;327171;327517;328408;46887.765561171975;46950.53049469461;47018.294725579144;47042.5295747045;47146.29280560794;1034.7516596017051;1062.0388548363744;1070.063694267516;1072.372661992743;1143.40542917684;25641.743582563937;27788;28081.43837123287;30667.159970401848;30686.386272273983;45155.77422112868;45931.77034114808;45979;46016.53983460122;46066.53933460623;293113;296423;296681;297429;297558;30396;31436.842815785774;33904.83047584746;34473;34983;38566.80716596399;38919.805400972815;39605.60394396019;39840.40239396354;40290.798546007085;32684.50973235451;33507.83246083754;33569.83215083909;33647.4952875712;34243.31513369769;32580.51129233016;33301.666983330826;33632.83183584164;33997.660023400436;34744.652553475156;33158.83420582978;33234.33531329408;33366;33517.83241083779;33640;26604.201873943814;26752.7324726758;27646.861765691043;27654.585181221897;27743.167704968884;23749.287521374386;24166.516669666158;24180.63729044101;24313.231449125415;24546.75453245516 20:34:31 INFO - PROCESS | 5869 | |2;jquery.html;342.3802916720734;356.53116152259776;358.5070528023967;359.8758428342221;383.51485371005685;15039.774403383944;15892.68214635708;16772.83227167728;16860.66278674426;16890.577735556617;15467.845321546809;16179.676406471894;16320.102394368334;16328.673426531463;16339.18304084794;4493.438320209982;4891.828785992491;4922.704637721748;4923.163062279421;4926.261060840885;3579.463080537927;3764.7929363884973;4816.638752093607;5484.506394424501;5730.570207234453;5788.218590490272;5797.449242321973;5799.2750906136735;5800.506956908668;5801.796937107202;4989.575886049672;5218.921716174261;5253.106971814763;5313.468653134694;5792.68140252286;5149.201873709581;5151.716655583941;5153.896922061575;5157.974210128963;5158.226266060084;12831;15150.393984240618;19552.413427597196;19604.80395196044;19612.509687257934;1779.2704990953646;1886.3303527247767;1947.6688962876203;1988.62216178927;2383.7973772229207;8702.173293537104;8982.191602755784;9033.644953256999;9041.638334466614;9337;1626.341331760639;1628.080134723877;1671.8578920791626;1688.0715606416422;1737.2529812180758;56826.7158664204;61181.38818611801;61941.69029154871;62143;64078.67960660167;9379.343445958853;9394.624215031323;9613.807723845484;9645.951770241103;9952.950235248922;13254.138480998705;13261;13263.137896036727;13265.602031939057;13374.665633359049;6467.4179323860135;6500.252470965805;6635.303293154149;6698.698558564876;6781.491388145811;6028.668423236764;6054.3945605439985;6211.689415529206;6229.813105606839;6245.344238854946;3934;4083.4691490106097;4091.0795071108764;4093.16090201508;4245.575442455792;1586.4606033948512;1696.4486541873694;1703.3137194177923;1771.5925337172523;1784.3130394798097;718.511412239682;817.2399668308531;854.7008547008497;872.4111224923151;874.1695389380114;16071.437499687454;16415.753763693316;16563.585910352096;16567.50297491077;17436.47690569285;824.7525742277293;837.0833936839151;837.6984285657159;867.137198487509;871.6600525794945;8822.911770882209;9366.157045865904;9401.200897923616;9466.148046675695;9539.18916892058;326804;327920;328003;328207;334793.5425488812;70068.6496567514;70726.64636676783;70980;71420.64289678622;73121;675.2707076357522;691.180950573572;691.6403470195571;691.87892118879;691.989620155698;11449.771004579696;14688.632784180481;15327.989205920994;15378.46175383901;15517.37930482768;32543.165935153884;32895.506567401986;33205.50191747078;33811.492827607115;33866.49200262047;43618.12763744771;44554.10891782211;45915.77042114768;46921.29618055664;47180.7640961793;7394.667239974106;7445.10658720957;7452.292032256927;7462.589557574169;7755.612219389121;10397.636082737068;11221.27061741017;11440.828387574027;11506.94246528762;11872.881271187178;7763.805904852424;9806.65676701312;9824.754381140528;9868.50657467138;10417.114545263737;10139.290249682452;10311.91724868908;10360.067593916583;10478.214133939833;10529.947350263199;9946.204303655835;10360.171186304926;10490.108340791117;10495.265331426726;10918.126549875831;6496.350364963466;6595.769148079794;6818.420434263143;7648.847023059397;7803.804904877424;9973.102420781874;10464.529096190841;10503.94748026255;10707.357558546511;10973.451327433437 20:34:31 INFO - PROCESS | 5869 | |3;mootools.html;1315.099157077402;1323.8279023726914;1373.9381727822247;1613.8870279080454;1616.3938523053862;5943.138244954479;6128.754849806002;6302.212223472066;6623.768168114111;6661.533692641511;6470.38531339522;6700.3299670032975;6711.563748356366;6906.723731050752;6936.375726184642;2020.1414398880454;2052.6202652509332;2055.3731112010832;2059.5983783162287;2068.379486154148;1790.2570433270178;1862.0968830117383;2036.9796302037012;2038.6534289170877;2039.8368130549595;1975.1013288953563;2062.9071691773906;2067.638163321413;2070.254708305009;2087.5720477302193;1988.7116368126613;2000.2399088346408;2016.4757163137542;2034.257496013959;2049.1803278688494;2062.577171679817;2080.2927004818434;2086.7600225974056;2088.697138914864;2088.7597926238527;6666.466682665424;6720.126383570154;6779;6782.084418603524;6787.287334829821;4065.26825171469;4178.12259425521;4190.16196760646;4192.4549808525;4200.726952748061;2651.2576478585834;2690.9192724218306;2879.8128121672025;2890.508613535704;2891.465078960378;830.4892491117979;854.9529775862325;865.0916537635458;866.5797088412115;866.8786369908217;8133.75598732039;8313.376496762767;8332.083470818205;8339.95830020852;8385.496870187808;3540.7875527468436;3725.0873535983314;3771.9057023574082;3822.235552889433;3850.8267127978747;7621.733239336708;7626.618669066635;7635.198304178092;7637.732679356307;7646.8088297793;4283.378910058024;4314.870553883388;4319.287317592562;4320.65434765218;4324.048709283952;3803.5245594300713;3854.6145385461227;3910.765354078764;3911.5697273299916;3915.393114067324;3208.69517395847;3223.2103134732142;3312.7184189343693;3375;3378.682313897582;1044.3629386074488;1054.6835949215206;1077.7996168487082;1128.351198061118;1132.0999805154756;701.7333413303014;779.6296759039411;787.6731156570074;818.1981657975099;823.9546824924566;4678.157931572349;4699.412573428322;4773.188557945157;4848.660593758474;4857.271409288564;752.8306131120563;767.2902565127235;770.942179336552;861.345377513082;906.795970906554;3149.3228955774616;3170.920726981844;3216.260260140181;3238.659940706239;3275.3776782411264;7683;7953.602319883983;8064.072631647318;8223.465474744122;8232.217939295757;8114.391420643476;8198.42611017235;8207.425480216327;8214.055383630839;8215.137410571924;6300.7479700811455;6489.837754056186;6490.123833282447;6493.220813502505;6494.707738151795;4564.452265728134;4572;4625.213713668617;4680.063987202641;4712.811487540597;7379.9262007381385;7419.777406677808;7498.362639175732;7524.887126692995;7582.052243469567;7545.434092442979;7560.319571238615;7664.616769161631;7713.1129920057665;7740.690372385042;5968.522518198447;6072.210612620331;6107.633541987495;6109.266887973472;6120.387961203844;6404.711787969646;6508.642024688687;6510.837229069311;6511.674416279262;6527.608343499405;5711.599831778872;5838.795642152504;5908.113782932594;5943.791967281124;5964.731587078505;5732.885342293047;5795.652260864362;5799.82600521985;5854.795082172274;5897.174395584536;5315.813946511854;5443.537299329601;5480.506754392124;5490.890182196414;5501.422350653123;4129.566395528426;4290;4322.697411181313;4334.653227741836;4560.429946256718;4159.812808423568;4211.326187809936;4283.721558098714;4343.739375637472;4374.103308821747 20:34:31 INFO - PROCESS | 5869 | |4;prototype.html;336.1780446807555;345.0132620704784;348.99837466471223;354.83322838266037;359.87944038747037;4552.271636538155;4658.720476771387;4713.104510143075;4751.216049351857;4785.186518291895;4550.111703642992;4617.353570500132;4632.4672662643725;4655.278431843061;4688.812447502096;3785.2807966486416;3786.5266841644793;3791.772493650376;3794.677452416541;3800.5819359870393;3788.412796016622;3796.6583007529316;3799.7530160539477;3801.9049523761987;3804.9429258561004;3506.9473957890523;3567.9831248094297;3724.459953306769;3771.3400154972906;3772.15126596515;3736.5516138063335;3750.5311836020496;3765.1904840459433;3770.9434358484646;3774.9433758493506;3372.763906526544;3375.7468189885612;3377.088186189715;3380.8985730428126;3383.796972181677;4480.395146655193;4546.499885012679;4573.314002899559;4574.839880604196;4583.266677331644;4250.128723611652;4253.595908388698;4264.594863487963;4280.250956082673;4280.892977675552;4911.880955593224;4913.213885778294;4914.378255175783;4925.482824303433;4926.452953873206;3690.5571331440133;3694.688385623119;3699.9260014799825;3703.574088979775;3708.6662200402093;5003.699778013331;5062.417821950449;5073.771680274396;5091.643584949055;5095.388553373619;3743.2513497300647;3748.331992263471;3751.306008388457;3780.8109594520715;3781.489498917666;3818.4463252828186;3828.73198876076;3835.884923452301;3839.5793556384315;3840.635139661728;4146.129312844276;4273.786310684453;4280.935785963213;4292.441982542249;4294.592013758688;4912.803487860517;4921.335619691367;4927.581155601814;4932.950670493321;4955.975220123948;1242.9627111186678;1284.6724085358173;1294.695746499572;1298.9545365912147;1301.7721898667696;889.888763904512;894.7428862448271;894.932880034;900.1088921967336;904.9140331668481;4208.537060923296;4346.304591265382;4361.193179261847;4366.563343665608;4377.124575084996;5060.620453466005;5064.240363945364;5076.36545431821;5076.517730815566;5082.466341034212;4231.196072746168;4333.501647310537;4356.106998065389;4358.5205627380965;4360.215161271001;2607.6479675243977;2610.9477810443686;2619.2796980830426;2621.0564196889104;2629.579267317258;4453.710508816916;4496.505384407713;4499.190145773792;4519.81920723174;4527.411436513232;4771.5228477152705;4977.402711674622;5022.824201152942;5030.144875371123;5050.9494905051215;4482.372467854503;4490.663200259994;4503.572160644733;4511.390962220124;4511.729296242236;4879.438864530624;4882.829100981448;4924.926126108183;4946.625619702635;4953.430355509163;4666.183417901786;4814.759262036954;4826;4827.203511420576;4850.53919877611;4474.284114541658;4489.595936365743;4493.415855938838;4505.752183629932;4511.330807601208;3724.8696295630607;3727.614326830776;3737.682297004785;3737.9252414952093;3760;4727;4875.6099512038245;4942.629302802232;4947.802087916587;4995.425526064549;4776.426828780569;4785.779626195437;4786.8167668500055;4822.734749588806;4843.346148269939;4734.638406731259;4737.3130896020575;4756.785944632431;4764;4797.872499962436;4514.48083470392;4670.1827180244;4676.836310729244;4687.835925742583;4718.02764258515;4722.5513576210205;4739.573438390561;4748.596369308648;4790.952090479051;4793.945332026949;4598.172328980816;4636.397268355092;4678.92981605283;4702.412198475191;4738.431388233434 20:34:31 INFO - PROCESS | 5869 | |5;yui.html;587.2453896742686;603.6951339573515;636.9044643303504;707.695690852933;743.3867059675767;12443.813342799855;13445.46218151274;13454.663633409169;13476.797848032287;13504.324783760798;12959.222446653184;13001.934990325059;13032.543860964868;13035.41340639671;13053.347332633353;610.0879185617508;628.1519948070091;748.498506000978;749.3817600479613;768.0284440183173;763.6410886883156;772.2162005564356;777.4014009212902;780.6565111350988;781.3475747750635;811.2455416462687;813.4021494201756;813.5484805932705;813.979650508739;814.6578437056421;642.1010585180761;658.9472842172614;662.2020465339255;665.3213722003578;806.8426656801926;485.97570121494135;580.1124279851833;592.1236569876606;599.1551911804335;599.691159053088;12647.810282845765;12670.366481675972;12670.429830657642;12709.300988445631;12728.427220774995;11941.582044628396;12166.695832604168;12529.498820047187;12625.431855566521;12927.224366537945;10000.349977251528;10194.745131371701;10298.433586152758;11446.313221206754;11552.711182220428;4113.91772164555;4124.628783409507;4125.927258912674;4132.235536425741;4133.441985331971;58879;61601;62797.37202628006;63082.68458657769;64383.678081609294;9865.210783137332;9930.851037234448;10044.949775251223;10080.445575493419;10107.140893024176;17753.7336939946;17785.021823799816;17843.643127137646;17984.460466186036;18164.63670726578;6443.387878151568;6463.418292353711;6484.383983521652;6539.411452969161;6632.900506492407;3398.4392575225306;3491.9825400872833;3524.8590056397456;3659.0486473517076;3685.244524872395;2596.2470883443966;2670.9065182718514;2694.3937614036686;2721.047633328319;2727.481778462086;460.97003694759735;466.0841446557463;467.7637792914624;468.5853020077256;476.1738383903924;488.819136919335;515.0548743056534;517.092502657833;518.9377274726982;525.5138996428288;6264.229525674207;6515.934840651627;6805.897911531331;6894.24163342032;6998.405135563534;387.1598630970744;405.2462419898986;407.48860180473315;408.7833448272361;459.15744608643513;3363.9495407568907;3414.095264754842;3440.4839274109086;3503.3168532136497;3537.663921927413;50290.74854625703;55198.44801552013;62956;63079;63146.36853631405;55935;56126;56490;56572.43427565754;58140;41481.585184148375;52551.73724131508;52700.73649631727;52790.20814687783;53142.46857531375;6526.641034743135;6732.3267673232285;6735;6742.325767423218;6851.109355783717;32220.516692250105;34247.31505369928;36624.81687591545;37525.62474375221;37736.433953491265;49104.2634360492;49950;50129.24806127984;50678;50913;7874.448788584744;7952.562609056326;8078.394120440873;8095.55474448911;8242.17578242171;8838.77903052403;9103.544822758968;9220.769480763034;9250.72247832566;9274.6290148396;8532.360072994674;8914.910850891667;8927.196552310323;8966.372353935161;9018.549072546215;8481.491110533389;8515.19105684959;8582.485050896967;8599.097094804956;8622.956885215533;8604.440711353742;8768.386212965032;8769.780755481164;8781.780455488408;8870.15733505316;7520.811979700333;7570.205128461653;7593.658285377061;7641.6561254742555;7653.9234607655435;7320.450966177665;7514.248575142442;7698.92301076982;7761.805954851174;8019.91980080215 20:34:31 INFO - PROCESS | 5869 | __end_tp_report 20:34:31 INFO - PROCESS | 5869 | __start_cc_report 20:34:31 INFO - PROCESS | 5869 | _x_x_mozilla_cycle_collect,1268 20:34:31 INFO - PROCESS | 5869 | __end_cc_report 20:34:31 INFO - PROCESS | 5869 | __startTimestamp1481690071804__endTimestamp 20:34:31 INFO - PROCESS | 5869 | 20:34:31 INFO - PROCESS | 5869 | ------- Summary: start ------- 20:34:31 INFO - PROCESS | 5869 | Number of tests: 6 20:34:31 INFO - PROCESS | 5869 | 20:34:31 INFO - PROCESS | 5869 | [#0] dojo.html Cycles:165 Average:4459.19 Median:4586.29 stddev:477.08 (10.4%) stddev-sans-first:453.81 20:34:31 INFO - PROCESS | 5869 | Values: 2526.5 2551.7 2582.3 2585.4 2595.5 4424.6 4487.8 4550.3 4579.2 4586.3 4522.2 4556.9 4600.7 4620.3 4649.3 4088.4 4093.0 4134.4 4154.7 4223.0 4104.9 4174.2 4195.1 4241.4 4277.1 4030.4 4062.6 4247.4 4289.0 4311.5 4079.7 4094.3 4099.6 4105.5 4114.6 4083.4 4087.5 4087.8 4088.0 4095.9 4532.3 4548.3 4556.7 4575.6 4582.8 4882.0 4883.3 4893.0 4895.0 4938.5 4704.8 4903.8 4908.3 4917.6 4951.0 4445.1 4490.2 4560.5 4599.6 4607.9 4965.8 4987.3 5020.9 5029.6 5037.9 4728.9 4741.2 4779.7 4784.0 4848.8 4665.7 4699.3 4855.0 4865.6 4915.0 4686.9 4693.7 4699.5 4706.4 4711.3 4702.4 4705.4 4710.7 4730.6 4755.3 3994.5 3995.5 3997.5 4035.0 4036.3 3482.5 3491.8 3492.0 3512.5 3544.3 4127.1 4147.3 4150.1 4158.9 4193.9 4853.2 4855.0 4857.7 4885.3 4902.0 4046.9 4155.1 4161.1 4161.9 4198.2 4276.3 4332.8 4362.6 4376.9 4397.5 4428.9 4432.4 4454.3 4474.6 4493.5 4875.8 4887.4 4887.5 4888.8 4899.8 4247.2 4294.1 4352.7 4429.7 4439.5 4721.5 4765.4 4767.4 4809.9 4814.4 4825.5 4832.8 4848.8 4851.7 4872.8 4528.2 4583.8 4680.7 4691.5 4738.6 4695.3 4733.1 4746.3 4753.7 4799.7 4674.5 4687.9 4698.6 4719.6 4751.0 4606.9 4794.3 4806.5 4813.8 4851.6 4528.0 4623.4 4668.1 4680.1 4746.4 20:34:31 INFO - PROCESS | 5869 | 20:34:31 INFO - PROCESS | 5869 | [#1] ext.html Cycles:180 Average:44071.59 Median:33776.16 stddev:75560.99 (223.7%) stddev-sans-first:75702.20 20:34:31 INFO - PROCESS | 5869 | Values: 517.9 542.3 544.2 547.8 557.6 27338.7 35771.6 38019.8 38030.6 40721.4 39191.4 39596.6 39629.6 39635.8 39653.0 7516.8 7739.8 7740.4 7743.7 7750.1 7178.9 7384.7 9672.3 9960.0 9964.6 9931.1 10016.1 10018.1 10026.9 10035.7 9961.1 10001.7 10027.9 10043.9 10044.8 9814.9 9876.8 9877.7 9885.8 9888.3 36178.6 36418.1 36465.3 36509.6 36512.6 2908.4 3041.1 3087.4 3266.5 3323.9 24571.9 24684.6 25300.4 26097.4 28755.0 3405.8 3437.2 3462.3 3493.8 3513.5 233147.0 234278.0 234404.8 234516.0 234809.0 51272.7 51669.7 51726.5 51737.5 51769.2 52821.2 53269.0 53277.5 53327.0 53404.7 11751.4 12097.6 12113.4 12127.9 12134.9 8232.6 8480.1 9137.5 9179.3 9240.1 14425.4 15748.4 15864.8 16236.4 16753.2 5727.1 5767.3 5821.8 5882.4 5894.8 753.7 805.9 866.2 891.6 1004.1 25910.2 26887.9 26905.5 27369.3 27791.4 936.4 938.3 981.3 1029.0 1036.2 14022.8 14505.6 14634.7 14724.5 14776.9 325563.0 326326.0 327171.0 327517.0 328408.0 46887.8 46950.5 47018.3 47042.5 47146.3 1034.8 1062.0 1070.1 1072.4 1143.4 25641.7 27788.0 28081.4 30667.2 30686.4 45155.8 45931.8 45979.0 46016.5 46066.5 293113.0 296423.0 296681.0 297429.0 297558.0 30396.0 31436.8 33904.8 34473.0 34983.0 38566.8 38919.8 39605.6 39840.4 40290.8 32684.5 33507.8 33569.8 33647.5 34243.3 32580.5 33301.7 33632.8 33997.7 34744.7 33158.8 33234.3 33366.0 33517.8 33640.0 26604.2 26752.7 27646.9 27654.6 27743.2 23749.3 24166.5 24180.6 24313.2 24546.8 20:34:31 INFO - PROCESS | 5869 | 20:34:31 INFO - PROCESS | 5869 | [#2] jquery.html Cycles:180 Average:21668.83 Median:47051.03 stddev:54446.49 (115.7%) stddev-sans-first:54575.68 20:34:31 INFO - PROCESS | 5869 | Values: 342.4 356.5 358.5 359.9 383.5 15039.8 15892.7 16772.8 16860.7 16890.6 15467.8 16179.7 16320.1 16328.7 16339.2 4493.4 4891.8 4922.7 4923.2 4926.3 3579.5 3764.8 4816.6 5484.5 5730.6 5788.2 5797.4 5799.3 5800.5 5801.8 4989.6 5218.9 5253.1 5313.5 5792.7 5149.2 5151.7 5153.9 5158.0 5158.2 12831.0 15150.4 19552.4 19604.8 19612.5 1779.3 1886.3 1947.7 1988.6 2383.8 8702.2 8982.2 9033.6 9041.6 9337.0 1626.3 1628.1 1671.9 1688.1 1737.3 56826.7 61181.4 61941.7 62143.0 64078.7 9379.3 9394.6 9613.8 9646.0 9953.0 13254.1 13261.0 13263.1 13265.6 13374.7 6467.4 6500.3 6635.3 6698.7 6781.5 6028.7 6054.4 6211.7 6229.8 6245.3 3934.0 4083.5 4091.1 4093.2 4245.6 1586.5 1696.4 1703.3 1771.6 1784.3 718.5 817.2 854.7 872.4 874.2 16071.4 16415.8 16563.6 16567.5 17436.5 824.8 837.1 837.7 867.1 871.7 8822.9 9366.2 9401.2 9466.1 9539.2 326804.0 327920.0 328003.0 328207.0 334793.5 70068.6 70726.6 70980.0 71420.6 73121.0 675.3 691.2 691.6 691.9 692.0 11449.8 14688.6 15328.0 15378.5 15517.4 32543.2 32895.5 33205.5 33811.5 33866.5 43618.1 44554.1 45915.8 46921.3 47180.8 7394.7 7445.1 7452.3 7462.6 7755.6 10397.6 11221.3 11440.8 11506.9 11872.9 7763.8 9806.7 9824.8 9868.5 10417.1 10139.3 10311.9 10360.1 10478.2 10529.9 9946.2 10360.2 10490.1 10495.3 10918.1 6496.4 6595.8 6818.4 7648.8 7803.8 9973.1 10464.5 10503.9 10707.4 10973.5 20:34:31 INFO - PROCESS | 5869 | 20:34:31 INFO - PROCESS | 5869 | [#3] mootools.html Cycles:180 Average:4495.03 Median:5379.68 stddev:2346.21 (43.6%) stddev-sans-first:2340.62 20:34:31 INFO - PROCESS | 5869 | Values: 1315.1 1323.8 1373.9 1613.9 1616.4 5943.1 6128.8 6302.2 6623.8 6661.5 6470.4 6700.3 6711.6 6906.7 6936.4 2020.1 2052.6 2055.4 2059.6 2068.4 1790.3 1862.1 2037.0 2038.7 2039.8 1975.1 2062.9 2067.6 2070.3 2087.6 1988.7 2000.2 2016.5 2034.3 2049.2 2062.6 2080.3 2086.8 2088.7 2088.8 6666.5 6720.1 6779.0 6782.1 6787.3 4065.3 4178.1 4190.2 4192.5 4200.7 2651.3 2690.9 2879.8 2890.5 2891.5 830.5 855.0 865.1 866.6 866.9 8133.8 8313.4 8332.1 8340.0 8385.5 3540.8 3725.1 3771.9 3822.2 3850.8 7621.7 7626.6 7635.2 7637.7 7646.8 4283.4 4314.9 4319.3 4320.7 4324.0 3803.5 3854.6 3910.8 3911.6 3915.4 3208.7 3223.2 3312.7 3375.0 3378.7 1044.4 1054.7 1077.8 1128.4 1132.1 701.7 779.6 787.7 818.2 824.0 4678.2 4699.4 4773.2 4848.7 4857.3 752.8 767.3 770.9 861.3 906.8 3149.3 3170.9 3216.3 3238.7 3275.4 7683.0 7953.6 8064.1 8223.5 8232.2 8114.4 8198.4 8207.4 8214.1 8215.1 6300.7 6489.8 6490.1 6493.2 6494.7 4564.5 4572.0 4625.2 4680.1 4712.8 7379.9 7419.8 7498.4 7524.9 7582.1 7545.4 7560.3 7664.6 7713.1 7740.7 5968.5 6072.2 6107.6 6109.3 6120.4 6404.7 6508.6 6510.8 6511.7 6527.6 5711.6 5838.8 5908.1 5943.8 5964.7 5732.9 5795.7 5799.8 5854.8 5897.2 5315.8 5443.5 5480.5 5490.9 5501.4 4129.6 4290.0 4322.7 4334.7 4560.4 4159.8 4211.3 4283.7 4343.7 4374.1 20:34:31 INFO - PROCESS | 5869 | 20:34:31 INFO - PROCESS | 5869 | [#4] prototype.html Cycles:180 Average:4064.96 Median:4508.54 stddev:1123.79 (24.9%) stddev-sans-first:1091.54 20:34:31 INFO - PROCESS | 5869 | Values: 336.2 345.0 349.0 354.8 359.9 4552.3 4658.7 4713.1 4751.2 4785.2 4550.1 4617.4 4632.5 4655.3 4688.8 3785.3 3786.5 3791.8 3794.7 3800.6 3788.4 3796.7 3799.8 3801.9 3804.9 3506.9 3568.0 3724.5 3771.3 3772.2 3736.6 3750.5 3765.2 3770.9 3774.9 3372.8 3375.7 3377.1 3380.9 3383.8 4480.4 4546.5 4573.3 4574.8 4583.3 4250.1 4253.6 4264.6 4280.3 4280.9 4911.9 4913.2 4914.4 4925.5 4926.5 3690.6 3694.7 3699.9 3703.6 3708.7 5003.7 5062.4 5073.8 5091.6 5095.4 3743.3 3748.3 3751.3 3780.8 3781.5 3818.4 3828.7 3835.9 3839.6 3840.6 4146.1 4273.8 4280.9 4292.4 4294.6 4912.8 4921.3 4927.6 4933.0 4956.0 1243.0 1284.7 1294.7 1299.0 1301.8 889.9 894.7 894.9 900.1 904.9 4208.5 4346.3 4361.2 4366.6 4377.1 5060.6 5064.2 5076.4 5076.5 5082.5 4231.2 4333.5 4356.1 4358.5 4360.2 2607.6 2610.9 2619.3 2621.1 2629.6 4453.7 4496.5 4499.2 4519.8 4527.4 4771.5 4977.4 5022.8 5030.1 5050.9 4482.4 4490.7 4503.6 4511.4 4511.7 4879.4 4882.8 4924.9 4946.6 4953.4 4666.2 4814.8 4826.0 4827.2 4850.5 4474.3 4489.6 4493.4 4505.8 4511.3 3724.9 3727.6 3737.7 3737.9 3760.0 4727.0 4875.6 4942.6 4947.8 4995.4 4776.4 4785.8 4786.8 4822.7 4843.3 4734.6 4737.3 4756.8 4764.0 4797.9 4514.5 4670.2 4676.8 4687.8 4718.0 4722.6 4739.6 4748.6 4791.0 4793.9 4598.2 4636.4 4678.9 4702.4 4738.4 20:34:31 INFO - PROCESS | 5869 | 20:34:31 INFO - PROCESS | 5869 | [#5] yui.html Cycles:180 Average:13946.74 Median:29360.06 stddev:18168.37 (61.9%) stddev-sans-first:18191.64 20:34:31 INFO - PROCESS | 5869 | Values: 587.2 603.7 636.9 707.7 743.4 12443.8 13445.5 13454.7 13476.8 13504.3 12959.2 13001.9 13032.5 13035.4 13053.3 610.1 628.2 748.5 749.4 768.0 763.6 772.2 777.4 780.7 781.3 811.2 813.4 813.5 814.0 814.7 642.1 658.9 662.2 665.3 806.8 486.0 580.1 592.1 599.2 599.7 12647.8 12670.4 12670.4 12709.3 12728.4 11941.6 12166.7 12529.5 12625.4 12927.2 10000.3 10194.7 10298.4 11446.3 11552.7 4113.9 4124.6 4125.9 4132.2 4133.4 58879.0 61601.0 62797.4 63082.7 64383.7 9865.2 9930.9 10044.9 10080.4 10107.1 17753.7 17785.0 17843.6 17984.5 18164.6 6443.4 6463.4 6484.4 6539.4 6632.9 3398.4 3492.0 3524.9 3659.0 3685.2 2596.2 2670.9 2694.4 2721.0 2727.5 461.0 466.1 467.8 468.6 476.2 488.8 515.1 517.1 518.9 525.5 6264.2 6515.9 6805.9 6894.2 6998.4 387.2 405.2 407.5 408.8 459.2 3363.9 3414.1 3440.5 3503.3 3537.7 50290.7 55198.4 62956.0 63079.0 63146.4 55935.0 56126.0 56490.0 56572.4 58140.0 41481.6 52551.7 52700.7 52790.2 53142.5 6526.6 6732.3 6735.0 6742.3 6851.1 32220.5 34247.3 36624.8 37525.6 37736.4 49104.3 49950.0 50129.2 50678.0 50913.0 7874.4 7952.6 8078.4 8095.6 8242.2 8838.8 9103.5 9220.8 9250.7 9274.6 8532.4 8914.9 8927.2 8966.4 9018.5 8481.5 8515.2 8582.5 8599.1 8623.0 8604.4 8768.4 8769.8 8781.8 8870.2 7520.8 7570.2 7593.7 7641.7 7653.9 7320.5 7514.2 7698.9 7761.8 8019.9 20:34:31 INFO - PROCESS | 5869 | -------- Summary: end -------- 20:34:31 INFO - PROCESS | 5869 | 20:34:32 INFO - TEST-INFO | 5869: exit 0 20:34:32 INFO - TEST-OK | dromaeo_css | took 1121337ms 20:34:32 INFO - TEST-START | kraken 20:34:32 INFO - operating with platform_type : linux_ 20:34:32 INFO - Initialising browser for kraken test... 20:34:32 INFO - TEST-INFO | started process 6175 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN0YKGK/profile http://localhost:46274/getInfo.html) 20:34:37 INFO - PROCESS | 6175 | __metrics Screen width/height:1600/1200 20:34:37 INFO - PROCESS | 6175 | colorDepth:24 20:34:37 INFO - PROCESS | 6175 | Browser inner width/height: 1024/697 20:34:37 INFO - PROCESS | 6175 | __metrics 20:34:37 INFO - PROCESS | 6175 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:34:37 INFO - PROCESS | 6175 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:34:38 INFO - PROCESS | 6175 | console.error: PushService: 20:34:38 INFO - PROCESS | 6175 | stateChangeProcessEnqueue: Error transitioning state 20:34:38 INFO - PROCESS | 6175 | UnknownError 20:34:38 INFO - TEST-INFO | 6175: exit 0 20:34:38 INFO - Browser initialized. 20:34:38 INFO - Running cycle 1/1 for kraken test... 20:34:38 INFO - TEST-INFO | started process 6258 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN0YKGK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:34:51 INFO - PROCESS | 6258 | RSS: Main: 173342720 20:34:51 INFO - PROCESS | 6258 | 20:34:53 INFO - PROCESS | 6258 | Cycle 1(1): loaded http://localhost:46274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46274/tests/kraken/driver.html?testName=audio-beat-detection) 20:34:54 INFO - PROCESS | 6258 | RSS: Main: 239882240 20:34:54 INFO - PROCESS | 6258 | 20:34:57 INFO - PROCESS | 6258 | Cycle 1(1): loaded http://localhost:46274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46274/tests/kraken/driver.html?testName=audio-dft) 20:34:58 INFO - PROCESS | 6258 | RSS: Main: 218570752 20:34:58 INFO - PROCESS | 6258 | 20:35:01 INFO - PROCESS | 6258 | Cycle 1(1): loaded http://localhost:46274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46274/tests/kraken/driver.html?testName=audio-fft) 20:35:02 INFO - PROCESS | 6258 | RSS: Main: 301527040 20:35:02 INFO - PROCESS | 6258 | 20:35:04 INFO - PROCESS | 6258 | Cycle 1(1): loaded http://localhost:46274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46274/tests/kraken/driver.html?testName=audio-oscillator) 20:35:04 INFO - PROCESS | 6258 | RSS: Main: 212103168 20:35:04 INFO - PROCESS | 6258 | 20:35:07 INFO - PROCESS | 6258 | Cycle 1(1): loaded http://localhost:46274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:35:07 INFO - PROCESS | 6258 | RSS: Main: 214540288 20:35:07 INFO - PROCESS | 6258 | 20:35:11 INFO - PROCESS | 6258 | Cycle 1(1): loaded http://localhost:46274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46274/tests/kraken/driver.html?testName=imaging-darkroom) 20:35:11 INFO - PROCESS | 6258 | RSS: Main: 254431232 20:35:11 INFO - PROCESS | 6258 | 20:35:15 INFO - PROCESS | 6258 | Cycle 1(1): loaded http://localhost:46274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46274/tests/kraken/driver.html?testName=imaging-desaturate) 20:35:15 INFO - PROCESS | 6258 | RSS: Main: 253648896 20:35:15 INFO - PROCESS | 6258 | 20:35:18 INFO - PROCESS | 6258 | Cycle 1(1): loaded http://localhost:46274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46274/tests/kraken/driver.html?testName=json-parse-financial) 20:35:19 INFO - PROCESS | 6258 | RSS: Main: 252682240 20:35:19 INFO - PROCESS | 6258 | 20:35:20 INFO - PROCESS | 6258 | Cycle 1(1): loaded http://localhost:46274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:35:21 INFO - PROCESS | 6258 | RSS: Main: 215314432 20:35:21 INFO - PROCESS | 6258 | 20:35:23 INFO - PROCESS | 6258 | Cycle 1(1): loaded http://localhost:46274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46274/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:35:24 INFO - PROCESS | 6258 | RSS: Main: 222859264 20:35:24 INFO - PROCESS | 6258 | 20:35:26 INFO - PROCESS | 6258 | Cycle 1(1): loaded http://localhost:46274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:35:26 INFO - PROCESS | 6258 | RSS: Main: 230748160 20:35:26 INFO - PROCESS | 6258 | 20:35:29 INFO - PROCESS | 6258 | Cycle 1(1): loaded http://localhost:46274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:35:30 INFO - PROCESS | 6258 | RSS: Main: 239792128 20:35:30 INFO - PROCESS | 6258 | 20:35:33 INFO - PROCESS | 6258 | Cycle 1(1): loaded http://localhost:46274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:35:34 INFO - PROCESS | 6258 | RSS: Main: 236580864 20:35:34 INFO - PROCESS | 6258 | 20:35:36 INFO - PROCESS | 6258 | Cycle 1(1): loaded http://localhost:46274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46274/tests/kraken/driver.html?testName=ai-astar) 20:35:36 INFO - PROCESS | 6258 | RSS: Main: 287772672 20:35:36 INFO - PROCESS | 6258 | 20:35:36 INFO - PROCESS | 6258 | __start_tp_report 20:35:36 INFO - PROCESS | 6258 | _x_x_mozilla_page_load 20:35:36 INFO - PROCESS | 6258 | _x_x_mozilla_page_load_details 20:35:36 INFO - PROCESS | 6258 | |i|pagename|runs| 20:35:36 INFO - PROCESS | 6258 | |0;ai-astar;108;116;116;116;116;119;116;116;117;116 20:35:36 INFO - PROCESS | 6258 | |1;audio-beat-detection;153;129;127;175;132;135;136;134;154;130 20:35:36 INFO - PROCESS | 6258 | |2;audio-dft;162;162;171;163;162;162;160;162;161;162 20:35:36 INFO - PROCESS | 6258 | |3;audio-fft;77;76;76;107;78;76;77;78;103;76 20:35:36 INFO - PROCESS | 6258 | |4;audio-oscillator;86;86;112;84;85;85;107;86;86;110 20:35:36 INFO - PROCESS | 6258 | |5;imaging-gaussian-blur;128;127;129;129;128;130;127;127;128;128 20:35:36 INFO - PROCESS | 6258 | |6;imaging-darkroom;148;147;146;146;148;146;147;146;147;146 20:35:36 INFO - PROCESS | 6258 | |7;imaging-desaturate;96;96;95;95;96;96;96;96;96;95 20:35:36 INFO - PROCESS | 6258 | |8;json-parse-financial;66;65;68;65;65;65;66;64;64;66 20:35:36 INFO - PROCESS | 6258 | |9;json-stringify-tinderbox;65;65;65;65;67;66;66;66;67;67 20:35:36 INFO - PROCESS | 6258 | |10;stanford-crypto-aes;86;85;84;85;85;85;87;85;95;95 20:35:36 INFO - PROCESS | 6258 | |11;stanford-crypto-ccm;144;150;145;152;140;155;146;142;187;144 20:35:36 INFO - PROCESS | 6258 | |12;stanford-crypto-pbkdf2;186;181;185;186;186;186;191;191;184;182 20:35:36 INFO - PROCESS | 6258 | |13;stanford-crypto-sha256-iterative;69;69;68;69;69;68;67;68;68;68 20:35:36 INFO - PROCESS | 6258 | __end_tp_report 20:35:36 INFO - PROCESS | 6258 | __start_cc_report 20:35:36 INFO - PROCESS | 6258 | _x_x_mozilla_cycle_collect,1975 20:35:36 INFO - PROCESS | 6258 | __end_cc_report 20:35:36 INFO - PROCESS | 6258 | __startTimestamp1481690136422__endTimestamp 20:35:36 INFO - PROCESS | 6258 | 20:35:36 INFO - PROCESS | 6258 | ------- Summary: start ------- 20:35:36 INFO - PROCESS | 6258 | Number of tests: 14 20:35:36 INFO - PROCESS | 6258 | 20:35:36 INFO - PROCESS | 6258 | [#0] ai-astar Cycles:10 Average:115.60 Median:116.00 stddev:2.84 (2.4%) stddev-sans-first:1.01 20:35:36 INFO - PROCESS | 6258 | Values: 108.0 116.0 116.0 116.0 116.0 119.0 116.0 116.0 117.0 116.0 20:35:36 INFO - PROCESS | 6258 | 20:35:36 INFO - PROCESS | 6258 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:135.50 stddev:15.34 (11.3%) stddev-sans-first:15.59 20:35:36 INFO - PROCESS | 6258 | Values: 153.0 129.0 127.0 175.0 132.0 135.0 136.0 134.0 154.0 130.0 20:35:36 INFO - PROCESS | 6258 | 20:35:36 INFO - PROCESS | 6258 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:3.02 (1.9%) stddev-sans-first:3.19 20:35:36 INFO - PROCESS | 6258 | Values: 162.0 162.0 171.0 163.0 162.0 162.0 160.0 162.0 161.0 162.0 20:35:36 INFO - PROCESS | 6258 | 20:35:36 INFO - PROCESS | 6258 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.50 stddev:11.97 (15.7%) stddev-sans-first:12.54 20:35:36 INFO - PROCESS | 6258 | Values: 77.0 76.0 76.0 107.0 78.0 76.0 77.0 78.0 103.0 76.0 20:35:36 INFO - PROCESS | 6258 | 20:35:36 INFO - PROCESS | 6258 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:85.50 stddev:11.79 (13.8%) stddev-sans-first:12.25 20:35:36 INFO - PROCESS | 6258 | Values: 86.0 86.0 112.0 84.0 85.0 85.0 107.0 86.0 86.0 110.0 20:35:36 INFO - PROCESS | 6258 | 20:35:36 INFO - PROCESS | 6258 | [#5] imaging-gaussian-blur Cycles:10 Average:128.10 Median:128.00 stddev:0.99 (0.8%) stddev-sans-first:1.05 20:35:36 INFO - PROCESS | 6258 | Values: 128.0 127.0 129.0 129.0 128.0 130.0 127.0 127.0 128.0 128.0 20:35:36 INFO - PROCESS | 6258 | 20:35:36 INFO - PROCESS | 6258 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 20:35:36 INFO - PROCESS | 6258 | Values: 148.0 147.0 146.0 146.0 148.0 146.0 147.0 146.0 147.0 146.0 20:35:36 INFO - PROCESS | 6258 | 20:35:36 INFO - PROCESS | 6258 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 20:35:36 INFO - PROCESS | 6258 | Values: 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 20:35:36 INFO - PROCESS | 6258 | 20:35:36 INFO - PROCESS | 6258 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:65.50 stddev:1.17 (1.8%) stddev-sans-first:1.22 20:35:36 INFO - PROCESS | 6258 | Values: 66.0 65.0 68.0 65.0 65.0 65.0 66.0 64.0 64.0 66.0 20:35:36 INFO - PROCESS | 6258 | 20:35:36 INFO - PROCESS | 6258 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 20:35:36 INFO - PROCESS | 6258 | Values: 65.0 65.0 65.0 65.0 67.0 66.0 66.0 66.0 67.0 67.0 20:35:36 INFO - PROCESS | 6258 | 20:35:36 INFO - PROCESS | 6258 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:85.50 stddev:4.18 (4.9%) stddev-sans-first:4.42 20:35:36 INFO - PROCESS | 6258 | Values: 86.0 85.0 84.0 85.0 85.0 85.0 87.0 85.0 95.0 95.0 20:35:36 INFO - PROCESS | 6258 | 20:35:36 INFO - PROCESS | 6258 | [#11] stanford-crypto-ccm Cycles:10 Average:150.50 Median:148.00 stddev:13.63 (9.2%) stddev-sans-first:14.25 20:35:36 INFO - PROCESS | 6258 | Values: 144.0 150.0 145.0 152.0 140.0 155.0 146.0 142.0 187.0 144.0 20:35:36 INFO - PROCESS | 6258 | 20:35:36 INFO - PROCESS | 6258 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.80 Median:186.00 stddev:3.26 (1.8%) stddev-sans-first:3.46 20:35:36 INFO - PROCESS | 6258 | Values: 186.0 181.0 185.0 186.0 186.0 186.0 191.0 191.0 184.0 182.0 20:35:36 INFO - PROCESS | 6258 | 20:35:36 INFO - PROCESS | 6258 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 20:35:36 INFO - PROCESS | 6258 | Values: 69.0 69.0 68.0 69.0 69.0 68.0 67.0 68.0 68.0 68.0 20:35:36 INFO - PROCESS | 6258 | -------- Summary: end -------- 20:35:36 INFO - PROCESS | 6258 | 20:35:37 INFO - TEST-INFO | 6258: exit 0 20:35:37 INFO - TEST-OK | kraken | took 64884ms 20:35:37 INFO - SUITE-END | took 1186s 20:35:38 INFO - Completed test suite (00:19:46) 20:35:38 INFO - javascript benchmark 20:35:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2526.4694414173027, 2551.719310875802, 2582.2511471673215, 2585.3536615846037, 2595.46792907454, 4424.646028317735, 4487.753173575452, 4550.340200670905, 4579.152856721509, 4586.289125185597, 4522.163399771045, 4556.863294101182, 4600.746958917258, 4620.330052142437, 4649.279361698934, 4088.407180958759, 4093.0, 4134.400511925769, 4154.729942553739, 4223.0, 4104.8973775655695, 4174.20690068886, 4195.139996300766, 4241.448611680477, 4277.080427708042, 4030.3551431770775, 4062.593740625943, 4247.447831781848, 4288.957110428887, 4311.482622085354, 4079.73481723687, 4094.344904815245, 4099.631033206996, 4105.486814148231, 4114.629683328515, 4083.448734420845, 4087.5299340575916, 4087.8364865405347, 4088.0393107619684, 4095.89760255993, 4532.29749388842, 4548.295014272793, 4556.726596404226, 4575.633949284049, 4582.839600613963, 4882.048000639841, 4883.34074899891, 4893.0, 4894.975525122387, 4938.506149385069, 4704.835330763407, 4903.754812259408, 4908.263760435928, 4917.606591472673, 4950.960298337353, 4445.110977804452, 4490.2142125127975, 4560.4527456704745, 4599.586037256596, 4607.884802879955, 4965.8013679452415, 4987.251912213197, 5020.874478138076, 5029.597632189416, 5037.899242015139, 4728.881777955578, 4741.193997020515, 4779.665423420327, 4783.976080119577, 4848.757562121879, 4665.6967297125575, 4699.295105734167, 4855.0, 4865.56209941107, 4914.975425122851, 4686.859394218179, 4693.6949098308505, 4699.459562150328, 4706.388169537938, 4711.269753188261, 4702.388689470347, 4705.435347758291, 4710.717356958594, 4730.645201609893, 4755.286706993909, 3994.500687414073, 3995.5205375355144, 3997.540282867449, 4034.9798251008556, 4036.2936486114813, 3482.4776283557667, 3491.8428670709877, 3492.022233774547, 3512.5433693619666, 3544.3442963051916, 4127.09203975125, 4147.315692910696, 4150.128473020639, 4158.9376159357635, 4193.937090943638, 4853.150698627796, 4854.951450485521, 4857.732824694605, 4885.316055752198, 4902.0, 4046.9392959105635, 4155.128785129391, 4161.126163505698, 4161.91676166481, 4198.202341555156, 4276.251655960256, 4332.848350307724, 4362.563743625612, 4376.868693939187, 4397.516273209944, 4428.889277767953, 4432.401625780607, 4454.287314029804, 4474.597286244254, 4493.505714371482, 4875.829345972874, 4887.413510378778, 4887.535684110004, 4888.828890988798, 4899.779509922133, 4247.1505698860965, 4294.055307832272, 4352.717073390219, 4429.734215947054, 4439.489458712289, 4721.457032441176, 4765.380500534909, 4767.427908650984, 4809.927851082307, 4814.422269327703, 4825.4933232011535, 4832.806687732592, 4848.8302909398, 4851.684640498356, 4872.829450969199, 4528.162289976365, 4583.770811459481, 4680.742559159143, 4691.50739172382, 4738.597219236403, 4695.295705644044, 4733.07704997536, 4746.33551302811, 4753.714777113384, 4799.736014519235, 4674.485806561208, 4687.929681054855, 4698.647601429838, 4719.646026547954, 4751.049790042074, 4606.88482787933, 4794.30482580017, 4806.543378379049, 4813.78337974785, 4851.611871050237, 4527.9547204527535, 4623.398958135421, 4668.066386722601, 4680.110778951988, 4746.43042834862], "value": 4428.777281297438, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.9119549676554, 542.2896006231837, 544.2163284869787, 547.8301726464795, 557.5623135838367, 27338.726612733866, 35771.64228357716, 38019.80990095049, 38030.61969380312, 40721.38917916234, 39191.41212881802, 39596.60403395965, 39629.60370396295, 39635.80182099093, 39653.0, 7516.774496765092, 7739.845203095934, 7740.419468539854, 7743.6515356808795, 7750.108737495176, 7178.8564228715395, 7384.704611815521, 9672.274579406538, 9959.950200248988, 9964.601415943354, 9931.106200441995, 10016.148627366683, 10018.098371146596, 10026.949865250663, 10035.749106272366, 9961.053699898534, 10001.749956251078, 10027.89972100277, 10043.899561004442, 10044.84932726006, 9814.852777208347, 9876.82709803842, 9877.654282100164, 9885.802283954352, 9888.307818452711, 36178.63821361779, 36418.08954776125, 36465.27069458622, 36509.63490365089, 36512.634873651456, 2908.43285559316, 3041.0876736978817, 3087.38252349531, 3266.5426840242385, 3323.850426730803, 24571.877140614182, 24684.629730554057, 25300.367490812692, 26097.359160194897, 28755.0, 3405.8297085145646, 3437.157896315419, 3462.3248466549035, 3493.807840568768, 3513.4554144107706, 233147.0, 234278.0, 234404.82797586074, 234516.0, 234809.0, 51272.74363628158, 51669.74165129226, 51726.48273517217, 51737.482625174016, 51769.22346164811, 52821.2076818848, 53269.0, 53277.46722532725, 53327.0, 53404.73297633487, 11751.353675547927, 12097.57658481949, 12113.39433028345, 12127.878721212852, 12134.878651213552, 8232.62953167109, 8480.109588493242, 9137.543122843832, 9179.265658747285, 9240.075992400707, 14425.393651587103, 15748.448804291795, 15864.841351586336, 16236.350545978265, 16753.1623418831, 5727.136431784108, 5767.279090113736, 5821.825345239649, 5882.3529411764675, 5894.823155305347, 753.6796861333911, 805.85970851246, 866.2333834556463, 891.6477991193442, 1004.1213937804421, 25910.222693319232, 26887.86556067207, 26905.461890762468, 27369.315767105585, 27791.44417111687, 936.4007035497287, 938.2634631813993, 981.33173604872, 1029.0378496106164, 1036.1969473657975, 14022.789658155136, 14505.637359066108, 14634.707305853823, 14724.484643037442, 14776.852231477547, 325563.0, 326326.0, 327171.0, 327517.0, 328408.0, 46887.765561171975, 46950.53049469461, 47018.294725579144, 47042.5295747045, 47146.29280560794, 1034.7516596017051, 1062.0388548363744, 1070.063694267516, 1072.372661992743, 1143.40542917684, 25641.743582563937, 27788.0, 28081.43837123287, 30667.159970401848, 30686.386272273983, 45155.77422112868, 45931.77034114808, 45979.0, 46016.53983460122, 46066.53933460623, 293113.0, 296423.0, 296681.0, 297429.0, 297558.0, 30396.0, 31436.842815785774, 33904.83047584746, 34473.0, 34983.0, 38566.80716596399, 38919.805400972815, 39605.60394396019, 39840.40239396354, 40290.798546007085, 32684.50973235451, 33507.83246083754, 33569.83215083909, 33647.4952875712, 34243.31513369769, 32580.51129233016, 33301.666983330826, 33632.83183584164, 33997.660023400436, 34744.652553475156, 33158.83420582978, 33234.33531329408, 33366.0, 33517.83241083779, 33640.0, 26604.201873943814, 26752.7324726758, 27646.861765691043, 27654.585181221897, 27743.167704968884, 23749.287521374386, 24166.516669666158, 24180.63729044101, 24313.231449125415, 24546.75453245516], "value": 17076.91937421646, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.3802916720734, 356.53116152259776, 358.5070528023967, 359.8758428342221, 383.51485371005685, 15039.774403383944, 15892.68214635708, 16772.83227167728, 16860.66278674426, 16890.577735556617, 15467.845321546809, 16179.676406471894, 16320.102394368334, 16328.673426531463, 16339.18304084794, 4493.438320209982, 4891.828785992491, 4922.704637721748, 4923.163062279421, 4926.261060840885, 3579.463080537927, 3764.7929363884973, 4816.638752093607, 5484.506394424501, 5730.570207234453, 5788.218590490272, 5797.449242321973, 5799.2750906136735, 5800.506956908668, 5801.796937107202, 4989.575886049672, 5218.921716174261, 5253.106971814763, 5313.468653134694, 5792.68140252286, 5149.201873709581, 5151.716655583941, 5153.896922061575, 5157.974210128963, 5158.226266060084, 12831.0, 15150.393984240618, 19552.413427597196, 19604.80395196044, 19612.509687257934, 1779.2704990953646, 1886.3303527247767, 1947.6688962876203, 1988.62216178927, 2383.7973772229207, 8702.173293537104, 8982.191602755784, 9033.644953256999, 9041.638334466614, 9337.0, 1626.341331760639, 1628.080134723877, 1671.8578920791626, 1688.0715606416422, 1737.2529812180758, 56826.7158664204, 61181.38818611801, 61941.69029154871, 62143.0, 64078.67960660167, 9379.343445958853, 9394.624215031323, 9613.807723845484, 9645.951770241103, 9952.950235248922, 13254.138480998705, 13261.0, 13263.137896036727, 13265.602031939057, 13374.665633359049, 6467.4179323860135, 6500.252470965805, 6635.303293154149, 6698.698558564876, 6781.491388145811, 6028.668423236764, 6054.3945605439985, 6211.689415529206, 6229.813105606839, 6245.344238854946, 3934.0, 4083.4691490106097, 4091.0795071108764, 4093.16090201508, 4245.575442455792, 1586.4606033948512, 1696.4486541873694, 1703.3137194177923, 1771.5925337172523, 1784.3130394798097, 718.511412239682, 817.2399668308531, 854.7008547008497, 872.4111224923151, 874.1695389380114, 16071.437499687454, 16415.753763693316, 16563.585910352096, 16567.50297491077, 17436.47690569285, 824.7525742277293, 837.0833936839151, 837.6984285657159, 867.137198487509, 871.6600525794945, 8822.911770882209, 9366.157045865904, 9401.200897923616, 9466.148046675695, 9539.18916892058, 326804.0, 327920.0, 328003.0, 328207.0, 334793.5425488812, 70068.6496567514, 70726.64636676783, 70980.0, 71420.64289678622, 73121.0, 675.2707076357522, 691.180950573572, 691.6403470195571, 691.87892118879, 691.989620155698, 11449.771004579696, 14688.632784180481, 15327.989205920994, 15378.46175383901, 15517.37930482768, 32543.165935153884, 32895.506567401986, 33205.50191747078, 33811.492827607115, 33866.49200262047, 43618.12763744771, 44554.10891782211, 45915.77042114768, 46921.29618055664, 47180.7640961793, 7394.667239974106, 7445.10658720957, 7452.292032256927, 7462.589557574169, 7755.612219389121, 10397.636082737068, 11221.27061741017, 11440.828387574027, 11506.94246528762, 11872.881271187178, 7763.805904852424, 9806.65676701312, 9824.754381140528, 9868.50657467138, 10417.114545263737, 10139.290249682452, 10311.91724868908, 10360.067593916583, 10478.214133939833, 10529.947350263199, 9946.204303655835, 10360.171186304926, 10490.108340791117, 10495.265331426726, 10918.126549875831, 6496.350364963466, 6595.769148079794, 6818.420434263143, 7648.847023059397, 7803.804904877424, 9973.102420781874, 10464.529096190841, 10503.94748026255, 10707.357558546511, 10973.451327433437], "value": 7741.007236476035, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.099157077402, 1323.8279023726914, 1373.9381727822247, 1613.8870279080454, 1616.3938523053862, 5943.138244954479, 6128.754849806002, 6302.212223472066, 6623.768168114111, 6661.533692641511, 6470.38531339522, 6700.3299670032975, 6711.563748356366, 6906.723731050752, 6936.375726184642, 2020.1414398880454, 2052.6202652509332, 2055.3731112010832, 2059.5983783162287, 2068.379486154148, 1790.2570433270178, 1862.0968830117383, 2036.9796302037012, 2038.6534289170877, 2039.8368130549595, 1975.1013288953563, 2062.9071691773906, 2067.638163321413, 2070.254708305009, 2087.5720477302193, 1988.7116368126613, 2000.2399088346408, 2016.4757163137542, 2034.257496013959, 2049.1803278688494, 2062.577171679817, 2080.2927004818434, 2086.7600225974056, 2088.697138914864, 2088.7597926238527, 6666.466682665424, 6720.126383570154, 6779.0, 6782.084418603524, 6787.287334829821, 4065.26825171469, 4178.12259425521, 4190.16196760646, 4192.4549808525, 4200.726952748061, 2651.2576478585834, 2690.9192724218306, 2879.8128121672025, 2890.508613535704, 2891.465078960378, 830.4892491117979, 854.9529775862325, 865.0916537635458, 866.5797088412115, 866.8786369908217, 8133.75598732039, 8313.376496762767, 8332.083470818205, 8339.95830020852, 8385.496870187808, 3540.7875527468436, 3725.0873535983314, 3771.9057023574082, 3822.235552889433, 3850.8267127978747, 7621.733239336708, 7626.618669066635, 7635.198304178092, 7637.732679356307, 7646.8088297793, 4283.378910058024, 4314.870553883388, 4319.287317592562, 4320.65434765218, 4324.048709283952, 3803.5245594300713, 3854.6145385461227, 3910.765354078764, 3911.5697273299916, 3915.393114067324, 3208.69517395847, 3223.2103134732142, 3312.7184189343693, 3375.0, 3378.682313897582, 1044.3629386074488, 1054.6835949215206, 1077.7996168487082, 1128.351198061118, 1132.0999805154756, 701.7333413303014, 779.6296759039411, 787.6731156570074, 818.1981657975099, 823.9546824924566, 4678.157931572349, 4699.412573428322, 4773.188557945157, 4848.660593758474, 4857.271409288564, 752.8306131120563, 767.2902565127235, 770.942179336552, 861.345377513082, 906.795970906554, 3149.3228955774616, 3170.920726981844, 3216.260260140181, 3238.659940706239, 3275.3776782411264, 7683.0, 7953.602319883983, 8064.072631647318, 8223.465474744122, 8232.217939295757, 8114.391420643476, 8198.42611017235, 8207.425480216327, 8214.055383630839, 8215.137410571924, 6300.7479700811455, 6489.837754056186, 6490.123833282447, 6493.220813502505, 6494.707738151795, 4564.452265728134, 4572.0, 4625.213713668617, 4680.063987202641, 4712.811487540597, 7379.9262007381385, 7419.777406677808, 7498.362639175732, 7524.887126692995, 7582.052243469567, 7545.434092442979, 7560.319571238615, 7664.616769161631, 7713.1129920057665, 7740.690372385042, 5968.522518198447, 6072.210612620331, 6107.633541987495, 6109.266887973472, 6120.387961203844, 6404.711787969646, 6508.642024688687, 6510.837229069311, 6511.674416279262, 6527.608343499405, 5711.599831778872, 5838.795642152504, 5908.113782932594, 5943.791967281124, 5964.731587078505, 5732.885342293047, 5795.652260864362, 5799.82600521985, 5854.795082172274, 5897.174395584536, 5315.813946511854, 5443.537299329601, 5480.506754392124, 5490.890182196414, 5501.422350653123, 4129.566395528426, 4290.0, 4322.697411181313, 4334.653227741836, 4560.429946256718, 4159.812808423568, 4211.326187809936, 4283.721558098714, 4343.739375637472, 4374.103308821747], "value": 3707.0627888221766, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.1780446807555, 345.0132620704784, 348.99837466471223, 354.83322838266037, 359.87944038747037, 4552.271636538155, 4658.720476771387, 4713.104510143075, 4751.216049351857, 4785.186518291895, 4550.111703642992, 4617.353570500132, 4632.4672662643725, 4655.278431843061, 4688.812447502096, 3785.2807966486416, 3786.5266841644793, 3791.772493650376, 3794.677452416541, 3800.5819359870393, 3788.412796016622, 3796.6583007529316, 3799.7530160539477, 3801.9049523761987, 3804.9429258561004, 3506.9473957890523, 3567.9831248094297, 3724.459953306769, 3771.3400154972906, 3772.15126596515, 3736.5516138063335, 3750.5311836020496, 3765.1904840459433, 3770.9434358484646, 3774.9433758493506, 3372.763906526544, 3375.7468189885612, 3377.088186189715, 3380.8985730428126, 3383.796972181677, 4480.395146655193, 4546.499885012679, 4573.314002899559, 4574.839880604196, 4583.266677331644, 4250.128723611652, 4253.595908388698, 4264.594863487963, 4280.250956082673, 4280.892977675552, 4911.880955593224, 4913.213885778294, 4914.378255175783, 4925.482824303433, 4926.452953873206, 3690.5571331440133, 3694.688385623119, 3699.9260014799825, 3703.574088979775, 3708.6662200402093, 5003.699778013331, 5062.417821950449, 5073.771680274396, 5091.643584949055, 5095.388553373619, 3743.2513497300647, 3748.331992263471, 3751.306008388457, 3780.8109594520715, 3781.489498917666, 3818.4463252828186, 3828.73198876076, 3835.884923452301, 3839.5793556384315, 3840.635139661728, 4146.129312844276, 4273.786310684453, 4280.935785963213, 4292.441982542249, 4294.592013758688, 4912.803487860517, 4921.335619691367, 4927.581155601814, 4932.950670493321, 4955.975220123948, 1242.9627111186678, 1284.6724085358173, 1294.695746499572, 1298.9545365912147, 1301.7721898667696, 889.888763904512, 894.7428862448271, 894.932880034, 900.1088921967336, 904.9140331668481, 4208.537060923296, 4346.304591265382, 4361.193179261847, 4366.563343665608, 4377.124575084996, 5060.620453466005, 5064.240363945364, 5076.36545431821, 5076.517730815566, 5082.466341034212, 4231.196072746168, 4333.501647310537, 4356.106998065389, 4358.5205627380965, 4360.215161271001, 2607.6479675243977, 2610.9477810443686, 2619.2796980830426, 2621.0564196889104, 2629.579267317258, 4453.710508816916, 4496.505384407713, 4499.190145773792, 4519.81920723174, 4527.411436513232, 4771.5228477152705, 4977.402711674622, 5022.824201152942, 5030.144875371123, 5050.9494905051215, 4482.372467854503, 4490.663200259994, 4503.572160644733, 4511.390962220124, 4511.729296242236, 4879.438864530624, 4882.829100981448, 4924.926126108183, 4946.625619702635, 4953.430355509163, 4666.183417901786, 4814.759262036954, 4826.0, 4827.203511420576, 4850.53919877611, 4474.284114541658, 4489.595936365743, 4493.415855938838, 4505.752183629932, 4511.330807601208, 3724.8696295630607, 3727.614326830776, 3737.682297004785, 3737.9252414952093, 3760.0, 4727.0, 4875.6099512038245, 4942.629302802232, 4947.802087916587, 4995.425526064549, 4776.426828780569, 4785.779626195437, 4786.8167668500055, 4822.734749588806, 4843.346148269939, 4734.638406731259, 4737.3130896020575, 4756.785944632431, 4764.0, 4797.872499962436, 4514.48083470392, 4670.1827180244, 4676.836310729244, 4687.835925742583, 4718.02764258515, 4722.5513576210205, 4739.573438390561, 4748.596369308648, 4790.952090479051, 4793.945332026949, 4598.172328980816, 4636.397268355092, 4678.92981605283, 4702.412198475191, 4738.431388233434], "value": 3725.6305645215584, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.2453896742686, 603.6951339573515, 636.9044643303504, 707.695690852933, 743.3867059675767, 12443.813342799855, 13445.46218151274, 13454.663633409169, 13476.797848032287, 13504.324783760798, 12959.222446653184, 13001.934990325059, 13032.543860964868, 13035.41340639671, 13053.347332633353, 610.0879185617508, 628.1519948070091, 748.498506000978, 749.3817600479613, 768.0284440183173, 763.6410886883156, 772.2162005564356, 777.4014009212902, 780.6565111350988, 781.3475747750635, 811.2455416462687, 813.4021494201756, 813.5484805932705, 813.979650508739, 814.6578437056421, 642.1010585180761, 658.9472842172614, 662.2020465339255, 665.3213722003578, 806.8426656801926, 485.97570121494135, 580.1124279851833, 592.1236569876606, 599.1551911804335, 599.691159053088, 12647.810282845765, 12670.366481675972, 12670.429830657642, 12709.300988445631, 12728.427220774995, 11941.582044628396, 12166.695832604168, 12529.498820047187, 12625.431855566521, 12927.224366537945, 10000.349977251528, 10194.745131371701, 10298.433586152758, 11446.313221206754, 11552.711182220428, 4113.91772164555, 4124.628783409507, 4125.927258912674, 4132.235536425741, 4133.441985331971, 58879.0, 61601.0, 62797.37202628006, 63082.68458657769, 64383.678081609294, 9865.210783137332, 9930.851037234448, 10044.949775251223, 10080.445575493419, 10107.140893024176, 17753.7336939946, 17785.021823799816, 17843.643127137646, 17984.460466186036, 18164.63670726578, 6443.387878151568, 6463.418292353711, 6484.383983521652, 6539.411452969161, 6632.900506492407, 3398.4392575225306, 3491.9825400872833, 3524.8590056397456, 3659.0486473517076, 3685.244524872395, 2596.2470883443966, 2670.9065182718514, 2694.3937614036686, 2721.047633328319, 2727.481778462086, 460.97003694759735, 466.0841446557463, 467.7637792914624, 468.5853020077256, 476.1738383903924, 488.819136919335, 515.0548743056534, 517.092502657833, 518.9377274726982, 525.5138996428288, 6264.229525674207, 6515.934840651627, 6805.897911531331, 6894.24163342032, 6998.405135563534, 387.1598630970744, 405.2462419898986, 407.48860180473315, 408.7833448272361, 459.15744608643513, 3363.9495407568907, 3414.095264754842, 3440.4839274109086, 3503.3168532136497, 3537.663921927413, 50290.74854625703, 55198.44801552013, 62956.0, 63079.0, 63146.36853631405, 55935.0, 56126.0, 56490.0, 56572.43427565754, 58140.0, 41481.585184148375, 52551.73724131508, 52700.73649631727, 52790.20814687783, 53142.46857531375, 6526.641034743135, 6732.3267673232285, 6735.0, 6742.325767423218, 6851.109355783717, 32220.516692250105, 34247.31505369928, 36624.81687591545, 37525.62474375221, 37736.433953491265, 49104.2634360492, 49950.0, 50129.24806127984, 50678.0, 50913.0, 7874.448788584744, 7952.562609056326, 8078.394120440873, 8095.55474448911, 8242.17578242171, 8838.77903052403, 9103.544822758968, 9220.769480763034, 9250.72247832566, 9274.6290148396, 8532.360072994674, 8914.910850891667, 8927.196552310323, 8966.372353935161, 9018.549072546215, 8481.491110533389, 8515.19105684959, 8582.485050896967, 8599.097094804956, 8622.956885215533, 8604.440711353742, 8768.386212965032, 8769.780755481164, 8781.780455488408, 8870.15733505316, 7520.811979700333, 7570.205128461653, 7593.658285377061, 7641.6561254742555, 7653.9234607655435, 7320.450966177665, 7514.248575142442, 7698.92301076982, 7761.805954851174, 8019.91980080215], "value": 5660.541520442008, "unit": "score"}], "name": "dromaeo_css", "value": 5980.977247216214, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 116.0, 116.0, 116.0, 116.0, 119.0, 116.0, 116.0, 117.0, 116.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 129.0, 127.0, 175.0, 132.0, 135.0, 136.0, 134.0, 154.0, 130.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 171.0, 163.0, 162.0, 162.0, 160.0, 162.0, 161.0, 162.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 107.0, 78.0, 76.0, 77.0, 78.0, 103.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 112.0, 84.0, 85.0, 85.0, 107.0, 86.0, 86.0, 110.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 129.0, 129.0, 128.0, 130.0, 127.0, 127.0, 128.0, 128.0], "value": 128.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 146.0, 148.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 68.0, 65.0, 65.0, 65.0, 66.0, 64.0, 64.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 67.0, 66.0, 66.0, 66.0, 67.0, 67.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 85.0, 85.0, 85.0, 87.0, 85.0, 95.0, 95.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 150.0, 145.0, 152.0, 140.0, 155.0, 146.0, 142.0, 187.0, 144.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 181.0, 185.0, 186.0, 186.0, 186.0, 191.0, 191.0, 184.0, 182.0], "value": 185.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 69.0, 69.0, 68.0, 67.0, 68.0, 68.0, 68.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1587.5000000000002, "alertThreshold": 2.0}]} 20:35:38 INFO - Return code: 0 20:35:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:35:38 INFO - # TBPL SUCCESS # 20:35:38 INFO - Running post-action listener: _resource_record_post_action 20:35:38 INFO - [mozharness: 2016-12-14 04:35:38.227591Z] Finished run-tests step (success) 20:35:38 INFO - Running post-run listener: _resource_record_post_run 20:35:38 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392663040; Read time: 16; Write time: 247108 20:35:38 INFO - TinderboxPrint: CPU usage
13.2% 20:35:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 20:35:38 INFO - TinderboxPrint: I/O write bytes / time
392,663,040 / 247,108 20:35:38 INFO - TinderboxPrint: CPU idle
8,334.0 (86.8%) 20:35:38 INFO - TinderboxPrint: CPU user
1,216.1 (12.7%) 20:35:38 INFO - TinderboxPrint: Swap in / out
0 / 0 20:35:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99807232; Read time: 0; Write time: 88136 20:35:38 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 292855808; Read time: 0; Write time: 158972 20:35:38 INFO - Running post-run listener: _upload_blobber_files 20:35:38 INFO - Blob upload gear active. 20:35:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:35:38 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 20:35:38 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'] 20:35:38 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 20:35:39 INFO - (blobuploader) - INFO - Open directory for files ... 20:35:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:35:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:35:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:40 INFO - (blobuploader) - INFO - Done attempting. 20:35:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:35:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:35:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:40 INFO - (blobuploader) - INFO - Done attempting. 20:35:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:35:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:35:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:43 INFO - (blobuploader) - INFO - Done attempting. 20:35:43 INFO - (blobuploader) - INFO - Iteration through files over. 20:35:43 INFO - Return code: 0 20:35:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:35:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:35:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c882ef1d97b0e49b0de4f745bd949128d523061c5f276aa66382609d82189688ee362d6c8f1c3693b33c565f10ff3e1abb4e4f52172b824c4874c3b5e9aa3e5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/63691341b1ba40ac91e00301ef9436b1b3acd982bb3191ce726b8bb64ebe635f2f3cd803eb74f7b2b0403750abe0e4c7c3ace7febaa38fec4ba47ed588355ad7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/466880fb5ddf80919984ff2fa16689134228583d462fe7669e277055cb3c794dbc750a33435d808ffb8f9e8ff27fef5e413c51516271f72ae927b1daf9632495"} 20:35:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:35:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:35:43 INFO - Contents: 20:35:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c882ef1d97b0e49b0de4f745bd949128d523061c5f276aa66382609d82189688ee362d6c8f1c3693b33c565f10ff3e1abb4e4f52172b824c4874c3b5e9aa3e5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/63691341b1ba40ac91e00301ef9436b1b3acd982bb3191ce726b8bb64ebe635f2f3cd803eb74f7b2b0403750abe0e4c7c3ace7febaa38fec4ba47ed588355ad7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/466880fb5ddf80919984ff2fa16689134228583d462fe7669e277055cb3c794dbc750a33435d808ffb8f9e8ff27fef5e413c51516271f72ae927b1daf9632495"} 20:35:43 INFO - Running post-run listener: copy_logs_to_upload_dir 20:35:43 INFO - Copying logs to upload dir... 20:35:43 INFO - mkdir: /builds/slave/test/build/upload/logs 20:35:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.541858 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-12-13 20:35:43.478992) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 20:35:43.482969) ========= 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=6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857 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/c882ef1d97b0e49b0de4f745bd949128d523061c5f276aa66382609d82189688ee362d6c8f1c3693b33c565f10ff3e1abb4e4f52172b824c4874c3b5e9aa3e5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/63691341b1ba40ac91e00301ef9436b1b3acd982bb3191ce726b8bb64ebe635f2f3cd803eb74f7b2b0403750abe0e4c7c3ace7febaa38fec4ba47ed588355ad7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/466880fb5ddf80919984ff2fa16689134228583d462fe7669e277055cb3c794dbc750a33435d808ffb8f9e8ff27fef5e413c51516271f72ae927b1daf9632495"} build_url:https://queue.taskcluster.net/v1/task/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.012000 build_url: 'https://queue.taskcluster.net/v1/task/M4jZ24DMSAqZF7WOfQl4eA/artifacts/public/build/firefox-53.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/c882ef1d97b0e49b0de4f745bd949128d523061c5f276aa66382609d82189688ee362d6c8f1c3693b33c565f10ff3e1abb4e4f52172b824c4874c3b5e9aa3e5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/63691341b1ba40ac91e00301ef9436b1b3acd982bb3191ce726b8bb64ebe635f2f3cd803eb74f7b2b0403750abe0e4c7c3ace7febaa38fec4ba47ed588355ad7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/466880fb5ddf80919984ff2fa16689134228583d462fe7669e277055cb3c794dbc750a33435d808ffb8f9e8ff27fef5e413c51516271f72ae927b1daf9632495"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 20:35:43.512250) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 20:35:43.512590) ========= 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=6d15e502d8e29d5d2676d664000001c3-1481684649.624037-1936132857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004377 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 20:35:43.598563) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 20:35:43.599316) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 20:35:43.600025) ========= ========= Total master_lag: 0.19 =========