builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1470728151.1 results: success (0) buildid: 20160808232220 builduid: 041f84b1745e4094b2724f1a736e2a10 revision: 8b38a9d101490846e89f84551e7b06b299b1a8f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 00:35:51.099680) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 00:35:51.100107) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 00:35:51.100464) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 00:35:51.142743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 00:35:51.143014) ========= 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=8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-09 00:35:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 60.5M=0s 2016-08-09 00:35:51 (60.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070424 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 00:35:51.235212) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 00:35:51.235801) ========= 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=8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017753 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 00:35:51.298170) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 00:35:51.298515) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 8b38a9d101490846e89f84551e7b06b299b1a8f9 --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 8b38a9d101490846e89f84551e7b06b299b1a8f9 --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=8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-09 00:35:51,618 truncating revision to first 12 chars 2016-08-09 00:35:51,618 Setting DEBUG logging. 2016-08-09 00:35:51,618 attempt 1/10 2016-08-09 00:35:51,618 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/8b38a9d10149?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 00:35:51,924 unpacking tar archive at: autoland-8b38a9d10149/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644992 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 00:35:51.958082) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 00:35:51.958450) ========= script_repo_revision: 8b38a9d101490846e89f84551e7b06b299b1a8f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 00:35:51.958853) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 00:35:51.959117) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 00:35:51.969161) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-09 00:35:51.969567) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:35:52 INFO - MultiFileLogger online at 20160809 00:35:52 in /builds/slave/test 00:35:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 00:35:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:35:52 INFO - {'append_to_log': False, 00:35:52 INFO - 'base_work_dir': '/builds/slave/test', 00:35:52 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 00:35:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:35:52 INFO - 'branch': 'Autoland-Non-PGO', 00:35:52 INFO - 'buildbot_json_path': 'buildprops.json', 00:35:52 INFO - 'config_files': ('talos/linux_config.py',), 00:35:52 INFO - 'default_actions': ('clobber', 00:35:52 INFO - 'read-buildbot-config', 00:35:52 INFO - 'download-and-extract', 00:35:52 INFO - 'populate-webroot', 00:35:52 INFO - 'create-virtualenv', 00:35:52 INFO - 'install', 00:35:52 INFO - 'run-tests'), 00:35:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:35:52 INFO - 'download_minidump_stackwalk': True, 00:35:52 INFO - 'download_symbols': 'ondemand', 00:35:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:35:52 INFO - 'tooltool.py': '/tools/tooltool.py', 00:35:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:35:52 INFO - '/tools/misc-python/virtualenv.py')}, 00:35:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:35:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:35:52 INFO - 'installer_path': 'installer.exe', 00:35:52 INFO - 'log_level': 'info', 00:35:52 INFO - 'log_name': 'talos', 00:35:52 INFO - 'log_to_console': True, 00:35:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:35:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:35:52 INFO - 'opt_config_files': (), 00:35:52 INFO - 'pip_index': False, 00:35:52 INFO - 'sps_profile': False, 00:35:52 INFO - 'sps_profile_interval': 0, 00:35:52 INFO - 'suite': 'dromaeojs-e10s', 00:35:52 INFO - 'system_bits': '32', 00:35:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:35:52 INFO - 'title': 'talos-linux64-ix-001', 00:35:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:35:52 INFO - 'use_talos_json': True, 00:35:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:35:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:35:52 INFO - 'work_dir': 'build'} 00:35:52 INFO - [mozharness: 2016-08-09 07:35:52.378634Z] Running clobber step. 00:35:52 INFO - Running pre-action listener: _resource_record_pre_action 00:35:52 INFO - Running main action method: clobber 00:35:52 INFO - rmtree: /builds/slave/test/build 00:35:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:35:52 INFO - Running post-action listener: _resource_record_post_action 00:35:52 INFO - [mozharness: 2016-08-09 07:35:52.840583Z] Finished clobber step (success) 00:35:52 INFO - [mozharness: 2016-08-09 07:35:52.840683Z] Running read-buildbot-config step. 00:35:52 INFO - Running pre-action listener: _resource_record_pre_action 00:35:52 INFO - Running main action method: read_buildbot_config 00:35:52 INFO - Using buildbot properties: 00:35:52 INFO - { 00:35:52 INFO - "project": "", 00:35:52 INFO - "product": "firefox", 00:35:52 INFO - "script_repo_revision": "production", 00:35:52 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 00:35:52 INFO - "repository": "", 00:35:52 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 00:35:52 INFO - "buildid": "20160808232220", 00:35:52 INFO - "pgo_build": "False", 00:35:52 INFO - "basedir": "/builds/slave/test", 00:35:52 INFO - "buildnumber": 258, 00:35:52 INFO - "slavename": "talos-linux64-ix-001", 00:35:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:35:52 INFO - "platform": "ubuntu64_hw", 00:35:52 INFO - "scheduler": "tests-autoland-linux64-talos", 00:35:52 INFO - "branch": "autoland", 00:35:52 INFO - "repo_path": "integration/autoland", 00:35:52 INFO - "revision": "8b38a9d101490846e89f84551e7b06b299b1a8f9", 00:35:52 INFO - "stage_platform": "linux64", 00:35:52 INFO - "builduid": "041f84b1745e4094b2724f1a736e2a10", 00:35:52 INFO - "slavebuilddir": "test" 00:35:52 INFO - } 00:35:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 00:35:52 INFO - Running post-action listener: _resource_record_post_action 00:35:52 INFO - [mozharness: 2016-08-09 07:35:52.843112Z] Finished read-buildbot-config step (success) 00:35:52 INFO - [mozharness: 2016-08-09 07:35:52.843201Z] Running download-and-extract step. 00:35:52 INFO - Running pre-action listener: _resource_record_pre_action 00:35:52 INFO - Running main action method: download_and_extract 00:35:52 INFO - mkdir: /builds/slave/test/build/tests 00:35:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:35:52 INFO - trying https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 00:35:52 INFO - Downloading https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/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 00:35:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/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 00:35:53 INFO - Downloaded 1361 bytes. 00:35:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 00:35:53 INFO - Using the following test package requirements: 00:35:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 00:35:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:35:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:35:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:35:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:35:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:35:53 INFO - u'jsshell-linux-x86_64.zip'], 00:35:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:35:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:35:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 00:35:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:35:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:35:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:35:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:35:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:35:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:35:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:35:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:35:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:35:53 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')]} 00:35:53 INFO - trying https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:35:53 INFO - Downloading https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/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 00:35:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/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 00:35:54 INFO - Downloaded 20258539 bytes. 00:35:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:35:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:35:55 INFO - Return code: 0 00:35:55 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 00:35: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')]} 00:35:55 INFO - trying https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:35:55 INFO - Downloading https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/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 00:35:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/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 00:35:56 INFO - Downloaded 20258539 bytes. 00:35:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:35:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:35:57 INFO - Return code: 0 00:35:57 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')]} 00:35:57 INFO - trying https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 00:35:57 INFO - Downloading https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/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 00:35:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/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 00:35:59 INFO - Downloaded 14413723 bytes. 00:35:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:35:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 00:35:59 INFO - Return code: 0 00:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:35:59 INFO - trying https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:35:59 INFO - Downloading https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/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 00:35:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/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 00:36:01 INFO - Downloaded 56141006 bytes. 00:36:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:36:01 INFO - mkdir: /builds/slave/test/properties 00:36:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:36:01 INFO - Writing to file /builds/slave/test/properties/build_url 00:36:01 INFO - Contents: 00:36:01 INFO - build_url:https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:36:02 INFO - Running post-action listener: _resource_record_post_action 00:36:02 INFO - Running post-action listener: set_extra_try_arguments 00:36:02 INFO - [mozharness: 2016-08-09 07:36:02.502465Z] Finished download-and-extract step (success) 00:36:02 INFO - [mozharness: 2016-08-09 07:36:02.502697Z] Running populate-webroot step. 00:36:02 INFO - Running pre-action listener: _resource_record_pre_action 00:36:02 INFO - Running main action method: populate_webroot 00:36:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:36:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:36:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:36:02 INFO - '--tppagecycles', 00:36:02 INFO - '7'], 00:36:02 INFO - 'tests': ['tsvgm']}}, 00:36:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:36:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:36:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:36:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:36:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:36:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:36:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:36:02 INFO - 'talos_options': ['--disable-e10s'], 00:36:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:36:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:36:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:36:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:36:02 INFO - 'talos_options': ['--disable-e10s'], 00:36:02 INFO - 'tests': ['damp', 'tps']}, 00:36:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:36:02 INFO - 'tests': ['damp', 'tps']}, 00:36:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:36:02 INFO - 'tests': ['dromaeo_dom']}, 00:36:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:36:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:36:02 INFO - 'tests': ['basic_compositor_video']}, 00:36:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:36:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:36:02 INFO - 'tests': ['a11yr', 00:36:02 INFO - 'ts_paint', 00:36:02 INFO - 'tpaint', 00:36:02 INFO - 'sessionrestore', 00:36:02 INFO - 'sessionrestore_no_auto_restore', 00:36:02 INFO - 'tabpaint']}, 00:36:02 INFO - 'other-e10s': {'tests': ['a11yr', 00:36:02 INFO - 'ts_paint', 00:36:02 INFO - 'tpaint', 00:36:02 INFO - 'sessionrestore', 00:36:02 INFO - 'sessionrestore_no_auto_restore', 00:36:02 INFO - 'tabpaint']}, 00:36:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:36:02 INFO - 'ts_paint', 00:36:02 INFO - 'tpaint', 00:36:02 INFO - 'sessionrestore', 00:36:02 INFO - 'sessionrestore_no_auto_restore', 00:36:02 INFO - 'tabpaint']}, 00:36:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:36:02 INFO - 'ts_paint', 00:36:02 INFO - 'tpaint', 00:36:02 INFO - 'sessionrestore', 00:36:02 INFO - 'sessionrestore_no_auto_restore', 00:36:02 INFO - 'tabpaint']}, 00:36:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:36:02 INFO - 'tests': ['a11yr', 00:36:02 INFO - 'ts_paint', 00:36:02 INFO - 'tpaint', 00:36:02 INFO - 'sessionrestore', 00:36:02 INFO - 'sessionrestore_no_auto_restore', 00:36:02 INFO - 'tabpaint']}, 00:36:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:36:02 INFO - 'tests': ['a11yr', 00:36:02 INFO - 'ts_paint', 00:36:02 INFO - 'tpaint', 00:36:02 INFO - 'sessionrestore', 00:36:02 INFO - 'sessionrestore_no_auto_restore', 00:36:02 INFO - 'tabpaint']}, 00:36:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:36:02 INFO - 'tests': ['tsvgx', 00:36:02 INFO - 'tsvgr_opacity', 00:36:02 INFO - 'tart', 00:36:02 INFO - 'tscrollx', 00:36:02 INFO - 'cart']}, 00:36:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:36:02 INFO - 'tsvgr_opacity', 00:36:02 INFO - 'tart', 00:36:02 INFO - 'tscrollx', 00:36:02 INFO - 'cart']}, 00:36:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:36:02 INFO - 'talos_options': ['--disable-e10s'], 00:36:02 INFO - 'tests': ['tp5o']}, 00:36:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:36:02 INFO - 'tests': ['tp5o']}, 00:36:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:36:02 INFO - 'talos_options': ['--disable-e10s', 00:36:02 INFO - '--xperf_path', 00:36:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:36:02 INFO - 'tests': ['tp5n']}, 00:36:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:36:02 INFO - 'talos_options': ['--xperf_path', 00:36:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:36:02 INFO - 'tests': ['tp5n']}}, 00:36:02 INFO - 'talos.zip': {'path': '', 00:36:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:36:02 INFO - Running post-action listener: _resource_record_post_action 00:36:02 INFO - [mozharness: 2016-08-09 07:36:02.524796Z] Finished populate-webroot step (success) 00:36:02 INFO - [mozharness: 2016-08-09 07:36:02.524901Z] Running create-virtualenv step. 00:36:02 INFO - Running pre-action listener: _resource_record_pre_action 00:36:02 INFO - Running main action method: create_virtualenv 00:36:02 INFO - Creating virtualenv /builds/slave/test/build/venv 00:36:02 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 00:36:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:36:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:36:02 INFO - Using real prefix '/usr' 00:36:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:36:03 INFO - Installing distribute.............................................................................................................................................................................................done. 00:36:05 INFO - Installing pip.................done. 00:36:05 INFO - Return code: 0 00:36:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:36:05 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 0xcff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbd570>, '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 0xfbe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe900>, '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': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', '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 00:36:05 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 00:36:05 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 00:36:05 INFO - Using env: {'DISPLAY': ':0', 00:36:05 INFO - 'HOME': '/home/cltbld', 00:36:05 INFO - 'LANG': 'en_US.UTF-8', 00:36:05 INFO - 'LANGUAGE': 'en_US:en', 00:36:05 INFO - 'LOGNAME': 'cltbld', 00:36:05 INFO - 'MAIL': '/var/mail/cltbld', 00:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:05 INFO - 'MOZ_NO_REMOTE': '1', 00:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:05 INFO - 'NO_EM_RESTART': '1', 00:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:05 INFO - 'PWD': '/builds/slave/test', 00:36:05 INFO - 'SHELL': '/bin/bash', 00:36:05 INFO - 'SHLVL': '1', 00:36:05 INFO - 'TERM': 'linux', 00:36:05 INFO - 'TMOUT': '86400', 00:36:05 INFO - 'USER': 'cltbld', 00:36:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', 00:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:05 INFO - '_': '/tools/buildbot/bin/python'} 00:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:36:05 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 00:36:05 INFO - Cleaning up... 00:36:05 INFO - Return code: 0 00:36:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:36:05 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 0xcff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbd570>, '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 0xfbe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe900>, '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': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', '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 00:36:05 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 00:36:05 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 00:36:05 INFO - Using env: {'DISPLAY': ':0', 00:36:05 INFO - 'HOME': '/home/cltbld', 00:36:05 INFO - 'LANG': 'en_US.UTF-8', 00:36:05 INFO - 'LANGUAGE': 'en_US:en', 00:36:05 INFO - 'LOGNAME': 'cltbld', 00:36:05 INFO - 'MAIL': '/var/mail/cltbld', 00:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:05 INFO - 'MOZ_NO_REMOTE': '1', 00:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:05 INFO - 'NO_EM_RESTART': '1', 00:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:05 INFO - 'PWD': '/builds/slave/test', 00:36:05 INFO - 'SHELL': '/bin/bash', 00:36:05 INFO - 'SHLVL': '1', 00:36:05 INFO - 'TERM': 'linux', 00:36:05 INFO - 'TMOUT': '86400', 00:36:05 INFO - 'USER': 'cltbld', 00:36:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', 00:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:05 INFO - '_': '/tools/buildbot/bin/python'} 00:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:36:05 INFO - Downloading/unpacking psutil>=3.1.1 00:36:05 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 00:36:05 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 00:36:05 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 00:36:05 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 00:36:05 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 00:36:05 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 00:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:36:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:36:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:36:07 INFO - Installing collected packages: psutil 00:36:07 INFO - Running setup.py install for psutil 00:36:07 INFO - building 'psutil._psutil_linux' extension 00:36:07 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 00:36:07 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 00:36:07 INFO - building 'psutil._psutil_posix' extension 00:36:07 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 00:36:07 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 00:36:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:36:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:36:07 INFO - Successfully installed psutil 00:36:07 INFO - Cleaning up... 00:36:08 INFO - Return code: 0 00:36:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:36:08 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 0xcff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbd570>, '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 0xfbe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe900>, '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': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', '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 00:36:08 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 00:36:08 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 00:36:08 INFO - Using env: {'DISPLAY': ':0', 00:36:08 INFO - 'HOME': '/home/cltbld', 00:36:08 INFO - 'LANG': 'en_US.UTF-8', 00:36:08 INFO - 'LANGUAGE': 'en_US:en', 00:36:08 INFO - 'LOGNAME': 'cltbld', 00:36:08 INFO - 'MAIL': '/var/mail/cltbld', 00:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:08 INFO - 'MOZ_NO_REMOTE': '1', 00:36:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:08 INFO - 'NO_EM_RESTART': '1', 00:36:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:08 INFO - 'PWD': '/builds/slave/test', 00:36:08 INFO - 'SHELL': '/bin/bash', 00:36:08 INFO - 'SHLVL': '1', 00:36:08 INFO - 'TERM': 'linux', 00:36:08 INFO - 'TMOUT': '86400', 00:36:08 INFO - 'USER': 'cltbld', 00:36:08 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', 00:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:08 INFO - '_': '/tools/buildbot/bin/python'} 00:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:36:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:36:08 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 00:36:08 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 00:36:08 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 00:36:08 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 00:36:08 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 00:36:08 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 00:36:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:36:10 INFO - Installing collected packages: mozsystemmonitor 00:36:10 INFO - Running setup.py install for mozsystemmonitor 00:36:10 INFO - Successfully installed mozsystemmonitor 00:36:10 INFO - Cleaning up... 00:36:10 INFO - Return code: 0 00:36:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:36: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')]} 00:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:36: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')]} 00:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:36:10 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 0xcff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbd570>, '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 0xfbe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe900>, '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': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', '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 00:36:10 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 00:36:10 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 00:36:10 INFO - Using env: {'DISPLAY': ':0', 00:36:10 INFO - 'HOME': '/home/cltbld', 00:36:10 INFO - 'LANG': 'en_US.UTF-8', 00:36:10 INFO - 'LANGUAGE': 'en_US:en', 00:36:10 INFO - 'LOGNAME': 'cltbld', 00:36:10 INFO - 'MAIL': '/var/mail/cltbld', 00:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:10 INFO - 'MOZ_NO_REMOTE': '1', 00:36:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:10 INFO - 'NO_EM_RESTART': '1', 00:36:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:10 INFO - 'PWD': '/builds/slave/test', 00:36:10 INFO - 'SHELL': '/bin/bash', 00:36:10 INFO - 'SHLVL': '1', 00:36:10 INFO - 'TERM': 'linux', 00:36:10 INFO - 'TMOUT': '86400', 00:36:10 INFO - 'USER': 'cltbld', 00:36:10 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', 00:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:10 INFO - '_': '/tools/buildbot/bin/python'} 00:36:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:36:10 INFO - Downloading/unpacking jsonschema==2.5.1 00:36:10 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 00:36:10 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 00:36:10 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 00:36:10 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 00:36:10 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 00:36:10 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 00:36:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:36:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:36:12 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 00:36:12 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 00:36:12 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 00:36:12 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 00:36:12 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 00:36:12 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 00:36:12 INFO - Downloading functools32-3.2.3-2.tar.gz 00:36:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:36:12 INFO - warning: no files found matching '*.txt' 00:36:12 INFO - no previously-included directories found matching 'build' 00:36:12 INFO - no previously-included directories found matching 'dist' 00:36:12 INFO - no previously-included directories found matching '.git*' 00:36:12 INFO - Installing collected packages: jsonschema, functools32 00:36:12 INFO - Running setup.py install for functools32 00:36:12 INFO - warning: no files found matching '*.txt' 00:36:12 INFO - no previously-included directories found matching 'build' 00:36:12 INFO - no previously-included directories found matching 'dist' 00:36:12 INFO - no previously-included directories found matching '.git*' 00:36:12 INFO - Successfully installed jsonschema functools32 00:36:12 INFO - Cleaning up... 00:36:12 INFO - Return code: 0 00:36:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:36:12 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')]} 00:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:36:12 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')]} 00:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:36:12 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 0xcff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbd570>, '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 0xfbe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe900>, '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': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', '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 00:36:12 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 00:36:12 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 00:36:12 INFO - Using env: {'DISPLAY': ':0', 00:36:12 INFO - 'HOME': '/home/cltbld', 00:36:12 INFO - 'LANG': 'en_US.UTF-8', 00:36:12 INFO - 'LANGUAGE': 'en_US:en', 00:36:12 INFO - 'LOGNAME': 'cltbld', 00:36:12 INFO - 'MAIL': '/var/mail/cltbld', 00:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:12 INFO - 'MOZ_NO_REMOTE': '1', 00:36:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:12 INFO - 'NO_EM_RESTART': '1', 00:36:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:12 INFO - 'PWD': '/builds/slave/test', 00:36:12 INFO - 'SHELL': '/bin/bash', 00:36:12 INFO - 'SHLVL': '1', 00:36:12 INFO - 'TERM': 'linux', 00:36:12 INFO - 'TMOUT': '86400', 00:36:12 INFO - 'USER': 'cltbld', 00:36:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', 00:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:12 INFO - '_': '/tools/buildbot/bin/python'} 00:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:36:13 INFO - Cleaning up... 00:36:13 INFO - Return code: 0 00:36:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:36:13 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')]} 00:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:36:13 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')]} 00:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:36:13 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 0xcff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbd570>, '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 0xfbe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe900>, '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': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', '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 00:36:13 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 00:36:13 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 00:36:13 INFO - Using env: {'DISPLAY': ':0', 00:36:13 INFO - 'HOME': '/home/cltbld', 00:36:13 INFO - 'LANG': 'en_US.UTF-8', 00:36:13 INFO - 'LANGUAGE': 'en_US:en', 00:36:13 INFO - 'LOGNAME': 'cltbld', 00:36:13 INFO - 'MAIL': '/var/mail/cltbld', 00:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:13 INFO - 'MOZ_NO_REMOTE': '1', 00:36:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:13 INFO - 'NO_EM_RESTART': '1', 00:36:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:13 INFO - 'PWD': '/builds/slave/test', 00:36:13 INFO - 'SHELL': '/bin/bash', 00:36:13 INFO - 'SHLVL': '1', 00:36:13 INFO - 'TERM': 'linux', 00:36:13 INFO - 'TMOUT': '86400', 00:36:13 INFO - 'USER': 'cltbld', 00:36:13 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', 00:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:13 INFO - '_': '/tools/buildbot/bin/python'} 00:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:36:13 INFO - Downloading/unpacking blobuploader==1.2.4 00:36:13 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 00:36:13 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 00:36:13 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 00:36:13 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 00:36:13 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 00:36:13 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 00:36:15 INFO - Downloading blobuploader-1.2.4.tar.gz 00:36:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:36:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:36: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 00:36: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 00:36: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 00:36: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 00:36: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 00:36: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 00:36:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:36:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:36: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 00:36: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 00:36: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 00:36: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 00:36: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 00:36: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 00:36:15 INFO - Downloading docopt-0.6.1.tar.gz 00:36:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:36:15 INFO - Installing collected packages: blobuploader, requests, docopt 00:36:15 INFO - Running setup.py install for blobuploader 00:36:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:36:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:36:16 INFO - Running setup.py install for requests 00:36:16 INFO - Running setup.py install for docopt 00:36:16 INFO - Successfully installed blobuploader requests docopt 00:36:16 INFO - Cleaning up... 00:36:16 INFO - Return code: 0 00:36:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:36:16 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 0xcff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbd570>, '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 0xfbe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe900>, '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': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', '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 00:36:16 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 00:36:16 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 00:36:16 INFO - Using env: {'DISPLAY': ':0', 00:36:16 INFO - 'HOME': '/home/cltbld', 00:36:16 INFO - 'LANG': 'en_US.UTF-8', 00:36:16 INFO - 'LANGUAGE': 'en_US:en', 00:36:16 INFO - 'LOGNAME': 'cltbld', 00:36:16 INFO - 'MAIL': '/var/mail/cltbld', 00:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:16 INFO - 'MOZ_NO_REMOTE': '1', 00:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:16 INFO - 'NO_EM_RESTART': '1', 00:36:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:16 INFO - 'PWD': '/builds/slave/test', 00:36:16 INFO - 'SHELL': '/bin/bash', 00:36:16 INFO - 'SHLVL': '1', 00:36:16 INFO - 'TERM': 'linux', 00:36:16 INFO - 'TMOUT': '86400', 00:36:16 INFO - 'USER': 'cltbld', 00:36:16 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', 00:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:16 INFO - '_': '/tools/buildbot/bin/python'} 00:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:36:16 INFO - Running setup.py (path:/tmp/pip-HzKu6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:36:16 INFO - Running setup.py (path:/tmp/pip-f3MvWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:36:16 INFO - Running setup.py (path:/tmp/pip-7XsTUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:36:16 INFO - Running setup.py (path:/tmp/pip-Bt0VCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:36:17 INFO - Running setup.py (path:/tmp/pip-S5cquJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:36:17 INFO - Running setup.py (path:/tmp/pip-Ys3gjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:36:17 INFO - Running setup.py (path:/tmp/pip-e7ERWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:36:17 INFO - Running setup.py (path:/tmp/pip-nVAcIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:36:17 INFO - Running setup.py (path:/tmp/pip-gzglfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:36:17 INFO - Running setup.py (path:/tmp/pip-FKctDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:36:17 INFO - Running setup.py (path:/tmp/pip-qzlq4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:36:17 INFO - Running setup.py (path:/tmp/pip-OojDKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:36:17 INFO - Running setup.py (path:/tmp/pip-rP82T7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:36:17 INFO - Running setup.py (path:/tmp/pip-q50LXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:36:17 INFO - Running setup.py (path:/tmp/pip-zCkqot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:36:17 INFO - Running setup.py (path:/tmp/pip-bs_2ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:36:17 INFO - Running setup.py (path:/tmp/pip-XUJEZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:36:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:36:17 INFO - Running setup.py install for manifestparser 00:36:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:36:18 INFO - Running setup.py install for mozcrash 00:36:18 INFO - Running setup.py install for mozdebug 00:36:18 INFO - Running setup.py install for mozdevice 00:36:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:36:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:36:18 INFO - Running setup.py install for mozfile 00:36:18 INFO - Running setup.py install for mozhttpd 00:36:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:36:18 INFO - Running setup.py install for mozinfo 00:36:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:36:18 INFO - Running setup.py install for mozInstall 00:36:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:36:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:36:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:36:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:36:18 INFO - Running setup.py install for mozleak 00:36:18 INFO - Running setup.py install for mozlog 00:36:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:36:19 INFO - Running setup.py install for moznetwork 00:36:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:36:19 INFO - Running setup.py install for mozprocess 00:36:19 INFO - Running setup.py install for mozprofile 00:36:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:36:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:36:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:36:19 INFO - Running setup.py install for mozrunner 00:36:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:36:19 INFO - Running setup.py install for mozscreenshot 00:36:19 INFO - Running setup.py install for moztest 00:36:19 INFO - Running setup.py install for mozversion 00:36:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:36:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:36:19 INFO - Cleaning up... 00:36:19 INFO - Return code: 0 00:36:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:36: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')]} 00:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:36: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')]} 00:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:36:19 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 0xcff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbd570>, '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 0xfbe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe900>, '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': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', '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 00:36:19 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 00:36:19 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 00:36:19 INFO - Using env: {'DISPLAY': ':0', 00:36:19 INFO - 'HOME': '/home/cltbld', 00:36:19 INFO - 'LANG': 'en_US.UTF-8', 00:36:19 INFO - 'LANGUAGE': 'en_US:en', 00:36:19 INFO - 'LOGNAME': 'cltbld', 00:36:19 INFO - 'MAIL': '/var/mail/cltbld', 00:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:19 INFO - 'MOZ_NO_REMOTE': '1', 00:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:19 INFO - 'NO_EM_RESTART': '1', 00:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:19 INFO - 'PWD': '/builds/slave/test', 00:36:19 INFO - 'SHELL': '/bin/bash', 00:36:19 INFO - 'SHLVL': '1', 00:36:19 INFO - 'TERM': 'linux', 00:36:19 INFO - 'TMOUT': '86400', 00:36:19 INFO - 'USER': 'cltbld', 00:36:19 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', 00:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:19 INFO - '_': '/tools/buildbot/bin/python'} 00:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:36:20 INFO - Running setup.py (path:/tmp/pip-dg4YR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:36:20 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)) 00:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:36:20 INFO - Running setup.py (path:/tmp/pip-BupHgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:36:20 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)) 00:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:36:20 INFO - Running setup.py (path:/tmp/pip-zDF33Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:36:20 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)) 00:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:36:20 INFO - Running setup.py (path:/tmp/pip-HPyC_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:36:20 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)) 00:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:36:20 INFO - Running setup.py (path:/tmp/pip-aNaJZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:36:20 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)) 00:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:36:20 INFO - Running setup.py (path:/tmp/pip-8M5RsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:36:20 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)) 00:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:36:20 INFO - Running setup.py (path:/tmp/pip-pDuJsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:36:20 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)) 00:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:36:20 INFO - Running setup.py (path:/tmp/pip-bvjMtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:36:20 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)) 00:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:36:20 INFO - Running setup.py (path:/tmp/pip-WOsdm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:36:20 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)) 00:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:36:20 INFO - Running setup.py (path:/tmp/pip-TVbkJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:36:20 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)) 00:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:36:20 INFO - Running setup.py (path:/tmp/pip-9J9hOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:36:20 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)) 00:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:36:20 INFO - Running setup.py (path:/tmp/pip-e2knnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:36:20 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)) 00:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:36:20 INFO - Running setup.py (path:/tmp/pip-Nt3a7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:36:20 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)) 00:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:36:20 INFO - Running setup.py (path:/tmp/pip-lRFplB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:36:21 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)) 00:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:36:21 INFO - Running setup.py (path:/tmp/pip-IXK70D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:36:21 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)) 00:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:36:21 INFO - Running setup.py (path:/tmp/pip-qmHuu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:36:21 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)) 00:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:36:21 INFO - Running setup.py (path:/tmp/pip-OatdPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:36:21 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)) 00:36:21 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)) 00:36:21 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)) 00:36:21 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)) 00:36:21 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)) 00:36:21 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)) 00:36:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:36: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 00:36: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 00:36: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 00:36: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 00:36: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 00:36: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 00:36:23 INFO - Downloading blessings-1.6.tar.gz 00:36:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:36:23 INFO - Installing collected packages: blessings 00:36:23 INFO - Running setup.py install for blessings 00:36:23 INFO - Successfully installed blessings 00:36:23 INFO - Cleaning up... 00:36:23 INFO - Return code: 0 00:36:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:36:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:36:23 INFO - Reading from file tmpfile_stdout 00:36:23 INFO - Current package versions: 00:36:23 INFO - argparse == 1.2.1 00:36:23 INFO - blessings == 1.6 00:36:23 INFO - blobuploader == 1.2.4 00:36:23 INFO - docopt == 0.6.1 00:36:23 INFO - functools32 == 3.2.3-2 00:36:23 INFO - jsonschema == 2.5.1 00:36:23 INFO - manifestparser == 1.1 00:36:23 INFO - mozInstall == 1.12 00:36:23 INFO - mozcrash == 0.17 00:36:23 INFO - mozdebug == 0.1 00:36:23 INFO - mozdevice == 0.48 00:36:23 INFO - mozfile == 1.2 00:36:23 INFO - mozhttpd == 0.7 00:36:23 INFO - mozinfo == 0.9 00:36:23 INFO - mozleak == 0.1 00:36:23 INFO - mozlog == 3.3 00:36:23 INFO - moznetwork == 0.27 00:36:23 INFO - mozprocess == 0.23 00:36:23 INFO - mozprofile == 0.28 00:36:23 INFO - mozrunner == 6.12 00:36:23 INFO - mozscreenshot == 0.1 00:36:23 INFO - mozsystemmonitor == 0.3 00:36:23 INFO - moztest == 0.7 00:36:23 INFO - mozversion == 1.4 00:36:23 INFO - psutil == 3.1.1 00:36:23 INFO - requests == 1.2.3 00:36:23 INFO - wsgiref == 0.1.2 00:36:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:36: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')]} 00:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:36: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')]} 00:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:36:23 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 0xcff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbd570>, '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 0xfbe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe900>, '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': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', '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 00:36:23 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 00:36:23 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 00:36:23 INFO - Using env: {'DISPLAY': ':0', 00:36:23 INFO - 'HOME': '/home/cltbld', 00:36:23 INFO - 'LANG': 'en_US.UTF-8', 00:36:23 INFO - 'LANGUAGE': 'en_US:en', 00:36:23 INFO - 'LOGNAME': 'cltbld', 00:36:23 INFO - 'MAIL': '/var/mail/cltbld', 00:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:23 INFO - 'MOZ_NO_REMOTE': '1', 00:36:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:23 INFO - 'NO_EM_RESTART': '1', 00:36:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:23 INFO - 'PWD': '/builds/slave/test', 00:36:23 INFO - 'SHELL': '/bin/bash', 00:36:23 INFO - 'SHLVL': '1', 00:36:23 INFO - 'TERM': 'linux', 00:36:23 INFO - 'TMOUT': '86400', 00:36:23 INFO - 'USER': 'cltbld', 00:36:23 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', 00:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:23 INFO - '_': '/tools/buildbot/bin/python'} 00:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:36:23 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)) 00:36:23 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)) 00:36:23 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)) 00:36:23 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)) 00:36:23 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)) 00:36:23 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)) 00:36:23 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)) 00:36:23 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)) 00:36:23 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)) 00:36:23 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)) 00:36:23 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)) 00:36:23 INFO - Cleaning up... 00:36:23 INFO - Return code: 0 00:36:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:36: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')]} 00:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:36: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')]} 00:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:36: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcff030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbd570>, '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 0xfbe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe900>, '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': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', '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 00:36: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', 'jsonschema'] in /builds/slave/test/build 00:36: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 jsonschema 00:36:23 INFO - Using env: {'DISPLAY': ':0', 00:36:23 INFO - 'HOME': '/home/cltbld', 00:36:23 INFO - 'LANG': 'en_US.UTF-8', 00:36:23 INFO - 'LANGUAGE': 'en_US:en', 00:36:23 INFO - 'LOGNAME': 'cltbld', 00:36:23 INFO - 'MAIL': '/var/mail/cltbld', 00:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:23 INFO - 'MOZ_NO_REMOTE': '1', 00:36:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:23 INFO - 'NO_EM_RESTART': '1', 00:36:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:23 INFO - 'PWD': '/builds/slave/test', 00:36:23 INFO - 'SHELL': '/bin/bash', 00:36:23 INFO - 'SHLVL': '1', 00:36:23 INFO - 'TERM': 'linux', 00:36:23 INFO - 'TMOUT': '86400', 00:36:23 INFO - 'USER': 'cltbld', 00:36:23 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', 00:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:23 INFO - '_': '/tools/buildbot/bin/python'} 00:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:36:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:36:23 INFO - Cleaning up... 00:36:24 INFO - Return code: 0 00:36:24 INFO - Running post-action listener: _resource_record_post_action 00:36:24 INFO - Running post-action listener: _start_resource_monitoring 00:36:24 INFO - Starting resource monitoring. 00:36:24 INFO - [mozharness: 2016-08-09 07:36:24.036726Z] Finished create-virtualenv step (success) 00:36:24 INFO - [mozharness: 2016-08-09 07:36:24.037272Z] Running install step. 00:36:24 INFO - Running pre-action listener: _resource_record_pre_action 00:36:24 INFO - Running main action method: install 00:36:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:36:24 INFO - Reading from file tmpfile_stdout 00:36:24 INFO - Detecting whether we're running mozinstall >=1.0... 00:36:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:36:24 INFO - Reading from file tmpfile_stdout 00:36:24 INFO - Output received: 00:36:24 INFO - Usage: mozinstall [options] installer 00:36:24 INFO - Options: 00:36:24 INFO - -h, --help show this help message and exit 00:36:24 INFO - -d DEST, --destination=DEST 00:36:24 INFO - Directory to install application into. [default: 00:36:24 INFO - "/builds/slave/test"] 00:36:24 INFO - --app=APP Application being installed. [default: firefox] 00:36:24 INFO - mkdir: /builds/slave/test/build/application 00:36:24 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'] 00:36:24 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 00:36:40 INFO - Reading from file tmpfile_stdout 00:36:40 INFO - Output received: 00:36:40 INFO - /builds/slave/test/build/application/firefox/firefox 00:36:40 INFO - Running post-action listener: _resource_record_post_action 00:36:40 INFO - [mozharness: 2016-08-09 07:36:40.570536Z] Finished install step (success) 00:36:40 INFO - [mozharness: 2016-08-09 07:36:40.570783Z] Running run-tests step. 00:36:40 INFO - Running pre-action listener: _resource_record_pre_action 00:36:40 INFO - Running main action method: run_tests 00:36:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:36:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:36:40 INFO - Python 2.7.3 00:36:40 INFO - Return code: 0 00:36:40 INFO - grabbing minidump binary from tooltool 00:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:36:40 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 0xfbd570>, '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 0xfbe470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:36:40 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 00:36:40 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 00:36:40 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 00:36:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:36:40 INFO - Return code: 0 00:36:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:36:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:36:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:36:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:36:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:36:40 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 00:36:40 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 00:36:40 INFO - Using env: {'DISPLAY': ':0', 00:36:40 INFO - 'HOME': '/home/cltbld', 00:36:40 INFO - 'LANG': 'en_US.UTF-8', 00:36:40 INFO - 'LANGUAGE': 'en_US:en', 00:36:40 INFO - 'LOGNAME': 'cltbld', 00:36:40 INFO - 'MAIL': '/var/mail/cltbld', 00:36:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:36:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:36:40 INFO - 'MOZ_NO_REMOTE': '1', 00:36:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:36:40 INFO - 'NO_EM_RESTART': '1', 00:36:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:36:40 INFO - 'PWD': '/builds/slave/test', 00:36:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:36:40 INFO - 'SHELL': '/bin/bash', 00:36:40 INFO - 'SHLVL': '1', 00:36:40 INFO - 'TERM': 'linux', 00:36:40 INFO - 'TMOUT': '86400', 00:36:40 INFO - 'USER': 'cltbld', 00:36:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614', 00:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:36:40 INFO - '_': '/tools/buildbot/bin/python'} 00:36:40 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 00:36:40 INFO - mozversion application_buildid: 20160808232220 00:36:40 INFO - mozversion application_changeset: 8b38a9d101490846e89f84551e7b06b299b1a8f9 00:36:40 INFO - mozversion application_display_name: Nightly 00:36:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:36:40 INFO - mozversion application_name: Firefox 00:36:40 INFO - mozversion application_remotingname: firefox 00:36:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 00:36:40 INFO - mozversion application_vendor: Mozilla 00:36:40 INFO - mozversion application_version: 51.0a1 00:36:40 INFO - mozversion platform_buildid: 20160808232220 00:36:40 INFO - mozversion platform_changeset: 8b38a9d101490846e89f84551e7b06b299b1a8f9 00:36:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 00:36:40 INFO - mozversion platform_version: 51.0a1 00:36:40 INFO - using testdate: 1470728200 00:36:40 INFO - actual date: 1470728200 00:36:40 INFO - starting webserver on 'localhost:48661' 00:36:40 INFO - SUITE-START | Running 2 tests 00:36:40 INFO - TEST-START | dromaeo_css 00:36:40 INFO - operating with platform_type : linux_ 00:36:40 INFO - Initialising browser for dromaeo_css test... 00:36:40 INFO - TEST-INFO | started process 10193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3wu_T6/profile http://localhost:48661/getInfo.html) 00:36:45 INFO - PROCESS | 10193 | __metrics Screen width/height:1600/1200 00:36:45 INFO - PROCESS | 10193 | colorDepth:24 00:36:45 INFO - PROCESS | 10193 | Browser inner width/height: 1024/697 00:36:45 INFO - PROCESS | 10193 | __metrics 00:36:46 ERROR - PROCESS | 10193 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 00:36:47 INFO - TEST-INFO | 10193: exit 0 00:36:47 INFO - Browser initialized. 00:36:47 INFO - Running cycle 1/1 for dromaeo_css test... 00:36:47 INFO - TEST-INFO | started process 10314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3wu_T6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:36:59 INFO - PROCESS | 10314 | RSS: Main: 164720640 00:36:59 INFO - PROCESS | 10314 | 00:37:48 INFO - PROCESS | 10314 | 1470728268849 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] 00:40:01 INFO - PROCESS | 10314 | Cycle 1(1): loaded http://localhost:48661/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48661/tests/dromaeo/cssquery-ext.html) 00:40:02 INFO - PROCESS | 10314 | RSS: Main: 166510592 00:40:02 INFO - PROCESS | 10314 | 00:43:05 INFO - PROCESS | 10314 | Cycle 1(1): loaded http://localhost:48661/tests/dromaeo/cssquery-ext.html (next: http://localhost:48661/tests/dromaeo/cssquery-jquery.html) 00:43:05 INFO - PROCESS | 10314 | RSS: Main: 166326272 00:43:05 INFO - PROCESS | 10314 | 00:46:07 INFO - PROCESS | 10314 | Cycle 1(1): loaded http://localhost:48661/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48661/tests/dromaeo/cssquery-mootools.html) 00:46:08 INFO - PROCESS | 10314 | RSS: Main: 170332160 00:46:08 INFO - PROCESS | 10314 | 00:49:10 INFO - PROCESS | 10314 | Cycle 1(1): loaded http://localhost:48661/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48661/tests/dromaeo/cssquery-prototype.html) 00:49:11 INFO - PROCESS | 10314 | RSS: Main: 163831808 00:49:11 INFO - PROCESS | 10314 | 00:52:14 INFO - PROCESS | 10314 | Cycle 1(1): loaded http://localhost:48661/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48661/tests/dromaeo/cssquery-yui.html) 00:52:14 INFO - PROCESS | 10314 | RSS: Main: 166629376 00:52:14 INFO - PROCESS | 10314 | 00:55:17 INFO - PROCESS | 10314 | Cycle 1(1): loaded http://localhost:48661/tests/dromaeo/cssquery-yui.html (next: http://localhost:48661/tests/dromaeo/cssquery-dojo.html) 00:55:17 INFO - PROCESS | 10314 | RSS: Main: 169578496 00:55:17 INFO - PROCESS | 10314 | 00:55:17 INFO - PROCESS | 10314 | __start_tp_report 00:55:17 INFO - PROCESS | 10314 | _x_x_mozilla_page_load 00:55:17 INFO - PROCESS | 10314 | _x_x_mozilla_page_load_details 00:55:17 INFO - PROCESS | 10314 | |i|pagename|runs| 00:55:17 INFO - PROCESS | 10314 | |0;dojo.html;2676.8661566921655;2688.287603784996;2699.7570218680326;2704.9188524344277;2725.8773355199014;4671.532846715327;4812.205986012308;4834.0815245103495;4845.6850304730215;4872.805087796488;4745.857624271269;4784.282357646355;4805.3032310315075;4810.687305325151;4812.0375924815;4423.4249547558775;4434.379186913835;4434.933475997855;4438.977805110986;4499.437570303712;4435.866923992286;4442.355858400546;4462.464504259493;4474.0380818124095;4525.094981003813;4549.954500455003;4580.038191979688;4591.357209990604;4592.288195329713;4604.424446944132;4274.743515389056;4389.912201755979;4402.097569998143;4493.662975276835;4558.247889098328;4356.716813407118;4362.432883725127;4362.956370436286;4430.689851710382;4439.933400998988;4818.71087734737;4828.534696684324;4832.565069143759;4846.103470857867;4890.388701412324;5143.485651434864;5166.302549155854;5186.0665080285535;5251.4485978972425;5257.76340064698;5275.446078161776;5280.075986702312;5295.523402893758;5295.920561191585;5301.469853014668;4923.113839508923;4928.285398617216;4930.876728081755;4950.75246237683;4952.727599981963;5145.9485405146215;5345.812896548602;5389.568834493231;5405.78376864921;5483.7806487740845;5130.743462826844;5148.510891465305;5169.53474187325;5188.610854185951;5198.584113270929;5246.0557099721655;5248.317718696545;5252.264682944391;5257.737113144328;5311.814086506954;4942.481039490874;4980.252962055648;5121.590272778169;5165.535101840853;5179.585633149339;5118.411382691038;5154.768035438415;5177.197534382101;5184.8963020739375;5192.948070519322;4419.491758447755;4431.667624928144;4432.069265454226;4441.689081764245;4466.642668586505;3745.8688945886765;3821.9871733990517;3874.302625527432;3899.220155968761;3907.843686252518;4464.709793863389;4482.843100491467;4503.639708823352;4526.886827829265;4536.274196128604;5198.428172900978;5221.817236396708;5222.4255331913455;5245.868853278622;5281.815136470205;4271.594198551133;4450.421445212167;4475.977620111944;4501.572350626685;4537.909241815145;4698.154332220165;4702.200625893606;4709.62323014158;4763.261694437368;4770.928436073462;4878.536539028786;4931.432885218246;4951.9752401237765;4965.503449654933;4965.50344965515;4975.353204083446;5192.662476938987;5277.656952298088;5290.7354632269;5313.4952179544425;4908.042931628298;4917.409910810726;4940.6788558743565;4946.950530494649;4967.900641987212;5176.4305926348825;5176.870578235424;5183.714895680774;5200.869978250574;5222.190560463135;5006.249062640633;5122.154844450624;5228.8757917048015;5242;5262.736863156903;5002.149634562061;5040.294358789845;5043.87390315245;5088.618353623419;5091.974540127276;5022.221555658879;5033.823816166417;5034.723090229926;5037.949620503748;5099.23511473282;4787.3537072496165;4900.828471003498;4934.827281045146;4960.379952505937;4967.155583550732;5003.574696150868;5047.394312682502;5073.518015788494;5095.031943930641;5096.311997880239;4935;4945.208766597327;4950;4955.975220123876;4960.30555722192 00:55:17 INFO - PROCESS | 10314 | |1;ext.html;545.7680485793537;552.353746117043;558.1348909190754;574.6552068758742;576.3573615418804;34862.477062844046;35934.8203258984;39582.406263906065;39630.99999999996;39710.404343934795;39317.42730290785;40171.79914100425;40310.19379612406;40464.39303410451;40632.187356252856;7565.2812982766545;7736.34241089508;7777.416693747963;7778.727744528915;7795.532268063935;7613.543187408745;7684.462087653867;7688.615569221516;7691.307782299592;7696.884546731803;7624.199459056802;7665.770026899202;7671.501352412075;7673.577953212571;7685.116211635677;7569.848603027936;7614.505057171294;7652.426068044919;7668.578228197447;7675.117361503415;7662;7679.385649148055;7693.9615301923695;7700.730474433368;7717.228277172294;36689;36842.631573684186;36863.07842303937;36863.63136368629;36982.445263321075;3046.466868298039;3292.6378098409155;3320.4355259605927;3618.4029635110173;3859.517560304962;28877.56683649726;29232.123036308945;29593.260168495744;29674.55488167679;29686.257843553867;3252.4796032634663;3270.3949769292517;3356.6475520070285;3457.8271086445575;3463.2207753255566;257602;258992;259247;259274;261253;31650;53047.73476132672;53206.73396632992;53536.732316338945;53715;31956;33960.66039339625;33976.83011584926;34024;34137.146571335914;13912.652183695489;13966.441342346192;14078.577642670736;14113.85886141146;14121.85878141226;11832.408379580986;11842.88157118435;11850.703732406759;11905.464254108585;11926.761464770656;7797.610119494003;7883.487573307832;7971.202879712098;8020.879686804703;8028.197180281925;3080.6765289644713;3099.395617854497;3113.532970054465;3152.2119470132466;3159.462891308483;858.6951632170615;865.9307255419551;910.644848509082;979.2361957673027;996.4917891875195;25419;25451.61822572663;25630.487390252463;25766.74233257681;25821.3544661385;853.249140756143;913.8263729891299;930.06993006993;963.9325247232766;983.7688143286322;13070.607881763563;13186;13648.112872663245;13653;13673.521426750214;391769;395216;396785;398722;400239;51609;52020;52092.47907520952;52139;52139.21791173136;1196.75685775113;1209.2804781155198;1213.5813144465146;1221.9633410997685;1232.5069972011268;24199.738812294105;26666.466670666865;28667.426651466438;28758.85620571884;28966.710332897244;44388.00253988643;44535.55464445314;44632.55367446284;44676.77661611671;44681.32978005268;278762;278996;279083.2550047004;279365;279512;25582.488350232517;25666.743332566435;25699.229023129337;25961.144274129452;26050.86974565115;43425.7828710867;43602.78198608987;44089;44291.33562996622;44402.77798610986;36977;37145;37267.81366093152;37991;39177.41233881437;37331.626683732815;37359.25281494409;37483.43774843434;37491.53959469599;37673.62326376701;32027.67972320247;36089.45865811963;36586;36714.63285367112;37022.259554809294;31846.52230216595;34136.851898841676;34261.486077709356;34412.82793586016;34427.65572344245;26123;26200.213993580222;26212.8689356552;26232.606510902733;26243.73756262413 00:55:17 INFO - PROCESS | 10314 | |2;jquery.html;338.5345150418175;359.3280565342809;364.7665494083785;365.99085022874425;378.64785749253184;15963.521094367174;16703.832961670396;16886.155692215387;17207.13964301786;17288.913555432206;16064.83935160648;16870.493885183434;17343.82656173438;17452.738208926876;17502.649947001053;4878.463369029404;5104.310918026074;5106.183010718286;5108.055009823194;5116.1302578561545;3727.4967879336214;5038.470960549126;5642.57680673949;5852.882942341151;5923.733431995571;5954.880902381949;5959.1359252908305;5971.880562388749;5980.491658209057;5991.131285963555;5738.311402631669;5739;5768.740406681667;5779.884402311951;5782.363939966643;4561.543845615412;5006.224035274538;5118.795248190068;5134.5378915897745;5138.871528211787;12117.454714537867;12778.808317875239;12870.806937895939;12893.871061289361;12943.611691649265;1888.612834368951;1921.807819218067;1935.632229876319;1992.621401933628;2122.4163355077476;9355.578998945064;9381.812363752686;9392.530373481299;9540.427574345493;9683.41899486026;1670.599056226497;1706.9402570909958;1751;1754.5350482122249;1766.646670665872;67775.66112169457;68238.65880670614;68934;70572.29427705708;70618.64690676513;9227.400218985744;9340.673076442292;9498.620055197714;9597.520123993772;10221.795564088825;12095.455704493143;12096.576619818265;12105.636830894911;12118.939405302917;12149.392530373447;7125.89311160333;7258.6007769572125;7379.372753315921;7500.849983000418;7523.360514356232;7073.82315442118;7201.855962880818;7216.96391518039;7546.132194797558;7560.810979725551;3829.157585331223;3869.2068126034096;3882.5340959085092;3980.20395920817;4000.4999375078114;1627.2839950421776;1656.9751453728204;1689.6198355370188;1760.4278609451978;1761.3218910719465;779.8011507065662;844.7550210439027;863.5423225690395;913.6299798581585;918.0681608167715;16785;17066.914665426593;17629.82370176282;17645.205965731573;18110;853.249140756143;858.7810108422437;874.0691163910415;882.170759486081;914.0996118822954;9496.192823609932;9598.760030999141;9737.513124343895;9840.3603765755;9956.203503719686;394700;397325;400063;401947;406589;81783;84962;85334.57332713297;85370;87795.56102219448;916.2624087609405;939.8825146856643;966.5264020629982;972.7033254857337;978.6721448314894;15286.617834554225;15744.97657652249;15782.368705251662;16090.758638620664;16502.75245871289;24847.509149451093;27925.720742792313;37608.247835043694;37742.8112859434;38054;51786.741066294424;52591.21113183382;53880.73059634834;54311.45688543064;55406;7022.6488675565;7335.816604584928;7351.66917488725;7550.66022029021;7674.462787604814;8226.465279756796;10280.537375818256;10797.29817561856;11211.55153793839;11348.375839328586;9295.953520232626;9336.39313444624;9733.707988760349;9888.50557472138;10251.282410231212;9999.250056245664;10088.041636044563;10136.695899123039;10226.130778883879;10672.359658420519;9218.769530761785;9602.95198524003;9823.410595364301;9866.802663946537;9971.700848974542;7457.589832559262;7500.474966752275;7519.624018798929;7573.053368328959;7697.230276972482;7343.77968660941;9482.857757133786;9722.173615242784;9776.086783755725;10033.648822291476 00:55:17 INFO - PROCESS | 10314 | |3;mootools.html;1376.256821316489;1404.1294397473564;1493.8804895608353;1668.5661727950744;1697.4568138195782;6695.966520167404;7216.314450127243;7340.816479588013;7933.127355990837;7933.682652693892;7279.235680253577;7470.178280389153;7477.177510473857;7541.886871696929;7543.849123017536;2162.113533451285;2205.680176374433;2209.933701988943;2210.8120809731113;2213.9557208855895;2108.093519786491;2143.764185939553;2182.388931099295;2184.857984231028;2189.890505474728;2193.4954960359128;2199.83501237407;2202.4053505553493;2211.579799838026;2215.9335219943428;2137.9893100534478;2147.0552956699003;2148.3769706785015;2157.7842215778455;2162.2540223622823;2106.694529293259;2152.13914434226;2152.3435352217566;2171.630822760119;2174.749903761072;7715.961420192919;7729.768106956801;7732.884006739903;7749.186335434754;7846.5292082475235;4546.749928753918;4582.266837306015;4673.415823022122;4679.4618618858585;4681.672282940195;2829.533127034037;2925.561165825122;2939;2957.5267957126757;2967.436187124461;874.335505016186;921.2906062332033;921.4010892919589;927.1331305229631;932.303208161147;10583.735406614896;10584.523696433602;10625.20310976672;10643.840342394948;10646.787064258671;3902.180542086137;4080.755154690728;4165;4177.624013838708;4254.595813397722;9181.265498760084;9181.678641247525;9182.90817091834;9186.540672966325;9192.540372981324;4671.15919134559;4697.060587882437;4697.647676424282;4708.788104535304;4721.197396442613;3435.2270739083506;4119.340905455113;4190.057237121623;4240.872773816791;4294.184105020036;3527.647235276503;3562.4656301554974;3617.6924961378577;3688.096416377951;3792.867249646249;1131.9830202546805;1132.252713209278;1140.224647239885;1142.765733024728;1151.8329842172839;679.4496457869142;806.1132753970703;823.4030328012143;824.698984870518;826.5454000299811;5020.422651395063;5044.520770526794;5049.116404629175;5129.538341549204;5184.170532714747;397.8945579421456;401.52018338086293;403.67705835331617;408.9059516311265;416.7541150721089;3501.089716673683;3528.1532432216595;3531.9646803531637;3544.202554425285;3589.9282014359565;9065.818683626423;9540.475273860004;9548.522573871278;9558.904410955802;9568.712938611852;9536.475493847905;9536.666216682383;9547.188488978376;9552.57013434397;9559.283053770994;6918.5502942309595;7000.844860598047;7158.176809666851;7339.59632220233;7430.368418684472;4962;5101.9489805101475;5246.790128394821;5343.278657381359;5425.945740542544;8584.871226931476;8787.868181977148;8915.598798054232;8916.420432671855;8918.24194943437;9040.141186587263;9065.954670226607;9119.316051296311;9130.634774609207;9169.037251088539;5670.347909990404;6593.472522198117;6722.159730033746;6855.725770969106;6974.0236366909685;7499;7511.136219334628;7531.472796904164;7543;7551.471397002157;6828.385445309946;6836.38472537474;6914.204866440424;6999.300069993164;7113.146422429135;6729.865402691821;6761.121054263111;6770.729170833111;6825.419839313714;6843.692033858389;6101.176341194059;6114.327423983269;6115.235595550556;6136.171616831671;6204.224471941007;4378.321360189176;4380.277254253013;4414.492333381702;4541.931871022003;4576.794044267949;4396.164728701537;4479.148961697267;4495.57292057254;4558.133954548625;4631.698939568917 00:55:17 INFO - PROCESS | 10314 | |4;prototype.html;298.1101412284331;298.96711361750204;302.83646830711416;309.34573377307004;309.9116751725759;5144.845654630358;5184.948150518494;5185.222216667502;5192.688438693681;5208.90612971276;5023.773930173142;5051.31807206027;5052.433745538886;5064.72144032079;5121.078205922932;3762.5484941806953;3898.941515877264;3965;3982.287616324979;4032.576579459144;3988.3419235826054;3988.6809055275653;3992.7604343739467;4029.2344454553686;4037.899052523681;3988.282109220339;4012.3780813973735;4022.718409711307;4031.21391328691;4053.8986525336954;3796.1648437343742;4001.7398869073418;4004.2391945530258;4034.7579145251234;4037.7577345359227;3540.0972751948348;3542.2384187399834;3548.290341931598;3549.6627820357025;3552.6980206682465;5004.249362595603;5014.348134742497;5044.39467263927;5048.823291184827;5053.772580233898;4487.775611219458;4591.265397536378;4627.814887404534;4636.188666983298;4639.768011599406;5219.947800521984;5302.920456193122;5313.681179129226;5320.228566857784;5332.880095180017;3841.6350446707797;3865.2269546090615;3876.9030774230587;3887.922241555153;3899.298126337258;5545.271789972335;5562.916556251659;5621.18492818539;5666.858328541778;5687.943120568824;3886.6696330812197;3947.348687466536;3952.4268980997595;3962.712118561479;3992.5608183099835;4033.253848038122;4043.1711499142607;4050.554439011765;4050.837966481308;4061.8578349757618;4571.588557029817;4583.662332210597;4600.309953506934;4601.470830854428;4608.078384323148;5234.241035049972;5243.842684719464;5321.521063104339;5323.760430780624;5389.838304850782;1374.8588671402713;1396.273937552467;1399.230423267199;1401.5795261421533;1406.1282005156868;851.880736696863;867.8611422172548;908.6819613135482;910.940788848736;915.7481692534607;4553;4652.55800698933;4667.369905062773;4675.4155730533685;4693.647976401783;5517.5585953124455;5536.667799932017;5579.716665166953;5592.217089607459;5598.412166722517;4427.446569178853;4657.301404789308;4670.439547254283;4684.625229981593;4693;2905.4334404791284;2928.663203731598;2957.290250339946;2964.4960356739407;2968.9703102969124;5161.200013997836;5201.945231633484;5214.966163196356;5252;5271.156614941668;5462.808801691922;5631.030123762737;5674.716264186774;5699;5759.22250496186;5203.8178663746585;5205.843824685341;5206.370782754685;5222.608304377187;5256.316678831728;5595.972020139873;5630.577706671934;5635.7037881286715;5664.122061080539;5670.177824215383;5109.20807274873;5442.755076021509;5448.093167391381;5507.73322135903;5525;5290.418054013979;5290.947090529045;5294.796648028042;5307.230451584576;5313.707746073848;3803.2203398302727;3878.301905657009;3895.6493915546603;3905.5899130592015;3918.1967696622696;5512.283403157564;5563.221149039056;5577.498025177753;5591.329040515002;5643.26637537134;5374.731263436891;5377.838664840061;5395.2176934343515;5421.2681288025615;5481.561475082063;5083.237514372874;5331.333583302087;5367.194920761761;5401.432849550898;5457.154141108134;5267.71027593486;5268.288781014514;5272.340957380327;5296.894062118813;5323.387810401853;5213.191955246943;5268.973655131853;5398;5408.323959505062;5416.18557783147;5284.798585124912;5289.576833853205;5320.17537281722;5330.840074797762;5332.1202001670845 00:55:17 INFO - PROCESS | 10314 | |5;yui.html;627.4854619212244;664.4285914113862;667.6061123936877;682.3006418421118;699.1330749870159;12669.809952850715;13744.450221991108;13745.656358591028;13763.311834408278;13771.517996870112;13427.530036448727;13538.93230533846;13754;14258.287085645703;14350.497732579362;760.4182800157884;779.7037125892182;781.2421950707804;783.1815752538611;784.0434669702953;630.3979699387097;744.7467860927284;763.5723994563062;766.4098644044083;778.906531216252;809.9149589293128;816.2286639125998;817.652497688483;817.6729308276707;818.2104269380047;814.0109766633539;814.2956342763497;814.3932770086294;814.7759366174349;815.0748899998486;592.3661682000261;593.4984937727613;593.557799439416;594.2037669522817;594.2838879150613;13657.453701851913;13675.384607692678;13730.244836533986;13736.519221827188;13739.519116830863;13431.932840335736;13495.460181592725;13740.725185496334;13798.310084495735;13812.654683632989;10708.571657133705;10754.892451075468;10815.459227038617;10874.401907895062;10883.23817332787;3281;3307.255867429833;3315.6850099240532;3326.7837590556537;3398.065531978701;50970;52896.20655690129;53041.734791326184;70565.2943470569;70750.64624676896;10225.335353202017;10595.682129536126;10619.94690026545;10798.51406686701;10892.346459212473;16541.917290413712;16607.169641517874;16705.498835034967;16765.413210537572;17207.1396430178;7056.717731290793;7103.92896071043;7109.111361079865;7275.308845659654;7428.294312040348;3728.5525736911745;3767.3407153747985;3782.7730336179916;3811.5426148862316;3907.1794923066473;3037.559553864677;3135.0908236611126;3160.0361889623427;3164.0666003529013;3164.651888292286;522.068108426457;526.8524813052352;526.8867193553405;531.7607076815449;545.2475583694555;476.73064718434665;516.2333934107846;555.3252797850631;574.5016520643353;584.3905429591335;7726.652300646484;7926.801829954297;8155.959220203979;8261.256486916207;8297.12880147588;517.5161224255334;523.5523627298682;544.6106034185576;549.5630973376176;550.5568017745753;3890.922181556353;3968.3849003404516;4006.358982562776;4050.7569545827346;4178.26880295947;105475.47262263793;105497;105882.47058764657;108184.4590777041;109202;87793;88475.55762221148;90531.54734226418;90642.54678726564;91469.54265228764;76133;79875;80239;81190.99999999882;81392.59303703562;7749.690012399441;7769.7669069928;7799.745151913433;7993.960030199812;8022.478538894953;47172.7641361791;47457.28814067723;47900;48441.75779121082;48950;60689.089663654195;61114.38885611087;67032.3296767026;68257.31742682708;69046;9175.632974680939;9387.671431500137;9425.62297508092;9522.906004244165;9566.712998610054;10626;10728.89271107279;10975.231733778559;11060.723481913017;11090;10191.796164076528;11090.500927458123;11451.327874156988;11465.942670286595;11466.369349685847;11142.3591856136;11400.94299528497;11551.249168804337;11859.34773587461;11869.169158158846;10977;11181.664550063511;11278.210525263154;11345.319280843176;11455.140864435367;9352.894030734746;9776.748669585197;10187.847182292124;10347.793044138925;10741.838872417076;9744.366616169926;10306.948465257627;10330.948345258226;10396.116330112025;10417.166626669698 00:55:17 INFO - PROCESS | 10314 | __end_tp_report 00:55:17 INFO - PROCESS | 10314 | __start_cc_report 00:55:17 INFO - PROCESS | 10314 | _x_x_mozilla_cycle_collect,368 00:55:17 INFO - PROCESS | 10314 | __end_cc_report 00:55:17 INFO - PROCESS | 10314 | __startTimestamp1470729317638__endTimestamp 00:55:17 INFO - PROCESS | 10314 | 00:55:17 INFO - PROCESS | 10314 | ------- Summary: start ------- 00:55:17 INFO - PROCESS | 10314 | Number of tests: 6 00:55:17 INFO - PROCESS | 10314 | 00:55:17 INFO - PROCESS | 10314 | [#0] dojo.html Cycles:165 Average:4805.50 Median:4942.48 stddev:510.67 (10.3%) stddev-sans-first:484.17 00:55:17 INFO - PROCESS | 10314 | Values: 2676.9 2688.3 2699.8 2704.9 2725.9 4671.5 4812.2 4834.1 4845.7 4872.8 4745.9 4784.3 4805.3 4810.7 4812.0 4423.4 4434.4 4434.9 4439.0 4499.4 4435.9 4442.4 4462.5 4474.0 4525.1 4550.0 4580.0 4591.4 4592.3 4604.4 4274.7 4389.9 4402.1 4493.7 4558.2 4356.7 4362.4 4363.0 4430.7 4439.9 4818.7 4828.5 4832.6 4846.1 4890.4 5143.5 5166.3 5186.1 5251.4 5257.8 5275.4 5280.1 5295.5 5295.9 5301.5 4923.1 4928.3 4930.9 4950.8 4952.7 5145.9 5345.8 5389.6 5405.8 5483.8 5130.7 5148.5 5169.5 5188.6 5198.6 5246.1 5248.3 5252.3 5257.7 5311.8 4942.5 4980.3 5121.6 5165.5 5179.6 5118.4 5154.8 5177.2 5184.9 5192.9 4419.5 4431.7 4432.1 4441.7 4466.6 3745.9 3822.0 3874.3 3899.2 3907.8 4464.7 4482.8 4503.6 4526.9 4536.3 5198.4 5221.8 5222.4 5245.9 5281.8 4271.6 4450.4 4476.0 4501.6 4537.9 4698.2 4702.2 4709.6 4763.3 4770.9 4878.5 4931.4 4952.0 4965.5 4965.5 4975.4 5192.7 5277.7 5290.7 5313.5 4908.0 4917.4 4940.7 4947.0 4967.9 5176.4 5176.9 5183.7 5200.9 5222.2 5006.2 5122.2 5228.9 5242.0 5262.7 5002.1 5040.3 5043.9 5088.6 5092.0 5022.2 5033.8 5034.7 5037.9 5099.2 4787.4 4900.8 4934.8 4960.4 4967.2 5003.6 5047.4 5073.5 5095.0 5096.3 4935.0 4945.2 4950.0 4956.0 4960.3 00:55:17 INFO - PROCESS | 10314 | 00:55:17 INFO - PROCESS | 10314 | [#1] ext.html Cycles:180 Average:45875.37 Median:36979.72 stddev:83746.43 (226.5%) stddev-sans-first:83912.21 00:55:17 INFO - PROCESS | 10314 | Values: 545.8 552.4 558.1 574.7 576.4 34862.5 35934.8 39582.4 39631.0 39710.4 39317.4 40171.8 40310.2 40464.4 40632.2 7565.3 7736.3 7777.4 7778.7 7795.5 7613.5 7684.5 7688.6 7691.3 7696.9 7624.2 7665.8 7671.5 7673.6 7685.1 7569.8 7614.5 7652.4 7668.6 7675.1 7662.0 7679.4 7694.0 7700.7 7717.2 36689.0 36842.6 36863.1 36863.6 36982.4 3046.5 3292.6 3320.4 3618.4 3859.5 28877.6 29232.1 29593.3 29674.6 29686.3 3252.5 3270.4 3356.6 3457.8 3463.2 257602.0 258992.0 259247.0 259274.0 261253.0 31650.0 53047.7 53206.7 53536.7 53715.0 31956.0 33960.7 33976.8 34024.0 34137.1 13912.7 13966.4 14078.6 14113.9 14121.9 11832.4 11842.9 11850.7 11905.5 11926.8 7797.6 7883.5 7971.2 8020.9 8028.2 3080.7 3099.4 3113.5 3152.2 3159.5 858.7 865.9 910.6 979.2 996.5 25419.0 25451.6 25630.5 25766.7 25821.4 853.2 913.8 930.1 963.9 983.8 13070.6 13186.0 13648.1 13653.0 13673.5 391769.0 395216.0 396785.0 398722.0 400239.0 51609.0 52020.0 52092.5 52139.0 52139.2 1196.8 1209.3 1213.6 1222.0 1232.5 24199.7 26666.5 28667.4 28758.9 28966.7 44388.0 44535.6 44632.6 44676.8 44681.3 278762.0 278996.0 279083.3 279365.0 279512.0 25582.5 25666.7 25699.2 25961.1 26050.9 43425.8 43602.8 44089.0 44291.3 44402.8 36977.0 37145.0 37267.8 37991.0 39177.4 37331.6 37359.3 37483.4 37491.5 37673.6 32027.7 36089.5 36586.0 36714.6 37022.3 31846.5 34136.9 34261.5 34412.8 34427.7 26123.0 26200.2 26212.9 26232.6 26243.7 00:55:17 INFO - PROCESS | 10314 | 00:55:17 INFO - PROCESS | 10314 | [#2] jquery.html Cycles:180 Average:24452.84 Median:54096.09 stddev:66271.65 (122.5%) stddev-sans-first:66432.82 00:55:17 INFO - PROCESS | 10314 | Values: 338.5 359.3 364.8 366.0 378.6 15963.5 16703.8 16886.2 17207.1 17288.9 16064.8 16870.5 17343.8 17452.7 17502.6 4878.5 5104.3 5106.2 5108.1 5116.1 3727.5 5038.5 5642.6 5852.9 5923.7 5954.9 5959.1 5971.9 5980.5 5991.1 5738.3 5739.0 5768.7 5779.9 5782.4 4561.5 5006.2 5118.8 5134.5 5138.9 12117.5 12778.8 12870.8 12893.9 12943.6 1888.6 1921.8 1935.6 1992.6 2122.4 9355.6 9381.8 9392.5 9540.4 9683.4 1670.6 1706.9 1751.0 1754.5 1766.6 67775.7 68238.7 68934.0 70572.3 70618.6 9227.4 9340.7 9498.6 9597.5 10221.8 12095.5 12096.6 12105.6 12118.9 12149.4 7125.9 7258.6 7379.4 7500.8 7523.4 7073.8 7201.9 7217.0 7546.1 7560.8 3829.2 3869.2 3882.5 3980.2 4000.5 1627.3 1657.0 1689.6 1760.4 1761.3 779.8 844.8 863.5 913.6 918.1 16785.0 17066.9 17629.8 17645.2 18110.0 853.2 858.8 874.1 882.2 914.1 9496.2 9598.8 9737.5 9840.4 9956.2 394700.0 397325.0 400063.0 401947.0 406589.0 81783.0 84962.0 85334.6 85370.0 87795.6 916.3 939.9 966.5 972.7 978.7 15286.6 15745.0 15782.4 16090.8 16502.8 24847.5 27925.7 37608.2 37742.8 38054.0 51786.7 52591.2 53880.7 54311.5 55406.0 7022.6 7335.8 7351.7 7550.7 7674.5 8226.5 10280.5 10797.3 11211.6 11348.4 9296.0 9336.4 9733.7 9888.5 10251.3 9999.3 10088.0 10136.7 10226.1 10672.4 9218.8 9603.0 9823.4 9866.8 9971.7 7457.6 7500.5 7519.6 7573.1 7697.2 7343.8 9482.9 9722.2 9776.1 10033.6 00:55:17 INFO - PROCESS | 10314 | 00:55:17 INFO - PROCESS | 10314 | [#3] mootools.html Cycles:180 Average:5083.91 Median:4991.21 stddev:2875.69 (57.6%) stddev-sans-first:2870.26 00:55:17 INFO - PROCESS | 10314 | Values: 1376.3 1404.1 1493.9 1668.6 1697.5 6696.0 7216.3 7340.8 7933.1 7933.7 7279.2 7470.2 7477.2 7541.9 7543.8 2162.1 2205.7 2209.9 2210.8 2214.0 2108.1 2143.8 2182.4 2184.9 2189.9 2193.5 2199.8 2202.4 2211.6 2215.9 2138.0 2147.1 2148.4 2157.8 2162.3 2106.7 2152.1 2152.3 2171.6 2174.7 7716.0 7729.8 7732.9 7749.2 7846.5 4546.7 4582.3 4673.4 4679.5 4681.7 2829.5 2925.6 2939.0 2957.5 2967.4 874.3 921.3 921.4 927.1 932.3 10583.7 10584.5 10625.2 10643.8 10646.8 3902.2 4080.8 4165.0 4177.6 4254.6 9181.3 9181.7 9182.9 9186.5 9192.5 4671.2 4697.1 4697.6 4708.8 4721.2 3435.2 4119.3 4190.1 4240.9 4294.2 3527.6 3562.5 3617.7 3688.1 3792.9 1132.0 1132.3 1140.2 1142.8 1151.8 679.4 806.1 823.4 824.7 826.5 5020.4 5044.5 5049.1 5129.5 5184.2 397.9 401.5 403.7 408.9 416.8 3501.1 3528.2 3532.0 3544.2 3589.9 9065.8 9540.5 9548.5 9558.9 9568.7 9536.5 9536.7 9547.2 9552.6 9559.3 6918.6 7000.8 7158.2 7339.6 7430.4 4962.0 5101.9 5246.8 5343.3 5425.9 8584.9 8787.9 8915.6 8916.4 8918.2 9040.1 9066.0 9119.3 9130.6 9169.0 5670.3 6593.5 6722.2 6855.7 6974.0 7499.0 7511.1 7531.5 7543.0 7551.5 6828.4 6836.4 6914.2 6999.3 7113.1 6729.9 6761.1 6770.7 6825.4 6843.7 6101.2 6114.3 6115.2 6136.2 6204.2 4378.3 4380.3 4414.5 4541.9 4576.8 4396.2 4479.1 4495.6 4558.1 4631.7 00:55:17 INFO - PROCESS | 10314 | 00:55:17 INFO - PROCESS | 10314 | [#4] prototype.html Cycles:180 Average:4471.52 Median:5115.14 stddev:1300.95 (25.4%) stddev-sans-first:1266.32 00:55:17 INFO - PROCESS | 10314 | Values: 298.1 299.0 302.8 309.3 309.9 5144.8 5184.9 5185.2 5192.7 5208.9 5023.8 5051.3 5052.4 5064.7 5121.1 3762.5 3898.9 3965.0 3982.3 4032.6 3988.3 3988.7 3992.8 4029.2 4037.9 3988.3 4012.4 4022.7 4031.2 4053.9 3796.2 4001.7 4004.2 4034.8 4037.8 3540.1 3542.2 3548.3 3549.7 3552.7 5004.2 5014.3 5044.4 5048.8 5053.8 4487.8 4591.3 4627.8 4636.2 4639.8 5219.9 5302.9 5313.7 5320.2 5332.9 3841.6 3865.2 3876.9 3887.9 3899.3 5545.3 5562.9 5621.2 5666.9 5687.9 3886.7 3947.3 3952.4 3962.7 3992.6 4033.3 4043.2 4050.6 4050.8 4061.9 4571.6 4583.7 4600.3 4601.5 4608.1 5234.2 5243.8 5321.5 5323.8 5389.8 1374.9 1396.3 1399.2 1401.6 1406.1 851.9 867.9 908.7 910.9 915.7 4553.0 4652.6 4667.4 4675.4 4693.6 5517.6 5536.7 5579.7 5592.2 5598.4 4427.4 4657.3 4670.4 4684.6 4693.0 2905.4 2928.7 2957.3 2964.5 2969.0 5161.2 5201.9 5215.0 5252.0 5271.2 5462.8 5631.0 5674.7 5699.0 5759.2 5203.8 5205.8 5206.4 5222.6 5256.3 5596.0 5630.6 5635.7 5664.1 5670.2 5109.2 5442.8 5448.1 5507.7 5525.0 5290.4 5290.9 5294.8 5307.2 5313.7 3803.2 3878.3 3895.6 3905.6 3918.2 5512.3 5563.2 5577.5 5591.3 5643.3 5374.7 5377.8 5395.2 5421.3 5481.6 5083.2 5331.3 5367.2 5401.4 5457.2 5267.7 5268.3 5272.3 5296.9 5323.4 5213.2 5269.0 5398.0 5408.3 5416.2 5284.8 5289.6 5320.2 5330.8 5332.1 00:55:17 INFO - PROCESS | 10314 | 00:55:17 INFO - PROCESS | 10314 | [#5] yui.html Cycles:180 Average:18339.63 Median:48170.88 stddev:27075.12 (56.2%) stddev-sans-first:27118.41 00:55:17 INFO - PROCESS | 10314 | Values: 627.5 664.4 667.6 682.3 699.1 12669.8 13744.5 13745.7 13763.3 13771.5 13427.5 13538.9 13754.0 14258.3 14350.5 760.4 779.7 781.2 783.2 784.0 630.4 744.7 763.6 766.4 778.9 809.9 816.2 817.7 817.7 818.2 814.0 814.3 814.4 814.8 815.1 592.4 593.5 593.6 594.2 594.3 13657.5 13675.4 13730.2 13736.5 13739.5 13431.9 13495.5 13740.7 13798.3 13812.7 10708.6 10754.9 10815.5 10874.4 10883.2 3281.0 3307.3 3315.7 3326.8 3398.1 50970.0 52896.2 53041.7 70565.3 70750.6 10225.3 10595.7 10619.9 10798.5 10892.3 16541.9 16607.2 16705.5 16765.4 17207.1 7056.7 7103.9 7109.1 7275.3 7428.3 3728.6 3767.3 3782.8 3811.5 3907.2 3037.6 3135.1 3160.0 3164.1 3164.7 522.1 526.9 526.9 531.8 545.2 476.7 516.2 555.3 574.5 584.4 7726.7 7926.8 8156.0 8261.3 8297.1 517.5 523.6 544.6 549.6 550.6 3890.9 3968.4 4006.4 4050.8 4178.3 105475.5 105497.0 105882.5 108184.5 109202.0 87793.0 88475.6 90531.5 90642.5 91469.5 76133.0 79875.0 80239.0 81191.0 81392.6 7749.7 7769.8 7799.7 7994.0 8022.5 47172.8 47457.3 47900.0 48441.8 48950.0 60689.1 61114.4 67032.3 68257.3 69046.0 9175.6 9387.7 9425.6 9522.9 9566.7 10626.0 10728.9 10975.2 11060.7 11090.0 10191.8 11090.5 11451.3 11465.9 11466.4 11142.4 11400.9 11551.2 11859.3 11869.2 10977.0 11181.7 11278.2 11345.3 11455.1 9352.9 9776.7 10187.8 10347.8 10741.8 9744.4 10306.9 10330.9 10396.1 10417.2 00:55:17 INFO - PROCESS | 10314 | -------- Summary: end -------- 00:55:17 INFO - PROCESS | 10314 | 00:55:18 INFO - TEST-INFO | 10314: exit 0 00:55:18 INFO - TEST-OK | dromaeo_css | took 1117605ms 00:55:18 INFO - TEST-START | kraken 00:55:18 INFO - operating with platform_type : linux_ 00:55:18 INFO - Initialising browser for kraken test... 00:55:18 INFO - TEST-INFO | started process 10560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGtS9Zw/profile http://localhost:48661/getInfo.html) 00:55:23 INFO - PROCESS | 10560 | __metrics Screen width/height:1600/1200 00:55:23 INFO - PROCESS | 10560 | colorDepth:24 00:55:23 INFO - PROCESS | 10560 | Browser inner width/height: 1024/697 00:55:23 INFO - PROCESS | 10560 | __metrics 00:55:23 ERROR - PROCESS | 10560 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 00:55:24 INFO - TEST-INFO | 10560: exit 0 00:55:24 INFO - Browser initialized. 00:55:24 INFO - Running cycle 1/1 for kraken test... 00:55:24 INFO - TEST-INFO | started process 10682 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGtS9Zw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:55:36 INFO - PROCESS | 10682 | RSS: Main: 164372480 00:55:36 INFO - PROCESS | 10682 | 00:55:39 INFO - PROCESS | 10682 | Cycle 1(1): loaded http://localhost:48661/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48661/tests/kraken/driver.html?testName=audio-beat-detection) 00:55:40 INFO - PROCESS | 10682 | RSS: Main: 169791488 00:55:40 INFO - PROCESS | 10682 | 00:55:43 INFO - PROCESS | 10682 | Cycle 1(1): loaded http://localhost:48661/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48661/tests/kraken/driver.html?testName=audio-dft) 00:55:43 INFO - PROCESS | 10682 | RSS: Main: 168833024 00:55:43 INFO - PROCESS | 10682 | 00:55:46 INFO - PROCESS | 10682 | Cycle 1(1): loaded http://localhost:48661/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48661/tests/kraken/driver.html?testName=audio-fft) 00:55:47 INFO - PROCESS | 10682 | RSS: Main: 164937728 00:55:47 INFO - PROCESS | 10682 | 00:55:49 INFO - PROCESS | 10682 | Cycle 1(1): loaded http://localhost:48661/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48661/tests/kraken/driver.html?testName=audio-oscillator) 00:55:50 INFO - PROCESS | 10682 | RSS: Main: 165707776 00:55:50 INFO - PROCESS | 10682 | 00:55:52 INFO - PROCESS | 10682 | Cycle 1(1): loaded http://localhost:48661/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48661/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:55:53 INFO - PROCESS | 10682 | RSS: Main: 166268928 00:55:53 INFO - PROCESS | 10682 | 00:55:56 INFO - PROCESS | 10682 | Cycle 1(1): loaded http://localhost:48661/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48661/tests/kraken/driver.html?testName=imaging-darkroom) 00:55:56 INFO - PROCESS | 10682 | RSS: Main: 166387712 00:55:56 INFO - PROCESS | 10682 | 00:56:00 INFO - PROCESS | 10682 | Cycle 1(1): loaded http://localhost:48661/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48661/tests/kraken/driver.html?testName=imaging-desaturate) 00:56:01 INFO - PROCESS | 10682 | RSS: Main: 163667968 00:56:01 INFO - PROCESS | 10682 | 00:56:04 INFO - PROCESS | 10682 | Cycle 1(1): loaded http://localhost:48661/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48661/tests/kraken/driver.html?testName=json-parse-financial) 00:56:04 INFO - PROCESS | 10682 | RSS: Main: 165298176 00:56:04 INFO - PROCESS | 10682 | 00:56:06 INFO - PROCESS | 10682 | Cycle 1(1): loaded http://localhost:48661/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48661/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:56:07 INFO - PROCESS | 10682 | RSS: Main: 165466112 00:56:07 INFO - PROCESS | 10682 | 00:56:09 INFO - PROCESS | 10682 | Cycle 1(1): loaded http://localhost:48661/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48661/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:56:09 INFO - PROCESS | 10682 | RSS: Main: 165728256 00:56:09 INFO - PROCESS | 10682 | 00:56:11 INFO - PROCESS | 10682 | Cycle 1(1): loaded http://localhost:48661/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48661/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:56:12 INFO - PROCESS | 10682 | RSS: Main: 166248448 00:56:12 INFO - PROCESS | 10682 | 00:56:15 INFO - PROCESS | 10682 | Cycle 1(1): loaded http://localhost:48661/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48661/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:56:16 INFO - PROCESS | 10682 | RSS: Main: 166494208 00:56:16 INFO - PROCESS | 10682 | 00:56:18 INFO - PROCESS | 10682 | Cycle 1(1): loaded http://localhost:48661/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48661/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:56:19 INFO - PROCESS | 10682 | RSS: Main: 166588416 00:56:19 INFO - PROCESS | 10682 | 00:56:21 INFO - PROCESS | 10682 | Cycle 1(1): loaded http://localhost:48661/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48661/tests/kraken/driver.html?testName=ai-astar) 00:56:21 INFO - PROCESS | 10682 | RSS: Main: 167055360 00:56:21 INFO - PROCESS | 10682 | 00:56:21 INFO - PROCESS | 10682 | __start_tp_report 00:56:21 INFO - PROCESS | 10682 | _x_x_mozilla_page_load 00:56:21 INFO - PROCESS | 10682 | _x_x_mozilla_page_load_details 00:56:21 INFO - PROCESS | 10682 | |i|pagename|runs| 00:56:21 INFO - PROCESS | 10682 | |0;ai-astar;104;116;110;115;114;115;117;116;115;115 00:56:21 INFO - PROCESS | 10682 | |1;audio-beat-detection;155;124;152;188;129;160;148;126;174;126 00:56:21 INFO - PROCESS | 10682 | |2;audio-dft;166;163;166;175;163;164;163;167;162;163 00:56:21 INFO - PROCESS | 10682 | |3;audio-fft;76;76;76;167;77;76;76;76;163;76 00:56:21 INFO - PROCESS | 10682 | |4;audio-oscillator;86;87;157;86;85;85;138;86;85;134 00:56:21 INFO - PROCESS | 10682 | |5;imaging-gaussian-blur;117;118;117;118;118;118;119;119;118;117 00:56:21 INFO - PROCESS | 10682 | |6;imaging-darkroom;149;149;147;149;148;147;148;149;147;148 00:56:21 INFO - PROCESS | 10682 | |7;imaging-desaturate;96;97;98;98;97;96;95;95;95;96 00:56:21 INFO - PROCESS | 10682 | |8;json-parse-financial;63;65;65;66;63;68;66;65;63;64 00:56:21 INFO - PROCESS | 10682 | |9;json-stringify-tinderbox;66;66;65;67;67;66;66;67;66;66 00:56:21 INFO - PROCESS | 10682 | |10;stanford-crypto-aes;80;86;89;86;84;87;80;81;83;79 00:56:21 INFO - PROCESS | 10682 | |11;stanford-crypto-ccm;149;132;134;135;136;134;142;151;166;133 00:56:21 INFO - PROCESS | 10682 | |12;stanford-crypto-pbkdf2;172;168;168;171;166;171;173;170;168;169 00:56:21 INFO - PROCESS | 10682 | |13;stanford-crypto-sha256-iterative;69;79;69;69;70;67;68;67;67;67 00:56:21 INFO - PROCESS | 10682 | __end_tp_report 00:56:21 INFO - PROCESS | 10682 | __start_cc_report 00:56:21 INFO - PROCESS | 10682 | _x_x_mozilla_cycle_collect,954 00:56:21 INFO - PROCESS | 10682 | __end_cc_report 00:56:21 INFO - PROCESS | 10682 | __startTimestamp1470729381629__endTimestamp 00:56:21 INFO - PROCESS | 10682 | 00:56:21 INFO - PROCESS | 10682 | ------- Summary: start ------- 00:56:21 INFO - PROCESS | 10682 | Number of tests: 14 00:56:21 INFO - PROCESS | 10682 | 00:56:21 INFO - PROCESS | 10682 | [#0] ai-astar Cycles:10 Average:113.70 Median:115.00 stddev:3.89 (3.4%) stddev-sans-first:1.99 00:56:21 INFO - PROCESS | 10682 | Values: 104.0 116.0 110.0 115.0 114.0 115.0 117.0 116.0 115.0 115.0 00:56:21 INFO - PROCESS | 10682 | 00:56:21 INFO - PROCESS | 10682 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:153.50 stddev:22.08 (14.4%) stddev-sans-first:23.29 00:56:21 INFO - PROCESS | 10682 | Values: 155.0 124.0 152.0 188.0 129.0 160.0 148.0 126.0 174.0 126.0 00:56:21 INFO - PROCESS | 10682 | 00:56:21 INFO - PROCESS | 10682 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.00 stddev:3.82 (2.3%) stddev-sans-first:4.04 00:56:21 INFO - PROCESS | 10682 | Values: 166.0 163.0 166.0 175.0 163.0 164.0 163.0 167.0 162.0 163.0 00:56:21 INFO - PROCESS | 10682 | 00:56:21 INFO - PROCESS | 10682 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:37.49 (49.3%) stddev-sans-first:39.20 00:56:21 INFO - PROCESS | 10682 | Values: 76.0 76.0 76.0 167.0 77.0 76.0 76.0 76.0 163.0 76.0 00:56:21 INFO - PROCESS | 10682 | 00:56:21 INFO - PROCESS | 10682 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:85.50 stddev:28.28 (33.1%) stddev-sans-first:29.32 00:56:21 INFO - PROCESS | 10682 | Values: 86.0 87.0 157.0 86.0 85.0 85.0 138.0 86.0 85.0 134.0 00:56:21 INFO - PROCESS | 10682 | 00:56:21 INFO - PROCESS | 10682 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 00:56:21 INFO - PROCESS | 10682 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 119.0 119.0 118.0 117.0 00:56:21 INFO - PROCESS | 10682 | 00:56:21 INFO - PROCESS | 10682 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.50 stddev:0.88 (0.6%) stddev-sans-first:0.87 00:56:21 INFO - PROCESS | 10682 | Values: 149.0 149.0 147.0 149.0 148.0 147.0 148.0 149.0 147.0 148.0 00:56:21 INFO - PROCESS | 10682 | 00:56:21 INFO - PROCESS | 10682 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:1.16 (1.2%) stddev-sans-first:1.22 00:56:21 INFO - PROCESS | 10682 | Values: 96.0 97.0 98.0 98.0 97.0 96.0 95.0 95.0 95.0 96.0 00:56:21 INFO - PROCESS | 10682 | 00:56:21 INFO - PROCESS | 10682 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:1.62 (2.5%) stddev-sans-first:1.58 00:56:21 INFO - PROCESS | 10682 | Values: 63.0 65.0 65.0 66.0 63.0 68.0 66.0 65.0 63.0 64.0 00:56:21 INFO - PROCESS | 10682 | 00:56:21 INFO - PROCESS | 10682 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 00:56:21 INFO - PROCESS | 10682 | Values: 66.0 66.0 65.0 67.0 67.0 66.0 66.0 67.0 66.0 66.0 00:56:21 INFO - PROCESS | 10682 | 00:56:21 INFO - PROCESS | 10682 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:85.00 stddev:3.44 (4.0%) stddev-sans-first:3.41 00:56:21 INFO - PROCESS | 10682 | Values: 80.0 86.0 89.0 86.0 84.0 87.0 80.0 81.0 83.0 79.0 00:56:21 INFO - PROCESS | 10682 | 00:56:21 INFO - PROCESS | 10682 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:139.00 stddev:11.02 (7.9%) stddev-sans-first:11.32 00:56:21 INFO - PROCESS | 10682 | Values: 149.0 132.0 134.0 135.0 136.0 134.0 142.0 151.0 166.0 133.0 00:56:21 INFO - PROCESS | 10682 | 00:56:21 INFO - PROCESS | 10682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:170.50 stddev:2.17 (1.3%) stddev-sans-first:2.12 00:56:21 INFO - PROCESS | 10682 | Values: 172.0 168.0 168.0 171.0 166.0 171.0 173.0 170.0 168.0 169.0 00:56:21 INFO - PROCESS | 10682 | 00:56:21 INFO - PROCESS | 10682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:3.61 (5.2%) stddev-sans-first:3.83 00:56:21 INFO - PROCESS | 10682 | Values: 69.0 79.0 69.0 69.0 70.0 67.0 68.0 67.0 67.0 67.0 00:56:21 INFO - PROCESS | 10682 | -------- Summary: end -------- 00:56:21 INFO - PROCESS | 10682 | 00:56:22 INFO - TEST-INFO | 10682: exit 0 00:56:22 INFO - TEST-OK | kraken | took 64298ms 00:56:22 INFO - SUITE-END | took 1181s 00:56:22 INFO - Completed test suite (00:19:41) 00:56:22 INFO - javascript benchmark 00:56:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6378.394061186348, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2676.8661566921655, 2688.287603784996, 2699.7570218680326, 2704.9188524344277, 2725.8773355199014, 4671.532846715327, 4812.205986012308, 4834.0815245103495, 4845.6850304730215, 4872.805087796488, 4745.857624271269, 4784.282357646355, 4805.3032310315075, 4810.687305325151, 4812.0375924815, 4423.4249547558775, 4434.379186913835, 4434.933475997855, 4438.977805110986, 4499.437570303712, 4435.866923992286, 4442.355858400546, 4462.464504259493, 4474.0380818124095, 4525.094981003813, 4549.954500455003, 4580.038191979688, 4591.357209990604, 4592.288195329713, 4604.424446944132, 4274.743515389056, 4389.912201755979, 4402.097569998143, 4493.662975276835, 4558.247889098328, 4356.716813407118, 4362.432883725127, 4362.956370436286, 4430.689851710382, 4439.933400998988, 4818.71087734737, 4828.534696684324, 4832.565069143759, 4846.103470857867, 4890.388701412324, 5143.485651434864, 5166.302549155854, 5186.0665080285535, 5251.4485978972425, 5257.76340064698, 5275.446078161776, 5280.075986702312, 5295.523402893758, 5295.920561191585, 5301.469853014668, 4923.113839508923, 4928.285398617216, 4930.876728081755, 4950.75246237683, 4952.727599981963, 5145.9485405146215, 5345.812896548602, 5389.568834493231, 5405.78376864921, 5483.7806487740845, 5130.743462826844, 5148.510891465305, 5169.53474187325, 5188.610854185951, 5198.584113270929, 5246.0557099721655, 5248.317718696545, 5252.264682944391, 5257.737113144328, 5311.814086506954, 4942.481039490874, 4980.252962055648, 5121.590272778169, 5165.535101840853, 5179.585633149339, 5118.411382691038, 5154.768035438415, 5177.197534382101, 5184.8963020739375, 5192.948070519322, 4419.491758447755, 4431.667624928144, 4432.069265454226, 4441.689081764245, 4466.642668586505, 3745.8688945886765, 3821.9871733990517, 3874.302625527432, 3899.220155968761, 3907.843686252518, 4464.709793863389, 4482.843100491467, 4503.639708823352, 4526.886827829265, 4536.274196128604, 5198.428172900978, 5221.817236396708, 5222.4255331913455, 5245.868853278622, 5281.815136470205, 4271.594198551133, 4450.421445212167, 4475.977620111944, 4501.572350626685, 4537.909241815145, 4698.154332220165, 4702.200625893606, 4709.62323014158, 4763.261694437368, 4770.928436073462, 4878.536539028786, 4931.432885218246, 4951.9752401237765, 4965.503449654933, 4965.50344965515, 4975.353204083446, 5192.662476938987, 5277.656952298088, 5290.7354632269, 5313.4952179544425, 4908.042931628298, 4917.409910810726, 4940.6788558743565, 4946.950530494649, 4967.900641987212, 5176.4305926348825, 5176.870578235424, 5183.714895680774, 5200.869978250574, 5222.190560463135, 5006.249062640633, 5122.154844450624, 5228.8757917048015, 5242.0, 5262.736863156903, 5002.149634562061, 5040.294358789845, 5043.87390315245, 5088.618353623419, 5091.974540127276, 5022.221555658879, 5033.823816166417, 5034.723090229926, 5037.949620503748, 5099.23511473282, 4787.3537072496165, 4900.828471003498, 4934.827281045146, 4960.379952505937, 4967.155583550732, 5003.574696150868, 5047.394312682502, 5073.518015788494, 5095.031943930641, 5096.311997880239, 4935.0, 4945.208766597327, 4950.0, 4955.975220123876, 4960.30555722192], "value": 4772.515331944026, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.7680485793537, 552.353746117043, 558.1348909190754, 574.6552068758742, 576.3573615418804, 34862.477062844046, 35934.8203258984, 39582.406263906065, 39630.99999999996, 39710.404343934795, 39317.42730290785, 40171.79914100425, 40310.19379612406, 40464.39303410451, 40632.187356252856, 7565.2812982766545, 7736.34241089508, 7777.416693747963, 7778.727744528915, 7795.532268063935, 7613.543187408745, 7684.462087653867, 7688.615569221516, 7691.307782299592, 7696.884546731803, 7624.199459056802, 7665.770026899202, 7671.501352412075, 7673.577953212571, 7685.116211635677, 7569.848603027936, 7614.505057171294, 7652.426068044919, 7668.578228197447, 7675.117361503415, 7662.0, 7679.385649148055, 7693.9615301923695, 7700.730474433368, 7717.228277172294, 36689.0, 36842.631573684186, 36863.07842303937, 36863.63136368629, 36982.445263321075, 3046.466868298039, 3292.6378098409155, 3320.4355259605927, 3618.4029635110173, 3859.517560304962, 28877.56683649726, 29232.123036308945, 29593.260168495744, 29674.55488167679, 29686.257843553867, 3252.4796032634663, 3270.3949769292517, 3356.6475520070285, 3457.8271086445575, 3463.2207753255566, 257602.0, 258992.0, 259247.0, 259274.0, 261253.0, 31650.0, 53047.73476132672, 53206.73396632992, 53536.732316338945, 53715.0, 31956.0, 33960.66039339625, 33976.83011584926, 34024.0, 34137.146571335914, 13912.652183695489, 13966.441342346192, 14078.577642670736, 14113.85886141146, 14121.85878141226, 11832.408379580986, 11842.88157118435, 11850.703732406759, 11905.464254108585, 11926.761464770656, 7797.610119494003, 7883.487573307832, 7971.202879712098, 8020.879686804703, 8028.197180281925, 3080.6765289644713, 3099.395617854497, 3113.532970054465, 3152.2119470132466, 3159.462891308483, 858.6951632170615, 865.9307255419551, 910.644848509082, 979.2361957673027, 996.4917891875195, 25419.0, 25451.61822572663, 25630.487390252463, 25766.74233257681, 25821.3544661385, 853.249140756143, 913.8263729891299, 930.06993006993, 963.9325247232766, 983.7688143286322, 13070.607881763563, 13186.0, 13648.112872663245, 13653.0, 13673.521426750214, 391769.0, 395216.0, 396785.0, 398722.0, 400239.0, 51609.0, 52020.0, 52092.47907520952, 52139.0, 52139.21791173136, 1196.75685775113, 1209.2804781155198, 1213.5813144465146, 1221.9633410997685, 1232.5069972011268, 24199.738812294105, 26666.466670666865, 28667.426651466438, 28758.85620571884, 28966.710332897244, 44388.00253988643, 44535.55464445314, 44632.55367446284, 44676.77661611671, 44681.32978005268, 278762.0, 278996.0, 279083.2550047004, 279365.0, 279512.0, 25582.488350232517, 25666.743332566435, 25699.229023129337, 25961.144274129452, 26050.86974565115, 43425.7828710867, 43602.78198608987, 44089.0, 44291.33562996622, 44402.77798610986, 36977.0, 37145.0, 37267.81366093152, 37991.0, 39177.41233881437, 37331.626683732815, 37359.25281494409, 37483.43774843434, 37491.53959469599, 37673.62326376701, 32027.67972320247, 36089.45865811963, 36586.0, 36714.63285367112, 37022.259554809294, 31846.52230216595, 34136.851898841676, 34261.486077709356, 34412.82793586016, 34427.65572344245, 26123.0, 26200.213993580222, 26212.8689356552, 26232.606510902733, 26243.73756262413], "value": 16480.81292406378, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.5345150418175, 359.3280565342809, 364.7665494083785, 365.99085022874425, 378.64785749253184, 15963.521094367174, 16703.832961670396, 16886.155692215387, 17207.13964301786, 17288.913555432206, 16064.83935160648, 16870.493885183434, 17343.82656173438, 17452.738208926876, 17502.649947001053, 4878.463369029404, 5104.310918026074, 5106.183010718286, 5108.055009823194, 5116.1302578561545, 3727.4967879336214, 5038.470960549126, 5642.57680673949, 5852.882942341151, 5923.733431995571, 5954.880902381949, 5959.1359252908305, 5971.880562388749, 5980.491658209057, 5991.131285963555, 5738.311402631669, 5739.0, 5768.740406681667, 5779.884402311951, 5782.363939966643, 4561.543845615412, 5006.224035274538, 5118.795248190068, 5134.5378915897745, 5138.871528211787, 12117.454714537867, 12778.808317875239, 12870.806937895939, 12893.871061289361, 12943.611691649265, 1888.612834368951, 1921.807819218067, 1935.632229876319, 1992.621401933628, 2122.4163355077476, 9355.578998945064, 9381.812363752686, 9392.530373481299, 9540.427574345493, 9683.41899486026, 1670.599056226497, 1706.9402570909958, 1751.0, 1754.5350482122249, 1766.646670665872, 67775.66112169457, 68238.65880670614, 68934.0, 70572.29427705708, 70618.64690676513, 9227.400218985744, 9340.673076442292, 9498.620055197714, 9597.520123993772, 10221.795564088825, 12095.455704493143, 12096.576619818265, 12105.636830894911, 12118.939405302917, 12149.392530373447, 7125.89311160333, 7258.6007769572125, 7379.372753315921, 7500.849983000418, 7523.360514356232, 7073.82315442118, 7201.855962880818, 7216.96391518039, 7546.132194797558, 7560.810979725551, 3829.157585331223, 3869.2068126034096, 3882.5340959085092, 3980.20395920817, 4000.4999375078114, 1627.2839950421776, 1656.9751453728204, 1689.6198355370188, 1760.4278609451978, 1761.3218910719465, 779.8011507065662, 844.7550210439027, 863.5423225690395, 913.6299798581585, 918.0681608167715, 16785.0, 17066.914665426593, 17629.82370176282, 17645.205965731573, 18110.0, 853.249140756143, 858.7810108422437, 874.0691163910415, 882.170759486081, 914.0996118822954, 9496.192823609932, 9598.760030999141, 9737.513124343895, 9840.3603765755, 9956.203503719686, 394700.0, 397325.0, 400063.0, 401947.0, 406589.0, 81783.0, 84962.0, 85334.57332713297, 85370.0, 87795.56102219448, 916.2624087609405, 939.8825146856643, 966.5264020629982, 972.7033254857337, 978.6721448314894, 15286.617834554225, 15744.97657652249, 15782.368705251662, 16090.758638620664, 16502.75245871289, 24847.509149451093, 27925.720742792313, 37608.247835043694, 37742.8112859434, 38054.0, 51786.741066294424, 52591.21113183382, 53880.73059634834, 54311.45688543064, 55406.0, 7022.6488675565, 7335.816604584928, 7351.66917488725, 7550.66022029021, 7674.462787604814, 8226.465279756796, 10280.537375818256, 10797.29817561856, 11211.55153793839, 11348.375839328586, 9295.953520232626, 9336.39313444624, 9733.707988760349, 9888.50557472138, 10251.282410231212, 9999.250056245664, 10088.041636044563, 10136.695899123039, 10226.130778883879, 10672.359658420519, 9218.769530761785, 9602.95198524003, 9823.410595364301, 9866.802663946537, 9971.700848974542, 7457.589832559262, 7500.474966752275, 7519.624018798929, 7573.053368328959, 7697.230276972482, 7343.77968660941, 9482.857757133786, 9722.173615242784, 9776.086783755725, 10033.648822291476], "value": 8011.540660294019, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.256821316489, 1404.1294397473564, 1493.8804895608353, 1668.5661727950744, 1697.4568138195782, 6695.966520167404, 7216.314450127243, 7340.816479588013, 7933.127355990837, 7933.682652693892, 7279.235680253577, 7470.178280389153, 7477.177510473857, 7541.886871696929, 7543.849123017536, 2162.113533451285, 2205.680176374433, 2209.933701988943, 2210.8120809731113, 2213.9557208855895, 2108.093519786491, 2143.764185939553, 2182.388931099295, 2184.857984231028, 2189.890505474728, 2193.4954960359128, 2199.83501237407, 2202.4053505553493, 2211.579799838026, 2215.9335219943428, 2137.9893100534478, 2147.0552956699003, 2148.3769706785015, 2157.7842215778455, 2162.2540223622823, 2106.694529293259, 2152.13914434226, 2152.3435352217566, 2171.630822760119, 2174.749903761072, 7715.961420192919, 7729.768106956801, 7732.884006739903, 7749.186335434754, 7846.5292082475235, 4546.749928753918, 4582.266837306015, 4673.415823022122, 4679.4618618858585, 4681.672282940195, 2829.533127034037, 2925.561165825122, 2939.0, 2957.5267957126757, 2967.436187124461, 874.335505016186, 921.2906062332033, 921.4010892919589, 927.1331305229631, 932.303208161147, 10583.735406614896, 10584.523696433602, 10625.20310976672, 10643.840342394948, 10646.787064258671, 3902.180542086137, 4080.755154690728, 4165.0, 4177.624013838708, 4254.595813397722, 9181.265498760084, 9181.678641247525, 9182.90817091834, 9186.540672966325, 9192.540372981324, 4671.15919134559, 4697.060587882437, 4697.647676424282, 4708.788104535304, 4721.197396442613, 3435.2270739083506, 4119.340905455113, 4190.057237121623, 4240.872773816791, 4294.184105020036, 3527.647235276503, 3562.4656301554974, 3617.6924961378577, 3688.096416377951, 3792.867249646249, 1131.9830202546805, 1132.252713209278, 1140.224647239885, 1142.765733024728, 1151.8329842172839, 679.4496457869142, 806.1132753970703, 823.4030328012143, 824.698984870518, 826.5454000299811, 5020.422651395063, 5044.520770526794, 5049.116404629175, 5129.538341549204, 5184.170532714747, 397.8945579421456, 401.52018338086293, 403.67705835331617, 408.9059516311265, 416.7541150721089, 3501.089716673683, 3528.1532432216595, 3531.9646803531637, 3544.202554425285, 3589.9282014359565, 9065.818683626423, 9540.475273860004, 9548.522573871278, 9558.904410955802, 9568.712938611852, 9536.475493847905, 9536.666216682383, 9547.188488978376, 9552.57013434397, 9559.283053770994, 6918.5502942309595, 7000.844860598047, 7158.176809666851, 7339.59632220233, 7430.368418684472, 4962.0, 5101.9489805101475, 5246.790128394821, 5343.278657381359, 5425.945740542544, 8584.871226931476, 8787.868181977148, 8915.598798054232, 8916.420432671855, 8918.24194943437, 9040.141186587263, 9065.954670226607, 9119.316051296311, 9130.634774609207, 9169.037251088539, 5670.347909990404, 6593.472522198117, 6722.159730033746, 6855.725770969106, 6974.0236366909685, 7499.0, 7511.136219334628, 7531.472796904164, 7543.0, 7551.471397002157, 6828.385445309946, 6836.38472537474, 6914.204866440424, 6999.300069993164, 7113.146422429135, 6729.865402691821, 6761.121054263111, 6770.729170833111, 6825.419839313714, 6843.692033858389, 6101.176341194059, 6114.327423983269, 6115.235595550556, 6136.171616831671, 6204.224471941007, 4378.321360189176, 4380.277254253013, 4414.492333381702, 4541.931871022003, 4576.794044267949, 4396.164728701537, 4479.148961697267, 4495.57292057254, 4558.133954548625, 4631.698939568917], "value": 4020.299934659108, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.1101412284331, 298.96711361750204, 302.83646830711416, 309.34573377307004, 309.9116751725759, 5144.845654630358, 5184.948150518494, 5185.222216667502, 5192.688438693681, 5208.90612971276, 5023.773930173142, 5051.31807206027, 5052.433745538886, 5064.72144032079, 5121.078205922932, 3762.5484941806953, 3898.941515877264, 3965.0, 3982.287616324979, 4032.576579459144, 3988.3419235826054, 3988.6809055275653, 3992.7604343739467, 4029.2344454553686, 4037.899052523681, 3988.282109220339, 4012.3780813973735, 4022.718409711307, 4031.21391328691, 4053.8986525336954, 3796.1648437343742, 4001.7398869073418, 4004.2391945530258, 4034.7579145251234, 4037.7577345359227, 3540.0972751948348, 3542.2384187399834, 3548.290341931598, 3549.6627820357025, 3552.6980206682465, 5004.249362595603, 5014.348134742497, 5044.39467263927, 5048.823291184827, 5053.772580233898, 4487.775611219458, 4591.265397536378, 4627.814887404534, 4636.188666983298, 4639.768011599406, 5219.947800521984, 5302.920456193122, 5313.681179129226, 5320.228566857784, 5332.880095180017, 3841.6350446707797, 3865.2269546090615, 3876.9030774230587, 3887.922241555153, 3899.298126337258, 5545.271789972335, 5562.916556251659, 5621.18492818539, 5666.858328541778, 5687.943120568824, 3886.6696330812197, 3947.348687466536, 3952.4268980997595, 3962.712118561479, 3992.5608183099835, 4033.253848038122, 4043.1711499142607, 4050.554439011765, 4050.837966481308, 4061.8578349757618, 4571.588557029817, 4583.662332210597, 4600.309953506934, 4601.470830854428, 4608.078384323148, 5234.241035049972, 5243.842684719464, 5321.521063104339, 5323.760430780624, 5389.838304850782, 1374.8588671402713, 1396.273937552467, 1399.230423267199, 1401.5795261421533, 1406.1282005156868, 851.880736696863, 867.8611422172548, 908.6819613135482, 910.940788848736, 915.7481692534607, 4553.0, 4652.55800698933, 4667.369905062773, 4675.4155730533685, 4693.647976401783, 5517.5585953124455, 5536.667799932017, 5579.716665166953, 5592.217089607459, 5598.412166722517, 4427.446569178853, 4657.301404789308, 4670.439547254283, 4684.625229981593, 4693.0, 2905.4334404791284, 2928.663203731598, 2957.290250339946, 2964.4960356739407, 2968.9703102969124, 5161.200013997836, 5201.945231633484, 5214.966163196356, 5252.0, 5271.156614941668, 5462.808801691922, 5631.030123762737, 5674.716264186774, 5699.0, 5759.22250496186, 5203.8178663746585, 5205.843824685341, 5206.370782754685, 5222.608304377187, 5256.316678831728, 5595.972020139873, 5630.577706671934, 5635.7037881286715, 5664.122061080539, 5670.177824215383, 5109.20807274873, 5442.755076021509, 5448.093167391381, 5507.73322135903, 5525.0, 5290.418054013979, 5290.947090529045, 5294.796648028042, 5307.230451584576, 5313.707746073848, 3803.2203398302727, 3878.301905657009, 3895.6493915546603, 3905.5899130592015, 3918.1967696622696, 5512.283403157564, 5563.221149039056, 5577.498025177753, 5591.329040515002, 5643.26637537134, 5374.731263436891, 5377.838664840061, 5395.2176934343515, 5421.2681288025615, 5481.561475082063, 5083.237514372874, 5331.333583302087, 5367.194920761761, 5401.432849550898, 5457.154141108134, 5267.71027593486, 5268.288781014514, 5272.340957380327, 5296.894062118813, 5323.387810401853, 5213.191955246943, 5268.973655131853, 5398.0, 5408.323959505062, 5416.18557783147, 5284.798585124912, 5289.576833853205, 5320.17537281722, 5330.840074797762, 5332.1202001670845], "value": 4052.510928247037, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.4854619212244, 664.4285914113862, 667.6061123936877, 682.3006418421118, 699.1330749870159, 12669.809952850715, 13744.450221991108, 13745.656358591028, 13763.311834408278, 13771.517996870112, 13427.530036448727, 13538.93230533846, 13754.0, 14258.287085645703, 14350.497732579362, 760.4182800157884, 779.7037125892182, 781.2421950707804, 783.1815752538611, 784.0434669702953, 630.3979699387097, 744.7467860927284, 763.5723994563062, 766.4098644044083, 778.906531216252, 809.9149589293128, 816.2286639125998, 817.652497688483, 817.6729308276707, 818.2104269380047, 814.0109766633539, 814.2956342763497, 814.3932770086294, 814.7759366174349, 815.0748899998486, 592.3661682000261, 593.4984937727613, 593.557799439416, 594.2037669522817, 594.2838879150613, 13657.453701851913, 13675.384607692678, 13730.244836533986, 13736.519221827188, 13739.519116830863, 13431.932840335736, 13495.460181592725, 13740.725185496334, 13798.310084495735, 13812.654683632989, 10708.571657133705, 10754.892451075468, 10815.459227038617, 10874.401907895062, 10883.23817332787, 3281.0, 3307.255867429833, 3315.6850099240532, 3326.7837590556537, 3398.065531978701, 50970.0, 52896.20655690129, 53041.734791326184, 70565.2943470569, 70750.64624676896, 10225.335353202017, 10595.682129536126, 10619.94690026545, 10798.51406686701, 10892.346459212473, 16541.917290413712, 16607.169641517874, 16705.498835034967, 16765.413210537572, 17207.1396430178, 7056.717731290793, 7103.92896071043, 7109.111361079865, 7275.308845659654, 7428.294312040348, 3728.5525736911745, 3767.3407153747985, 3782.7730336179916, 3811.5426148862316, 3907.1794923066473, 3037.559553864677, 3135.0908236611126, 3160.0361889623427, 3164.0666003529013, 3164.651888292286, 522.068108426457, 526.8524813052352, 526.8867193553405, 531.7607076815449, 545.2475583694555, 476.73064718434665, 516.2333934107846, 555.3252797850631, 574.5016520643353, 584.3905429591335, 7726.652300646484, 7926.801829954297, 8155.959220203979, 8261.256486916207, 8297.12880147588, 517.5161224255334, 523.5523627298682, 544.6106034185576, 549.5630973376176, 550.5568017745753, 3890.922181556353, 3968.3849003404516, 4006.358982562776, 4050.7569545827346, 4178.26880295947, 105475.47262263793, 105497.0, 105882.47058764657, 108184.4590777041, 109202.0, 87793.0, 88475.55762221148, 90531.54734226418, 90642.54678726564, 91469.54265228764, 76133.0, 79875.0, 80239.0, 81190.99999999882, 81392.59303703562, 7749.690012399441, 7769.7669069928, 7799.745151913433, 7993.960030199812, 8022.478538894953, 47172.7641361791, 47457.28814067723, 47900.0, 48441.75779121082, 48950.0, 60689.089663654195, 61114.38885611087, 67032.3296767026, 68257.31742682708, 69046.0, 9175.632974680939, 9387.671431500137, 9425.62297508092, 9522.906004244165, 9566.712998610054, 10626.0, 10728.89271107279, 10975.231733778559, 11060.723481913017, 11090.0, 10191.796164076528, 11090.500927458123, 11451.327874156988, 11465.942670286595, 11466.369349685847, 11142.3591856136, 11400.94299528497, 11551.249168804337, 11859.34773587461, 11869.169158158846, 10977.0, 11181.664550063511, 11278.210525263154, 11345.319280843176, 11455.140864435367, 9352.894030734746, 9776.748669585197, 10187.847182292124, 10347.793044138925, 10741.838872417076, 9744.366616169926, 10306.948465257627, 10330.948345258226, 10396.116330112025, 10417.166626669698], "value": 6558.416605353316, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1580.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 110.0, 115.0, 114.0, 115.0, 117.0, 116.0, 115.0, 115.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 152.0, 188.0, 129.0, 160.0, 148.0, 126.0, 174.0, 126.0], "value": 148.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 166.0, 175.0, 163.0, 164.0, 163.0, 167.0, 162.0, 163.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 167.0, 77.0, 76.0, 76.0, 76.0, 163.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 157.0, 86.0, 85.0, 85.0, 138.0, 86.0, 85.0, 134.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 119.0, 119.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 147.0, 149.0, 148.0, 147.0, 148.0, 149.0, 147.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 98.0, 98.0, 97.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 65.0, 66.0, 63.0, 68.0, 66.0, 65.0, 63.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 67.0, 67.0, 66.0, 66.0, 67.0, 66.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 86.0, 89.0, 86.0, 84.0, 87.0, 80.0, 81.0, 83.0, 79.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 132.0, 134.0, 135.0, 136.0, 134.0, 142.0, 151.0, 166.0, 133.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 168.0, 171.0, 166.0, 171.0, 173.0, 170.0, 168.0, 169.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 79.0, 69.0, 69.0, 70.0, 67.0, 68.0, 67.0, 67.0, 67.0], "value": 69.2, "unit": "score"}]}]} 00:56:22 INFO - Return code: 0 00:56:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:56:22 ERROR - # TBPL SUCCESS # 00:56:22 INFO - Running post-action listener: _resource_record_post_action 00:56:22 INFO - [mozharness: 2016-08-09 07:56:22.929966Z] Finished run-tests step (success) 00:56:22 INFO - Running post-run listener: _resource_record_post_run 00:56:22 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 536276992; Read time: 92; Write time: 412156 00:56:22 INFO - TinderboxPrint: CPU usage
13.3% 00:56:22 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 92 00:56:22 INFO - TinderboxPrint: I/O write bytes / time
536,276,992 / 412,156 00:56:22 INFO - TinderboxPrint: CPU idle
8,285.3 (86.7%) 00:56:22 INFO - TinderboxPrint: CPU user
1,219.3 (12.8%) 00:56:22 INFO - TinderboxPrint: Swap in / out
0 / 0 00:56:23 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 249794560; Read time: 80; Write time: 228448 00:56:23 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 286482432; Read time: 0; Write time: 183708 00:56:23 INFO - Running post-run listener: _upload_blobber_files 00:56:23 INFO - Blob upload gear active. 00:56:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:56:23 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 00:56:23 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'] 00:56:23 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 00:56:23 INFO - (blobuploader) - INFO - Open directory for files ... 00:56:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:56:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:56:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:56:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:56:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:56:28 INFO - (blobuploader) - INFO - Done attempting. 00:56:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:56:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:56:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:56:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:56:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:56:29 INFO - (blobuploader) - INFO - Done attempting. 00:56:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:56:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:56:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:56:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:56:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:56:30 INFO - (blobuploader) - INFO - Done attempting. 00:56:30 INFO - (blobuploader) - INFO - Iteration through files over. 00:56:30 INFO - Return code: 0 00:56:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:56:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:56:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a8de5fb4e29e20926ddbffab599d78ffd5c617ef28759bf9f3ee200a58a35e91146da75d56330d31521e8935b42a39dfaa7879cf6c77d78f4651dbe0b2084a68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b75717dfb37235b304e59bf56e0a1939a90bca84f59c05c4e50ca2a59ffc6414e931b50366f260be9f4b98deccd31c276519dc0c740f41bd0400dd0a89a2a683", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0d71533adb10dbc5cbda2d50dabefbab2ce0b5a8aa5e708d85ec57dbbfc0bc5ab121d8bd6f954ef0c9099c26491890086c3495db3b2a1d0f4b864447edd01dce"} 00:56:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:56:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:56:30 INFO - Contents: 00:56:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a8de5fb4e29e20926ddbffab599d78ffd5c617ef28759bf9f3ee200a58a35e91146da75d56330d31521e8935b42a39dfaa7879cf6c77d78f4651dbe0b2084a68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b75717dfb37235b304e59bf56e0a1939a90bca84f59c05c4e50ca2a59ffc6414e931b50366f260be9f4b98deccd31c276519dc0c740f41bd0400dd0a89a2a683", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0d71533adb10dbc5cbda2d50dabefbab2ce0b5a8aa5e708d85ec57dbbfc0bc5ab121d8bd6f954ef0c9099c26491890086c3495db3b2a1d0f4b864447edd01dce"} 00:56:30 INFO - Running post-run listener: copy_logs_to_upload_dir 00:56:30 INFO - Copying logs to upload dir... 00:56:30 INFO - mkdir: /builds/slave/test/build/upload/logs 00:56:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.591575 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-09 00:56:30.578077) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 00:56:30.581593) ========= 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=8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a8de5fb4e29e20926ddbffab599d78ffd5c617ef28759bf9f3ee200a58a35e91146da75d56330d31521e8935b42a39dfaa7879cf6c77d78f4651dbe0b2084a68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b75717dfb37235b304e59bf56e0a1939a90bca84f59c05c4e50ca2a59ffc6414e931b50366f260be9f4b98deccd31c276519dc0c740f41bd0400dd0a89a2a683", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0d71533adb10dbc5cbda2d50dabefbab2ce0b5a8aa5e708d85ec57dbbfc0bc5ab121d8bd6f954ef0c9099c26491890086c3495db3b2a1d0f4b864447edd01dce"} build_url:https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011174 build_url: 'https://queue.taskcluster.net/v1/task/R5WpqznLRJeYdhvbQNndvw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a8de5fb4e29e20926ddbffab599d78ffd5c617ef28759bf9f3ee200a58a35e91146da75d56330d31521e8935b42a39dfaa7879cf6c77d78f4651dbe0b2084a68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b75717dfb37235b304e59bf56e0a1939a90bca84f59c05c4e50ca2a59ffc6414e931b50366f260be9f4b98deccd31c276519dc0c740f41bd0400dd0a89a2a683", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0d71533adb10dbc5cbda2d50dabefbab2ce0b5a8aa5e708d85ec57dbbfc0bc5ab121d8bd6f954ef0c9099c26491890086c3495db3b2a1d0f4b864447edd01dce"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 00:56:30.606516) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 00:56:30.606841) ========= 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=8887e36bb8e381bfd44124ac000001a8-1470721790.203458-1088483614 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 00:56:30.692034) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 00:56:30.692358) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 00:56:30.692638) ========= ========= Total master_lag: 0.19 =========