builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1472503312.85 results: success (0) buildid: 20160829124531 builduid: f07d1c4813e64455b4b7a85a9950f896 revision: fe53c63024cbdeb84d6906b6a2707b4d8f236c6e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 13:41:52.849478) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 13:41:52.849954) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 13:41:52.850252) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 13:41:52.869774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:41:52.870213) ========= 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=7de08804244eb36560b44971000001c3-1472503311.814699-1990862124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-29 13:41: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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.4M=0s 2016-08-29 13:41:53 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.245751 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:41:53.131153) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:41:53.131539) ========= 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=7de08804244eb36560b44971000001c3-1472503311.814699-1990862124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.098402 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:41:53.242692) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:41:53.243141) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev fe53c63024cbdeb84d6906b6a2707b4d8f236c6e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev fe53c63024cbdeb84d6906b6a2707b4d8f236c6e --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=7de08804244eb36560b44971000001c3-1472503311.814699-1990862124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-29 13:41:53,578 truncating revision to first 12 chars 2016-08-29 13:41:53,578 Setting DEBUG logging. 2016-08-29 13:41:53,578 attempt 1/10 2016-08-29 13:41:53,578 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/fe53c63024cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-29 13:41:53,846 unpacking tar archive at: autoland-fe53c63024cb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.556989 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 13:41:53.815242) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 13:41:53.815659) ========= script_repo_revision: fe53c63024cbdeb84d6906b6a2707b4d8f236c6e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 13:41:53.816055) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 13:41:53.816340) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 13:41:53.826889) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-08-29 13:41:53.827208) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=7de08804244eb36560b44971000001c3-1472503311.814699-1990862124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:41:54 INFO - MultiFileLogger online at 20160829 13:41:54 in /builds/slave/test 13:41:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 13:41:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:41:54 INFO - {'append_to_log': False, 13:41:54 INFO - 'base_work_dir': '/builds/slave/test', 13:41:54 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 13:41:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:41:54 INFO - 'branch': 'Autoland-Non-PGO', 13:41:54 INFO - 'buildbot_json_path': 'buildprops.json', 13:41:54 INFO - 'config_files': ('talos/linux_config.py',), 13:41:54 INFO - 'default_actions': ('clobber', 13:41:54 INFO - 'read-buildbot-config', 13:41:54 INFO - 'download-and-extract', 13:41:54 INFO - 'populate-webroot', 13:41:54 INFO - 'create-virtualenv', 13:41:54 INFO - 'install', 13:41:54 INFO - 'run-tests'), 13:41:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:41:54 INFO - 'download_minidump_stackwalk': True, 13:41:54 INFO - 'download_symbols': 'ondemand', 13:41:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:41:54 INFO - 'tooltool.py': '/tools/tooltool.py', 13:41:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:41:54 INFO - '/tools/misc-python/virtualenv.py')}, 13:41:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:41:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:41:54 INFO - 'installer_path': 'installer.exe', 13:41:54 INFO - 'log_level': 'info', 13:41:54 INFO - 'log_name': 'talos', 13:41:54 INFO - 'log_to_console': True, 13:41:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:41:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:41:54 INFO - 'opt_config_files': (), 13:41:54 INFO - 'pip_index': False, 13:41:54 INFO - 'sps_profile': False, 13:41:54 INFO - 'sps_profile_interval': 0, 13:41:54 INFO - 'suite': 'dromaeojs', 13:41:54 INFO - 'system_bits': '32', 13:41:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:41:54 INFO - 'title': 'talos-linux64-ix-003', 13:41:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:41:54 INFO - 'use_talos_json': True, 13:41:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:41:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:41:54 INFO - 'work_dir': 'build'} 13:41:54 INFO - [mozharness: 2016-08-29 20:41:54.350032Z] Running clobber step. 13:41:54 INFO - Running pre-action listener: _resource_record_pre_action 13:41:54 INFO - Running main action method: clobber 13:41:54 INFO - rmtree: /builds/slave/test/build 13:41:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:41:55 INFO - Running post-action listener: _resource_record_post_action 13:41:55 INFO - [mozharness: 2016-08-29 20:41:55.395372Z] Finished clobber step (success) 13:41:55 INFO - [mozharness: 2016-08-29 20:41:55.395473Z] Running read-buildbot-config step. 13:41:55 INFO - Running pre-action listener: _resource_record_pre_action 13:41:55 INFO - Running main action method: read_buildbot_config 13:41:55 INFO - Using buildbot properties: 13:41:55 INFO - { 13:41:55 INFO - "project": "", 13:41:55 INFO - "product": "firefox", 13:41:55 INFO - "script_repo_revision": "production", 13:41:55 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 13:41:55 INFO - "repository": "", 13:41:55 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 13:41:55 INFO - "buildid": "20160829124531", 13:41:55 INFO - "pgo_build": "False", 13:41:55 INFO - "basedir": "/builds/slave/test", 13:41:55 INFO - "buildnumber": 341, 13:41:55 INFO - "slavename": "talos-linux64-ix-003", 13:41:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:41:55 INFO - "platform": "ubuntu64_hw", 13:41:55 INFO - "scheduler": "tests-autoland-linux64-talos", 13:41:55 INFO - "branch": "autoland", 13:41:55 INFO - "repo_path": "integration/autoland", 13:41:55 INFO - "revision": "fe53c63024cbdeb84d6906b6a2707b4d8f236c6e", 13:41:55 INFO - "stage_platform": "linux64", 13:41:55 INFO - "builduid": "f07d1c4813e64455b4b7a85a9950f896", 13:41:55 INFO - "slavebuilddir": "test" 13:41:55 INFO - } 13:41:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 13:41:55 INFO - Running post-action listener: _resource_record_post_action 13:41:55 INFO - [mozharness: 2016-08-29 20:41:55.397904Z] Finished read-buildbot-config step (success) 13:41:55 INFO - [mozharness: 2016-08-29 20:41:55.397993Z] Running download-and-extract step. 13:41:55 INFO - Running pre-action listener: _resource_record_pre_action 13:41:55 INFO - Running main action method: download_and_extract 13:41:55 INFO - mkdir: /builds/slave/test/build/tests 13:41: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')]} 13:41:55 INFO - trying https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:41:55 INFO - Downloading https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:41:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:41:56 INFO - Downloaded 1361 bytes. 13:41:56 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:41:56 INFO - Using the following test package requirements: 13:41:56 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:41:56 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:41:56 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:41:56 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:56 INFO - u'jsshell-linux-x86_64.zip'], 13:41:56 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:41:56 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:41:56 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:41:56 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:41:56 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:41:56 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:41:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:41:56 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:41:56 INFO - trying https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:41:56 INFO - Downloading https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:41:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:41:57 INFO - Downloaded 20308580 bytes. 13:41:57 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 13:42:02 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:02 INFO - trying https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:42:02 INFO - Downloading https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:42:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:42:03 INFO - Downloaded 20308580 bytes. 13:42:03 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 13:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:09 INFO - trying https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 13:42:09 INFO - Downloading https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 13:42:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:42:09 INFO - Downloaded 14413998 bytes. 13:42:09 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 13:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:10 INFO - trying https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:42:10 INFO - Downloading https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:42:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:42:11 INFO - Downloaded 55876429 bytes. 13:42:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:42:11 INFO - mkdir: /builds/slave/test/properties 13:42:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:42:11 INFO - Writing to file /builds/slave/test/properties/build_url 13:42:11 INFO - Contents: 13:42:11 INFO - build_url:https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:42:12 INFO - Running post-action listener: _resource_record_post_action 13:42:12 INFO - Running post-action listener: set_extra_try_arguments 13:42:12 INFO - [mozharness: 2016-08-29 20:42:12.058012Z] Finished download-and-extract step (success) 13:42:12 INFO - [mozharness: 2016-08-29 20:42:12.058244Z] Running populate-webroot step. 13:42:12 INFO - Running pre-action listener: _resource_record_pre_action 13:42:12 INFO - Running main action method: populate_webroot 13:42:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:42:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:42:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:42:12 INFO - '--tppagecycles', 13:42:12 INFO - '7'], 13:42:12 INFO - 'tests': ['tsvgm']}}, 13:42:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:42:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:42:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:42:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:42:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:42:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:42:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:12 INFO - 'talos_options': ['--disable-e10s'], 13:42:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:42:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:42:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:12 INFO - 'talos_options': ['--disable-e10s'], 13:42:12 INFO - 'tests': ['damp', 'tps']}, 13:42:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:12 INFO - 'tests': ['damp', 'tps']}, 13:42:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:42:12 INFO - 'tests': ['dromaeo_dom']}, 13:42:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:42:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:42:12 INFO - 'tests': ['basic_compositor_video']}, 13:42:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:42:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:42:12 INFO - 'tests': ['a11yr', 13:42:12 INFO - 'ts_paint', 13:42:12 INFO - 'tpaint', 13:42:12 INFO - 'sessionrestore', 13:42:12 INFO - 'sessionrestore_no_auto_restore', 13:42:12 INFO - 'tabpaint']}, 13:42:12 INFO - 'other-e10s': {'tests': ['a11yr', 13:42:12 INFO - 'ts_paint', 13:42:12 INFO - 'tpaint', 13:42:12 INFO - 'sessionrestore', 13:42:12 INFO - 'sessionrestore_no_auto_restore', 13:42:12 INFO - 'tabpaint']}, 13:42:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:42:12 INFO - 'ts_paint', 13:42:12 INFO - 'tpaint', 13:42:12 INFO - 'sessionrestore', 13:42:12 INFO - 'sessionrestore_no_auto_restore', 13:42:12 INFO - 'tabpaint']}, 13:42:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:42:12 INFO - 'ts_paint', 13:42:12 INFO - 'tpaint', 13:42:12 INFO - 'sessionrestore', 13:42:12 INFO - 'sessionrestore_no_auto_restore', 13:42:12 INFO - 'tabpaint']}, 13:42:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:42:12 INFO - 'tests': ['a11yr', 13:42:12 INFO - 'ts_paint', 13:42:12 INFO - 'tpaint', 13:42:12 INFO - 'sessionrestore', 13:42:12 INFO - 'sessionrestore_no_auto_restore', 13:42:12 INFO - 'tabpaint']}, 13:42:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:42:12 INFO - 'tests': ['a11yr', 13:42:12 INFO - 'ts_paint', 13:42:12 INFO - 'tpaint', 13:42:12 INFO - 'sessionrestore', 13:42:12 INFO - 'sessionrestore_no_auto_restore', 13:42:12 INFO - 'tabpaint']}, 13:42:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:42:12 INFO - 'tests': ['tsvgx', 13:42:12 INFO - 'tsvgr_opacity', 13:42:12 INFO - 'tart', 13:42:12 INFO - 'tscrollx', 13:42:12 INFO - 'cart']}, 13:42:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:42:12 INFO - 'tsvgr_opacity', 13:42:12 INFO - 'tart', 13:42:12 INFO - 'tscrollx', 13:42:12 INFO - 'cart']}, 13:42:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:12 INFO - 'talos_options': ['--disable-e10s'], 13:42:12 INFO - 'tests': ['tp5o']}, 13:42:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:12 INFO - 'tests': ['tp5o']}, 13:42:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:12 INFO - 'talos_options': ['--disable-e10s', 13:42:12 INFO - '--xperf_path', 13:42:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:42:12 INFO - 'tests': ['tp5n']}, 13:42:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:12 INFO - 'talos_options': ['--xperf_path', 13:42:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:42:12 INFO - 'tests': ['tp5n']}}, 13:42:12 INFO - 'talos.zip': {'path': '', 13:42:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:42:12 INFO - Running post-action listener: _resource_record_post_action 13:42:12 INFO - [mozharness: 2016-08-29 20:42:12.080811Z] Finished populate-webroot step (success) 13:42:12 INFO - [mozharness: 2016-08-29 20:42:12.080902Z] Running create-virtualenv step. 13:42:12 INFO - Running pre-action listener: _resource_record_pre_action 13:42:12 INFO - Running main action method: create_virtualenv 13:42:12 INFO - Creating virtualenv /builds/slave/test/build/venv 13:42: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 13:42:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:42:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:42:12 INFO - Using real prefix '/usr' 13:42:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:42:12 INFO - Installing distribute.............................................................................................................................................................................................done. 13:42:14 INFO - Installing pip.................done. 13:42:14 INFO - Return code: 0 13:42:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e8d47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1545d20>, '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 0x1546c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15470b0>, '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': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:42:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:42:14 INFO - Using env: {'DISPLAY': ':0', 13:42:14 INFO - 'HOME': '/home/cltbld', 13:42:14 INFO - 'LANG': 'en_US.UTF-8', 13:42:14 INFO - 'LANGUAGE': 'en_US:en', 13:42:14 INFO - 'LOGNAME': 'cltbld', 13:42:14 INFO - 'MAIL': '/var/mail/cltbld', 13:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:14 INFO - 'MOZ_NO_REMOTE': '1', 13:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:14 INFO - 'NO_EM_RESTART': '1', 13:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:14 INFO - 'PWD': '/builds/slave/test', 13:42:14 INFO - 'SHELL': '/bin/bash', 13:42:14 INFO - 'SHLVL': '1', 13:42:14 INFO - 'TERM': 'linux', 13:42:14 INFO - 'TMOUT': '86400', 13:42:14 INFO - 'USER': 'cltbld', 13:42:14 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 13:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:14 INFO - '_': '/tools/buildbot/bin/python'} 13:42:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42: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 13:42:15 INFO - Cleaning up... 13:42:15 INFO - Return code: 0 13:42:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:42: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')]} 13:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42: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')]} 13:42:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42: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 0x7f8e8d47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1545d20>, '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 0x1546c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15470b0>, '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': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:42: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 13:42: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 13:42:15 INFO - Using env: {'DISPLAY': ':0', 13:42:15 INFO - 'HOME': '/home/cltbld', 13:42:15 INFO - 'LANG': 'en_US.UTF-8', 13:42:15 INFO - 'LANGUAGE': 'en_US:en', 13:42:15 INFO - 'LOGNAME': 'cltbld', 13:42:15 INFO - 'MAIL': '/var/mail/cltbld', 13:42:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:15 INFO - 'MOZ_NO_REMOTE': '1', 13:42:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:15 INFO - 'NO_EM_RESTART': '1', 13:42:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:15 INFO - 'PWD': '/builds/slave/test', 13:42:15 INFO - 'SHELL': '/bin/bash', 13:42:15 INFO - 'SHLVL': '1', 13:42:15 INFO - 'TERM': 'linux', 13:42:15 INFO - 'TMOUT': '86400', 13:42:15 INFO - 'USER': 'cltbld', 13:42:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 13:42:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:15 INFO - '_': '/tools/buildbot/bin/python'} 13:42:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:15 INFO - Downloading/unpacking psutil>=3.1.1 13:42: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 13:42: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 13:42: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 13:42: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 13:42: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 13:42: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 13:42:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:42:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:42:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:42:17 INFO - Installing collected packages: psutil 13:42:17 INFO - Running setup.py install for psutil 13:42:17 INFO - building 'psutil._psutil_linux' extension 13:42: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 13:42: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:42:18 INFO - building 'psutil._psutil_posix' extension 13:42:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:42: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 13:42:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:42:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:42:19 INFO - Successfully installed psutil 13:42:19 INFO - Cleaning up... 13:42:19 INFO - Return code: 0 13:42:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e8d47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1545d20>, '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 0x1546c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15470b0>, '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': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:42:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:42:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:42:19 INFO - Using env: {'DISPLAY': ':0', 13:42:19 INFO - 'HOME': '/home/cltbld', 13:42:19 INFO - 'LANG': 'en_US.UTF-8', 13:42:19 INFO - 'LANGUAGE': 'en_US:en', 13:42:19 INFO - 'LOGNAME': 'cltbld', 13:42:19 INFO - 'MAIL': '/var/mail/cltbld', 13:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:19 INFO - 'MOZ_NO_REMOTE': '1', 13:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:19 INFO - 'NO_EM_RESTART': '1', 13:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:19 INFO - 'PWD': '/builds/slave/test', 13:42:19 INFO - 'SHELL': '/bin/bash', 13:42:19 INFO - 'SHLVL': '1', 13:42:19 INFO - 'TERM': 'linux', 13:42:19 INFO - 'TMOUT': '86400', 13:42:19 INFO - 'USER': 'cltbld', 13:42:19 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 13:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:19 INFO - '_': '/tools/buildbot/bin/python'} 13:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:42:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:42:21 INFO - Installing collected packages: mozsystemmonitor 13:42:21 INFO - Running setup.py install for mozsystemmonitor 13:42:21 INFO - Successfully installed mozsystemmonitor 13:42:21 INFO - Cleaning up... 13:42:21 INFO - Return code: 0 13:42:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:21 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 0x7f8e8d47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1545d20>, '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 0x1546c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15470b0>, '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': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:42:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:42:21 INFO - Using env: {'DISPLAY': ':0', 13:42:21 INFO - 'HOME': '/home/cltbld', 13:42:21 INFO - 'LANG': 'en_US.UTF-8', 13:42:21 INFO - 'LANGUAGE': 'en_US:en', 13:42:21 INFO - 'LOGNAME': 'cltbld', 13:42:21 INFO - 'MAIL': '/var/mail/cltbld', 13:42:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:21 INFO - 'MOZ_NO_REMOTE': '1', 13:42:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:21 INFO - 'NO_EM_RESTART': '1', 13:42:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:21 INFO - 'PWD': '/builds/slave/test', 13:42:21 INFO - 'SHELL': '/bin/bash', 13:42:21 INFO - 'SHLVL': '1', 13:42:21 INFO - 'TERM': 'linux', 13:42:21 INFO - 'TMOUT': '86400', 13:42:21 INFO - 'USER': 'cltbld', 13:42:21 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 13:42:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:21 INFO - '_': '/tools/buildbot/bin/python'} 13:42:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:21 INFO - Downloading/unpacking jsonschema==2.5.1 13:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:42:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:42: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 13:42: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 13:42: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 13:42: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 13:42: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 13:42: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 13:42:23 INFO - Downloading functools32-3.2.3-2.tar.gz 13:42:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:42:23 INFO - warning: no files found matching '*.txt' 13:42:23 INFO - no previously-included directories found matching 'build' 13:42:23 INFO - no previously-included directories found matching 'dist' 13:42:23 INFO - no previously-included directories found matching '.git*' 13:42:23 INFO - Installing collected packages: jsonschema, functools32 13:42:23 INFO - Running setup.py install for functools32 13:42:23 INFO - warning: no files found matching '*.txt' 13:42:23 INFO - no previously-included directories found matching 'build' 13:42:23 INFO - no previously-included directories found matching 'dist' 13:42:23 INFO - no previously-included directories found matching '.git*' 13:42:23 INFO - Successfully installed jsonschema functools32 13:42:23 INFO - Cleaning up... 13:42:23 INFO - Return code: 0 13:42:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:42: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')]} 13:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42: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')]} 13:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42: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 0x7f8e8d47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1545d20>, '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 0x1546c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15470b0>, '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': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:42: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 13:42: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 13:42:23 INFO - Using env: {'DISPLAY': ':0', 13:42:23 INFO - 'HOME': '/home/cltbld', 13:42:23 INFO - 'LANG': 'en_US.UTF-8', 13:42:23 INFO - 'LANGUAGE': 'en_US:en', 13:42:23 INFO - 'LOGNAME': 'cltbld', 13:42:23 INFO - 'MAIL': '/var/mail/cltbld', 13:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:23 INFO - 'MOZ_NO_REMOTE': '1', 13:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:23 INFO - 'NO_EM_RESTART': '1', 13:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:23 INFO - 'PWD': '/builds/slave/test', 13:42:23 INFO - 'SHELL': '/bin/bash', 13:42:23 INFO - 'SHLVL': '1', 13:42:23 INFO - 'TERM': 'linux', 13:42:23 INFO - 'TMOUT': '86400', 13:42:23 INFO - 'USER': 'cltbld', 13:42:23 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 13:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:23 INFO - '_': '/tools/buildbot/bin/python'} 13:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:42:24 INFO - Cleaning up... 13:42:24 INFO - Return code: 0 13:42:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8e8d47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1545d20>, '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 0x1546c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15470b0>, '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': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:42:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:42:24 INFO - Using env: {'DISPLAY': ':0', 13:42:24 INFO - 'HOME': '/home/cltbld', 13:42:24 INFO - 'LANG': 'en_US.UTF-8', 13:42:24 INFO - 'LANGUAGE': 'en_US:en', 13:42:24 INFO - 'LOGNAME': 'cltbld', 13:42:24 INFO - 'MAIL': '/var/mail/cltbld', 13:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:24 INFO - 'MOZ_NO_REMOTE': '1', 13:42:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:24 INFO - 'NO_EM_RESTART': '1', 13:42:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:24 INFO - 'PWD': '/builds/slave/test', 13:42:24 INFO - 'SHELL': '/bin/bash', 13:42:24 INFO - 'SHLVL': '1', 13:42:24 INFO - 'TERM': 'linux', 13:42:24 INFO - 'TMOUT': '86400', 13:42:24 INFO - 'USER': 'cltbld', 13:42:24 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 13:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:24 INFO - '_': '/tools/buildbot/bin/python'} 13:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:24 INFO - Downloading/unpacking blobuploader==1.2.4 13:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:26 INFO - Downloading blobuploader-1.2.4.tar.gz 13:42:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:42:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:42: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 13:42: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 13:42: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 13:42: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 13:42: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 13:42: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 13:42:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:42:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:42: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 13:42: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 13:42: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 13:42: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 13:42: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 13:42: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 13:42:26 INFO - Downloading docopt-0.6.1.tar.gz 13:42:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:42:27 INFO - Installing collected packages: blobuploader, requests, docopt 13:42:27 INFO - Running setup.py install for blobuploader 13:42:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:42:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:42:27 INFO - Running setup.py install for requests 13:42:27 INFO - Running setup.py install for docopt 13:42:27 INFO - Successfully installed blobuploader requests docopt 13:42:27 INFO - Cleaning up... 13:42:27 INFO - Return code: 0 13:42:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:42: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')]} 13:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42: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')]} 13:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42: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 0x7f8e8d47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1545d20>, '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 0x1546c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15470b0>, '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': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:42: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 13:42: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 13:42:27 INFO - Using env: {'DISPLAY': ':0', 13:42:27 INFO - 'HOME': '/home/cltbld', 13:42:27 INFO - 'LANG': 'en_US.UTF-8', 13:42:27 INFO - 'LANGUAGE': 'en_US:en', 13:42:27 INFO - 'LOGNAME': 'cltbld', 13:42:27 INFO - 'MAIL': '/var/mail/cltbld', 13:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:27 INFO - 'MOZ_NO_REMOTE': '1', 13:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:27 INFO - 'NO_EM_RESTART': '1', 13:42:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:27 INFO - 'PWD': '/builds/slave/test', 13:42:27 INFO - 'SHELL': '/bin/bash', 13:42:27 INFO - 'SHLVL': '1', 13:42:27 INFO - 'TERM': 'linux', 13:42:27 INFO - 'TMOUT': '86400', 13:42:27 INFO - 'USER': 'cltbld', 13:42:27 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 13:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:27 INFO - '_': '/tools/buildbot/bin/python'} 13:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:42:27 INFO - Running setup.py (path:/tmp/pip-LSBTqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:42:27 INFO - Running setup.py (path:/tmp/pip-K4FqLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:42:28 INFO - Running setup.py (path:/tmp/pip-rGCS7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:42:28 INFO - Running setup.py (path:/tmp/pip-oAWeJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:42:28 INFO - Running setup.py (path:/tmp/pip-fJyB4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:42:28 INFO - Running setup.py (path:/tmp/pip-kNDEjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:42:28 INFO - Running setup.py (path:/tmp/pip-Mfn5P_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:42:28 INFO - Running setup.py (path:/tmp/pip-boIxLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:42:28 INFO - Running setup.py (path:/tmp/pip-RwNi1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:42:28 INFO - Running setup.py (path:/tmp/pip-8A9dbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:42:28 INFO - Running setup.py (path:/tmp/pip-c5x8pV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:42:28 INFO - Running setup.py (path:/tmp/pip-5Ib6xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:42:28 INFO - Running setup.py (path:/tmp/pip-X8J3kF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:42:28 INFO - Running setup.py (path:/tmp/pip-mWDRPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:42:28 INFO - Running setup.py (path:/tmp/pip-UziFaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:42:28 INFO - Running setup.py (path:/tmp/pip-ixC4in-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:42:29 INFO - Running setup.py (path:/tmp/pip-X1Uixq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:42:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:42:29 INFO - Running setup.py install for manifestparser 13:42:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:42:29 INFO - Running setup.py install for mozcrash 13:42:29 INFO - Running setup.py install for mozdebug 13:42:29 INFO - Running setup.py install for mozdevice 13:42:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:42:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:42:29 INFO - Running setup.py install for mozfile 13:42:29 INFO - Running setup.py install for mozhttpd 13:42:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:42:29 INFO - Running setup.py install for mozinfo 13:42:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:42:29 INFO - Running setup.py install for mozInstall 13:42:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:42:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:42:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:42:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:42:29 INFO - Running setup.py install for mozleak 13:42:29 INFO - Running setup.py install for mozlog 13:42:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:42:30 INFO - Running setup.py install for moznetwork 13:42:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:42:30 INFO - Running setup.py install for mozprocess 13:42:30 INFO - Running setup.py install for mozprofile 13:42:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:42:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:42:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:42:30 INFO - Running setup.py install for mozrunner 13:42:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:42:30 INFO - Running setup.py install for mozscreenshot 13:42:30 INFO - Running setup.py install for moztest 13:42:30 INFO - Running setup.py install for mozversion 13:42:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:42:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:42:30 INFO - Cleaning up... 13:42:30 INFO - Return code: 0 13:42:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42: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 0x7f8e8d47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1545d20>, '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 0x1546c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15470b0>, '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': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:42: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 13:42: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 13:42:30 INFO - Using env: {'DISPLAY': ':0', 13:42:30 INFO - 'HOME': '/home/cltbld', 13:42:30 INFO - 'LANG': 'en_US.UTF-8', 13:42:30 INFO - 'LANGUAGE': 'en_US:en', 13:42:30 INFO - 'LOGNAME': 'cltbld', 13:42:30 INFO - 'MAIL': '/var/mail/cltbld', 13:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:30 INFO - 'MOZ_NO_REMOTE': '1', 13:42:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:30 INFO - 'NO_EM_RESTART': '1', 13:42:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:30 INFO - 'PWD': '/builds/slave/test', 13:42:30 INFO - 'SHELL': '/bin/bash', 13:42:30 INFO - 'SHLVL': '1', 13:42:30 INFO - 'TERM': 'linux', 13:42:30 INFO - 'TMOUT': '86400', 13:42:30 INFO - 'USER': 'cltbld', 13:42:30 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 13:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:30 INFO - '_': '/tools/buildbot/bin/python'} 13:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:42:31 INFO - Running setup.py (path:/tmp/pip-yz3bYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:42:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:42:31 INFO - Running setup.py (path:/tmp/pip-qTvDH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:42:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:42:31 INFO - Running setup.py (path:/tmp/pip-lnFOT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:42:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:42:31 INFO - Running setup.py (path:/tmp/pip-W1eVXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:42:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:42:31 INFO - Running setup.py (path:/tmp/pip-KbOfT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:42:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:42:31 INFO - Running setup.py (path:/tmp/pip-ipU1Ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:42: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)) 13:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:42:31 INFO - Running setup.py (path:/tmp/pip-BHg0qX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:42: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)) 13:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:42:31 INFO - Running setup.py (path:/tmp/pip-58HiIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:42: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)) 13:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:42:31 INFO - Running setup.py (path:/tmp/pip-mAPHdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:42: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)) 13:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:42:31 INFO - Running setup.py (path:/tmp/pip-FWhiCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:42:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:42:31 INFO - Running setup.py (path:/tmp/pip-WhUCpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:42: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)) 13:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:42:31 INFO - Running setup.py (path:/tmp/pip-o0453E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:42: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)) 13:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:42:31 INFO - Running setup.py (path:/tmp/pip-XkB4jO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:42:32 INFO - Running setup.py (path:/tmp/pip-_6WtmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:42:32 INFO - Running setup.py (path:/tmp/pip-bw8dqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:42:32 INFO - Running setup.py (path:/tmp/pip-SOSoU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:42:32 INFO - Running setup.py (path:/tmp/pip-a7KSJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:42:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:34 INFO - Downloading blessings-1.6.tar.gz 13:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:42:34 INFO - Installing collected packages: blessings 13:42:34 INFO - Running setup.py install for blessings 13:42:34 INFO - Successfully installed blessings 13:42:34 INFO - Cleaning up... 13:42:34 INFO - Return code: 0 13:42:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:42:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:42:34 INFO - Reading from file tmpfile_stdout 13:42:34 INFO - Current package versions: 13:42:34 INFO - argparse == 1.2.1 13:42:34 INFO - blessings == 1.6 13:42:34 INFO - blobuploader == 1.2.4 13:42:34 INFO - docopt == 0.6.1 13:42:34 INFO - functools32 == 3.2.3-2 13:42:34 INFO - jsonschema == 2.5.1 13:42:34 INFO - manifestparser == 1.1 13:42:34 INFO - mozInstall == 1.12 13:42:34 INFO - mozcrash == 0.17 13:42:34 INFO - mozdebug == 0.1 13:42:34 INFO - mozdevice == 0.48 13:42:34 INFO - mozfile == 1.2 13:42:34 INFO - mozhttpd == 0.7 13:42:34 INFO - mozinfo == 0.9 13:42:34 INFO - mozleak == 0.1 13:42:34 INFO - mozlog == 3.3 13:42:34 INFO - moznetwork == 0.27 13:42:34 INFO - mozprocess == 0.23 13:42:34 INFO - mozprofile == 0.28 13:42:34 INFO - mozrunner == 6.12 13:42:34 INFO - mozscreenshot == 0.1 13:42:34 INFO - mozsystemmonitor == 0.3 13:42:34 INFO - moztest == 0.7 13:42:34 INFO - mozversion == 1.4 13:42:34 INFO - psutil == 3.1.1 13:42:34 INFO - requests == 1.2.3 13:42:34 INFO - wsgiref == 0.1.2 13:42:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:42: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')]} 13:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42: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')]} 13:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42: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 0x7f8e8d47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1545d20>, '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 0x1546c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15470b0>, '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': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:42: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 13:42: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 13:42:34 INFO - Using env: {'DISPLAY': ':0', 13:42:34 INFO - 'HOME': '/home/cltbld', 13:42:34 INFO - 'LANG': 'en_US.UTF-8', 13:42:34 INFO - 'LANGUAGE': 'en_US:en', 13:42:34 INFO - 'LOGNAME': 'cltbld', 13:42:34 INFO - 'MAIL': '/var/mail/cltbld', 13:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:34 INFO - 'MOZ_NO_REMOTE': '1', 13:42:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:34 INFO - 'NO_EM_RESTART': '1', 13:42:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:34 INFO - 'PWD': '/builds/slave/test', 13:42:34 INFO - 'SHELL': '/bin/bash', 13:42:34 INFO - 'SHLVL': '1', 13:42:34 INFO - 'TERM': 'linux', 13:42:34 INFO - 'TMOUT': '86400', 13:42:34 INFO - 'USER': 'cltbld', 13:42:34 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 13:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:34 INFO - '_': '/tools/buildbot/bin/python'} 13:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42: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)) 13:42: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)) 13:42: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)) 13:42: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)) 13:42: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)) 13:42: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)) 13:42: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)) 13:42: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)) 13:42: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)) 13:42: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)) 13:42: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)) 13:42:34 INFO - Cleaning up... 13:42:34 INFO - Return code: 0 13:42:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:42: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')]} 13:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42: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')]} 13:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42: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 0x7f8e8d47ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1545d20>, '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 0x1546c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15470b0>, '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': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:42: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 13:42: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 13:42:34 INFO - Using env: {'DISPLAY': ':0', 13:42:34 INFO - 'HOME': '/home/cltbld', 13:42:34 INFO - 'LANG': 'en_US.UTF-8', 13:42:34 INFO - 'LANGUAGE': 'en_US:en', 13:42:34 INFO - 'LOGNAME': 'cltbld', 13:42:34 INFO - 'MAIL': '/var/mail/cltbld', 13:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:34 INFO - 'MOZ_NO_REMOTE': '1', 13:42:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:34 INFO - 'NO_EM_RESTART': '1', 13:42:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:34 INFO - 'PWD': '/builds/slave/test', 13:42:34 INFO - 'SHELL': '/bin/bash', 13:42:34 INFO - 'SHLVL': '1', 13:42:34 INFO - 'TERM': 'linux', 13:42:34 INFO - 'TMOUT': '86400', 13:42:34 INFO - 'USER': 'cltbld', 13:42:34 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 13:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:34 INFO - '_': '/tools/buildbot/bin/python'} 13:42:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:42:35 INFO - Cleaning up... 13:42:35 INFO - Return code: 0 13:42:35 INFO - Running post-action listener: _resource_record_post_action 13:42:35 INFO - Running post-action listener: _start_resource_monitoring 13:42:35 INFO - Starting resource monitoring. 13:42:35 INFO - [mozharness: 2016-08-29 20:42:35.133622Z] Finished create-virtualenv step (success) 13:42:35 INFO - [mozharness: 2016-08-29 20:42:35.134630Z] Running install step. 13:42:35 INFO - Running pre-action listener: _resource_record_pre_action 13:42:35 INFO - Running main action method: install 13:42:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:42:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:42:35 INFO - Reading from file tmpfile_stdout 13:42:35 INFO - Detecting whether we're running mozinstall >=1.0... 13:42:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:42:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:42:35 INFO - Reading from file tmpfile_stdout 13:42:35 INFO - Output received: 13:42:35 INFO - Usage: mozinstall [options] installer 13:42:35 INFO - Options: 13:42:35 INFO - -h, --help show this help message and exit 13:42:35 INFO - -d DEST, --destination=DEST 13:42:35 INFO - Directory to install application into. [default: 13:42:35 INFO - "/builds/slave/test"] 13:42:35 INFO - --app=APP Application being installed. [default: firefox] 13:42:35 INFO - mkdir: /builds/slave/test/build/application 13:42:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:42:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:42:51 INFO - Reading from file tmpfile_stdout 13:42:51 INFO - Output received: 13:42:51 INFO - /builds/slave/test/build/application/firefox/firefox 13:42:51 INFO - Running post-action listener: _resource_record_post_action 13:42:51 INFO - [mozharness: 2016-08-29 20:42:51.559518Z] Finished install step (success) 13:42:51 INFO - [mozharness: 2016-08-29 20:42:51.559802Z] Running run-tests step. 13:42:51 INFO - Running pre-action listener: _resource_record_pre_action 13:42:51 INFO - Running main action method: run_tests 13:42:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:42:51 INFO - Python 2.7.3 13:42:51 INFO - Return code: 0 13:42:51 INFO - grabbing minidump binary from tooltool 13:42: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')]} 13:42: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 0x1545d20>, '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 0x1546c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15470b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:42: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 13:42: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 13:42: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 13:42:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:42:51 INFO - Return code: 0 13:42:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:42:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:42:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:42:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:42:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:42:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:42:51 INFO - Using env: {'DISPLAY': ':0', 13:42:51 INFO - 'HOME': '/home/cltbld', 13:42:51 INFO - 'LANG': 'en_US.UTF-8', 13:42:51 INFO - 'LANGUAGE': 'en_US:en', 13:42:51 INFO - 'LOGNAME': 'cltbld', 13:42:51 INFO - 'MAIL': '/var/mail/cltbld', 13:42:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:42:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:51 INFO - 'MOZ_NO_REMOTE': '1', 13:42:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:42:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:51 INFO - 'NO_EM_RESTART': '1', 13:42:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:51 INFO - 'PWD': '/builds/slave/test', 13:42:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:42:51 INFO - 'SHELL': '/bin/bash', 13:42:51 INFO - 'SHLVL': '1', 13:42:51 INFO - 'TERM': 'linux', 13:42:51 INFO - 'TMOUT': '86400', 13:42:51 INFO - 'USER': 'cltbld', 13:42:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472503311.814699-1990862124', 13:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:51 INFO - '_': '/tools/buildbot/bin/python'} 13:42:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:42:52 INFO - mozversion application_buildid: 20160829124531 13:42:52 INFO - mozversion application_changeset: fe53c63024cbdeb84d6906b6a2707b4d8f236c6e 13:42:52 INFO - mozversion application_display_name: Nightly 13:42:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:42:52 INFO - mozversion application_name: Firefox 13:42:52 INFO - mozversion application_remotingname: firefox 13:42:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 13:42:52 INFO - mozversion application_vendor: Mozilla 13:42:52 INFO - mozversion application_version: 51.0a1 13:42:52 INFO - mozversion platform_buildid: 20160829124531 13:42:52 INFO - mozversion platform_changeset: fe53c63024cbdeb84d6906b6a2707b4d8f236c6e 13:42:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 13:42:52 INFO - mozversion platform_version: 51.0a1 13:42:52 INFO - using testdate: 1472503372 13:42:52 INFO - actual date: 1472503372 13:42:52 INFO - starting webserver on 'localhost:37057' 13:42:52 INFO - SUITE-START | Running 2 tests 13:42:52 INFO - TEST-START | dromaeo_css 13:42:52 INFO - operating with platform_type : linux_ 13:42:52 INFO - Initialising browser for dromaeo_css test... 13:42:52 INFO - TEST-INFO | started process 3299 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyBl3gT/profile http://localhost:37057/getInfo.html) 13:42:58 INFO - PROCESS | 3299 | __metrics Screen width/height:1600/1200 13:42:58 INFO - PROCESS | 3299 | colorDepth:24 13:42:58 INFO - PROCESS | 3299 | Browser inner width/height: 1024/697 13:42:58 INFO - PROCESS | 3299 | __metrics 13:42:59 INFO - PROCESS | 3299 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:42:59 INFO - PROCESS | 3299 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:42:59 INFO - PROCESS | 3299 | console.error: PushService: 13:42:59 INFO - PROCESS | 3299 | stateChangeProcessEnqueue: Error transitioning state 13:42:59 INFO - PROCESS | 3299 | UnknownError 13:43:00 INFO - TEST-INFO | 3299: exit 0 13:43:00 INFO - Browser initialized. 13:43:00 INFO - Running cycle 1/1 for dromaeo_css test... 13:43:00 INFO - TEST-INFO | started process 3380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyBl3gT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:43:12 INFO - PROCESS | 3380 | RSS: Main: 182247424 13:43:12 INFO - PROCESS | 3380 | 13:44:03 INFO - PROCESS | 3380 | 1472503443854 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:46:16 INFO - PROCESS | 3380 | Cycle 1(1): loaded http://localhost:37057/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37057/tests/dromaeo/cssquery-ext.html) 13:46:18 INFO - PROCESS | 3380 | RSS: Main: 292384768 13:46:18 INFO - PROCESS | 3380 | 13:49:20 INFO - PROCESS | 3380 | Cycle 1(1): loaded http://localhost:37057/tests/dromaeo/cssquery-ext.html (next: http://localhost:37057/tests/dromaeo/cssquery-jquery.html) 13:49:21 INFO - PROCESS | 3380 | RSS: Main: 274337792 13:49:21 INFO - PROCESS | 3380 | 13:52:23 INFO - PROCESS | 3380 | Cycle 1(1): loaded http://localhost:37057/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37057/tests/dromaeo/cssquery-mootools.html) 13:52:24 INFO - PROCESS | 3380 | RSS: Main: 256630784 13:52:24 INFO - PROCESS | 3380 | 13:55:26 INFO - PROCESS | 3380 | Cycle 1(1): loaded http://localhost:37057/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37057/tests/dromaeo/cssquery-prototype.html) 13:55:27 INFO - PROCESS | 3380 | RSS: Main: 219095040 13:55:27 INFO - PROCESS | 3380 | 13:58:30 INFO - PROCESS | 3380 | Cycle 1(1): loaded http://localhost:37057/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37057/tests/dromaeo/cssquery-yui.html) 13:58:30 INFO - PROCESS | 3380 | RSS: Main: 219373568 13:58:30 INFO - PROCESS | 3380 | 14:01:33 INFO - PROCESS | 3380 | Cycle 1(1): loaded http://localhost:37057/tests/dromaeo/cssquery-yui.html (next: http://localhost:37057/tests/dromaeo/cssquery-dojo.html) 14:01:33 INFO - PROCESS | 3380 | RSS: Main: 257187840 14:01:33 INFO - PROCESS | 3380 | 14:01:33 INFO - PROCESS | 3380 | __start_tp_report 14:01:33 INFO - PROCESS | 3380 | _x_x_mozilla_page_load 14:01:33 INFO - PROCESS | 3380 | _x_x_mozilla_page_load_details 14:01:33 INFO - PROCESS | 3380 | |i|pagename|runs| 14:01:33 INFO - PROCESS | 3380 | |0;dojo.html;2535.93660158496;2591.5594348960676;2604.400987772812;2609.869506524674;2630.4344565918323;4590.540945905412;4651.4418269807675;4670.76646167692;4728.503507131753;4810.278458231267;4680.625549956012;4693.155232058228;4726.62187025038;4736.218523943554;4810.759462026894;4276.935845962313;4314.503832059322;4446.088551846879;4449.977750111245;4474.395956545874;4363.847265345714;4395.758233297167;4441.5336389679105;4453.977730111361;4500.392447019643;4222.78886055696;4305.935410968838;4333.371661109121;4381.474223093217;4392.055708022758;4285.9785701071605;4289.571042895716;4306.009617787895;4404.933925991113;4428.535003824616;4300.35494675798;4308.9353659695125;4313.266744653416;4318.546552611993;4386.144701783153;4635;4639;4668.229742092584;4703.529647035303;4790.473047964721;5084;5084.7457627118865;5085.364329458817;5091.541761241469;5119.48805119485;5103.642745007851;5106.5659418949435;5137.51193636604;5137.768800403991;5155.639105262633;4627.537246275346;4654.697444666086;4704.129735998851;4705.976470117627;4725.5510726480925;5064.518870707277;5087.847364579068;5088.898222035538;5129.461406552258;5148.588112950955;4887.95112048882;4922.089413458521;4924.876878078005;4925.335079764186;4985.750712464363;4869.853904382874;4931.778069986859;4970.676906001098;5000.64995450315;5008.12357837377;4972.453030166679;4980.626453016038;4983.07813054586;4986.376702912136;5003.149464591028;4966.528179822911;4975.353204083446;4985.177445721488;4988.950110498921;5033.446320904697;4298.656107511391;4349.347597860283;4350.521442641307;4408.228560001987;4410.22821006329;3820.8280627371837;3821.522309711286;3854.5759966403675;3873.3802591585772;3881.7865017423746;4364.738115713068;4369.235383807821;4373.365861950063;4378.408914796525;4412.294032954712;4958;5082.33929589151;5118.846434606968;5134.974325128351;5186.092433824066;4364.781760911942;4384.276594361894;4421.182081314967;4437.844675436344;4439.711418757771;4677.555632214934;4693.671442998957;4693.83571575;4698.201305777958;4752.477227504972;4561.178987782231;4651;4668.486466488752;4743.928841067387;4770.451398089264;5041.521055499722;5058.1148299048255;5067.797288108582;5133.460986596503;5141.357330333708;4660.091282199938;4678.976605116953;4688.296755486705;4691.085238378483;4750.667453278237;4820.783064762024;4878.829240976549;4905.681130726492;4967.850964471072;5028.773705183348;4979.925301120558;5006.098902197639;5010.048090862724;5043.773030213576;5069.9746501267255;4833.275008748716;4834.613230941586;4835.081334546425;4853.927191092207;4933.506649335038;4726.645501587326;4825.396825396825;4838.806447742051;4877.634177436636;4893.09477746618;4832.758362081811;4849.733264670477;4852.102361063215;4875.0493653737185;4879.682820616648;4931.778069986787;4953.959668469518;4955.1823949048;4964.35463389757;5013.699178049329;4644.303354496852;4685;4700.271457924027;4806.7836947336755;4874.610031197425 14:01:33 INFO - PROCESS | 3380 | |1;ext.html;570.1277046119437;570.7174948400537;573.839324989003;579.2093791973957;581.621945735272;27238.31904202396;29730.108096757103;38723.61276387232;39586;39773;39280.80359598205;39510.8024459878;39523.40714889279;39527.209455810866;39650.40524392129;7662.616869156548;7786.416018798584;7803.843923121534;7806.102298235691;7806.258405451473;7256.6734496947765;9810.509474526281;10078.294519383646;10079.748006299827;10342.896571034305;9907.356021858592;9947.253955953296;9986.300958932878;9991.500424978758;9998.45008524531;7247.20280769115;10042.69871903844;10076.09315161639;10113.544890479872;10125.898741012606;9493.477858717768;9880;9946.35348702332;10266.7433314167;10276.383416995004;36726.449103263476;36939.63060369389;37037.814810925775;37045.81477092624;37068.25863482742;2632.139442961232;2718.836869787819;2732.3715545424466;2743.3004583831193;2748.6426764520684;27855.582166267523;27945.86027069872;27971.720282797116;28022.439551208863;28873.422531549462;3292.506124081383;3357.446021406465;3379.7803142795888;3411.8635254589785;3449.586049674055;253446;254234;255896;256105;256123.71938140376;51027.23459148116;51347.48652513502;51379;51396;51413.74293128585;32233.677663223538;32867.34265314681;33015.66984330174;54567.45432545703;54669.72665136649;13326.466941322433;13475.460981560824;13519.864801351861;13520.864791352158;13524.256165910772;9766.121049105615;10505.789884202273;10509.632162874263;10520.631777887736;11016.559337626566;17103.74344384835;17210.041690411275;17431.825681743274;17534.91232543829;17893.552661183574;6459.870802584016;6475.579087359307;6532.738690452424;6600.636964966973;6690.264070952191;775.3758224629115;841.4530555139208;956.9377990430617;963.677168148678;986.6497393425374;25772.742272577034;26064.478710426065;26476.47047059048;26920.59619105715;27280.72719272782;937.6952490440634;962.5860879821744;973.3235401395962;998.825205589019;1026.10728666061;13938.58184254474;14243.430262789372;14392.35234414454;14506.347214375379;14558.636034099232;367971;371971;372666;372904;373260;47742.76128619404;47921.5207847924;47944.520554794704;48150.759246203546;48324.51675483271;1031.6234574380296;1110.5335758981248;1167.830664553652;1202.2666173634077;1289.1105137455127;24455.877720611283;27967;28361.858190708914;28822.279443014093;29456.263593410335;41449.37825932553;42298.1540369197;42320.57679423167;42360.15279694327;42387.57612423836;326799;330298;330474;331536;332428;36105.458418124275;37155;37902.8104859474;39264;40025.1994960105;40390.59609403869;40509.39235911405;40798.38802417907;41036;41387.1722565553;34441.65558344385;34504.13739656529;34663.826680866434;34689.479657805656;34851.825740871136;34868.47697284492;35152.47271290984;35261.82369088138;35323.470147947286;35486.82256588701;34615.30769384649;34680.65319346774;34777.47833782546;35032.82483587566;36101.458478122324;29973.700262997092;31852.5222121673;32423.675763242067;32477.83761081274;32572.674273256966;23172.768272317735;23811.166609168595;23859.761402386448;23871.164509242095;23937.281881543582 14:01:33 INFO - PROCESS | 3380 | |2;jquery.html;341.34291488883895;368.28552607940594;370.0563562914568;372.92541491701667;388.1247786242024;12452.128351015432;16016.199190040496;16469.341226350945;16895.324187032536;17974.730379044326;14426.855731442682;14664.560063198094;14848;15137.924310378432;15247.695046099072;4587.954120458786;4977.427595826481;5025.252770992884;5160.819371322004;5184.922226166611;5057.418396884369;5139.15203991341;5150.459201783815;5152.819651312205;5153.716545589991;5114.079465696173;5119.360079990001;5119.948800511985;5279.656822306557;5509.311336082989;5525.171224316345;5531.640443371188;5539.695316757577;5563.582731295169;5566.165075238706;5238.449962753894;5351.57187425005;5399.217113518557;5470.261514695505;5471.562275017989;12325.260484370967;12352.876471235262;12538.874611253954;12561.874381256162;20445.28441504555;1759.692053890564;1794.7038738608114;1857.5541869951114;2026.3920823752815;2311.5030268492187;8885.777855553599;9443.575039123187;9517.571932540415;9786.853197201977;9794.510274486247;1730.23869497422;1749.0729913146054;1763.6031892824012;1766.0728117738163;1809.4390738870993;67670.66164669146;70248.2975170252;70541;70678.47839487769;71719.64140179318;9692.757681057888;9700.175485083846;9947.253955953332;9964.25268104895;10547.683569492927;13581.592552223448;13585.913126949821;13593.184408935496;13594.45622175102;13603.591892243248;7001.299870012958;7095.538789978635;7102.68037938294;7148.106486689164;7150.96424517874;6611;6644.103046088813;6765.188177418741;6786.830329241809;6850.4862135340045;4155.8961025974595;4179.456670632859;4254.595813397722;4376.059147283349;4376.14665140301;1727.9568010799578;1796.6316905034437;1815.0924537731134;1820.681380758362;1821.6720990221888;821.3059964330131;856.4732689395977;876.2332958661171;906.6962567539816;938.1931538876561;16244.269007894673;16244.75632865508;16398.918005409898;16694.4156954506;17532.824671753373;765.5406755946499;844.3962566764793;847.584683505078;871.3595507302127;886.9312478463436;8934.73195804127;8993.235574976201;9642.276829237835;9680.612775489042;9820.4107753535;354850;357206;378671;379180;379683;72950.63524682343;75013;76282.23717762751;78795.60602196952;79035.60482197667;830.1325115254574;848.4951453885052;848.7114381110453;849.7705619482829;850.3069997951774;14359.199956008479;14740.631484212981;14882;15008.324625392102;15259.618509537351;35405.468917965736;35570;36144.638553614124;36351;36390;46519.767401162775;49794;50659.74670126626;50872.74563627158;53172;7322.853542929218;7562.508436951801;7772.106207786177;7850.0972388173805;7918.168592297726;10886.727831804268;12120.818187727014;12140.939295303468;12178.817317740419;12293.262404255416;10060.647877324258;10180;10676.199285053497;10702.678919632424;10753.731156721145;10394.324368915995;10605.363678179334;10626.946865265934;10709.410982396043;10764.62323818694;10155.54300056514;10565.52455139536;10588.629397971034;10781.514831832743;10999.670009899715;7499.812504687427;7725.575093369918;7748.496347737379;7863.882041769263;7942.046954365514;10376.429296388771;10407.427591482541;10509.737256568647;10537.104346130665;10934.289271197347 14:01:33 INFO - PROCESS | 3380 | |3;mootools.html;1240.3302216802927;1359.9116057456265;1397.6994946086593;1466.6113479927822;1699.3202718912432;7117.7508787192455;7372.668229929653;7472.364848987836;7709.961450192741;7726.072871255443;7646.96176519118;7758.922410775905;7762.340201082915;7765.611719414035;7767.6116194190345;2189.9890500547513;2201.2295696506176;2213.0262684418885;2214.8560343577697;2216.8780717060554;2144.2280778919653;2178.0307763045453;2207.547452772178;2210.3258506155616;2211.1708109458955;2142.678598210265;2165.361218440564;2165.4802847316687;2167.707359506462;2168.533765240473;2098.569793192392;2100;2103.579284143162;2103.863248888825;2104.5790841831695;2097.5699981503753;2130.041481333406;2133.0721136305756;2137.5297434564372;2139.689744986968;7559.130699969464;7574.35617972473;7710.922890771077;7714.228577142297;7715.344195743369;4329.631981281595;4449.332600109977;4451.532589078132;4459.487158976727;4469.508354081048;2742.067696983035;2869.0962346860674;2928.4728748825205;2938.7795915306224;2940.1326608650284;913.7898283394857;932.1657116880422;949.4635530925005;950.7242899559119;954.8519979403134;10520.631777887813;10610.840837387444;10613.204009699226;10639.042486176204;10659.573617055308;4046.615571520701;4084.3669231268605;4166;4186.225548273579;4216.7680777557525;8339.416240863082;8418.074011858691;8419.07390187079;8427.452215605967;8431.536265505456;4465.620422264079;4470.798814053375;4476.529964353696;4477.440319960005;4478.820847166076;3670.50448189491;4049.453323801249;4082.1631565528996;4085.4076158956786;4209.116085622054;3312.205070783043;3331.6335203127637;3408.50576666382;3459.290845376692;3475.374432602105;1013.7566983923805;1016.6594190945968;1017.8218811707922;1042.9061384475433;1044.0446991003148;771.5949126708523;791.7268542352879;792.1959211400433;795.7493389582263;814.6171299489231;4863.465018847924;4893.657443978887;4966.950330496648;5078.390593128848;5254.632175747737;414.836139724807;417.926862799009;418.2346306259598;420.2456590420203;431.105456178431;3120.5943227380294;3163.620365556148;3197.728193103566;3308;3426.3489936911906;9056.954715226382;9690.37012594179;9776.413415195111;9786.706398808046;9822.066903644143;9732.610695572239;9753.317267791328;9755.658551950648;9757.756056098655;9761.755956101155;6966.756163534354;7187.245339239409;7220.566765994057;7326.523775954546;7340.119185697644;5130.948690513047;5132.307138536399;5152.227165925141;5186.922196167136;5276.920846187233;8611.31109511225;8721.607527661143;8730.956345218234;8811.206991370807;8823.60293786794;8616.310695144248;8732.170443807829;8835.249003834746;8839.425437346552;8884.511351875708;6119.388061193845;6580.078788969452;6877.415419689382;7001.829432875825;7006.614636195059;7325.340719335285;7489.9625501874325;7551.886721699069;7557.470977031775;7564.167941526538;6544.901826472702;6570.375814297634;6607.398967562786;6769.830754231184;6805.863882722417;6531.412172904462;6531.575447595891;6584.637844918576;6592.76925307612;6654.168228971379;5947.3457919627945;6059.242594675666;6067.817965461043;6077.361877003028;6078.665673388006;4499;4580.839670611513;4629.282461218517;4695.5304469552775;4710.646701497333;4316.330968699856;4410.911781764411;4460.30865215892;4553.499115097403;4625.352450656844 14:01:33 INFO - PROCESS | 3380 | |4;prototype.html;306.7377392329558;308.4447993611499;309.1113049981304;314.5878898642778;314.8945103390364;4788.0663270662235;4803.615710743141;4822.999999999995;4832.323474713543;4841.273808928662;4799.256115302133;4801.759912004403;4810.278458231267;4821.903561928768;4828.661993660445;3564.982175089121;3692.7230457715646;3722.4788529605876;3736.0099573613015;3753.9436908446396;3659.2864391443677;3812.3519001769628;3822.10180607557;3835.1562656215588;3839.347310957144;3761.37937240355;3763.6800871925784;3770.6417890300377;3778.886633401002;3782;3543.309054734302;3745.9438108428394;3788.1287303920117;3791.8862434126745;3807.8667246646373;3299.3236386540943;3299.835008249578;3308.602967643874;3311.2053107254087;3340.615829179627;4666.53334666534;4674.158651442739;4692.483826779052;4699.553542413465;4701.130290896195;4291.141771645684;4296.0978194578865;4305.3326734355915;4306;4308.246056940023;4876.21980483121;4895.730734809584;4959.603231741452;4975.179095449246;4982.932083185474;3551.0057183988265;3555.924125631336;3557.4130268505664;3559.483874838134;3570.517980072683;5210.244514545369;5224.294720212761;5233.9738301308635;5243.187305967581;5268.604854635918;3520.331137083946;3619.4027985382645;3648.85404583819;3652.196516766307;3654.3422184007136;3685.7235707322056;3694.649008344257;3704.7406681532034;3704.7777133372083;3716.955674379081;4214.726042807208;4215.156968606291;4215.494140703136;4235.898666346772;4243.957560424418;4835.564799168022;4955.72743499111;4958.281049247839;4977.328060711758;5003.399592048978;1266.3288457117558;1268.4989429175423;1275.915471848921;1279.9232046077266;1289.3810970733912;792.3502727763295;812.6546217857505;822.3462347433805;824.8350329934037;832.309183377795;4206.621404073648;4290.914181716411;4373.781310934441;4443.844465443759;4462.576055274743;5086.72023038729;5130.692158470429;5170.836561773646;5187.377514698261;5191.9480805192225;4450.287953927356;4463.375127482155;4464.464264288306;4467.285234362552;4468.530804265505;2593.260920637609;2689.3411114276737;2690.5829596412586;2702.5135475614184;2737.890484380642;4735.905281894343;4740.976295118502;4741.478437371887;4747.596454301423;4748.572628463455;5119.718519843752;5198.8960220796125;5232.215167724872;5237.957196693293;5275.973620131875;4721.811127554859;4741.407324084489;4767.283777839974;4767.308740232716;4785.377900872933;5080.847574572768;5089.847304580869;5133.974330128325;5138.254953031864;5143.5627971622835;4871.683340582851;5003.574696150868;5013.849584512471;5017.623678224075;5029.195328747529;4756.835639783821;4763.452202996561;4775.140474714584;4775.5463230993;4782.7847746850775;3749.3438648235906;3764.416515440111;3791.962080379161;3793.1275806565195;3809.29528037314;5118.129917914038;5132.230165475208;5137.8201762938115;5147.459516750687;5159.767810448464;4733.668643194943;4924.891899322623;4942;4945.8021679132435;4952.182889823139;4918;4937.975310123426;4956.900861982812;4970.453250142554;4971.502849715;4857.878553036202;4859.805607775649;4865.172920603577;4899.755012249302;4911.312416261798;4733.763311834326;4823.758812059313;4931.186354251508;5046.116929537389;5092.872678183075;4867.464578896389;4871.537203965618;4873.342098816614;4879.4629691647015;4898.314236007033 14:01:33 INFO - PROCESS | 3380 | |5;yui.html;549.5658429840427;582.8688545077357;644.7066584703961;651.8337823854918;657.3853447027027;11988.280703157816;12681.682957926056;12699.301538415384;13007.219566825997;13013.60959171224;13183.143095698773;13755.79366309506;13888.513902013432;14063.718725625482;14087.92956035221;733.5158795195172;750.3584435307815;752.059925093633;752.1200195770961;752.4394326226968;600.2976517474565;725.7351066860584;751.1662055118813;751.177460680554;755.9470837041409;787.8857565652977;788.5505262000662;788.9250521200477;789.5105034878354;789.6288744290174;786.5831109511939;787.330768846476;788.4559653838891;788.4914230321468;788.9723859664941;460.3026414981306;555.886043361114;571.1090698510337;571.4114462104039;574.7097715653568;12171;12177.33024683642;12185.32980686062;12199.39003049844;12200.084993625514;11183.552657893675;11888.227265227733;11997.880021199764;12146.392680365947;12437.689057773538;10181.933772729328;10208.693739187836;10219.233557483218;10413.5834566618;10449.425281609509;3287.3589650018257;3295.983520082408;3298.6041674998914;3339.8664053437833;3442.277121804424;59835.40164598342;60308;60427.69786151085;60551;61238.38761612371;8608.268297194683;8846.424982376126;8964.417312874642;9065.728028159167;9117.635294588143;16849.41027064047;17000.234989425506;17049.659006819795;17070.146492675318;17339.739903901453;6388.425041746173;6494.415502604788;6553.41019308255;6601.900971485432;6608.008798680236;3460.8615655374006;3594.155373487228;3607.6211997740384;3608.1160115771804;3640.672339489459;2829.0522674904137;2955.2907302247736;2973.435047340998;2985.3730716549335;2991.1475229559906;489.20259976238503;489.7918384686494;490.8183971930337;496.82859413502285;503.54680787291;477.5821156488073;498.1922035386404;534.5402953460022;553.1757681055279;560.5403569073321;8018.438709290293;8119.837603247902;8330.958345208235;8347.375243032955;8706.564671766386;561.2367180634334;566.4250785452768;575.2694078520256;579.3226381461659;595.946364827159;3848.114933565296;3930.6265904739575;3962.4650672159464;4090.181963607231;4095.3447448408706;70896.64551677312;72276;73437;96808;100199.49900250453;44777.77611111924;44817;45281.77359113183;59509.404905951254;77332.61333693408;61000;67620.32379676239;69036.6548167266;70288.64855675689;71517.6424117876;7949.483283586548;8099;8154.592270386338;8492.108328625653;8590;41541.37687934623;41958.580414195465;41997.1600567993;42294.78852605717;43058.78470607627;55906.720466397404;60750.924907508896;61849.38150618436;63864;64107.67946160239;10211.97880211973;10583.682489525327;10658.467076646291;10839.349639021684;11296.6046188383;11968.222065565711;12349.135560510678;12491.812622810847;12806.295653739135;12960.222386656831;11372.147088968195;11485.138614604106;11773.941130294294;11911.940440297743;12466.937665311616;11605.419729013684;11666.125040622157;11806.940965295118;12187.451564679433;12562.685932851751;10139.839214825584;10489;10765.89234107649;10775.245732798943;11078.279911805706;9490.24104494365;9755.414675119515;9898.50507474609;9945.602175912882;9993.650222242186;9347.813043739223;10245.710254652387;10305.381677099398;10470.162387008868;10489.318194317346 14:01:33 INFO - PROCESS | 3380 | __end_tp_report 14:01:33 INFO - PROCESS | 3380 | __start_cc_report 14:01:33 INFO - PROCESS | 3380 | _x_x_mozilla_cycle_collect,982 14:01:33 INFO - PROCESS | 3380 | __end_cc_report 14:01:33 INFO - PROCESS | 3380 | __startTimestamp1472504493968__endTimestamp 14:01:33 INFO - PROCESS | 3380 | 14:01:33 INFO - PROCESS | 3380 | ------- Summary: start ------- 14:01:33 INFO - PROCESS | 3380 | Number of tests: 6 14:01:33 INFO - PROCESS | 3380 | 14:01:33 INFO - PROCESS | 3380 | [#0] dojo.html Cycles:165 Average:4662.11 Median:4743.93 stddev:476.28 (10.0%) stddev-sans-first:447.59 14:01:33 INFO - PROCESS | 3380 | Values: 2535.9 2591.6 2604.4 2609.9 2630.4 4590.5 4651.4 4670.8 4728.5 4810.3 4680.6 4693.2 4726.6 4736.2 4810.8 4276.9 4314.5 4446.1 4450.0 4474.4 4363.8 4395.8 4441.5 4454.0 4500.4 4222.8 4305.9 4333.4 4381.5 4392.1 4286.0 4289.6 4306.0 4404.9 4428.5 4300.4 4308.9 4313.3 4318.5 4386.1 4635.0 4639.0 4668.2 4703.5 4790.5 5084.0 5084.7 5085.4 5091.5 5119.5 5103.6 5106.6 5137.5 5137.8 5155.6 4627.5 4654.7 4704.1 4706.0 4725.6 5064.5 5087.8 5088.9 5129.5 5148.6 4888.0 4922.1 4924.9 4925.3 4985.8 4869.9 4931.8 4970.7 5000.6 5008.1 4972.5 4980.6 4983.1 4986.4 5003.1 4966.5 4975.4 4985.2 4989.0 5033.4 4298.7 4349.3 4350.5 4408.2 4410.2 3820.8 3821.5 3854.6 3873.4 3881.8 4364.7 4369.2 4373.4 4378.4 4412.3 4958.0 5082.3 5118.8 5135.0 5186.1 4364.8 4384.3 4421.2 4437.8 4439.7 4677.6 4693.7 4693.8 4698.2 4752.5 4561.2 4651.0 4668.5 4743.9 4770.5 5041.5 5058.1 5067.8 5133.5 5141.4 4660.1 4679.0 4688.3 4691.1 4750.7 4820.8 4878.8 4905.7 4967.9 5028.8 4979.9 5006.1 5010.0 5043.8 5070.0 4833.3 4834.6 4835.1 4853.9 4933.5 4726.6 4825.4 4838.8 4877.6 4893.1 4832.8 4849.7 4852.1 4875.0 4879.7 4931.8 4954.0 4955.2 4964.4 5013.7 4644.3 4685.0 4700.3 4806.8 4874.6 14:01:33 INFO - PROCESS | 3380 | 14:01:33 INFO - PROCESS | 3380 | [#1] ext.html Cycles:180 Average:47005.96 Median:34814.65 stddev:84819.09 (243.6%) stddev-sans-first:84985.37 14:01:33 INFO - PROCESS | 3380 | Values: 570.1 570.7 573.8 579.2 581.6 27238.3 29730.1 38723.6 39586.0 39773.0 39280.8 39510.8 39523.4 39527.2 39650.4 7662.6 7786.4 7803.8 7806.1 7806.3 7256.7 9810.5 10078.3 10079.7 10342.9 9907.4 9947.3 9986.3 9991.5 9998.5 7247.2 10042.7 10076.1 10113.5 10125.9 9493.5 9880.0 9946.4 10266.7 10276.4 36726.4 36939.6 37037.8 37045.8 37068.3 2632.1 2718.8 2732.4 2743.3 2748.6 27855.6 27945.9 27971.7 28022.4 28873.4 3292.5 3357.4 3379.8 3411.9 3449.6 253446.0 254234.0 255896.0 256105.0 256123.7 51027.2 51347.5 51379.0 51396.0 51413.7 32233.7 32867.3 33015.7 54567.5 54669.7 13326.5 13475.5 13519.9 13520.9 13524.3 9766.1 10505.8 10509.6 10520.6 11016.6 17103.7 17210.0 17431.8 17534.9 17893.6 6459.9 6475.6 6532.7 6600.6 6690.3 775.4 841.5 956.9 963.7 986.6 25772.7 26064.5 26476.5 26920.6 27280.7 937.7 962.6 973.3 998.8 1026.1 13938.6 14243.4 14392.4 14506.3 14558.6 367971.0 371971.0 372666.0 372904.0 373260.0 47742.8 47921.5 47944.5 48150.8 48324.5 1031.6 1110.5 1167.8 1202.3 1289.1 24455.9 27967.0 28361.9 28822.3 29456.3 41449.4 42298.2 42320.6 42360.2 42387.6 326799.0 330298.0 330474.0 331536.0 332428.0 36105.5 37155.0 37902.8 39264.0 40025.2 40390.6 40509.4 40798.4 41036.0 41387.2 34441.7 34504.1 34663.8 34689.5 34851.8 34868.5 35152.5 35261.8 35323.5 35486.8 34615.3 34680.7 34777.5 35032.8 36101.5 29973.7 31852.5 32423.7 32477.8 32572.7 23172.8 23811.2 23859.8 23871.2 23937.3 14:01:33 INFO - PROCESS | 3380 | 14:01:33 INFO - PROCESS | 3380 | [#2] jquery.html Cycles:180 Average:23442.85 Median:4482.05 stddev:61270.17 (1367.0%) stddev-sans-first:61417.50 14:01:33 INFO - PROCESS | 3380 | Values: 341.3 368.3 370.1 372.9 388.1 12452.1 16016.2 16469.3 16895.3 17974.7 14426.9 14664.6 14848.0 15137.9 15247.7 4588.0 4977.4 5025.3 5160.8 5184.9 5057.4 5139.2 5150.5 5152.8 5153.7 5114.1 5119.4 5119.9 5279.7 5509.3 5525.2 5531.6 5539.7 5563.6 5566.2 5238.4 5351.6 5399.2 5470.3 5471.6 12325.3 12352.9 12538.9 12561.9 20445.3 1759.7 1794.7 1857.6 2026.4 2311.5 8885.8 9443.6 9517.6 9786.9 9794.5 1730.2 1749.1 1763.6 1766.1 1809.4 67670.7 70248.3 70541.0 70678.5 71719.6 9692.8 9700.2 9947.3 9964.3 10547.7 13581.6 13585.9 13593.2 13594.5 13603.6 7001.3 7095.5 7102.7 7148.1 7151.0 6611.0 6644.1 6765.2 6786.8 6850.5 4155.9 4179.5 4254.6 4376.1 4376.1 1728.0 1796.6 1815.1 1820.7 1821.7 821.3 856.5 876.2 906.7 938.2 16244.3 16244.8 16398.9 16694.4 17532.8 765.5 844.4 847.6 871.4 886.9 8934.7 8993.2 9642.3 9680.6 9820.4 354850.0 357206.0 378671.0 379180.0 379683.0 72950.6 75013.0 76282.2 78795.6 79035.6 830.1 848.5 848.7 849.8 850.3 14359.2 14740.6 14882.0 15008.3 15259.6 35405.5 35570.0 36144.6 36351.0 36390.0 46519.8 49794.0 50659.7 50872.7 53172.0 7322.9 7562.5 7772.1 7850.1 7918.2 10886.7 12120.8 12140.9 12178.8 12293.3 10060.6 10180.0 10676.2 10702.7 10753.7 10394.3 10605.4 10626.9 10709.4 10764.6 10155.5 10565.5 10588.6 10781.5 10999.7 7499.8 7725.6 7748.5 7863.9 7942.0 10376.4 10407.4 10509.7 10537.1 10934.3 14:01:33 INFO - PROCESS | 3380 | 14:01:33 INFO - PROCESS | 3380 | [#3] mootools.html Cycles:180 Average:5021.51 Median:4878.56 stddev:2864.84 (58.7%) stddev-sans-first:2858.78 14:01:33 INFO - PROCESS | 3380 | Values: 1240.3 1359.9 1397.7 1466.6 1699.3 7117.8 7372.7 7472.4 7710.0 7726.1 7647.0 7758.9 7762.3 7765.6 7767.6 2190.0 2201.2 2213.0 2214.9 2216.9 2144.2 2178.0 2207.5 2210.3 2211.2 2142.7 2165.4 2165.5 2167.7 2168.5 2098.6 2100.0 2103.6 2103.9 2104.6 2097.6 2130.0 2133.1 2137.5 2139.7 7559.1 7574.4 7710.9 7714.2 7715.3 4329.6 4449.3 4451.5 4459.5 4469.5 2742.1 2869.1 2928.5 2938.8 2940.1 913.8 932.2 949.5 950.7 954.9 10520.6 10610.8 10613.2 10639.0 10659.6 4046.6 4084.4 4166.0 4186.2 4216.8 8339.4 8418.1 8419.1 8427.5 8431.5 4465.6 4470.8 4476.5 4477.4 4478.8 3670.5 4049.5 4082.2 4085.4 4209.1 3312.2 3331.6 3408.5 3459.3 3475.4 1013.8 1016.7 1017.8 1042.9 1044.0 771.6 791.7 792.2 795.7 814.6 4863.5 4893.7 4967.0 5078.4 5254.6 414.8 417.9 418.2 420.2 431.1 3120.6 3163.6 3197.7 3308.0 3426.3 9057.0 9690.4 9776.4 9786.7 9822.1 9732.6 9753.3 9755.7 9757.8 9761.8 6966.8 7187.2 7220.6 7326.5 7340.1 5130.9 5132.3 5152.2 5186.9 5276.9 8611.3 8721.6 8731.0 8811.2 8823.6 8616.3 8732.2 8835.2 8839.4 8884.5 6119.4 6580.1 6877.4 7001.8 7006.6 7325.3 7490.0 7551.9 7557.5 7564.2 6544.9 6570.4 6607.4 6769.8 6805.9 6531.4 6531.6 6584.6 6592.8 6654.2 5947.3 6059.2 6067.8 6077.4 6078.7 4499.0 4580.8 4629.3 4695.5 4710.6 4316.3 4410.9 4460.3 4553.5 4625.4 14:01:33 INFO - PROCESS | 3380 | 14:01:33 INFO - PROCESS | 3380 | [#4] prototype.html Cycles:180 Average:4145.79 Median:4741.44 stddev:1195.39 (25.2%) stddev-sans-first:1163.49 14:01:33 INFO - PROCESS | 3380 | Values: 306.7 308.4 309.1 314.6 314.9 4788.1 4803.6 4823.0 4832.3 4841.3 4799.3 4801.8 4810.3 4821.9 4828.7 3565.0 3692.7 3722.5 3736.0 3753.9 3659.3 3812.4 3822.1 3835.2 3839.3 3761.4 3763.7 3770.6 3778.9 3782.0 3543.3 3745.9 3788.1 3791.9 3807.9 3299.3 3299.8 3308.6 3311.2 3340.6 4666.5 4674.2 4692.5 4699.6 4701.1 4291.1 4296.1 4305.3 4306.0 4308.2 4876.2 4895.7 4959.6 4975.2 4982.9 3551.0 3555.9 3557.4 3559.5 3570.5 5210.2 5224.3 5234.0 5243.2 5268.6 3520.3 3619.4 3648.9 3652.2 3654.3 3685.7 3694.6 3704.7 3704.8 3717.0 4214.7 4215.2 4215.5 4235.9 4244.0 4835.6 4955.7 4958.3 4977.3 5003.4 1266.3 1268.5 1275.9 1279.9 1289.4 792.4 812.7 822.3 824.8 832.3 4206.6 4290.9 4373.8 4443.8 4462.6 5086.7 5130.7 5170.8 5187.4 5191.9 4450.3 4463.4 4464.5 4467.3 4468.5 2593.3 2689.3 2690.6 2702.5 2737.9 4735.9 4741.0 4741.5 4747.6 4748.6 5119.7 5198.9 5232.2 5238.0 5276.0 4721.8 4741.4 4767.3 4767.3 4785.4 5080.8 5089.8 5134.0 5138.3 5143.6 4871.7 5003.6 5013.8 5017.6 5029.2 4756.8 4763.5 4775.1 4775.5 4782.8 3749.3 3764.4 3792.0 3793.1 3809.3 5118.1 5132.2 5137.8 5147.5 5159.8 4733.7 4924.9 4942.0 4945.8 4952.2 4918.0 4938.0 4956.9 4970.5 4971.5 4857.9 4859.8 4865.2 4899.8 4911.3 4733.8 4823.8 4931.2 5046.1 5092.9 4867.5 4871.5 4873.3 4879.5 4898.3 14:01:33 INFO - PROCESS | 3380 | 14:01:33 INFO - PROCESS | 3380 | [#5] yui.html Cycles:180 Average:16003.98 Median:489.50 stddev:21760.22 (4445.4%) stddev-sans-first:21790.32 14:01:33 INFO - PROCESS | 3380 | Values: 549.6 582.9 644.7 651.8 657.4 11988.3 12681.7 12699.3 13007.2 13013.6 13183.1 13755.8 13888.5 14063.7 14087.9 733.5 750.4 752.1 752.1 752.4 600.3 725.7 751.2 751.2 755.9 787.9 788.6 788.9 789.5 789.6 786.6 787.3 788.5 788.5 789.0 460.3 555.9 571.1 571.4 574.7 12171.0 12177.3 12185.3 12199.4 12200.1 11183.6 11888.2 11997.9 12146.4 12437.7 10181.9 10208.7 10219.2 10413.6 10449.4 3287.4 3296.0 3298.6 3339.9 3442.3 59835.4 60308.0 60427.7 60551.0 61238.4 8608.3 8846.4 8964.4 9065.7 9117.6 16849.4 17000.2 17049.7 17070.1 17339.7 6388.4 6494.4 6553.4 6601.9 6608.0 3460.9 3594.2 3607.6 3608.1 3640.7 2829.1 2955.3 2973.4 2985.4 2991.1 489.2 489.8 490.8 496.8 503.5 477.6 498.2 534.5 553.2 560.5 8018.4 8119.8 8331.0 8347.4 8706.6 561.2 566.4 575.3 579.3 595.9 3848.1 3930.6 3962.5 4090.2 4095.3 70896.6 72276.0 73437.0 96808.0 100199.5 44777.8 44817.0 45281.8 59509.4 77332.6 61000.0 67620.3 69036.7 70288.6 71517.6 7949.5 8099.0 8154.6 8492.1 8590.0 41541.4 41958.6 41997.2 42294.8 43058.8 55906.7 60750.9 61849.4 63864.0 64107.7 10212.0 10583.7 10658.5 10839.3 11296.6 11968.2 12349.1 12491.8 12806.3 12960.2 11372.1 11485.1 11773.9 11911.9 12466.9 11605.4 11666.1 11806.9 12187.5 12562.7 10139.8 10489.0 10765.9 10775.2 11078.3 9490.2 9755.4 9898.5 9945.6 9993.7 9347.8 10245.7 10305.4 10470.2 10489.3 14:01:33 INFO - PROCESS | 3380 | -------- Summary: end -------- 14:01:33 INFO - PROCESS | 3380 | 14:01:34 INFO - TEST-INFO | 3380: exit 0 14:01:34 INFO - TEST-OK | dromaeo_css | took 1122857ms 14:01:34 INFO - TEST-START | kraken 14:01:34 INFO - operating with platform_type : linux_ 14:01:34 INFO - Initialising browser for kraken test... 14:01:34 INFO - TEST-INFO | started process 3684 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm_PVyA/profile http://localhost:37057/getInfo.html) 14:01:39 INFO - PROCESS | 3684 | __metrics Screen width/height:1600/1200 14:01:39 INFO - PROCESS | 3684 | colorDepth:24 14:01:39 INFO - PROCESS | 3684 | Browser inner width/height: 1024/697 14:01:39 INFO - PROCESS | 3684 | __metrics 14:01:40 INFO - PROCESS | 3684 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:01:40 INFO - PROCESS | 3684 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:01:40 INFO - PROCESS | 3684 | console.error: PushService: 14:01:40 INFO - PROCESS | 3684 | stateChangeProcessEnqueue: Error transitioning state 14:01:40 INFO - PROCESS | 3684 | UnknownError 14:01:41 INFO - TEST-INFO | 3684: exit 0 14:01:41 INFO - Browser initialized. 14:01:41 INFO - Running cycle 1/1 for kraken test... 14:01:41 INFO - TEST-INFO | started process 3767 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm_PVyA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:01:53 INFO - PROCESS | 3767 | RSS: Main: 181727232 14:01:53 INFO - PROCESS | 3767 | 14:01:56 INFO - PROCESS | 3767 | Cycle 1(1): loaded http://localhost:37057/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37057/tests/kraken/driver.html?testName=audio-beat-detection) 14:01:57 INFO - PROCESS | 3767 | RSS: Main: 235122688 14:01:57 INFO - PROCESS | 3767 | 14:02:00 INFO - PROCESS | 3767 | Cycle 1(1): loaded http://localhost:37057/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37057/tests/kraken/driver.html?testName=audio-dft) 14:02:00 INFO - PROCESS | 3767 | RSS: Main: 226136064 14:02:00 INFO - PROCESS | 3767 | 14:02:03 INFO - PROCESS | 3767 | Cycle 1(1): loaded http://localhost:37057/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37057/tests/kraken/driver.html?testName=audio-fft) 14:02:04 INFO - PROCESS | 3767 | RSS: Main: 303161344 14:02:04 INFO - PROCESS | 3767 | 14:02:06 INFO - PROCESS | 3767 | Cycle 1(1): loaded http://localhost:37057/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37057/tests/kraken/driver.html?testName=audio-oscillator) 14:02:07 INFO - PROCESS | 3767 | RSS: Main: 214077440 14:02:07 INFO - PROCESS | 3767 | 14:02:09 INFO - PROCESS | 3767 | Cycle 1(1): loaded http://localhost:37057/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37057/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:02:10 INFO - PROCESS | 3767 | RSS: Main: 215220224 14:02:10 INFO - PROCESS | 3767 | 14:02:13 INFO - PROCESS | 3767 | Cycle 1(1): loaded http://localhost:37057/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37057/tests/kraken/driver.html?testName=imaging-darkroom) 14:02:13 INFO - PROCESS | 3767 | RSS: Main: 253132800 14:02:13 INFO - PROCESS | 3767 | 14:02:17 INFO - PROCESS | 3767 | Cycle 1(1): loaded http://localhost:37057/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37057/tests/kraken/driver.html?testName=imaging-desaturate) 14:02:17 INFO - PROCESS | 3767 | RSS: Main: 252284928 14:02:17 INFO - PROCESS | 3767 | 14:02:20 INFO - PROCESS | 3767 | Cycle 1(1): loaded http://localhost:37057/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37057/tests/kraken/driver.html?testName=json-parse-financial) 14:02:21 INFO - PROCESS | 3767 | RSS: Main: 252727296 14:02:21 INFO - PROCESS | 3767 | 14:02:23 INFO - PROCESS | 3767 | Cycle 1(1): loaded http://localhost:37057/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37057/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:02:23 INFO - PROCESS | 3767 | RSS: Main: 215646208 14:02:23 INFO - PROCESS | 3767 | 14:02:25 INFO - PROCESS | 3767 | Cycle 1(1): loaded http://localhost:37057/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37057/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:02:26 INFO - PROCESS | 3767 | RSS: Main: 223358976 14:02:26 INFO - PROCESS | 3767 | 14:02:28 INFO - PROCESS | 3767 | Cycle 1(1): loaded http://localhost:37057/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37057/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:02:29 INFO - PROCESS | 3767 | RSS: Main: 223141888 14:02:29 INFO - PROCESS | 3767 | 14:02:31 INFO - PROCESS | 3767 | Cycle 1(1): loaded http://localhost:37057/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37057/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:02:32 INFO - PROCESS | 3767 | RSS: Main: 223895552 14:02:32 INFO - PROCESS | 3767 | 14:02:35 INFO - PROCESS | 3767 | Cycle 1(1): loaded http://localhost:37057/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37057/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:02:36 INFO - PROCESS | 3767 | RSS: Main: 222236672 14:02:36 INFO - PROCESS | 3767 | 14:02:37 INFO - PROCESS | 3767 | Cycle 1(1): loaded http://localhost:37057/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37057/tests/kraken/driver.html?testName=ai-astar) 14:02:38 INFO - PROCESS | 3767 | RSS: Main: 273219584 14:02:38 INFO - PROCESS | 3767 | 14:02:38 INFO - PROCESS | 3767 | __start_tp_report 14:02:38 INFO - PROCESS | 3767 | _x_x_mozilla_page_load 14:02:38 INFO - PROCESS | 3767 | _x_x_mozilla_page_load_details 14:02:38 INFO - PROCESS | 3767 | |i|pagename|runs| 14:02:38 INFO - PROCESS | 3767 | |0;ai-astar;116;114;133;115;117;114;114;114;114;113 14:02:38 INFO - PROCESS | 3767 | |1;audio-beat-detection;155;122;147;186;125;148;143;123;175;120 14:02:38 INFO - PROCESS | 3767 | |2;audio-dft;162;162;161;164;161;161;163;161;161;163 14:02:38 INFO - PROCESS | 3767 | |3;audio-fft;76;74;75;158;78;76;75;75;159;77 14:02:38 INFO - PROCESS | 3767 | |4;audio-oscillator;84;85;143;84;84;86;142;84;83;134 14:02:38 INFO - PROCESS | 3767 | |5;imaging-gaussian-blur;117;117;117;117;118;118;117;117;117;117 14:02:38 INFO - PROCESS | 3767 | |6;imaging-darkroom;145;146;146;146;147;146;146;146;146;146 14:02:38 INFO - PROCESS | 3767 | |7;imaging-desaturate;95;94;94;95;95;95;94;95;94;95 14:02:38 INFO - PROCESS | 3767 | |8;json-parse-financial;63;64;64;64;63;64;65;64;64;66 14:02:38 INFO - PROCESS | 3767 | |9;json-stringify-tinderbox;66;66;66;65;66;65;65;66;66;67 14:02:38 INFO - PROCESS | 3767 | |10;stanford-crypto-aes;90;91;81;85;82;81;81;81;81;81 14:02:38 INFO - PROCESS | 3767 | |11;stanford-crypto-ccm;133;139;131;147;133;133;145;143;168;143 14:02:38 INFO - PROCESS | 3767 | |12;stanford-crypto-pbkdf2;175;173;174;172;178;177;171;170;171;171 14:02:38 INFO - PROCESS | 3767 | |13;stanford-crypto-sha256-iterative;71;68;70;67;68;69;69;69;68;71 14:02:38 INFO - PROCESS | 3767 | __end_tp_report 14:02:38 INFO - PROCESS | 3767 | __start_cc_report 14:02:38 INFO - PROCESS | 3767 | _x_x_mozilla_cycle_collect,1989 14:02:38 INFO - PROCESS | 3767 | __end_cc_report 14:02:38 INFO - PROCESS | 3767 | __startTimestamp1472504558113__endTimestamp 14:02:38 INFO - PROCESS | 3767 | 14:02:38 INFO - PROCESS | 3767 | ------- Summary: start ------- 14:02:38 INFO - PROCESS | 3767 | Number of tests: 14 14:02:38 INFO - PROCESS | 3767 | 14:02:38 INFO - PROCESS | 3767 | [#0] ai-astar Cycles:10 Average:116.40 Median:114.50 stddev:5.95 (5.2%) stddev-sans-first:6.31 14:02:38 INFO - PROCESS | 3767 | Values: 116.0 114.0 133.0 115.0 117.0 114.0 114.0 114.0 114.0 113.0 14:02:38 INFO - PROCESS | 3767 | 14:02:38 INFO - PROCESS | 3767 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:147.50 stddev:22.93 (15.5%) stddev-sans-first:24.00 14:02:38 INFO - PROCESS | 3767 | Values: 155.0 122.0 147.0 186.0 125.0 148.0 143.0 123.0 175.0 120.0 14:02:38 INFO - PROCESS | 3767 | 14:02:38 INFO - PROCESS | 3767 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 14:02:38 INFO - PROCESS | 3767 | Values: 162.0 162.0 161.0 164.0 161.0 161.0 163.0 161.0 161.0 163.0 14:02:38 INFO - PROCESS | 3767 | 14:02:38 INFO - PROCESS | 3767 | [#3] audio-fft Cycles:10 Average:92.30 Median:75.50 stddev:34.91 (46.2%) stddev-sans-first:36.53 14:02:38 INFO - PROCESS | 3767 | Values: 76.0 74.0 75.0 158.0 78.0 76.0 75.0 75.0 159.0 77.0 14:02:38 INFO - PROCESS | 3767 | 14:02:38 INFO - PROCESS | 3767 | [#4] audio-oscillator Cycles:10 Average:100.90 Median:84.00 stddev:26.86 (32.0%) stddev-sans-first:27.79 14:02:38 INFO - PROCESS | 3767 | Values: 84.0 85.0 143.0 84.0 84.0 86.0 142.0 84.0 83.0 134.0 14:02:38 INFO - PROCESS | 3767 | 14:02:38 INFO - PROCESS | 3767 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:02:38 INFO - PROCESS | 3767 | Values: 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 14:02:38 INFO - PROCESS | 3767 | 14:02:38 INFO - PROCESS | 3767 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 14:02:38 INFO - PROCESS | 3767 | Values: 145.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 14:02:38 INFO - PROCESS | 3767 | 14:02:38 INFO - PROCESS | 3767 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:02:38 INFO - PROCESS | 3767 | Values: 95.0 94.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 14:02:38 INFO - PROCESS | 3767 | 14:02:38 INFO - PROCESS | 3767 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:0.88 (1.4%) stddev-sans-first:0.83 14:02:38 INFO - PROCESS | 3767 | Values: 63.0 64.0 64.0 64.0 63.0 64.0 65.0 64.0 64.0 66.0 14:02:38 INFO - PROCESS | 3767 | 14:02:38 INFO - PROCESS | 3767 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 14:02:38 INFO - PROCESS | 3767 | Values: 66.0 66.0 66.0 65.0 66.0 65.0 65.0 66.0 66.0 67.0 14:02:38 INFO - PROCESS | 3767 | 14:02:38 INFO - PROCESS | 3767 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:81.50 stddev:3.95 (4.8%) stddev-sans-first:3.39 14:02:38 INFO - PROCESS | 3767 | Values: 90.0 91.0 81.0 85.0 82.0 81.0 81.0 81.0 81.0 81.0 14:02:38 INFO - PROCESS | 3767 | 14:02:38 INFO - PROCESS | 3767 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:143.00 stddev:10.97 (7.7%) stddev-sans-first:11.19 14:02:38 INFO - PROCESS | 3767 | Values: 133.0 139.0 131.0 147.0 133.0 133.0 145.0 143.0 168.0 143.0 14:02:38 INFO - PROCESS | 3767 | 14:02:38 INFO - PROCESS | 3767 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:173.50 stddev:2.74 (1.6%) stddev-sans-first:2.83 14:02:38 INFO - PROCESS | 3767 | Values: 175.0 173.0 174.0 172.0 178.0 177.0 171.0 170.0 171.0 171.0 14:02:38 INFO - PROCESS | 3767 | 14:02:38 INFO - PROCESS | 3767 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.33 (1.9%) stddev-sans-first:1.20 14:02:38 INFO - PROCESS | 3767 | Values: 71.0 68.0 70.0 67.0 68.0 69.0 69.0 69.0 68.0 71.0 14:02:38 INFO - PROCESS | 3767 | -------- Summary: end -------- 14:02:38 INFO - PROCESS | 3767 | 14:02:39 INFO - TEST-INFO | 3767: exit 0 14:02:39 INFO - TEST-OK | kraken | took 64556ms 14:02:39 INFO - SUITE-END | took 1187s 14:02:39 INFO - Completed test suite (00:19:47) 14:02:39 INFO - javascript benchmark 14:02:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2535.93660158496, 2591.5594348960676, 2604.400987772812, 2609.869506524674, 2630.4344565918323, 4590.540945905412, 4651.4418269807675, 4670.76646167692, 4728.503507131753, 4810.278458231267, 4680.625549956012, 4693.155232058228, 4726.62187025038, 4736.218523943554, 4810.759462026894, 4276.935845962313, 4314.503832059322, 4446.088551846879, 4449.977750111245, 4474.395956545874, 4363.847265345714, 4395.758233297167, 4441.5336389679105, 4453.977730111361, 4500.392447019643, 4222.78886055696, 4305.935410968838, 4333.371661109121, 4381.474223093217, 4392.055708022758, 4285.9785701071605, 4289.571042895716, 4306.009617787895, 4404.933925991113, 4428.535003824616, 4300.35494675798, 4308.9353659695125, 4313.266744653416, 4318.546552611993, 4386.144701783153, 4635.0, 4639.0, 4668.229742092584, 4703.529647035303, 4790.473047964721, 5084.0, 5084.7457627118865, 5085.364329458817, 5091.541761241469, 5119.48805119485, 5103.642745007851, 5106.5659418949435, 5137.51193636604, 5137.768800403991, 5155.639105262633, 4627.537246275346, 4654.697444666086, 4704.129735998851, 4705.976470117627, 4725.5510726480925, 5064.518870707277, 5087.847364579068, 5088.898222035538, 5129.461406552258, 5148.588112950955, 4887.95112048882, 4922.089413458521, 4924.876878078005, 4925.335079764186, 4985.750712464363, 4869.853904382874, 4931.778069986859, 4970.676906001098, 5000.64995450315, 5008.12357837377, 4972.453030166679, 4980.626453016038, 4983.07813054586, 4986.376702912136, 5003.149464591028, 4966.528179822911, 4975.353204083446, 4985.177445721488, 4988.950110498921, 5033.446320904697, 4298.656107511391, 4349.347597860283, 4350.521442641307, 4408.228560001987, 4410.22821006329, 3820.8280627371837, 3821.522309711286, 3854.5759966403675, 3873.3802591585772, 3881.7865017423746, 4364.738115713068, 4369.235383807821, 4373.365861950063, 4378.408914796525, 4412.294032954712, 4958.0, 5082.33929589151, 5118.846434606968, 5134.974325128351, 5186.092433824066, 4364.781760911942, 4384.276594361894, 4421.182081314967, 4437.844675436344, 4439.711418757771, 4677.555632214934, 4693.671442998957, 4693.83571575, 4698.201305777958, 4752.477227504972, 4561.178987782231, 4651.0, 4668.486466488752, 4743.928841067387, 4770.451398089264, 5041.521055499722, 5058.1148299048255, 5067.797288108582, 5133.460986596503, 5141.357330333708, 4660.091282199938, 4678.976605116953, 4688.296755486705, 4691.085238378483, 4750.667453278237, 4820.783064762024, 4878.829240976549, 4905.681130726492, 4967.850964471072, 5028.773705183348, 4979.925301120558, 5006.098902197639, 5010.048090862724, 5043.773030213576, 5069.9746501267255, 4833.275008748716, 4834.613230941586, 4835.081334546425, 4853.927191092207, 4933.506649335038, 4726.645501587326, 4825.396825396825, 4838.806447742051, 4877.634177436636, 4893.09477746618, 4832.758362081811, 4849.733264670477, 4852.102361063215, 4875.0493653737185, 4879.682820616648, 4931.778069986787, 4953.959668469518, 4955.1823949048, 4964.35463389757, 5013.699178049329, 4644.303354496852, 4685.0, 4700.271457924027, 4806.7836947336755, 4874.610031197425], "value": 4631.92578476141, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.1277046119437, 570.7174948400537, 573.839324989003, 579.2093791973957, 581.621945735272, 27238.31904202396, 29730.108096757103, 38723.61276387232, 39586.0, 39773.0, 39280.80359598205, 39510.8024459878, 39523.40714889279, 39527.209455810866, 39650.40524392129, 7662.616869156548, 7786.416018798584, 7803.843923121534, 7806.102298235691, 7806.258405451473, 7256.6734496947765, 9810.509474526281, 10078.294519383646, 10079.748006299827, 10342.896571034305, 9907.356021858592, 9947.253955953296, 9986.300958932878, 9991.500424978758, 9998.45008524531, 7247.20280769115, 10042.69871903844, 10076.09315161639, 10113.544890479872, 10125.898741012606, 9493.477858717768, 9880.0, 9946.35348702332, 10266.7433314167, 10276.383416995004, 36726.449103263476, 36939.63060369389, 37037.814810925775, 37045.81477092624, 37068.25863482742, 2632.139442961232, 2718.836869787819, 2732.3715545424466, 2743.3004583831193, 2748.6426764520684, 27855.582166267523, 27945.86027069872, 27971.720282797116, 28022.439551208863, 28873.422531549462, 3292.506124081383, 3357.446021406465, 3379.7803142795888, 3411.8635254589785, 3449.586049674055, 253446.0, 254234.0, 255896.0, 256105.0, 256123.71938140376, 51027.23459148116, 51347.48652513502, 51379.0, 51396.0, 51413.74293128585, 32233.677663223538, 32867.34265314681, 33015.66984330174, 54567.45432545703, 54669.72665136649, 13326.466941322433, 13475.460981560824, 13519.864801351861, 13520.864791352158, 13524.256165910772, 9766.121049105615, 10505.789884202273, 10509.632162874263, 10520.631777887736, 11016.559337626566, 17103.74344384835, 17210.041690411275, 17431.825681743274, 17534.91232543829, 17893.552661183574, 6459.870802584016, 6475.579087359307, 6532.738690452424, 6600.636964966973, 6690.264070952191, 775.3758224629115, 841.4530555139208, 956.9377990430617, 963.677168148678, 986.6497393425374, 25772.742272577034, 26064.478710426065, 26476.47047059048, 26920.59619105715, 27280.72719272782, 937.6952490440634, 962.5860879821744, 973.3235401395962, 998.825205589019, 1026.10728666061, 13938.58184254474, 14243.430262789372, 14392.35234414454, 14506.347214375379, 14558.636034099232, 367971.0, 371971.0, 372666.0, 372904.0, 373260.0, 47742.76128619404, 47921.5207847924, 47944.520554794704, 48150.759246203546, 48324.51675483271, 1031.6234574380296, 1110.5335758981248, 1167.830664553652, 1202.2666173634077, 1289.1105137455127, 24455.877720611283, 27967.0, 28361.858190708914, 28822.279443014093, 29456.263593410335, 41449.37825932553, 42298.1540369197, 42320.57679423167, 42360.15279694327, 42387.57612423836, 326799.0, 330298.0, 330474.0, 331536.0, 332428.0, 36105.458418124275, 37155.0, 37902.8104859474, 39264.0, 40025.1994960105, 40390.59609403869, 40509.39235911405, 40798.38802417907, 41036.0, 41387.1722565553, 34441.65558344385, 34504.13739656529, 34663.826680866434, 34689.479657805656, 34851.825740871136, 34868.47697284492, 35152.47271290984, 35261.82369088138, 35323.470147947286, 35486.82256588701, 34615.30769384649, 34680.65319346774, 34777.47833782546, 35032.82483587566, 36101.458478122324, 29973.700262997092, 31852.5222121673, 32423.675763242067, 32477.83761081274, 32572.674273256966, 23172.768272317735, 23811.166609168595, 23859.761402386448, 23871.164509242095, 23937.281881543582], "value": 17558.232866542232, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.34291488883895, 368.28552607940594, 370.0563562914568, 372.92541491701667, 388.1247786242024, 12452.128351015432, 16016.199190040496, 16469.341226350945, 16895.324187032536, 17974.730379044326, 14426.855731442682, 14664.560063198094, 14848.0, 15137.924310378432, 15247.695046099072, 4587.954120458786, 4977.427595826481, 5025.252770992884, 5160.819371322004, 5184.922226166611, 5057.418396884369, 5139.15203991341, 5150.459201783815, 5152.819651312205, 5153.716545589991, 5114.079465696173, 5119.360079990001, 5119.948800511985, 5279.656822306557, 5509.311336082989, 5525.171224316345, 5531.640443371188, 5539.695316757577, 5563.582731295169, 5566.165075238706, 5238.449962753894, 5351.57187425005, 5399.217113518557, 5470.261514695505, 5471.562275017989, 12325.260484370967, 12352.876471235262, 12538.874611253954, 12561.874381256162, 20445.28441504555, 1759.692053890564, 1794.7038738608114, 1857.5541869951114, 2026.3920823752815, 2311.5030268492187, 8885.777855553599, 9443.575039123187, 9517.571932540415, 9786.853197201977, 9794.510274486247, 1730.23869497422, 1749.0729913146054, 1763.6031892824012, 1766.0728117738163, 1809.4390738870993, 67670.66164669146, 70248.2975170252, 70541.0, 70678.47839487769, 71719.64140179318, 9692.757681057888, 9700.175485083846, 9947.253955953332, 9964.25268104895, 10547.683569492927, 13581.592552223448, 13585.913126949821, 13593.184408935496, 13594.45622175102, 13603.591892243248, 7001.299870012958, 7095.538789978635, 7102.68037938294, 7148.106486689164, 7150.96424517874, 6611.0, 6644.103046088813, 6765.188177418741, 6786.830329241809, 6850.4862135340045, 4155.8961025974595, 4179.456670632859, 4254.595813397722, 4376.059147283349, 4376.14665140301, 1727.9568010799578, 1796.6316905034437, 1815.0924537731134, 1820.681380758362, 1821.6720990221888, 821.3059964330131, 856.4732689395977, 876.2332958661171, 906.6962567539816, 938.1931538876561, 16244.269007894673, 16244.75632865508, 16398.918005409898, 16694.4156954506, 17532.824671753373, 765.5406755946499, 844.3962566764793, 847.584683505078, 871.3595507302127, 886.9312478463436, 8934.73195804127, 8993.235574976201, 9642.276829237835, 9680.612775489042, 9820.4107753535, 354850.0, 357206.0, 378671.0, 379180.0, 379683.0, 72950.63524682343, 75013.0, 76282.23717762751, 78795.60602196952, 79035.60482197667, 830.1325115254574, 848.4951453885052, 848.7114381110453, 849.7705619482829, 850.3069997951774, 14359.199956008479, 14740.631484212981, 14882.0, 15008.324625392102, 15259.618509537351, 35405.468917965736, 35570.0, 36144.638553614124, 36351.0, 36390.0, 46519.767401162775, 49794.0, 50659.74670126626, 50872.74563627158, 53172.0, 7322.853542929218, 7562.508436951801, 7772.106207786177, 7850.0972388173805, 7918.168592297726, 10886.727831804268, 12120.818187727014, 12140.939295303468, 12178.817317740419, 12293.262404255416, 10060.647877324258, 10180.0, 10676.199285053497, 10702.678919632424, 10753.731156721145, 10394.324368915995, 10605.363678179334, 10626.946865265934, 10709.410982396043, 10764.62323818694, 10155.54300056514, 10565.52455139536, 10588.629397971034, 10781.514831832743, 10999.670009899715, 7499.812504687427, 7725.575093369918, 7748.496347737379, 7863.882041769263, 7942.046954365514, 10376.429296388771, 10407.427591482541, 10509.737256568647, 10537.104346130665, 10934.289271197347], "value": 8029.026463592474, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1240.3302216802927, 1359.9116057456265, 1397.6994946086593, 1466.6113479927822, 1699.3202718912432, 7117.7508787192455, 7372.668229929653, 7472.364848987836, 7709.961450192741, 7726.072871255443, 7646.96176519118, 7758.922410775905, 7762.340201082915, 7765.611719414035, 7767.6116194190345, 2189.9890500547513, 2201.2295696506176, 2213.0262684418885, 2214.8560343577697, 2216.8780717060554, 2144.2280778919653, 2178.0307763045453, 2207.547452772178, 2210.3258506155616, 2211.1708109458955, 2142.678598210265, 2165.361218440564, 2165.4802847316687, 2167.707359506462, 2168.533765240473, 2098.569793192392, 2100.0, 2103.579284143162, 2103.863248888825, 2104.5790841831695, 2097.5699981503753, 2130.041481333406, 2133.0721136305756, 2137.5297434564372, 2139.689744986968, 7559.130699969464, 7574.35617972473, 7710.922890771077, 7714.228577142297, 7715.344195743369, 4329.631981281595, 4449.332600109977, 4451.532589078132, 4459.487158976727, 4469.508354081048, 2742.067696983035, 2869.0962346860674, 2928.4728748825205, 2938.7795915306224, 2940.1326608650284, 913.7898283394857, 932.1657116880422, 949.4635530925005, 950.7242899559119, 954.8519979403134, 10520.631777887813, 10610.840837387444, 10613.204009699226, 10639.042486176204, 10659.573617055308, 4046.615571520701, 4084.3669231268605, 4166.0, 4186.225548273579, 4216.7680777557525, 8339.416240863082, 8418.074011858691, 8419.07390187079, 8427.452215605967, 8431.536265505456, 4465.620422264079, 4470.798814053375, 4476.529964353696, 4477.440319960005, 4478.820847166076, 3670.50448189491, 4049.453323801249, 4082.1631565528996, 4085.4076158956786, 4209.116085622054, 3312.205070783043, 3331.6335203127637, 3408.50576666382, 3459.290845376692, 3475.374432602105, 1013.7566983923805, 1016.6594190945968, 1017.8218811707922, 1042.9061384475433, 1044.0446991003148, 771.5949126708523, 791.7268542352879, 792.1959211400433, 795.7493389582263, 814.6171299489231, 4863.465018847924, 4893.657443978887, 4966.950330496648, 5078.390593128848, 5254.632175747737, 414.836139724807, 417.926862799009, 418.2346306259598, 420.2456590420203, 431.105456178431, 3120.5943227380294, 3163.620365556148, 3197.728193103566, 3308.0, 3426.3489936911906, 9056.954715226382, 9690.37012594179, 9776.413415195111, 9786.706398808046, 9822.066903644143, 9732.610695572239, 9753.317267791328, 9755.658551950648, 9757.756056098655, 9761.755956101155, 6966.756163534354, 7187.245339239409, 7220.566765994057, 7326.523775954546, 7340.119185697644, 5130.948690513047, 5132.307138536399, 5152.227165925141, 5186.922196167136, 5276.920846187233, 8611.31109511225, 8721.607527661143, 8730.956345218234, 8811.206991370807, 8823.60293786794, 8616.310695144248, 8732.170443807829, 8835.249003834746, 8839.425437346552, 8884.511351875708, 6119.388061193845, 6580.078788969452, 6877.415419689382, 7001.829432875825, 7006.614636195059, 7325.340719335285, 7489.9625501874325, 7551.886721699069, 7557.470977031775, 7564.167941526538, 6544.901826472702, 6570.375814297634, 6607.398967562786, 6769.830754231184, 6805.863882722417, 6531.412172904462, 6531.575447595891, 6584.637844918576, 6592.76925307612, 6654.168228971379, 5947.3457919627945, 6059.242594675666, 6067.817965461043, 6077.361877003028, 6078.665673388006, 4499.0, 4580.839670611513, 4629.282461218517, 4695.5304469552775, 4710.646701497333, 4316.330968699856, 4410.911781764411, 4460.30865215892, 4553.499115097403, 4625.352450656844], "value": 3961.5673191067135, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.7377392329558, 308.4447993611499, 309.1113049981304, 314.5878898642778, 314.8945103390364, 4788.0663270662235, 4803.615710743141, 4822.999999999995, 4832.323474713543, 4841.273808928662, 4799.256115302133, 4801.759912004403, 4810.278458231267, 4821.903561928768, 4828.661993660445, 3564.982175089121, 3692.7230457715646, 3722.4788529605876, 3736.0099573613015, 3753.9436908446396, 3659.2864391443677, 3812.3519001769628, 3822.10180607557, 3835.1562656215588, 3839.347310957144, 3761.37937240355, 3763.6800871925784, 3770.6417890300377, 3778.886633401002, 3782.0, 3543.309054734302, 3745.9438108428394, 3788.1287303920117, 3791.8862434126745, 3807.8667246646373, 3299.3236386540943, 3299.835008249578, 3308.602967643874, 3311.2053107254087, 3340.615829179627, 4666.53334666534, 4674.158651442739, 4692.483826779052, 4699.553542413465, 4701.130290896195, 4291.141771645684, 4296.0978194578865, 4305.3326734355915, 4306.0, 4308.246056940023, 4876.21980483121, 4895.730734809584, 4959.603231741452, 4975.179095449246, 4982.932083185474, 3551.0057183988265, 3555.924125631336, 3557.4130268505664, 3559.483874838134, 3570.517980072683, 5210.244514545369, 5224.294720212761, 5233.9738301308635, 5243.187305967581, 5268.604854635918, 3520.331137083946, 3619.4027985382645, 3648.85404583819, 3652.196516766307, 3654.3422184007136, 3685.7235707322056, 3694.649008344257, 3704.7406681532034, 3704.7777133372083, 3716.955674379081, 4214.726042807208, 4215.156968606291, 4215.494140703136, 4235.898666346772, 4243.957560424418, 4835.564799168022, 4955.72743499111, 4958.281049247839, 4977.328060711758, 5003.399592048978, 1266.3288457117558, 1268.4989429175423, 1275.915471848921, 1279.9232046077266, 1289.3810970733912, 792.3502727763295, 812.6546217857505, 822.3462347433805, 824.8350329934037, 832.309183377795, 4206.621404073648, 4290.914181716411, 4373.781310934441, 4443.844465443759, 4462.576055274743, 5086.72023038729, 5130.692158470429, 5170.836561773646, 5187.377514698261, 5191.9480805192225, 4450.287953927356, 4463.375127482155, 4464.464264288306, 4467.285234362552, 4468.530804265505, 2593.260920637609, 2689.3411114276737, 2690.5829596412586, 2702.5135475614184, 2737.890484380642, 4735.905281894343, 4740.976295118502, 4741.478437371887, 4747.596454301423, 4748.572628463455, 5119.718519843752, 5198.8960220796125, 5232.215167724872, 5237.957196693293, 5275.973620131875, 4721.811127554859, 4741.407324084489, 4767.283777839974, 4767.308740232716, 4785.377900872933, 5080.847574572768, 5089.847304580869, 5133.974330128325, 5138.254953031864, 5143.5627971622835, 4871.683340582851, 5003.574696150868, 5013.849584512471, 5017.623678224075, 5029.195328747529, 4756.835639783821, 4763.452202996561, 4775.140474714584, 4775.5463230993, 4782.7847746850775, 3749.3438648235906, 3764.416515440111, 3791.962080379161, 3793.1275806565195, 3809.29528037314, 5118.129917914038, 5132.230165475208, 5137.8201762938115, 5147.459516750687, 5159.767810448464, 4733.668643194943, 4924.891899322623, 4942.0, 4945.8021679132435, 4952.182889823139, 4918.0, 4937.975310123426, 4956.900861982812, 4970.453250142554, 4971.502849715, 4857.878553036202, 4859.805607775649, 4865.172920603577, 4899.755012249302, 4911.312416261798, 4733.763311834326, 4823.758812059313, 4931.186354251508, 5046.116929537389, 5092.872678183075, 4867.464578896389, 4871.537203965618, 4873.342098816614, 4879.4629691647015, 4898.314236007033], "value": 3766.9382149731264, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.5658429840427, 582.8688545077357, 644.7066584703961, 651.8337823854918, 657.3853447027027, 11988.280703157816, 12681.682957926056, 12699.301538415384, 13007.219566825997, 13013.60959171224, 13183.143095698773, 13755.79366309506, 13888.513902013432, 14063.718725625482, 14087.92956035221, 733.5158795195172, 750.3584435307815, 752.059925093633, 752.1200195770961, 752.4394326226968, 600.2976517474565, 725.7351066860584, 751.1662055118813, 751.177460680554, 755.9470837041409, 787.8857565652977, 788.5505262000662, 788.9250521200477, 789.5105034878354, 789.6288744290174, 786.5831109511939, 787.330768846476, 788.4559653838891, 788.4914230321468, 788.9723859664941, 460.3026414981306, 555.886043361114, 571.1090698510337, 571.4114462104039, 574.7097715653568, 12171.0, 12177.33024683642, 12185.32980686062, 12199.39003049844, 12200.084993625514, 11183.552657893675, 11888.227265227733, 11997.880021199764, 12146.392680365947, 12437.689057773538, 10181.933772729328, 10208.693739187836, 10219.233557483218, 10413.5834566618, 10449.425281609509, 3287.3589650018257, 3295.983520082408, 3298.6041674998914, 3339.8664053437833, 3442.277121804424, 59835.40164598342, 60308.0, 60427.69786151085, 60551.0, 61238.38761612371, 8608.268297194683, 8846.424982376126, 8964.417312874642, 9065.728028159167, 9117.635294588143, 16849.41027064047, 17000.234989425506, 17049.659006819795, 17070.146492675318, 17339.739903901453, 6388.425041746173, 6494.415502604788, 6553.41019308255, 6601.900971485432, 6608.008798680236, 3460.8615655374006, 3594.155373487228, 3607.6211997740384, 3608.1160115771804, 3640.672339489459, 2829.0522674904137, 2955.2907302247736, 2973.435047340998, 2985.3730716549335, 2991.1475229559906, 489.20259976238503, 489.7918384686494, 490.8183971930337, 496.82859413502285, 503.54680787291, 477.5821156488073, 498.1922035386404, 534.5402953460022, 553.1757681055279, 560.5403569073321, 8018.438709290293, 8119.837603247902, 8330.958345208235, 8347.375243032955, 8706.564671766386, 561.2367180634334, 566.4250785452768, 575.2694078520256, 579.3226381461659, 595.946364827159, 3848.114933565296, 3930.6265904739575, 3962.4650672159464, 4090.181963607231, 4095.3447448408706, 70896.64551677312, 72276.0, 73437.0, 96808.0, 100199.49900250453, 44777.77611111924, 44817.0, 45281.77359113183, 59509.404905951254, 77332.61333693408, 61000.0, 67620.32379676239, 69036.6548167266, 70288.64855675689, 71517.6424117876, 7949.483283586548, 8099.0, 8154.592270386338, 8492.108328625653, 8590.0, 41541.37687934623, 41958.580414195465, 41997.1600567993, 42294.78852605717, 43058.78470607627, 55906.720466397404, 60750.924907508896, 61849.38150618436, 63864.0, 64107.67946160239, 10211.97880211973, 10583.682489525327, 10658.467076646291, 10839.349639021684, 11296.6046188383, 11968.222065565711, 12349.135560510678, 12491.812622810847, 12806.295653739135, 12960.222386656831, 11372.147088968195, 11485.138614604106, 11773.941130294294, 11911.940440297743, 12466.937665311616, 11605.419729013684, 11666.125040622157, 11806.940965295118, 12187.451564679433, 12562.685932851751, 10139.839214825584, 10489.0, 10765.89234107649, 10775.245732798943, 11078.279911805706, 9490.24104494365, 9755.414675119515, 9898.50507474609, 9945.602175912882, 9993.650222242186, 9347.813043739223, 10245.710254652387, 10305.381677099398, 10470.162387008868, 10489.318194317346], "value": 6233.7361658607215, "unit": "score"}], "name": "dromaeo_css", "value": 6269.8930522449255, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 133.0, 115.0, 117.0, 114.0, 114.0, 114.0, 114.0, 113.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 147.0, 186.0, 125.0, 148.0, 143.0, 123.0, 175.0, 120.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 164.0, 161.0, 161.0, 163.0, 161.0, 161.0, 163.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 158.0, 78.0, 76.0, 75.0, 75.0, 159.0, 77.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 143.0, 84.0, 84.0, 86.0, 142.0, 84.0, 83.0, 134.0], "value": 100.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 63.0, 64.0, 65.0, 64.0, 64.0, 66.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0, 66.0, 66.0, 67.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 81.0, 85.0, 82.0, 81.0, 81.0, 81.0, 81.0, 81.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 139.0, 131.0, 147.0, 133.0, 133.0, 145.0, 143.0, 168.0, 143.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 174.0, 172.0, 178.0, 177.0, 171.0, 170.0, 171.0, 171.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 70.0, 67.0, 68.0, 69.0, 69.0, 69.0, 68.0, 71.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1570.7, "alertThreshold": 2.0}]} 14:02:39 INFO - Return code: 0 14:02:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:02:39 INFO - # TBPL SUCCESS # 14:02:39 INFO - Running post-action listener: _resource_record_post_action 14:02:39 INFO - [mozharness: 2016-08-29 21:02:39.918179Z] Finished run-tests step (success) 14:02:39 INFO - Running post-run listener: _resource_record_post_run 14:02:39 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 7970816; Write bytes: 429027328; Read time: 1224; Write time: 290760 14:02:39 INFO - TinderboxPrint: CPU usage
13.0% 14:02:39 INFO - TinderboxPrint: I/O read bytes / time
7,970,816 / 1,224 14:02:39 INFO - TinderboxPrint: I/O write bytes / time
429,027,328 / 290,760 14:02:39 INFO - TinderboxPrint: CPU idle
8,352.3 (86.9%) 14:02:39 INFO - TinderboxPrint: CPU user
1,200.2 (12.5%) 14:02:39 INFO - TinderboxPrint: Swap in / out
0 / 0 14:02:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13504512; Read time: 0; Write time: 4060 14:02:40 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 5603328; Write bytes: 392351744; Read time: 956; Write time: 279996 14:02:40 INFO - Running post-run listener: _upload_blobber_files 14:02:40 INFO - Blob upload gear active. 14:02:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:02:40 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 14:02:40 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:02:40 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:02:41 INFO - (blobuploader) - INFO - Open directory for files ... 14:02:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:02:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:02:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:02:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:02:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:02:42 INFO - (blobuploader) - INFO - Done attempting. 14:02:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:02:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:02:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:02:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:02:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:02:42 INFO - (blobuploader) - INFO - Done attempting. 14:02:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:02:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:02:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:02:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:02:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:02:45 INFO - (blobuploader) - INFO - Done attempting. 14:02:45 INFO - (blobuploader) - INFO - Iteration through files over. 14:02:45 INFO - Return code: 0 14:02:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:02:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:02:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4e4a652c247e2d9eeefb2d939c206047ffe358e7a1ea2ec0b5e9bdc42dd12b3c0845575802ac0a590b0b2451aee5ebcc4742414d8efdaf10889307358b4b236f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dbef110c0b46a18040da09392cd0cda3ca3d27a91f247a84a7a24cead9a67aba8d56b51fd819ec9b524750f24917071bf0d4d87df5e4babb25fc464a1d9e0333", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6717ad6a7db9dee954ac1ab69b16e7ab3849ed47254a215f916e4cb5510324274a8f675762dec15987e7455ad955783c6123c182bf1e73c99764ecaf53747cd3"} 14:02:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:02:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:02:45 INFO - Contents: 14:02:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4e4a652c247e2d9eeefb2d939c206047ffe358e7a1ea2ec0b5e9bdc42dd12b3c0845575802ac0a590b0b2451aee5ebcc4742414d8efdaf10889307358b4b236f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dbef110c0b46a18040da09392cd0cda3ca3d27a91f247a84a7a24cead9a67aba8d56b51fd819ec9b524750f24917071bf0d4d87df5e4babb25fc464a1d9e0333", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6717ad6a7db9dee954ac1ab69b16e7ab3849ed47254a215f916e4cb5510324274a8f675762dec15987e7455ad955783c6123c182bf1e73c99764ecaf53747cd3"} 14:02:45 INFO - Running post-run listener: copy_logs_to_upload_dir 14:02:45 INFO - Copying logs to upload dir... 14:02:45 INFO - mkdir: /builds/slave/test/build/upload/logs 14:02:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.890087 ========= master_lag: 0.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-08-29 14:02:46.062057) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 14:02:46.065601) ========= 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=7de08804244eb36560b44971000001c3-1472503311.814699-1990862124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4e4a652c247e2d9eeefb2d939c206047ffe358e7a1ea2ec0b5e9bdc42dd12b3c0845575802ac0a590b0b2451aee5ebcc4742414d8efdaf10889307358b4b236f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dbef110c0b46a18040da09392cd0cda3ca3d27a91f247a84a7a24cead9a67aba8d56b51fd819ec9b524750f24917071bf0d4d87df5e4babb25fc464a1d9e0333", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6717ad6a7db9dee954ac1ab69b16e7ab3849ed47254a215f916e4cb5510324274a8f675762dec15987e7455ad955783c6123c182bf1e73c99764ecaf53747cd3"} build_url:https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011202 build_url: 'https://queue.taskcluster.net/v1/task/LNcHBGVrSiSnP-71-RCtAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4e4a652c247e2d9eeefb2d939c206047ffe358e7a1ea2ec0b5e9bdc42dd12b3c0845575802ac0a590b0b2451aee5ebcc4742414d8efdaf10889307358b4b236f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dbef110c0b46a18040da09392cd0cda3ca3d27a91f247a84a7a24cead9a67aba8d56b51fd819ec9b524750f24917071bf0d4d87df5e4babb25fc464a1d9e0333", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6717ad6a7db9dee954ac1ab69b16e7ab3849ed47254a215f916e4cb5510324274a8f675762dec15987e7455ad955783c6123c182bf1e73c99764ecaf53747cd3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 14:02:46.090794) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 14:02:46.091139) ========= 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=7de08804244eb36560b44971000001c3-1472503311.814699-1990862124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004318 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 14:02:46.175373) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 14:02:46.175755) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 14:02:46.176126) ========= ========= Total master_lag: 0.48 =========