builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1479155021.52 results: success (0) buildid: 20161114091743 builduid: 42ed84f7fcb64e2fb957c8f0e52037f0 revision: fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 12:23:41.517362) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 12:23:41.517884) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 12:23:41.518195) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 12:23:41.534158) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:23:41.534609) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-14 12:23:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 102M=0s 2016-11-14 12:23:41 (102 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086603 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:23:41.638402) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:23:41.638974) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016939 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:23:41.690196) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 12:23:41.690703) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 --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=2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-14 12:23:41,776 truncating revision to first 12 chars 2016-11-14 12:23:41,776 Setting DEBUG logging. 2016-11-14 12:23:41,776 attempt 1/10 2016-11-14 12:23:41,776 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fd3c6c15ec64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 12:23:43,010 unpacking tar archive at: mozilla-beta-fd3c6c15ec64/testing/mozharness/ program finished with exit code 0 elapsedTime=1.572843 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 12:23:43.279565) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 12:23:43.279947) ========= script_repo_revision: fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 12:23:43.280374) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 12:23:43.280642) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 12:23:43.290600) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-11-14 12:23:43.291006) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:23:43 INFO - MultiFileLogger online at 20161114 12:23:43 in /builds/slave/test 12:23:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:23:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:23:43 INFO - {'append_to_log': False, 12:23:43 INFO - 'base_work_dir': '/builds/slave/test', 12:23:43 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:23:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:23:43 INFO - 'branch': 'Mozilla-Beta', 12:23:43 INFO - 'buildbot_json_path': 'buildprops.json', 12:23:43 INFO - 'config_files': ('talos/linux_config.py',), 12:23:43 INFO - 'default_actions': ('clobber', 12:23:43 INFO - 'read-buildbot-config', 12:23:43 INFO - 'download-and-extract', 12:23:43 INFO - 'populate-webroot', 12:23:43 INFO - 'create-virtualenv', 12:23:43 INFO - 'install', 12:23:43 INFO - 'run-tests'), 12:23:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:23:43 INFO - 'download_minidump_stackwalk': True, 12:23:43 INFO - 'download_symbols': 'ondemand', 12:23:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:23:43 INFO - 'tooltool.py': '/tools/tooltool.py', 12:23:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:23:43 INFO - '/tools/misc-python/virtualenv.py')}, 12:23:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:23:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:23:43 INFO - 'installer_path': 'installer.exe', 12:23:43 INFO - 'log_level': 'info', 12:23:43 INFO - 'log_name': 'talos', 12:23:43 INFO - 'log_to_console': True, 12:23:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:23:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:23:43 INFO - 'opt_config_files': (), 12:23:43 INFO - 'pip_index': False, 12:23:43 INFO - 'sps_profile': False, 12:23:43 INFO - 'sps_profile_interval': 0, 12:23:43 INFO - 'suite': 'dromaeojs', 12:23:43 INFO - 'system_bits': '32', 12:23:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:23:43 INFO - 'title': 'talos-linux64-ix-012', 12:23:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:23:43 INFO - 'use_talos_json': True, 12:23:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:23:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:23:43 INFO - 'work_dir': 'build'} 12:23:43 INFO - [mozharness: 2016-11-14 20:23:43.472937Z] Running clobber step. 12:23:43 INFO - Running pre-action listener: _resource_record_pre_action 12:23:43 INFO - Running main action method: clobber 12:23:43 INFO - rmtree: /builds/slave/test/build 12:23:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:23:43 INFO - Running post-action listener: _resource_record_post_action 12:23:43 INFO - [mozharness: 2016-11-14 20:23:43.927896Z] Finished clobber step (success) 12:23:43 INFO - [mozharness: 2016-11-14 20:23:43.927996Z] Running read-buildbot-config step. 12:23:43 INFO - Running pre-action listener: _resource_record_pre_action 12:23:43 INFO - Running main action method: read_buildbot_config 12:23:43 INFO - Using buildbot properties: 12:23:43 INFO - { 12:23:43 INFO - "project": "", 12:23:43 INFO - "product": "firefox", 12:23:43 INFO - "script_repo_revision": "production", 12:23:43 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 12:23:43 INFO - "repository": "", 12:23:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 12:23:43 INFO - "buildid": "20161114091743", 12:23:43 INFO - "pgo_build": "True", 12:23:43 INFO - "basedir": "/builds/slave/test", 12:23:43 INFO - "buildnumber": 13, 12:23:43 INFO - "slavename": "talos-linux64-ix-012", 12:23:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:23:43 INFO - "platform": "ubuntu64_hw", 12:23:43 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:23:43 INFO - "branch": "mozilla-beta", 12:23:43 INFO - "repo_path": "releases/mozilla-beta", 12:23:43 INFO - "revision": "fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1", 12:23:43 INFO - "stage_platform": "linux64-pgo", 12:23:43 INFO - "builduid": "42ed84f7fcb64e2fb957c8f0e52037f0", 12:23:43 INFO - "slavebuilddir": "test" 12:23:43 INFO - } 12:23:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 12:23:43 INFO - Running post-action listener: _resource_record_post_action 12:23:43 INFO - [mozharness: 2016-11-14 20:23:43.930434Z] Finished read-buildbot-config step (success) 12:23:43 INFO - [mozharness: 2016-11-14 20:23:43.930523Z] Running download-and-extract step. 12:23:43 INFO - Running pre-action listener: _resource_record_pre_action 12:23:43 INFO - Running main action method: download_and_extract 12:23:43 INFO - mkdir: /builds/slave/test/build/tests 12:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:43 INFO - trying https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 12:23:43 INFO - Downloading https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 12:23:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:23:44 INFO - Downloaded 1327 bytes. 12:23:44 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 12:23:44 INFO - Using the following test package requirements: 12:23:44 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 12:23:44 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 12:23:44 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:23:44 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 12:23:44 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 12:23:44 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 12:23:44 INFO - u'jsshell-linux-x86_64.zip'], 12:23:44 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 12:23:44 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:23:44 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 12:23:44 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 12:23:44 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 12:23:44 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 12:23:44 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 12:23:44 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 12:23:44 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:23:44 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 12:23:44 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:23:44 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:23:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 12:23:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:23:44 INFO - Fetch https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 12:23:45 INFO - Expected file size: 21962426 12:23:49 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:23:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 12:23:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:23:49 INFO - Fetch https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 12:23:49 INFO - Expected file size: 21962426 12:23:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 12:23:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:23:54 INFO - Fetch https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 12:23:55 INFO - Expected file size: 14414089 12:23: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')]} 12:23:55 INFO - trying https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 12:23:55 INFO - Downloading https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 12:23:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:23:56 INFO - Downloaded 56978142 bytes. 12:23:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 12:23:56 INFO - mkdir: /builds/slave/test/properties 12:23:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:23:56 INFO - Writing to file /builds/slave/test/properties/build_url 12:23:56 INFO - Contents: 12:23:56 INFO - build_url:https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 12:23:57 INFO - Running post-action listener: _resource_record_post_action 12:23:57 INFO - Running post-action listener: set_extra_try_arguments 12:23:57 INFO - [mozharness: 2016-11-14 20:23:57.457815Z] Finished download-and-extract step (success) 12:23:57 INFO - [mozharness: 2016-11-14 20:23:57.458040Z] Running populate-webroot step. 12:23:57 INFO - Running pre-action listener: _resource_record_pre_action 12:23:57 INFO - Running main action method: populate_webroot 12:23:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:23:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:23:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:23:57 INFO - '--tppagecycles', 12:23:57 INFO - '7'], 12:23:57 INFO - 'tests': ['tsvgm']}}, 12:23:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:23:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:23:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:23:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:23:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:23:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:23:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:57 INFO - 'talos_options': ['--disable-e10s'], 12:23:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:23:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:23:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:57 INFO - 'talos_options': ['--disable-e10s'], 12:23:57 INFO - 'tests': ['damp', 'tps']}, 12:23:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:57 INFO - 'tests': ['damp', 'tps']}, 12:23:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:23:57 INFO - 'tests': ['dromaeo_dom']}, 12:23:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:23:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:23:57 INFO - 'tests': ['basic_compositor_video']}, 12:23:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:23:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:23:57 INFO - 'tests': ['a11yr', 12:23:57 INFO - 'ts_paint', 12:23:57 INFO - 'tpaint', 12:23:57 INFO - 'sessionrestore', 12:23:57 INFO - 'sessionrestore_no_auto_restore', 12:23:57 INFO - 'tabpaint']}, 12:23:57 INFO - 'other-e10s': {'tests': ['a11yr', 12:23:57 INFO - 'ts_paint', 12:23:57 INFO - 'tpaint', 12:23:57 INFO - 'sessionrestore', 12:23:57 INFO - 'sessionrestore_no_auto_restore', 12:23:57 INFO - 'tabpaint']}, 12:23:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:23:57 INFO - 'ts_paint', 12:23:57 INFO - 'tpaint', 12:23:57 INFO - 'sessionrestore', 12:23:57 INFO - 'sessionrestore_no_auto_restore', 12:23:57 INFO - 'tabpaint']}, 12:23:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:23:57 INFO - 'ts_paint', 12:23:57 INFO - 'tpaint', 12:23:57 INFO - 'sessionrestore', 12:23:57 INFO - 'sessionrestore_no_auto_restore', 12:23:57 INFO - 'tabpaint']}, 12:23:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:23:57 INFO - 'tests': ['a11yr', 12:23:57 INFO - 'ts_paint', 12:23:57 INFO - 'tpaint', 12:23:57 INFO - 'sessionrestore', 12:23:57 INFO - 'sessionrestore_no_auto_restore', 12:23:57 INFO - 'tabpaint']}, 12:23:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:23:57 INFO - 'tests': ['a11yr', 12:23:57 INFO - 'ts_paint', 12:23:57 INFO - 'tpaint', 12:23:57 INFO - 'sessionrestore', 12:23:57 INFO - 'sessionrestore_no_auto_restore', 12:23:57 INFO - 'tabpaint']}, 12:23:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:23:57 INFO - 'tests': ['tsvgx', 12:23:57 INFO - 'tsvgr_opacity', 12:23:57 INFO - 'tart', 12:23:57 INFO - 'tscrollx', 12:23:57 INFO - 'cart']}, 12:23:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:23:57 INFO - 'tsvgr_opacity', 12:23:57 INFO - 'tart', 12:23:57 INFO - 'tscrollx', 12:23:57 INFO - 'cart']}, 12:23:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:57 INFO - 'talos_options': ['--disable-e10s'], 12:23:57 INFO - 'tests': ['tp5o']}, 12:23:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:57 INFO - 'tests': ['tp5o']}, 12:23:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:57 INFO - 'talos_options': ['--disable-e10s', 12:23:57 INFO - '--xperf_path', 12:23:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:23:57 INFO - 'tests': ['tp5n']}, 12:23:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:57 INFO - 'talos_options': ['--xperf_path', 12:23:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:23:57 INFO - 'tests': ['tp5n']}}, 12:23:57 INFO - 'talos.zip': {'path': '', 12:23:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:23:57 INFO - Running post-action listener: _resource_record_post_action 12:23:57 INFO - [mozharness: 2016-11-14 20:23:57.474604Z] Finished populate-webroot step (success) 12:23:57 INFO - [mozharness: 2016-11-14 20:23:57.474697Z] Running create-virtualenv step. 12:23:57 INFO - Running pre-action listener: _resource_record_pre_action 12:23:57 INFO - Running main action method: create_virtualenv 12:23:57 INFO - Creating virtualenv /builds/slave/test/build/venv 12:23:57 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 12:23:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:23:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:23:57 INFO - Using real prefix '/usr' 12:23:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:23:58 INFO - Installing distribute.............................................................................................................................................................................................done. 12:24:00 INFO - Installing pip.................done. 12:24:00 INFO - Return code: 0 12:24:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e651af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1573ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1570f60>, '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 0x1571d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15721d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', '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 12:24:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:24:00 INFO - Using env: {'DISPLAY': ':0', 12:24:00 INFO - 'HOME': '/home/cltbld', 12:24:00 INFO - 'LANG': 'en_US.UTF-8', 12:24:00 INFO - 'LANGUAGE': 'en_US:en', 12:24:00 INFO - 'LOGNAME': 'cltbld', 12:24:00 INFO - 'MAIL': '/var/mail/cltbld', 12:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:00 INFO - 'MOZ_NO_REMOTE': '1', 12:24:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:00 INFO - 'NO_EM_RESTART': '1', 12:24:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:00 INFO - 'PWD': '/builds/slave/test', 12:24:00 INFO - 'SHELL': '/bin/bash', 12:24:00 INFO - 'SHLVL': '1', 12:24:00 INFO - 'TERM': 'linux', 12:24:00 INFO - 'TMOUT': '86400', 12:24:00 INFO - 'USER': 'cltbld', 12:24:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', 12:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:00 INFO - '_': '/tools/buildbot/bin/python'} 12:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:00 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 12:24:00 INFO - Cleaning up... 12:24:00 INFO - Return code: 0 12:24:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb3e651af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1573ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1570f60>, '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 0x1571d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15721d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', '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 12:24:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:24:00 INFO - Using env: {'DISPLAY': ':0', 12:24:00 INFO - 'HOME': '/home/cltbld', 12:24:00 INFO - 'LANG': 'en_US.UTF-8', 12:24:00 INFO - 'LANGUAGE': 'en_US:en', 12:24:00 INFO - 'LOGNAME': 'cltbld', 12:24:00 INFO - 'MAIL': '/var/mail/cltbld', 12:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:00 INFO - 'MOZ_NO_REMOTE': '1', 12:24:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:00 INFO - 'NO_EM_RESTART': '1', 12:24:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:00 INFO - 'PWD': '/builds/slave/test', 12:24:00 INFO - 'SHELL': '/bin/bash', 12:24:00 INFO - 'SHLVL': '1', 12:24:00 INFO - 'TERM': 'linux', 12:24:00 INFO - 'TMOUT': '86400', 12:24:00 INFO - 'USER': 'cltbld', 12:24:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', 12:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:00 INFO - '_': '/tools/buildbot/bin/python'} 12:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:00 INFO - Downloading/unpacking psutil>=3.1.1 12:24:00 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 12:24:00 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 12:24:00 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 12:24:00 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 12:24:00 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 12:24:00 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 12:24:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:24:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:24:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:24:02 INFO - Installing collected packages: psutil 12:24:02 INFO - Running setup.py install for psutil 12:24:02 INFO - building 'psutil._psutil_linux' extension 12:24:02 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 12:24:02 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 12:24:02 INFO - building 'psutil._psutil_posix' extension 12:24:02 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 12:24:02 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 12:24:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:24:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:24:03 INFO - Successfully installed psutil 12:24:03 INFO - Cleaning up... 12:24:03 INFO - Return code: 0 12:24:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:03 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 0x7fb3e651af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1573ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1570f60>, '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 0x1571d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15721d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', '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 12:24:03 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 12:24:03 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 12:24:03 INFO - Using env: {'DISPLAY': ':0', 12:24:03 INFO - 'HOME': '/home/cltbld', 12:24:03 INFO - 'LANG': 'en_US.UTF-8', 12:24:03 INFO - 'LANGUAGE': 'en_US:en', 12:24:03 INFO - 'LOGNAME': 'cltbld', 12:24:03 INFO - 'MAIL': '/var/mail/cltbld', 12:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:03 INFO - 'MOZ_NO_REMOTE': '1', 12:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:03 INFO - 'NO_EM_RESTART': '1', 12:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:03 INFO - 'PWD': '/builds/slave/test', 12:24:03 INFO - 'SHELL': '/bin/bash', 12:24:03 INFO - 'SHLVL': '1', 12:24:03 INFO - 'TERM': 'linux', 12:24:03 INFO - 'TMOUT': '86400', 12:24:03 INFO - 'USER': 'cltbld', 12:24:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', 12:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:03 INFO - '_': '/tools/buildbot/bin/python'} 12:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:24:03 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 12:24:03 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 12:24:03 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 12:24:03 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 12:24:03 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 12:24:03 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 12:24:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:24:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:24:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:24:05 INFO - Installing collected packages: mozsystemmonitor 12:24:05 INFO - Running setup.py install for mozsystemmonitor 12:24:05 INFO - Successfully installed mozsystemmonitor 12:24:05 INFO - Cleaning up... 12:24:05 INFO - Return code: 0 12:24:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:24: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')]} 12:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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')]} 12:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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', '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 0x7fb3e651af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1573ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1570f60>, '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 0x1571d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15721d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', '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 12:24: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:24: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 jsonschema==2.5.1 12:24:05 INFO - Using env: {'DISPLAY': ':0', 12:24:05 INFO - 'HOME': '/home/cltbld', 12:24:05 INFO - 'LANG': 'en_US.UTF-8', 12:24:05 INFO - 'LANGUAGE': 'en_US:en', 12:24:05 INFO - 'LOGNAME': 'cltbld', 12:24:05 INFO - 'MAIL': '/var/mail/cltbld', 12:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:05 INFO - 'MOZ_NO_REMOTE': '1', 12:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:05 INFO - 'NO_EM_RESTART': '1', 12:24:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:05 INFO - 'PWD': '/builds/slave/test', 12:24:05 INFO - 'SHELL': '/bin/bash', 12:24:05 INFO - 'SHLVL': '1', 12:24:05 INFO - 'TERM': 'linux', 12:24:05 INFO - 'TMOUT': '86400', 12:24:05 INFO - 'USER': 'cltbld', 12:24:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', 12:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:05 INFO - '_': '/tools/buildbot/bin/python'} 12:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:05 INFO - Downloading/unpacking jsonschema==2.5.1 12:24: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 12:24: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 12:24: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 12:24: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 12:24: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 12:24: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 12:24:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:24:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:24:07 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 12:24:07 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 12:24:07 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 12:24:07 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 12:24:07 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 12:24:07 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 12:24:08 INFO - Downloading functools32-3.2.3-2.tar.gz 12:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:24:08 INFO - warning: no files found matching '*.txt' 12:24:08 INFO - no previously-included directories found matching 'build' 12:24:08 INFO - no previously-included directories found matching 'dist' 12:24:08 INFO - no previously-included directories found matching '.git*' 12:24:08 INFO - Installing collected packages: jsonschema, functools32 12:24:08 INFO - Running setup.py install for functools32 12:24:08 INFO - warning: no files found matching '*.txt' 12:24:08 INFO - no previously-included directories found matching 'build' 12:24:08 INFO - no previously-included directories found matching 'dist' 12:24:08 INFO - no previously-included directories found matching '.git*' 12:24:08 INFO - Successfully installed jsonschema functools32 12:24:08 INFO - Cleaning up... 12:24:08 INFO - Return code: 0 12:24:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:24: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')]} 12:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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')]} 12:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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', '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 0x7fb3e651af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1573ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1570f60>, '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 0x1571d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15721d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', '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 12:24: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:24: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 functools32==3.2.3-2 12:24:08 INFO - Using env: {'DISPLAY': ':0', 12:24:08 INFO - 'HOME': '/home/cltbld', 12:24:08 INFO - 'LANG': 'en_US.UTF-8', 12:24:08 INFO - 'LANGUAGE': 'en_US:en', 12:24:08 INFO - 'LOGNAME': 'cltbld', 12:24:08 INFO - 'MAIL': '/var/mail/cltbld', 12:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:08 INFO - 'MOZ_NO_REMOTE': '1', 12:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:08 INFO - 'NO_EM_RESTART': '1', 12:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:08 INFO - 'PWD': '/builds/slave/test', 12:24:08 INFO - 'SHELL': '/bin/bash', 12:24:08 INFO - 'SHLVL': '1', 12:24:08 INFO - 'TERM': 'linux', 12:24:08 INFO - 'TMOUT': '86400', 12:24:08 INFO - 'USER': 'cltbld', 12:24:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', 12:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:08 INFO - '_': '/tools/buildbot/bin/python'} 12:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:24:08 INFO - Cleaning up... 12:24:08 INFO - Return code: 0 12:24:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:24: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')]} 12:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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')]} 12:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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', '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 0x7fb3e651af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1573ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1570f60>, '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 0x1571d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15721d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', '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 12:24: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:24: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 blobuploader==1.2.4 12:24:08 INFO - Using env: {'DISPLAY': ':0', 12:24:08 INFO - 'HOME': '/home/cltbld', 12:24:08 INFO - 'LANG': 'en_US.UTF-8', 12:24:08 INFO - 'LANGUAGE': 'en_US:en', 12:24:08 INFO - 'LOGNAME': 'cltbld', 12:24:08 INFO - 'MAIL': '/var/mail/cltbld', 12:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:08 INFO - 'MOZ_NO_REMOTE': '1', 12:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:08 INFO - 'NO_EM_RESTART': '1', 12:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:08 INFO - 'PWD': '/builds/slave/test', 12:24:08 INFO - 'SHELL': '/bin/bash', 12:24:08 INFO - 'SHLVL': '1', 12:24:08 INFO - 'TERM': 'linux', 12:24:08 INFO - 'TMOUT': '86400', 12:24:08 INFO - 'USER': 'cltbld', 12:24:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', 12:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:08 INFO - '_': '/tools/buildbot/bin/python'} 12:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:08 INFO - Downloading/unpacking blobuploader==1.2.4 12:24: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 12:24: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 12:24: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 12:24: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 12:24: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 12:24: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 12:24:10 INFO - Downloading blobuploader-1.2.4.tar.gz 12:24:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:24:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:24: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 12:24: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 12:24: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 12:24: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 12:24: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 12:24: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 12:24:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:24:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:11 INFO - Downloading docopt-0.6.1.tar.gz 12:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:24:11 INFO - Installing collected packages: blobuploader, requests, docopt 12:24:11 INFO - Running setup.py install for blobuploader 12:24:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:24:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:24:11 INFO - Running setup.py install for requests 12:24:11 INFO - Running setup.py install for docopt 12:24:11 INFO - Successfully installed blobuploader requests docopt 12:24:11 INFO - Cleaning up... 12:24:12 INFO - Return code: 0 12:24:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:24: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')]} 12:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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')]} 12:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:12 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 0x7fb3e651af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1573ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1570f60>, '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 0x1571d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15721d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', '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 12:24:12 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 12:24:12 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 12:24:12 INFO - Using env: {'DISPLAY': ':0', 12:24:12 INFO - 'HOME': '/home/cltbld', 12:24:12 INFO - 'LANG': 'en_US.UTF-8', 12:24:12 INFO - 'LANGUAGE': 'en_US:en', 12:24:12 INFO - 'LOGNAME': 'cltbld', 12:24:12 INFO - 'MAIL': '/var/mail/cltbld', 12:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:12 INFO - 'MOZ_NO_REMOTE': '1', 12:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:12 INFO - 'NO_EM_RESTART': '1', 12:24:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:12 INFO - 'PWD': '/builds/slave/test', 12:24:12 INFO - 'SHELL': '/bin/bash', 12:24:12 INFO - 'SHLVL': '1', 12:24:12 INFO - 'TERM': 'linux', 12:24:12 INFO - 'TMOUT': '86400', 12:24:12 INFO - 'USER': 'cltbld', 12:24:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', 12:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:12 INFO - '_': '/tools/buildbot/bin/python'} 12:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:24:12 INFO - Running setup.py (path:/tmp/pip-QnGeZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:24:12 INFO - Running setup.py (path:/tmp/pip-sROvCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:24:12 INFO - Running setup.py (path:/tmp/pip-0YG10D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:24:12 INFO - Running setup.py (path:/tmp/pip-pdaqFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:24:12 INFO - Running setup.py (path:/tmp/pip-05t13r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:24:12 INFO - Running setup.py (path:/tmp/pip-FQTKdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:24:12 INFO - Running setup.py (path:/tmp/pip-GCTF3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:24:12 INFO - Running setup.py (path:/tmp/pip-ZgPnfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:24:12 INFO - Running setup.py (path:/tmp/pip-z_OWol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:24:12 INFO - Running setup.py (path:/tmp/pip-F3Btk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:24:12 INFO - Running setup.py (path:/tmp/pip-0cLtrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:24:13 INFO - Running setup.py (path:/tmp/pip-6RmCPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:24:13 INFO - Running setup.py (path:/tmp/pip-dXbl3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:24:13 INFO - Running setup.py (path:/tmp/pip-wRRjYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:13 INFO - Running setup.py (path:/tmp/pip-EGk9uU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:24:13 INFO - Running setup.py (path:/tmp/pip-VdfvuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:24:13 INFO - Running setup.py (path:/tmp/pip-7JIIzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:24:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:24:13 INFO - Running setup.py install for manifestparser 12:24:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:24:13 INFO - Running setup.py install for mozcrash 12:24:13 INFO - Running setup.py install for mozdebug 12:24:13 INFO - Running setup.py install for mozdevice 12:24:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:24:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:24:13 INFO - Running setup.py install for mozfile 12:24:14 INFO - Running setup.py install for mozhttpd 12:24:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:24:14 INFO - Running setup.py install for mozinfo 12:24:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:24:14 INFO - Running setup.py install for mozInstall 12:24:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:24:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:24:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:24:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:24:14 INFO - Running setup.py install for mozleak 12:24:14 INFO - Running setup.py install for mozlog 12:24:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:24:14 INFO - Running setup.py install for moznetwork 12:24:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:24:14 INFO - Running setup.py install for mozprocess 12:24:14 INFO - Running setup.py install for mozprofile 12:24:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:24:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:24:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:24:14 INFO - Running setup.py install for mozrunner 12:24:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:24:14 INFO - Running setup.py install for mozscreenshot 12:24:15 INFO - Running setup.py install for moztest 12:24:15 INFO - Running setup.py install for mozversion 12:24:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:24:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:24:15 INFO - Cleaning up... 12:24:15 INFO - Return code: 0 12:24:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:15 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 0x7fb3e651af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1573ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1570f60>, '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 0x1571d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15721d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', '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 12:24:15 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 12:24:15 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 12:24:15 INFO - Using env: {'DISPLAY': ':0', 12:24:15 INFO - 'HOME': '/home/cltbld', 12:24:15 INFO - 'LANG': 'en_US.UTF-8', 12:24:15 INFO - 'LANGUAGE': 'en_US:en', 12:24:15 INFO - 'LOGNAME': 'cltbld', 12:24:15 INFO - 'MAIL': '/var/mail/cltbld', 12:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:15 INFO - 'MOZ_NO_REMOTE': '1', 12:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:15 INFO - 'NO_EM_RESTART': '1', 12:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:15 INFO - 'PWD': '/builds/slave/test', 12:24:15 INFO - 'SHELL': '/bin/bash', 12:24:15 INFO - 'SHLVL': '1', 12:24:15 INFO - 'TERM': 'linux', 12:24:15 INFO - 'TMOUT': '86400', 12:24:15 INFO - 'USER': 'cltbld', 12:24:15 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', 12:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:15 INFO - '_': '/tools/buildbot/bin/python'} 12:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:24:15 INFO - Running setup.py (path:/tmp/pip-OCINhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:24:15 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)) 12:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:24:15 INFO - Running setup.py (path:/tmp/pip-Pllqr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:24:15 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)) 12:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:24:15 INFO - Running setup.py (path:/tmp/pip-NJ5LR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:24:15 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)) 12:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:24:15 INFO - Running setup.py (path:/tmp/pip-EAdg07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:24:15 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)) 12:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:24:15 INFO - Running setup.py (path:/tmp/pip-8schsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:24:15 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)) 12:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:24:15 INFO - Running setup.py (path:/tmp/pip-ZAepNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:24:15 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)) 12:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:24:15 INFO - Running setup.py (path:/tmp/pip-UfWsax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:24:16 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)) 12:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:24:16 INFO - Running setup.py (path:/tmp/pip-a31tZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:24:16 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)) 12:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:24:16 INFO - Running setup.py (path:/tmp/pip-9nD_lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:24:16 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)) 12:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:24:16 INFO - Running setup.py (path:/tmp/pip-ThaZnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:24:16 INFO - Running setup.py (path:/tmp/pip-U6LgEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:24:16 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)) 12:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:24:16 INFO - Running setup.py (path:/tmp/pip-9IQiMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:24:16 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)) 12:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:24:16 INFO - Running setup.py (path:/tmp/pip-QTb1hM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:24:16 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)) 12:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:24:16 INFO - Running setup.py (path:/tmp/pip-rXhUV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:24:16 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)) 12:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:16 INFO - Running setup.py (path:/tmp/pip-Yw2Wg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:16 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)) 12:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:24:16 INFO - Running setup.py (path:/tmp/pip-xl_UjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:24:16 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)) 12:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:24:16 INFO - Running setup.py (path:/tmp/pip-TKjSym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:24:16 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)) 12:24:16 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)) 12:24:16 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)) 12:24:16 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)) 12:24:16 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)) 12:24:16 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)) 12:24:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:18 INFO - Downloading blessings-1.6.tar.gz 12:24:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:24:18 INFO - Installing collected packages: blessings 12:24:18 INFO - Running setup.py install for blessings 12:24:18 INFO - Successfully installed blessings 12:24:18 INFO - Cleaning up... 12:24:18 INFO - Return code: 0 12:24:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:24:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:24:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:24:19 INFO - Reading from file tmpfile_stdout 12:24:19 INFO - Current package versions: 12:24:19 INFO - argparse == 1.2.1 12:24:19 INFO - blessings == 1.6 12:24:19 INFO - blobuploader == 1.2.4 12:24:19 INFO - docopt == 0.6.1 12:24:19 INFO - functools32 == 3.2.3-2 12:24:19 INFO - jsonschema == 2.5.1 12:24:19 INFO - manifestparser == 1.1 12:24:19 INFO - mozInstall == 1.12 12:24:19 INFO - mozcrash == 0.17 12:24:19 INFO - mozdebug == 0.1 12:24:19 INFO - mozdevice == 0.48 12:24:19 INFO - mozfile == 1.2 12:24:19 INFO - mozhttpd == 0.7 12:24:19 INFO - mozinfo == 0.9 12:24:19 INFO - mozleak == 0.1 12:24:19 INFO - mozlog == 3.4 12:24:19 INFO - moznetwork == 0.27 12:24:19 INFO - mozprocess == 0.23 12:24:19 INFO - mozprofile == 0.28 12:24:19 INFO - mozrunner == 6.12 12:24:19 INFO - mozscreenshot == 0.1 12:24:19 INFO - mozsystemmonitor == 0.3 12:24:19 INFO - moztest == 0.7 12:24:19 INFO - mozversion == 1.4 12:24:19 INFO - psutil == 3.1.1 12:24:19 INFO - requests == 1.2.3 12:24:19 INFO - wsgiref == 0.1.2 12:24:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:24: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')]} 12:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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')]} 12:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:19 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 0x7fb3e651af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1573ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1570f60>, '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 0x1571d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15721d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', '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 12:24:19 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 12:24:19 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 12:24:19 INFO - Using env: {'DISPLAY': ':0', 12:24:19 INFO - 'HOME': '/home/cltbld', 12:24:19 INFO - 'LANG': 'en_US.UTF-8', 12:24:19 INFO - 'LANGUAGE': 'en_US:en', 12:24:19 INFO - 'LOGNAME': 'cltbld', 12:24:19 INFO - 'MAIL': '/var/mail/cltbld', 12:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:19 INFO - 'MOZ_NO_REMOTE': '1', 12:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:19 INFO - 'NO_EM_RESTART': '1', 12:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:19 INFO - 'PWD': '/builds/slave/test', 12:24:19 INFO - 'SHELL': '/bin/bash', 12:24:19 INFO - 'SHLVL': '1', 12:24:19 INFO - 'TERM': 'linux', 12:24:19 INFO - 'TMOUT': '86400', 12:24:19 INFO - 'USER': 'cltbld', 12:24:19 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', 12:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:19 INFO - '_': '/tools/buildbot/bin/python'} 12:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:19 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)) 12:24:19 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)) 12:24:19 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)) 12:24:19 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)) 12:24:19 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)) 12:24:19 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)) 12:24:19 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)) 12:24:19 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)) 12:24:19 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)) 12:24:19 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)) 12:24:19 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)) 12:24:19 INFO - Cleaning up... 12:24:19 INFO - Return code: 0 12:24:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:24: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')]} 12:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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')]} 12:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e651af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1573ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1570f60>, '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 0x1571d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15721d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', '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 12:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:24:19 INFO - Using env: {'DISPLAY': ':0', 12:24:19 INFO - 'HOME': '/home/cltbld', 12:24:19 INFO - 'LANG': 'en_US.UTF-8', 12:24:19 INFO - 'LANGUAGE': 'en_US:en', 12:24:19 INFO - 'LOGNAME': 'cltbld', 12:24:19 INFO - 'MAIL': '/var/mail/cltbld', 12:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:19 INFO - 'MOZ_NO_REMOTE': '1', 12:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:19 INFO - 'NO_EM_RESTART': '1', 12:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:19 INFO - 'PWD': '/builds/slave/test', 12:24:19 INFO - 'SHELL': '/bin/bash', 12:24:19 INFO - 'SHLVL': '1', 12:24:19 INFO - 'TERM': 'linux', 12:24:19 INFO - 'TMOUT': '86400', 12:24:19 INFO - 'USER': 'cltbld', 12:24:19 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', 12:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:19 INFO - '_': '/tools/buildbot/bin/python'} 12:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:24:19 INFO - Cleaning up... 12:24:19 INFO - Return code: 0 12:24:19 INFO - Running post-action listener: _resource_record_post_action 12:24:19 INFO - Running post-action listener: _start_resource_monitoring 12:24:19 INFO - Starting resource monitoring. 12:24:19 INFO - [mozharness: 2016-11-14 20:24:19.629308Z] Finished create-virtualenv step (success) 12:24:19 INFO - [mozharness: 2016-11-14 20:24:19.629803Z] Running install step. 12:24:19 INFO - Running pre-action listener: _resource_record_pre_action 12:24:19 INFO - Running main action method: install 12:24:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:24:19 INFO - Reading from file tmpfile_stdout 12:24:19 INFO - Detecting whether we're running mozinstall >=1.0... 12:24:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:24:19 INFO - Reading from file tmpfile_stdout 12:24:19 INFO - Output received: 12:24:19 INFO - Usage: mozinstall [options] installer 12:24:19 INFO - Options: 12:24:19 INFO - -h, --help show this help message and exit 12:24:19 INFO - -d DEST, --destination=DEST 12:24:19 INFO - Directory to install application into. [default: 12:24:19 INFO - "/builds/slave/test"] 12:24:19 INFO - --app=APP Application being installed. [default: firefox] 12:24:19 INFO - mkdir: /builds/slave/test/build/application 12:24:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:24:33 INFO - Reading from file tmpfile_stdout 12:24:33 INFO - Output received: 12:24:33 INFO - /builds/slave/test/build/application/firefox/firefox 12:24:33 INFO - Running post-action listener: _resource_record_post_action 12:24:33 INFO - [mozharness: 2016-11-14 20:24:33.421471Z] Finished install step (success) 12:24:33 INFO - [mozharness: 2016-11-14 20:24:33.421714Z] Running run-tests step. 12:24:33 INFO - Running pre-action listener: _resource_record_pre_action 12:24:33 INFO - Running main action method: run_tests 12:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:24:33 INFO - Python 2.7.3 12:24:33 INFO - Return code: 0 12:24:33 INFO - grabbing minidump binary from tooltool 12:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:24:33 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 0x1570f60>, '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 0x1571d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15721d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:24:33 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 12:24:33 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 12:24:33 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 12:24:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:24:33 INFO - Return code: 0 12:24:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:24:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:24:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:24:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:24:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:24:33 INFO - Using env: {'DISPLAY': ':0', 12:24:33 INFO - 'HOME': '/home/cltbld', 12:24:33 INFO - 'LANG': 'en_US.UTF-8', 12:24:33 INFO - 'LANGUAGE': 'en_US:en', 12:24:33 INFO - 'LOGNAME': 'cltbld', 12:24:33 INFO - 'MAIL': '/var/mail/cltbld', 12:24:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:24:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:33 INFO - 'MOZ_NO_REMOTE': '1', 12:24:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:24:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:33 INFO - 'NO_EM_RESTART': '1', 12:24:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:33 INFO - 'PWD': '/builds/slave/test', 12:24:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:24:33 INFO - 'SHELL': '/bin/bash', 12:24:33 INFO - 'SHLVL': '1', 12:24:33 INFO - 'TERM': 'linux', 12:24:33 INFO - 'TMOUT': '86400', 12:24:33 INFO - 'USER': 'cltbld', 12:24:33 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673', 12:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:33 INFO - '_': '/tools/buildbot/bin/python'} 12:24:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:24:33 INFO - mozversion application_buildid: 20161114091743 12:24:33 INFO - mozversion application_changeset: fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 12:24:33 INFO - mozversion application_display_name: Firefox 12:24:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:24:33 INFO - mozversion application_name: Firefox 12:24:33 INFO - mozversion application_remotingname: firefox 12:24:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:24:33 INFO - mozversion application_vendor: Mozilla 12:24:33 INFO - mozversion application_version: 51.0 12:24:33 INFO - mozversion platform_buildid: 20161114091743 12:24:33 INFO - mozversion platform_changeset: fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 12:24:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:24:33 INFO - mozversion platform_version: 51.0 12:24:33 INFO - using testdate: 1479155073 12:24:33 INFO - actual date: 1479155073 12:24:33 INFO - starting webserver on 'localhost:37901' 12:24:33 INFO - SUITE-START | Running 2 tests 12:24:33 INFO - TEST-START | dromaeo_css 12:24:33 INFO - operating with platform_type : linux_ 12:24:33 INFO - Initialising browser for dromaeo_css test... 12:24:33 INFO - TEST-INFO | started process 28714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmFvwp9/profile http://localhost:37901/getInfo.html) 12:24:37 INFO - PROCESS | 28714 | __metrics Screen width/height:1600/1200 12:24:37 INFO - PROCESS | 28714 | colorDepth:24 12:24:37 INFO - PROCESS | 28714 | Browser inner width/height: 1024/697 12:24:37 INFO - PROCESS | 28714 | __metrics 12:24:37 INFO - PROCESS | 28714 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:24:37 INFO - PROCESS | 28714 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:24:38 INFO - PROCESS | 28714 | console.error: PushService: 12:24:38 INFO - PROCESS | 28714 | stateChangeProcessEnqueue: Error transitioning state 12:24:38 INFO - PROCESS | 28714 | UnknownError 12:24:38 INFO - TEST-INFO | 28714: exit 0 12:24:38 INFO - Browser initialized. 12:24:38 INFO - Running cycle 1/1 for dromaeo_css test... 12:24:38 INFO - TEST-INFO | started process 28805 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmFvwp9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:24:50 INFO - PROCESS | 28805 | RSS: Main: 142700544 12:24:50 INFO - PROCESS | 28805 | 12:25:41 INFO - PROCESS | 28805 | 1479155141588 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] 12:27:50 INFO - PROCESS | 28805 | Cycle 1(1): loaded http://localhost:37901/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37901/tests/dromaeo/cssquery-ext.html) 12:27:51 INFO - PROCESS | 28805 | RSS: Main: 236130304 12:27:51 INFO - PROCESS | 28805 | 12:30:54 INFO - PROCESS | 28805 | Cycle 1(1): loaded http://localhost:37901/tests/dromaeo/cssquery-ext.html (next: http://localhost:37901/tests/dromaeo/cssquery-jquery.html) 12:30:54 INFO - PROCESS | 28805 | RSS: Main: 238485504 12:30:54 INFO - PROCESS | 28805 | 12:33:56 INFO - PROCESS | 28805 | Cycle 1(1): loaded http://localhost:37901/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37901/tests/dromaeo/cssquery-mootools.html) 12:33:57 INFO - PROCESS | 28805 | RSS: Main: 175927296 12:33:57 INFO - PROCESS | 28805 | 12:36:58 INFO - PROCESS | 28805 | Cycle 1(1): loaded http://localhost:37901/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37901/tests/dromaeo/cssquery-prototype.html) 12:36:59 INFO - PROCESS | 28805 | RSS: Main: 219656192 12:36:59 INFO - PROCESS | 28805 | 12:40:02 INFO - PROCESS | 28805 | Cycle 1(1): loaded http://localhost:37901/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37901/tests/dromaeo/cssquery-yui.html) 12:40:02 INFO - PROCESS | 28805 | RSS: Main: 178577408 12:40:02 INFO - PROCESS | 28805 | 12:43:05 INFO - PROCESS | 28805 | Cycle 1(1): loaded http://localhost:37901/tests/dromaeo/cssquery-yui.html (next: http://localhost:37901/tests/dromaeo/cssquery-dojo.html) 12:43:05 INFO - PROCESS | 28805 | RSS: Main: 274538496 12:43:05 INFO - PROCESS | 28805 | 12:43:05 INFO - PROCESS | 28805 | __start_tp_report 12:43:05 INFO - PROCESS | 28805 | _x_x_mozilla_page_load 12:43:05 INFO - PROCESS | 28805 | _x_x_mozilla_page_load_details 12:43:05 INFO - PROCESS | 28805 | |i|pagename|runs| 12:43:05 INFO - PROCESS | 28805 | |0;dojo.html;3120.968790312097;3161.367726454709;3167.5723777290073;3184.9840750796243;3203.1831882869865;5526.557875369971;5577.386487486373;5605.523530499902;5609;5631.380548139701;5641.943580564193;5685.9147112793235;5696.487316141546;5697.943020569793;5706.71466426678;5164.896702065957;5168.198929165986;5179.141893137831;5202.791888324463;5222.164453687411;4976.62675299354;5202.4277329493725;5234.6335756497065;5244.973775131138;5271.762770675309;5026.447090820026;5084.110280700881;5113;5120.411152717429;5130.820421285256;5175.663581867167;5204.9739751301195;5215.739213039371;5264.2893209416625;5281.498257665516;5116.565091967187;5161.870953226162;5225.4513276105845;5237.057329680656;5262.315898933152;5345.198220266952;5440.782368705247;5464.617476776627;5508.421615730371;5519.613627046108;5816.82549523515;5959.165716799652;5978.671173085479;5988.490978266853;6079.179310793031;6107.5419343548965;6110.175126357929;6124.11200375943;6125.5712100153005;6126.785562505335;5458.863528411782;5511.559075273968;5599.916001259984;5660.377358490563;5663.292088488939;6200.844978875474;6223.906641400383;6240.812775616739;6242;6245.188125543741;5977.970110149421;5982.282126144803;5990.274425136552;5991.340952495222;6024.1566180734735;5806;5856.033754430471;5975.611585247032;6042.577019608585;6074.787382441594;6076.088586712029;6080.0575910733905;6083.11794789753;6097.4817140543555;6113.144159817629;6012.338642749294;6031.668258245839;6071.817845464643;6094.481969032593;6117.296510901303;4506.369108324837;4539.6368290536675;4615.3077038443835;4667.533246675305;4680.251159814414;4117.691173162025;4141.91716165675;4162;4165.708400411942;4204.642605378577;5784.971075144597;5788.102844059177;5789.710514474259;5794.565407594448;5811.709414529341;5944.286685597756;5999.970000149971;6158.599691020159;6162.383761623802;6164.8767024659255;5557.499825015768;5701.971490142523;5719.313682358061;5754.424557544212;5759.395263497357;5261.710605916634;5289.3917199521775;5298.152295632757;5301.920471192935;5304.363476382859;6083.391660833881;6155.599886007395;6207.782727604512;6217.160683307786;6222.751089956441;5919.348871624032;6061.545384096122;6115.209918062534;6126.151269885628;6144.109104179958;6277.748890044347;6280.748770049329;6284.811455656338;6293.181886354744;6294.8426289341305;5956.255468066492;5989.9700501498955;5992.8801423972145;5994.6403215807195;6030.216071910623;5894.498967587631;5897.056470964625;5905.763769449346;5927.585069045125;5943.257092863392;5896.616719913192;5921.3190483094995;5921.7631294747725;5922.348541660328;5927.555433342431;5863.560232982458;5867.178594996789;5867.559933005127;5870.882582348415;5873.295204575478;5709.65742055478;5737.942620573741;5741.799037033684;5854.385289544536;5881.676507792113;5848.6783226921225;5852.268466441695;5852.912206316993;5873.148393483007;5892.941070589411;5699.1451282306325;5703.08750599902;5709.800156994485;5709.9714501427225;5715.799947001835 12:43:05 INFO - PROCESS | 28805 | |1;ext.html;602.9517638588914;625.1903784598945;632.1213513216633;644.9873698293678;647.1102234427661;35180;38554.22891542168;47265.999999999956;48132.27801582979;48179.51820481794;49019;49578;49602.751986240015;49626.75186624071;49654.50345496544;9276.165145136936;9424.623015079424;9432.764180895463;9435.43387396755;9439.716808495721;8511.191436813493;8720.52037137957;9199.356045076847;10739.516721747501;11106.944465277662;11298.717532061683;11393.316401015965;11400.315981041123;11403.885961140408;11406.258593191416;11083.833742493869;11134.777304453946;11144.442777861075;11158.051565616892;11177.66467005991;11064.502097405637;11143.721406964809;11150.163737719704;11159.721006974809;11166.274192177483;45870.77064614656;46043.30935035977;46093.30860037102;46135.53864461346;46196;4157.812898419548;4195.517515485697;4370.278903980871;4441.378207051015;4664.440267167962;35011.29977400438;35171.296574068634;35392.29215415703;35441.82279088614;37372.81313593442;4357.825686972517;4410.691251612388;4430.844920427802;4458.152950939344;4481.2381895077915;380362;381689;382115.08942455385;382128;385666;39282.41076383857;67684;68167.65916170487;68408.6579567099;68585.65707171432;39939.60060399417;42309.788451057546;42490.150196995884;42662.146757064686;42723;17375;17514.562135946704;17544.210510527057;17550.297988080332;17558.91220543915;12652.17760845542;13494.122882012638;13551;13579.660508487366;13631.04582679203;9058.230050445785;9407.670731524364;9688.273379496566;9695.563699633534;9822.607095716092;3670.4310831821113;3688.188598508324;3718.5723641781;3720.739548231598;3735.533058367704;983.8229118758549;1054.288355360129;1214.3745970825032;1222.216697329816;1238.5293588436336;34402.827985860415;34452.82773586116;34530.82734586311;34819.12952176216;35049.299014020085;1088.2491081153978;1143.874173840877;1149.7872893514727;1252.6930901929086;1260.602910083321;17328.740068898976;18274.817251827313;18304.450866474028;18305.267789288544;18322.541936451427;625233;634478;635675;636758;638363;65465;65793;65809.34190658032;66110.66944665246;66140.33859661438;1285.9742805143844;1294.1717300927414;1394.7280280345437;1431.1127101197117;1480.7852861335045;31469.370612588078;36040.819795900854;36265.81867090753;36346.27307453889;36500.45249321315;55580.44419555915;56176.71911640416;56288;56315.71842140763;56350;436954;439290;439822;439897;440270;27530.449391011665;28099.71900280971;30752.538711918893;31616;32029.839850800596;51025;52036.95926081381;52072.73963630158;52190.21714674359;52680;43419.34870977001;45374;45979;46161;46795;44395.33406998833;44856.32715509205;44974;45907.54092459033;46667;44595.331070033324;44823;45423.501707405085;45624.31563526616;45784.54215457803;37328.25343493061;39912;39936.60063399329;40068.39897401483;40179.191936362346;28785.56821647719;29459.922888604964;29696.257593560334;29947.70052299449;30189.698103018687 12:43:05 INFO - PROCESS | 28805 | |2;jquery.html;419.0947553284905;422.9429027081347;423.6018142945631;432.88744926319146;449.95950364467194;19008.524786880334;20429.897850510744;20953.68569471459;21334;21700.131994720232;19761.110750016247;21089.26187583435;21127.577448451022;21319.893400532976;21462.248821291258;5654.575906806986;5935.198748169007;5939.4654481096695;5947.078202878561;5948.107783832416;5605.411431799664;5810.3027636683655;5836.416358364172;5852.67810270435;5951.285845698522;5946.108083787423;5954.4938680212235;5960.403959604048;5965.433283838029;5965.46310832025;5829.8834023319505;6015.608985415955;6044.214252147237;6047.0627052806885;6054.848628784272;5698.458646428624;5854.2389489366105;5883.146943693183;5886.6468011919;5888.322842873082;15209.695806083817;15273.694526109526;15396.384144634201;15419.691606167813;15556.922215388851;2582.7804636605724;2697.9595306070423;2725.4549090181845;2967.896123635684;3136.4197623439736;11057.447127643665;11304.886951130466;11309.434528273554;11511.48198331077;11541.365224912626;1960.5686748915216;1962.6663467210608;2029.7158397824317;2058.9485262868548;2066.3077868913933;67707.2760998145;70628.6468567659;90072.09927900638;91425.54287228588;91482;11418.771624567462;11861.11041671878;11927.940360298317;12067.698307542207;12220.633380998584;17364.479065628053;17380.21789019497;17382.65234695299;17391.391301304648;17420.041897695748;8458.577071146417;8586.87119693205;8834.911650883538;8901.777455563533;8976.237019853386;8319.500829950222;8369.58152092393;8493.405461617627;8587.270082043096;8712.128787121364;4771.618270538349;4859.927101093486;5056.367954005749;5203.583713302926;5304.522592966651;2055.1779288284506;2072.3886453496257;2101.2015434135237;2117.5764847030655;2152.2789865394957;922.6678395777515;997.7605374710163;1035.3270374256642;1057.7091299892438;1070.8315660786968;19656.90171549133;20557.897210513853;21004.369868903956;21079.894600527205;21167.470813229793;1037.6420135053395;1039.2361614213546;1048.308116643012;1054.9578016879393;1067.354250678344;10739.463026848782;11827.704307392212;11864.88135118655;11866.525338986516;11895;512826;512866;515569;532699;534455;77081;82865.58567207246;86511.56744216238;87666;97108;1064.2762921213493;1099.70308016835;1103.806833804097;1105.9557617695202;1108.5731993182521;18567.628647426707;18618.53453663615;18836.434906952265;18926.905365473085;19181;40763.184736304516;41003.794981024905;41685;45705.31442028306;47883;62769.68615157078;62888.68555657376;62955;64077;64562.03156952743;8987.685431009882;9074.546272686208;9119.954400227956;9481.288903332139;9574.32979691415;8125.79685507867;9528;12992.870071299543;13220.603381898558;14147.43410263578;11057.668269951915;11322.716932076764;11345.716357091138;11524.711882203012;11900.166988310735;10482;10836.945815271189;11068.778624427627;11341.319520828776;11617.128715346551;11215.214934954474;11528.59649912249;11718.824217636913;11738.823917641414;11993.460294286953;8944.105589441004;9125.77185570366;9127.634894604142;9346.626134954799;9499.762505937408;10230.948845255725;10829.783404332027;11267.549298027987;11368.147388946027;11626.302421854716 12:43:05 INFO - PROCESS | 28805 | |3;mootools.html;1516.4389176004877;1531.1196062264198;1684.7220208665572;1811.8369346758789;1830.5606654402939;8760.167784060512;9353.064693530643;9356.064393560657;9358.11097945695;9367.81264374713;8141.715039973602;8392.748217553482;8844.601992910319;9131.726048218547;9208.447493150416;2487.577111890974;2506.410993416546;2516.5218608464425;2522.7351128131468;2524.204875464223;2167.913283468667;2230.386643672987;2230.7657695941934;2235.0947866114248;2241.2491815241915;2377.2749311459997;2389.139909632531;2394.7964423024064;2429.7327293997646;2433.6592876997233;2338.298510446859;2354.152505098163;2375.904963801446;2380.7143142822883;2380.880955952204;2321.0483701682397;2330.5921463743775;2330.755270696586;2335.322756400642;2335.5328934213057;9132.406393584462;9302.348835581512;9380.10888965554;9380.5309734513;9384.20234280087;5530.308711411074;5659.5755318351285;5668.093105103164;5677.403872593401;5678.148277758328;3418.8290585470627;3441.6042155152227;3524.6122926478065;3542.679544898096;3546.769459985093;1208.0456439412853;1230.8522977242699;1260.5462033667873;1278.0414688983262;1282.4036822877406;13080.476780928846;13089.869101309056;13097.476100956046;13109.47562097515;13142.86857131426;4851.393575803025;4957.975210123998;4972.353594032753;5062.443131255559;5103.18349064148;11040.558377664804;11063.834042489369;11063.944680276547;11064.612738554273;11065.944670276758;5718.599698021182;5732.77068917247;5739.483446489836;5739.62692424991;5744.971275143597;4541.613962813131;4583.770811459413;4909.239067944474;5179.430262671103;5283.788648454096;4339.305711086211;4343.956560434355;4357;4383.3863259143745;4438.28987362027;1356.4641966423208;1397.4410235905718;1407.4862675123507;1416.2706206303762;1435.454527279627;999.14073896449;1008.5159123620704;1012.4532752313668;1028.2596530498029;1035.1304903880775;6091;6166.537509686791;6208.4722798561725;6298.653574053379;6344.619322840552;486.4405933176804;488.3334248750501;491.4593946658647;499.3059647090547;506.71370675568187;4226.957730422718;4311.8706438806885;4411.382406463098;4471.731696098244;4495.820167193276;11083.944580277048;11531.538738450368;11560.884391156149;11578.478968446272;11622.825657615143;10509.474526273656;10787.67636970892;10928;11499.885001150049;11538.711532211762;8431.156884311642;8477.576121193915;8686.956565217133;8690.217880390795;8704.869426958601;6411.647359395278;6447.4197322241225;6521.119648847345;6574.539782215199;6644.335566443317;10655.30740501865;10877.564897404332;10918.23572349928;10919.454027298762;10935.726606834893;10830.133589312678;10945.179111566506;11122;11123.110151187724;11217.775644486901;7379.594122323324;7964.800879978047;8099.14958929304;8241.546714930737;8302.086770455366;9317.673881414388;9396.577154028222;9402.764930876783;9403.529823508661;9404.435733855991;7928.7621371358955;7978.720744773905;8071.596420179085;8239.670413183405;8242.093369729206;8248.876266856121;8274.751757447286;8316.126806685212;8409.663613455637;8574.91425085766;7202.96398518004;7349.1915889253205;7428.851422971618;7462.813429664302;7605.125410577854;5342.813001544927;5377.650452720561;5638.323401191719;5645.4072322405555;5730.369659337553;5423.810166644149;5522.917156242579;5617.382087970402;5621.353544342453;5829.883402332014 12:43:05 INFO - PROCESS | 28805 | |4;prototype.html;346.5148791691631;348.26168522731814;353.9539859818223;357.0965457392797;365.5321188878235;5620.803271885485;5634.267545219126;5639;5648.983183027064;5656.717164141792;5224.973875130619;5343.946560534403;5423.484768946953;5470;5519.668819870811;4371.819608705648;4380.518143004283;4381.298992161255;4389.736615803062;4391.824327026915;4391.890202744941;4396.560343965594;4406.779661016953;4408.25059739845;4409.933850992237;4100.211855937961;4321.222180007598;4340.240457919867;4347.260965635849;4372.890677733066;4309.288967320388;4330.437043184397;4340.652747780186;4347.739135651839;4349.804258808345;3823.8146174685935;3829.329867273244;3836.635519625659;3847.4421208924828;3849.480320156771;5254.3169387979315;5350.197470379435;5401.515302960643;5411.323584551931;5416.241726158341;4971.552560269557;4975.805806606425;4980.77586508608;4989.301497790312;4998.800047998076;5821.854453638651;5827.883442331172;5835.0372188588835;5837.270341207349;5840.88318233633;4118.75287482752;4195.412642230091;4208.831646734127;4219.135077309144;4277.572242775728;6000.549958753111;6005.249343832021;6019.217501724792;6029.939700602981;6036.879262414727;4327.156204540084;4345.500267469219;4346.978265108717;4349.586789255016;4358.978205108954;4312.784360781949;4372.475302963665;4385.693001489929;4404.713693609905;4417.293233082692;4970.478099799541;4971.65198436106;4975.875603109879;4976.651634385558;4988.7505624718615;5875.23621929155;5884.58807883444;5892.939270931188;5899.852503687356;5900.380460051719;1430.592281199874;1460.4377314733904;1461.693044460654;1513.4551561437875;1517.324790468231;1062.5112448273726;1081.967540973772;1102.7849569334064;1107.595727559435;1120;5571.860703482364;5677.17680936262;5712.942870571324;5755.424457554211;5770.682612456271;5790.392008839095;6050.848728781815;6060.787872424444;6066.998945174085;6067.635941843415;5757.971210143923;5759.769609215585;5775.249217601685;5779.797707080316;5789.450002249864;3182.98408507956;3200.439923013463;3211.983940080331;3213.4055199788113;3219.404410184123;6058.697065146725;6237.625742455467;6250.4374606285655;6279.623222606659;6304.968475157595;6169.475594574512;6173.271483984491;6182.567220294536;6183.598066125687;6187.443130118221;6123.112148738408;6213.627182369072;6256.343083976117;6269.905951410824;6304.338044505353;6035.668038257938;6035.69821508914;6037.939620603738;6042.274927008787;6064.48451881595;5824.194499705105;5901.498372638373;5942.940570594412;6032.336442991355;6037.396260373927;6088.208532890696;6122.326544080059;6204.503639708722;6236.376362363727;6244.65654389013;4302.376155457504;4357.172137293904;4359.735676653735;4437.378766972691;4440.111977604427;5753.367129615823;6017.819465416044;6050.969745151246;6098.359672234529;6099;5904.52763778888;5935.139404786368;5941.702914854326;5942.642407040009;5950.285965683973;5680.097167448951;5860.853478663067;5904.852378690567;5908.379620139824;5950.31571369298;5758.510526605285;5830.591858569859;5853.531717462508;5853.736581853912;5888.676122813115;5908.675022873783;5929.851753706192;5942.1383899335215;5992.250968628921;5993.160957465871;5672.688002159921;5730.656160630376;5785.82642520725;5788.681622510802;5811.709414529172 12:43:05 INFO - PROCESS | 28805 | |5;yui.html;796.80079980005;836.5106412748542;840.1556435782041;858.9863960526576;900.8783814185083;15649.843501564981;16852;16964.575885602837;17011.57471063221;17012.4045658402;15350.769738453931;15940.920295398506;16482.505524834243;16608.916955415236;16674.833251667478;826.099551488877;847.2332539052168;848.3340577646549;852.7484392104344;853.6713365354321;862.0302160069921;864.7838040489878;866.2766589897443;866.5493943149559;866.7399780065987;902.1835239108584;904.6291020681522;911.0388540090203;912.0104686415248;912.2291663544328;900.6127365232948;901.0313912544009;902.7562558109274;903.345074820753;903.3766700976305;662.3608218069586;663.3664850068221;663.6582160187459;663.7046514301138;663.7643636509018;15322.23388830554;15355.692886142326;15386.846131538765;15416.229188540528;16132.193390330554;15360.923195383952;16216.270267837976;16371;16510.75233871481;17079.829201707948;13616.86383136166;13691.589252322447;13704.794428083587;13705.246211458465;14091.224982625952;4075.9592404075875;4165.250254954107;4173.227952828706;4234.640055595247;4278.4010238566625;82110;83404.16595834025;84186;84420.99999999939;84798.15201847964;12258.877411225774;12333.198342107913;12362.567310144103;12543.059270554744;12580.4338804754;22346.55306893853;22350.55298894013;22393.55212895733;22425.55148897013;22427.32718018462;8871.689490867788;9010.50442225684;9051.683191088281;9175.128362805523;9464.384814987005;5112.795488180431;5113.233015047773;5147.253648220987;5221.765020574007;5228.302891289346;3675.7426980111672;3815.5039844819994;3816.809159542012;3817.2556351511744;3817.923641527154;657.572577824418;660.2308310817843;660.8678264347054;672.3814091036259;688.3151264491862;613.1201725523888;636.8726254749068;764.2395816162954;771.4908160613968;790.7706765038074;9850.261230407748;10219.182465402899;10289.742756431;10341.276110672181;10342.689719308282;755.7241606813474;756.2097607999654;756.6720405687983;760.6729106484154;803.1406395157126;5041.521055499722;5111.182210846247;5246.606504512177;5262.868428289246;5330.307060082165;74113.25886741171;108200;131991;133728;140747;71872.64063679648;111044;113183;113367;113753.43123284496;59783.40216597865;81023.78464323039;86144;93389.53305233567;94925;9667.70996870095;10057.949710251401;10314.04925635684;10625.9468702656;10627.681169564925;41282.38076428916;42496.78751606222;45669.77165114286;51319;54083.45916540784;69414.30585694079;83156;84108.57945710233;87394;94077;14531.346089426213;14740.778888316898;14860.925695371454;15386.615334616725;15444.691106178037;16082.839171608133;16290.266937988055;16318;17788.822111778718;18208.860192802975;14274.072185307921;14814.555563333117;14860.331285091981;15900.04599723974;15931.920340398225;15028.173450459892;15089.396424142911;15697.372105115668;15755.763663545285;16509.66980660404;13728.45086196541;14019.649508762363;14931.253437328307;15027.624309392353;15536.223188840739;11496.137789665976;11590.94204528972;12082.697932551757;12245.142840001114;12920.870791291967;12056;12185.756284874076;12226.87773122293;12385.566505172275;12575.371231438574 12:43:05 INFO - PROCESS | 28805 | __end_tp_report 12:43:05 INFO - PROCESS | 28805 | __start_cc_report 12:43:05 INFO - PROCESS | 28805 | _x_x_mozilla_cycle_collect,826 12:43:05 INFO - PROCESS | 28805 | __end_cc_report 12:43:05 INFO - PROCESS | 28805 | __startTimestamp1479156185527__endTimestamp 12:43:05 INFO - PROCESS | 28805 | 12:43:05 INFO - PROCESS | 28805 | ------- Summary: start ------- 12:43:05 INFO - PROCESS | 28805 | Number of tests: 6 12:43:05 INFO - PROCESS | 28805 | 12:43:05 INFO - PROCESS | 28805 | [#0] dojo.html Cycles:165 Average:5606.21 Median:5806.00 stddev:641.13 (11.0%) stddev-sans-first:612.74 12:43:05 INFO - PROCESS | 28805 | Values: 3121.0 3161.4 3167.6 3185.0 3203.2 5526.6 5577.4 5605.5 5609.0 5631.4 5641.9 5685.9 5696.5 5697.9 5706.7 5164.9 5168.2 5179.1 5202.8 5222.2 4976.6 5202.4 5234.6 5245.0 5271.8 5026.4 5084.1 5113.0 5120.4 5130.8 5175.7 5205.0 5215.7 5264.3 5281.5 5116.6 5161.9 5225.5 5237.1 5262.3 5345.2 5440.8 5464.6 5508.4 5519.6 5816.8 5959.2 5978.7 5988.5 6079.2 6107.5 6110.2 6124.1 6125.6 6126.8 5458.9 5511.6 5599.9 5660.4 5663.3 6200.8 6223.9 6240.8 6242.0 6245.2 5978.0 5982.3 5990.3 5991.3 6024.2 5806.0 5856.0 5975.6 6042.6 6074.8 6076.1 6080.1 6083.1 6097.5 6113.1 6012.3 6031.7 6071.8 6094.5 6117.3 4506.4 4539.6 4615.3 4667.5 4680.3 4117.7 4141.9 4162.0 4165.7 4204.6 5785.0 5788.1 5789.7 5794.6 5811.7 5944.3 6000.0 6158.6 6162.4 6164.9 5557.5 5702.0 5719.3 5754.4 5759.4 5261.7 5289.4 5298.2 5301.9 5304.4 6083.4 6155.6 6207.8 6217.2 6222.8 5919.3 6061.5 6115.2 6126.2 6144.1 6277.7 6280.7 6284.8 6293.2 6294.8 5956.3 5990.0 5992.9 5994.6 6030.2 5894.5 5897.1 5905.8 5927.6 5943.3 5896.6 5921.3 5921.8 5922.3 5927.6 5863.6 5867.2 5867.6 5870.9 5873.3 5709.7 5737.9 5741.8 5854.4 5881.7 5848.7 5852.3 5852.9 5873.1 5892.9 5699.1 5703.1 5709.8 5710.0 5715.8 12:43:05 INFO - PROCESS | 28805 | 12:43:05 INFO - PROCESS | 28805 | [#1] ext.html Cycles:180 Average:65061.54 Median:4176.67 stddev:132249.46 (3166.4%) stddev-sans-first:132531.90 12:43:05 INFO - PROCESS | 28805 | Values: 603.0 625.2 632.1 645.0 647.1 35180.0 38554.2 47266.0 48132.3 48179.5 49019.0 49578.0 49602.8 49626.8 49654.5 9276.2 9424.6 9432.8 9435.4 9439.7 8511.2 8720.5 9199.4 10739.5 11106.9 11298.7 11393.3 11400.3 11403.9 11406.3 11083.8 11134.8 11144.4 11158.1 11177.7 11064.5 11143.7 11150.2 11159.7 11166.3 45870.8 46043.3 46093.3 46135.5 46196.0 4157.8 4195.5 4370.3 4441.4 4664.4 35011.3 35171.3 35392.3 35441.8 37372.8 4357.8 4410.7 4430.8 4458.2 4481.2 380362.0 381689.0 382115.1 382128.0 385666.0 39282.4 67684.0 68167.7 68408.7 68585.7 39939.6 42309.8 42490.2 42662.1 42723.0 17375.0 17514.6 17544.2 17550.3 17558.9 12652.2 13494.1 13551.0 13579.7 13631.0 9058.2 9407.7 9688.3 9695.6 9822.6 3670.4 3688.2 3718.6 3720.7 3735.5 983.8 1054.3 1214.4 1222.2 1238.5 34402.8 34452.8 34530.8 34819.1 35049.3 1088.2 1143.9 1149.8 1252.7 1260.6 17328.7 18274.8 18304.5 18305.3 18322.5 625233.0 634478.0 635675.0 636758.0 638363.0 65465.0 65793.0 65809.3 66110.7 66140.3 1286.0 1294.2 1394.7 1431.1 1480.8 31469.4 36040.8 36265.8 36346.3 36500.5 55580.4 56176.7 56288.0 56315.7 56350.0 436954.0 439290.0 439822.0 439897.0 440270.0 27530.4 28099.7 30752.5 31616.0 32029.8 51025.0 52037.0 52072.7 52190.2 52680.0 43419.3 45374.0 45979.0 46161.0 46795.0 44395.3 44856.3 44974.0 45907.5 46667.0 44595.3 44823.0 45423.5 45624.3 45784.5 37328.3 39912.0 39936.6 40068.4 40179.2 28785.6 29459.9 29696.3 29947.7 30189.7 12:43:05 INFO - PROCESS | 28805 | 12:43:05 INFO - PROCESS | 28805 | [#2] jquery.html Cycles:180 Average:30095.11 Median:12141.46 stddev:85826.97 (706.9%) stddev-sans-first:86038.81 12:43:05 INFO - PROCESS | 28805 | Values: 419.1 422.9 423.6 432.9 450.0 19008.5 20429.9 20953.7 21334.0 21700.1 19761.1 21089.3 21127.6 21319.9 21462.2 5654.6 5935.2 5939.5 5947.1 5948.1 5605.4 5810.3 5836.4 5852.7 5951.3 5946.1 5954.5 5960.4 5965.4 5965.5 5829.9 6015.6 6044.2 6047.1 6054.8 5698.5 5854.2 5883.1 5886.6 5888.3 15209.7 15273.7 15396.4 15419.7 15556.9 2582.8 2698.0 2725.5 2967.9 3136.4 11057.4 11304.9 11309.4 11511.5 11541.4 1960.6 1962.7 2029.7 2058.9 2066.3 67707.3 70628.6 90072.1 91425.5 91482.0 11418.8 11861.1 11927.9 12067.7 12220.6 17364.5 17380.2 17382.7 17391.4 17420.0 8458.6 8586.9 8834.9 8901.8 8976.2 8319.5 8369.6 8493.4 8587.3 8712.1 4771.6 4859.9 5056.4 5203.6 5304.5 2055.2 2072.4 2101.2 2117.6 2152.3 922.7 997.8 1035.3 1057.7 1070.8 19656.9 20557.9 21004.4 21079.9 21167.5 1037.6 1039.2 1048.3 1055.0 1067.4 10739.5 11827.7 11864.9 11866.5 11895.0 512826.0 512866.0 515569.0 532699.0 534455.0 77081.0 82865.6 86511.6 87666.0 97108.0 1064.3 1099.7 1103.8 1106.0 1108.6 18567.6 18618.5 18836.4 18926.9 19181.0 40763.2 41003.8 41685.0 45705.3 47883.0 62769.7 62888.7 62955.0 64077.0 64562.0 8987.7 9074.5 9120.0 9481.3 9574.3 8125.8 9528.0 12992.9 13220.6 14147.4 11057.7 11322.7 11345.7 11524.7 11900.2 10482.0 10836.9 11068.8 11341.3 11617.1 11215.2 11528.6 11718.8 11738.8 11993.5 8944.1 9125.8 9127.6 9346.6 9499.8 10230.9 10829.8 11267.5 11368.1 11626.3 12:43:05 INFO - PROCESS | 28805 | 12:43:05 INFO - PROCESS | 28805 | [#3] mootools.html Cycles:180 Average:6134.20 Median:4717.58 stddev:3514.85 (74.5%) stddev-sans-first:3507.58 12:43:05 INFO - PROCESS | 28805 | Values: 1516.4 1531.1 1684.7 1811.8 1830.6 8760.2 9353.1 9356.1 9358.1 9367.8 8141.7 8392.7 8844.6 9131.7 9208.4 2487.6 2506.4 2516.5 2522.7 2524.2 2167.9 2230.4 2230.8 2235.1 2241.2 2377.3 2389.1 2394.8 2429.7 2433.7 2338.3 2354.2 2375.9 2380.7 2380.9 2321.0 2330.6 2330.8 2335.3 2335.5 9132.4 9302.3 9380.1 9380.5 9384.2 5530.3 5659.6 5668.1 5677.4 5678.1 3418.8 3441.6 3524.6 3542.7 3546.8 1208.0 1230.9 1260.5 1278.0 1282.4 13080.5 13089.9 13097.5 13109.5 13142.9 4851.4 4958.0 4972.4 5062.4 5103.2 11040.6 11063.8 11063.9 11064.6 11065.9 5718.6 5732.8 5739.5 5739.6 5745.0 4541.6 4583.8 4909.2 5179.4 5283.8 4339.3 4344.0 4357.0 4383.4 4438.3 1356.5 1397.4 1407.5 1416.3 1435.5 999.1 1008.5 1012.5 1028.3 1035.1 6091.0 6166.5 6208.5 6298.7 6344.6 486.4 488.3 491.5 499.3 506.7 4227.0 4311.9 4411.4 4471.7 4495.8 11083.9 11531.5 11560.9 11578.5 11622.8 10509.5 10787.7 10928.0 11499.9 11538.7 8431.2 8477.6 8687.0 8690.2 8704.9 6411.6 6447.4 6521.1 6574.5 6644.3 10655.3 10877.6 10918.2 10919.5 10935.7 10830.1 10945.2 11122.0 11123.1 11217.8 7379.6 7964.8 8099.1 8241.5 8302.1 9317.7 9396.6 9402.8 9403.5 9404.4 7928.8 7978.7 8071.6 8239.7 8242.1 8248.9 8274.8 8316.1 8409.7 8574.9 7203.0 7349.2 7428.9 7462.8 7605.1 5342.8 5377.7 5638.3 5645.4 5730.4 5423.8 5522.9 5617.4 5621.4 5829.9 12:43:05 INFO - PROCESS | 28805 | 12:43:05 INFO - PROCESS | 28805 | [#4] prototype.html Cycles:180 Average:4956.47 Median:5664.70 stddev:1450.13 (25.6%) stddev-sans-first:1412.32 12:43:05 INFO - PROCESS | 28805 | Values: 346.5 348.3 354.0 357.1 365.5 5620.8 5634.3 5639.0 5649.0 5656.7 5225.0 5343.9 5423.5 5470.0 5519.7 4371.8 4380.5 4381.3 4389.7 4391.8 4391.9 4396.6 4406.8 4408.3 4409.9 4100.2 4321.2 4340.2 4347.3 4372.9 4309.3 4330.4 4340.7 4347.7 4349.8 3823.8 3829.3 3836.6 3847.4 3849.5 5254.3 5350.2 5401.5 5411.3 5416.2 4971.6 4975.8 4980.8 4989.3 4998.8 5821.9 5827.9 5835.0 5837.3 5840.9 4118.8 4195.4 4208.8 4219.1 4277.6 6000.5 6005.2 6019.2 6029.9 6036.9 4327.2 4345.5 4347.0 4349.6 4359.0 4312.8 4372.5 4385.7 4404.7 4417.3 4970.5 4971.7 4975.9 4976.7 4988.8 5875.2 5884.6 5892.9 5899.9 5900.4 1430.6 1460.4 1461.7 1513.5 1517.3 1062.5 1082.0 1102.8 1107.6 1120.0 5571.9 5677.2 5712.9 5755.4 5770.7 5790.4 6050.8 6060.8 6067.0 6067.6 5758.0 5759.8 5775.2 5779.8 5789.5 3183.0 3200.4 3212.0 3213.4 3219.4 6058.7 6237.6 6250.4 6279.6 6305.0 6169.5 6173.3 6182.6 6183.6 6187.4 6123.1 6213.6 6256.3 6269.9 6304.3 6035.7 6035.7 6037.9 6042.3 6064.5 5824.2 5901.5 5942.9 6032.3 6037.4 6088.2 6122.3 6204.5 6236.4 6244.7 4302.4 4357.2 4359.7 4437.4 4440.1 5753.4 6017.8 6051.0 6098.4 6099.0 5904.5 5935.1 5941.7 5942.6 5950.3 5680.1 5860.9 5904.9 5908.4 5950.3 5758.5 5830.6 5853.5 5853.7 5888.7 5908.7 5929.9 5942.1 5992.3 5993.2 5672.7 5730.7 5785.8 5788.7 5811.7 12:43:05 INFO - PROCESS | 28805 | 12:43:05 INFO - PROCESS | 28805 | [#5] yui.html Cycles:180 Average:21943.02 Median:3946.94 stddev:31487.84 (797.8%) stddev-sans-first:31536.14 12:43:05 INFO - PROCESS | 28805 | Values: 796.8 836.5 840.2 859.0 900.9 15649.8 16852.0 16964.6 17011.6 17012.4 15350.8 15940.9 16482.5 16608.9 16674.8 826.1 847.2 848.3 852.7 853.7 862.0 864.8 866.3 866.5 866.7 902.2 904.6 911.0 912.0 912.2 900.6 901.0 902.8 903.3 903.4 662.4 663.4 663.7 663.7 663.8 15322.2 15355.7 15386.8 15416.2 16132.2 15360.9 16216.3 16371.0 16510.8 17079.8 13616.9 13691.6 13704.8 13705.2 14091.2 4076.0 4165.3 4173.2 4234.6 4278.4 82110.0 83404.2 84186.0 84421.0 84798.2 12258.9 12333.2 12362.6 12543.1 12580.4 22346.6 22350.6 22393.6 22425.6 22427.3 8871.7 9010.5 9051.7 9175.1 9464.4 5112.8 5113.2 5147.3 5221.8 5228.3 3675.7 3815.5 3816.8 3817.3 3817.9 657.6 660.2 660.9 672.4 688.3 613.1 636.9 764.2 771.5 790.8 9850.3 10219.2 10289.7 10341.3 10342.7 755.7 756.2 756.7 760.7 803.1 5041.5 5111.2 5246.6 5262.9 5330.3 74113.3 108200.0 131991.0 133728.0 140747.0 71872.6 111044.0 113183.0 113367.0 113753.4 59783.4 81023.8 86144.0 93389.5 94925.0 9667.7 10057.9 10314.0 10625.9 10627.7 41282.4 42496.8 45669.8 51319.0 54083.5 69414.3 83156.0 84108.6 87394.0 94077.0 14531.3 14740.8 14860.9 15386.6 15444.7 16082.8 16290.3 16318.0 17788.8 18208.9 14274.1 14814.6 14860.3 15900.0 15931.9 15028.2 15089.4 15697.4 15755.8 16509.7 13728.5 14019.6 14931.3 15027.6 15536.2 11496.1 11590.9 12082.7 12245.1 12920.9 12056.0 12185.8 12226.9 12385.6 12575.4 12:43:05 INFO - PROCESS | 28805 | -------- Summary: end -------- 12:43:05 INFO - PROCESS | 28805 | 12:43:06 INFO - TEST-INFO | 28805: exit 0 12:43:06 INFO - TEST-OK | dromaeo_css | took 1112628ms 12:43:06 INFO - TEST-START | kraken 12:43:06 INFO - operating with platform_type : linux_ 12:43:06 INFO - Initialising browser for kraken test... 12:43:06 INFO - TEST-INFO | started process 29113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPvhpNP/profile http://localhost:37901/getInfo.html) 12:43:09 INFO - PROCESS | 29113 | __metrics Screen width/height:1600/1200 12:43:09 INFO - PROCESS | 29113 | colorDepth:24 12:43:09 INFO - PROCESS | 29113 | Browser inner width/height: 1024/697 12:43:09 INFO - PROCESS | 29113 | __metrics 12:43:10 INFO - PROCESS | 29113 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:43:10 INFO - PROCESS | 29113 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:43:10 INFO - PROCESS | 29113 | console.error: PushService: 12:43:10 INFO - PROCESS | 29113 | stateChangeProcessEnqueue: Error transitioning state 12:43:10 INFO - PROCESS | 29113 | UnknownError 12:43:11 INFO - TEST-INFO | 29113: exit 0 12:43:11 INFO - Browser initialized. 12:43:11 INFO - Running cycle 1/1 for kraken test... 12:43:11 INFO - TEST-INFO | started process 29205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPvhpNP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:43:22 INFO - PROCESS | 29205 | RSS: Main: 144093184 12:43:22 INFO - PROCESS | 29205 | 12:43:25 INFO - PROCESS | 29205 | Cycle 1(1): loaded http://localhost:37901/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37901/tests/kraken/driver.html?testName=audio-beat-detection) 12:43:26 INFO - PROCESS | 29205 | RSS: Main: 186236928 12:43:26 INFO - PROCESS | 29205 | 12:43:28 INFO - PROCESS | 29205 | Cycle 1(1): loaded http://localhost:37901/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37901/tests/kraken/driver.html?testName=audio-dft) 12:43:29 INFO - PROCESS | 29205 | RSS: Main: 174276608 12:43:29 INFO - PROCESS | 29205 | 12:43:32 INFO - PROCESS | 29205 | Cycle 1(1): loaded http://localhost:37901/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37901/tests/kraken/driver.html?testName=audio-fft) 12:43:32 INFO - PROCESS | 29205 | RSS: Main: 265818112 12:43:32 INFO - PROCESS | 29205 | 12:43:34 INFO - PROCESS | 29205 | Cycle 1(1): loaded http://localhost:37901/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37901/tests/kraken/driver.html?testName=audio-oscillator) 12:43:35 INFO - PROCESS | 29205 | RSS: Main: 171982848 12:43:35 INFO - PROCESS | 29205 | 12:43:37 INFO - PROCESS | 29205 | Cycle 1(1): loaded http://localhost:37901/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37901/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:43:38 INFO - PROCESS | 29205 | RSS: Main: 173903872 12:43:38 INFO - PROCESS | 29205 | 12:43:41 INFO - PROCESS | 29205 | Cycle 1(1): loaded http://localhost:37901/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37901/tests/kraken/driver.html?testName=imaging-darkroom) 12:43:41 INFO - PROCESS | 29205 | RSS: Main: 209805312 12:43:41 INFO - PROCESS | 29205 | 12:43:44 INFO - PROCESS | 29205 | Cycle 1(1): loaded http://localhost:37901/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37901/tests/kraken/driver.html?testName=imaging-desaturate) 12:43:45 INFO - PROCESS | 29205 | RSS: Main: 208613376 12:43:45 INFO - PROCESS | 29205 | 12:43:48 INFO - PROCESS | 29205 | Cycle 1(1): loaded http://localhost:37901/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37901/tests/kraken/driver.html?testName=json-parse-financial) 12:43:48 INFO - PROCESS | 29205 | RSS: Main: 208060416 12:43:48 INFO - PROCESS | 29205 | 12:43:50 INFO - PROCESS | 29205 | Cycle 1(1): loaded http://localhost:37901/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37901/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:43:50 INFO - PROCESS | 29205 | RSS: Main: 170332160 12:43:50 INFO - PROCESS | 29205 | 12:43:52 INFO - PROCESS | 29205 | Cycle 1(1): loaded http://localhost:37901/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37901/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:43:53 INFO - PROCESS | 29205 | RSS: Main: 177664000 12:43:53 INFO - PROCESS | 29205 | 12:43:55 INFO - PROCESS | 29205 | Cycle 1(1): loaded http://localhost:37901/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37901/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:43:55 INFO - PROCESS | 29205 | RSS: Main: 187219968 12:43:55 INFO - PROCESS | 29205 | 12:43:58 INFO - PROCESS | 29205 | Cycle 1(1): loaded http://localhost:37901/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37901/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:43:58 INFO - PROCESS | 29205 | RSS: Main: 195080192 12:43:58 INFO - PROCESS | 29205 | 12:44:01 INFO - PROCESS | 29205 | Cycle 1(1): loaded http://localhost:37901/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37901/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:44:02 INFO - PROCESS | 29205 | RSS: Main: 191406080 12:44:02 INFO - PROCESS | 29205 | 12:44:03 INFO - PROCESS | 29205 | Cycle 1(1): loaded http://localhost:37901/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37901/tests/kraken/driver.html?testName=ai-astar) 12:44:04 INFO - PROCESS | 29205 | RSS: Main: 243740672 12:44:04 INFO - PROCESS | 29205 | 12:44:04 INFO - PROCESS | 29205 | __start_tp_report 12:44:04 INFO - PROCESS | 29205 | _x_x_mozilla_page_load 12:44:04 INFO - PROCESS | 29205 | _x_x_mozilla_page_load_details 12:44:04 INFO - PROCESS | 29205 | |i|pagename|runs| 12:44:04 INFO - PROCESS | 29205 | |0;ai-astar;111;112;111;110;111;113;110;110;110;111 12:44:04 INFO - PROCESS | 29205 | |1;audio-beat-detection;141;120;118;155;122;117;123;117;142;119 12:44:04 INFO - PROCESS | 29205 | |2;audio-dft;159;160;161;160;159;159;161;159;163;160 12:44:04 INFO - PROCESS | 29205 | |3;audio-fft;74;75;75;115;75;75;79;76;97;74 12:44:04 INFO - PROCESS | 29205 | |4;audio-oscillator;81;81;123;81;82;82;99;82;82;109 12:44:04 INFO - PROCESS | 29205 | |5;imaging-gaussian-blur;117;117;116;118;117;118;117;117;117;117 12:44:04 INFO - PROCESS | 29205 | |6;imaging-darkroom;147;145;145;146;146;146;146;145;146;146 12:44:04 INFO - PROCESS | 29205 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;94 12:44:04 INFO - PROCESS | 29205 | |8;json-parse-financial;49;49;49;48;49;48;48;48;50;49 12:44:04 INFO - PROCESS | 29205 | |9;json-stringify-tinderbox;59;59;59;59;60;59;59;59;59;58 12:44:04 INFO - PROCESS | 29205 | |10;stanford-crypto-aes;75;78;73;73;73;77;73;72;73;74 12:44:04 INFO - PROCESS | 29205 | |11;stanford-crypto-ccm;134;122;120;128;123;122;117;127;162;125 12:44:04 INFO - PROCESS | 29205 | |12;stanford-crypto-pbkdf2;154;157;155;152;152;154;154;155;157;155 12:44:04 INFO - PROCESS | 29205 | |13;stanford-crypto-sha256-iterative;62;63;62;61;62;64;61;61;61;60 12:44:04 INFO - PROCESS | 29205 | __end_tp_report 12:44:04 INFO - PROCESS | 29205 | __start_cc_report 12:44:04 INFO - PROCESS | 29205 | _x_x_mozilla_cycle_collect,1594 12:44:04 INFO - PROCESS | 29205 | __end_cc_report 12:44:04 INFO - PROCESS | 29205 | __startTimestamp1479156244107__endTimestamp 12:44:04 INFO - PROCESS | 29205 | 12:44:04 INFO - PROCESS | 29205 | ------- Summary: start ------- 12:44:04 INFO - PROCESS | 29205 | Number of tests: 14 12:44:04 INFO - PROCESS | 29205 | 12:44:04 INFO - PROCESS | 29205 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:0.99 (0.9%) stddev-sans-first:1.05 12:44:04 INFO - PROCESS | 29205 | Values: 111.0 112.0 111.0 110.0 111.0 113.0 110.0 110.0 110.0 111.0 12:44:04 INFO - PROCESS | 29205 | 12:44:04 INFO - PROCESS | 29205 | [#1] audio-beat-detection Cycles:10 Average:127.40 Median:122.50 stddev:13.49 (11.0%) stddev-sans-first:13.38 12:44:04 INFO - PROCESS | 29205 | Values: 141.0 120.0 118.0 155.0 122.0 117.0 123.0 117.0 142.0 119.0 12:44:04 INFO - PROCESS | 29205 | 12:44:04 INFO - PROCESS | 29205 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:1.29 (0.8%) stddev-sans-first:1.30 12:44:04 INFO - PROCESS | 29205 | Values: 159.0 160.0 161.0 160.0 159.0 159.0 161.0 159.0 163.0 160.0 12:44:04 INFO - PROCESS | 29205 | 12:44:04 INFO - PROCESS | 29205 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.00 stddev:13.66 (18.2%) stddev-sans-first:14.22 12:44:04 INFO - PROCESS | 29205 | Values: 74.0 75.0 75.0 115.0 75.0 75.0 79.0 76.0 97.0 74.0 12:44:04 INFO - PROCESS | 29205 | 12:44:04 INFO - PROCESS | 29205 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:82.00 stddev:15.02 (18.3%) stddev-sans-first:15.55 12:44:04 INFO - PROCESS | 29205 | Values: 81.0 81.0 123.0 81.0 82.0 82.0 99.0 82.0 82.0 109.0 12:44:04 INFO - PROCESS | 29205 | 12:44:04 INFO - PROCESS | 29205 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 12:44:04 INFO - PROCESS | 29205 | Values: 117.0 117.0 116.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 12:44:04 INFO - PROCESS | 29205 | 12:44:04 INFO - PROCESS | 29205 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 12:44:04 INFO - PROCESS | 29205 | Values: 147.0 145.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 12:44:04 INFO - PROCESS | 29205 | 12:44:04 INFO - PROCESS | 29205 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:44:04 INFO - PROCESS | 29205 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 12:44:04 INFO - PROCESS | 29205 | 12:44:04 INFO - PROCESS | 29205 | [#8] json-parse-financial Cycles:10 Average:48.70 Median:49.00 stddev:0.67 (1.4%) stddev-sans-first:0.71 12:44:04 INFO - PROCESS | 29205 | Values: 49.0 49.0 49.0 48.0 49.0 48.0 48.0 48.0 50.0 49.0 12:44:04 INFO - PROCESS | 29205 | 12:44:04 INFO - PROCESS | 29205 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 12:44:04 INFO - PROCESS | 29205 | Values: 59.0 59.0 59.0 59.0 60.0 59.0 59.0 59.0 59.0 58.0 12:44:04 INFO - PROCESS | 29205 | 12:44:04 INFO - PROCESS | 29205 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:73.50 stddev:1.97 (2.7%) stddev-sans-first:2.06 12:44:04 INFO - PROCESS | 29205 | Values: 75.0 78.0 73.0 73.0 73.0 77.0 73.0 72.0 73.0 74.0 12:44:04 INFO - PROCESS | 29205 | 12:44:04 INFO - PROCESS | 29205 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:126.00 stddev:12.84 (10.2%) stddev-sans-first:13.44 12:44:04 INFO - PROCESS | 29205 | Values: 134.0 122.0 120.0 128.0 123.0 122.0 117.0 127.0 162.0 125.0 12:44:04 INFO - PROCESS | 29205 | 12:44:04 INFO - PROCESS | 29205 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.50 Median:155.00 stddev:1.72 (1.1%) stddev-sans-first:1.81 12:44:04 INFO - PROCESS | 29205 | Values: 154.0 157.0 155.0 152.0 152.0 154.0 154.0 155.0 157.0 155.0 12:44:04 INFO - PROCESS | 29205 | 12:44:04 INFO - PROCESS | 29205 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.00 stddev:1.16 (1.9%) stddev-sans-first:1.22 12:44:04 INFO - PROCESS | 29205 | Values: 62.0 63.0 62.0 61.0 62.0 64.0 61.0 61.0 61.0 60.0 12:44:04 INFO - PROCESS | 29205 | -------- Summary: end -------- 12:44:04 INFO - PROCESS | 29205 | 12:44:05 INFO - TEST-INFO | 29205: exit 0 12:44:05 INFO - TEST-OK | kraken | took 58812ms 12:44:05 INFO - SUITE-END | took 1171s 12:44:05 INFO - Completed test suite (00:19:31) 12:44:05 INFO - javascript benchmark 12:44:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3120.968790312097, 3161.367726454709, 3167.5723777290073, 3184.9840750796243, 3203.1831882869865, 5526.557875369971, 5577.386487486373, 5605.523530499902, 5609.0, 5631.380548139701, 5641.943580564193, 5685.9147112793235, 5696.487316141546, 5697.943020569793, 5706.71466426678, 5164.896702065957, 5168.198929165986, 5179.141893137831, 5202.791888324463, 5222.164453687411, 4976.62675299354, 5202.4277329493725, 5234.6335756497065, 5244.973775131138, 5271.762770675309, 5026.447090820026, 5084.110280700881, 5113.0, 5120.411152717429, 5130.820421285256, 5175.663581867167, 5204.9739751301195, 5215.739213039371, 5264.2893209416625, 5281.498257665516, 5116.565091967187, 5161.870953226162, 5225.4513276105845, 5237.057329680656, 5262.315898933152, 5345.198220266952, 5440.782368705247, 5464.617476776627, 5508.421615730371, 5519.613627046108, 5816.82549523515, 5959.165716799652, 5978.671173085479, 5988.490978266853, 6079.179310793031, 6107.5419343548965, 6110.175126357929, 6124.11200375943, 6125.5712100153005, 6126.785562505335, 5458.863528411782, 5511.559075273968, 5599.916001259984, 5660.377358490563, 5663.292088488939, 6200.844978875474, 6223.906641400383, 6240.812775616739, 6242.0, 6245.188125543741, 5977.970110149421, 5982.282126144803, 5990.274425136552, 5991.340952495222, 6024.1566180734735, 5806.0, 5856.033754430471, 5975.611585247032, 6042.577019608585, 6074.787382441594, 6076.088586712029, 6080.0575910733905, 6083.11794789753, 6097.4817140543555, 6113.144159817629, 6012.338642749294, 6031.668258245839, 6071.817845464643, 6094.481969032593, 6117.296510901303, 4506.369108324837, 4539.6368290536675, 4615.3077038443835, 4667.533246675305, 4680.251159814414, 4117.691173162025, 4141.91716165675, 4162.0, 4165.708400411942, 4204.642605378577, 5784.971075144597, 5788.102844059177, 5789.710514474259, 5794.565407594448, 5811.709414529341, 5944.286685597756, 5999.970000149971, 6158.599691020159, 6162.383761623802, 6164.8767024659255, 5557.499825015768, 5701.971490142523, 5719.313682358061, 5754.424557544212, 5759.395263497357, 5261.710605916634, 5289.3917199521775, 5298.152295632757, 5301.920471192935, 5304.363476382859, 6083.391660833881, 6155.599886007395, 6207.782727604512, 6217.160683307786, 6222.751089956441, 5919.348871624032, 6061.545384096122, 6115.209918062534, 6126.151269885628, 6144.109104179958, 6277.748890044347, 6280.748770049329, 6284.811455656338, 6293.181886354744, 6294.8426289341305, 5956.255468066492, 5989.9700501498955, 5992.8801423972145, 5994.6403215807195, 6030.216071910623, 5894.498967587631, 5897.056470964625, 5905.763769449346, 5927.585069045125, 5943.257092863392, 5896.616719913192, 5921.3190483094995, 5921.7631294747725, 5922.348541660328, 5927.555433342431, 5863.560232982458, 5867.178594996789, 5867.559933005127, 5870.882582348415, 5873.295204575478, 5709.65742055478, 5737.942620573741, 5741.799037033684, 5854.385289544536, 5881.676507792113, 5848.6783226921225, 5852.268466441695, 5852.912206316993, 5873.148393483007, 5892.941070589411, 5699.1451282306325, 5703.08750599902, 5709.800156994485, 5709.9714501427225, 5715.799947001835], "value": 5561.924322817767, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.9517638588914, 625.1903784598945, 632.1213513216633, 644.9873698293678, 647.1102234427661, 35180.0, 38554.22891542168, 47265.999999999956, 48132.27801582979, 48179.51820481794, 49019.0, 49578.0, 49602.751986240015, 49626.75186624071, 49654.50345496544, 9276.165145136936, 9424.623015079424, 9432.764180895463, 9435.43387396755, 9439.716808495721, 8511.191436813493, 8720.52037137957, 9199.356045076847, 10739.516721747501, 11106.944465277662, 11298.717532061683, 11393.316401015965, 11400.315981041123, 11403.885961140408, 11406.258593191416, 11083.833742493869, 11134.777304453946, 11144.442777861075, 11158.051565616892, 11177.66467005991, 11064.502097405637, 11143.721406964809, 11150.163737719704, 11159.721006974809, 11166.274192177483, 45870.77064614656, 46043.30935035977, 46093.30860037102, 46135.53864461346, 46196.0, 4157.812898419548, 4195.517515485697, 4370.278903980871, 4441.378207051015, 4664.440267167962, 35011.29977400438, 35171.296574068634, 35392.29215415703, 35441.82279088614, 37372.81313593442, 4357.825686972517, 4410.691251612388, 4430.844920427802, 4458.152950939344, 4481.2381895077915, 380362.0, 381689.0, 382115.08942455385, 382128.0, 385666.0, 39282.41076383857, 67684.0, 68167.65916170487, 68408.6579567099, 68585.65707171432, 39939.60060399417, 42309.788451057546, 42490.150196995884, 42662.146757064686, 42723.0, 17375.0, 17514.562135946704, 17544.210510527057, 17550.297988080332, 17558.91220543915, 12652.17760845542, 13494.122882012638, 13551.0, 13579.660508487366, 13631.04582679203, 9058.230050445785, 9407.670731524364, 9688.273379496566, 9695.563699633534, 9822.607095716092, 3670.4310831821113, 3688.188598508324, 3718.5723641781, 3720.739548231598, 3735.533058367704, 983.8229118758549, 1054.288355360129, 1214.3745970825032, 1222.216697329816, 1238.5293588436336, 34402.827985860415, 34452.82773586116, 34530.82734586311, 34819.12952176216, 35049.299014020085, 1088.2491081153978, 1143.874173840877, 1149.7872893514727, 1252.6930901929086, 1260.602910083321, 17328.740068898976, 18274.817251827313, 18304.450866474028, 18305.267789288544, 18322.541936451427, 625233.0, 634478.0, 635675.0, 636758.0, 638363.0, 65465.0, 65793.0, 65809.34190658032, 66110.66944665246, 66140.33859661438, 1285.9742805143844, 1294.1717300927414, 1394.7280280345437, 1431.1127101197117, 1480.7852861335045, 31469.370612588078, 36040.819795900854, 36265.81867090753, 36346.27307453889, 36500.45249321315, 55580.44419555915, 56176.71911640416, 56288.0, 56315.71842140763, 56350.0, 436954.0, 439290.0, 439822.0, 439897.0, 440270.0, 27530.449391011665, 28099.71900280971, 30752.538711918893, 31616.0, 32029.839850800596, 51025.0, 52036.95926081381, 52072.73963630158, 52190.21714674359, 52680.0, 43419.34870977001, 45374.0, 45979.0, 46161.0, 46795.0, 44395.33406998833, 44856.32715509205, 44974.0, 45907.54092459033, 46667.0, 44595.331070033324, 44823.0, 45423.501707405085, 45624.31563526616, 45784.54215457803, 37328.25343493061, 39912.0, 39936.60063399329, 40068.39897401483, 40179.191936362346, 28785.56821647719, 29459.922888604964, 29696.257593560334, 29947.70052299449, 30189.698103018687], "value": 20896.008631210956, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.0947553284905, 422.9429027081347, 423.6018142945631, 432.88744926319146, 449.95950364467194, 19008.524786880334, 20429.897850510744, 20953.68569471459, 21334.0, 21700.131994720232, 19761.110750016247, 21089.26187583435, 21127.577448451022, 21319.893400532976, 21462.248821291258, 5654.575906806986, 5935.198748169007, 5939.4654481096695, 5947.078202878561, 5948.107783832416, 5605.411431799664, 5810.3027636683655, 5836.416358364172, 5852.67810270435, 5951.285845698522, 5946.108083787423, 5954.4938680212235, 5960.403959604048, 5965.433283838029, 5965.46310832025, 5829.8834023319505, 6015.608985415955, 6044.214252147237, 6047.0627052806885, 6054.848628784272, 5698.458646428624, 5854.2389489366105, 5883.146943693183, 5886.6468011919, 5888.322842873082, 15209.695806083817, 15273.694526109526, 15396.384144634201, 15419.691606167813, 15556.922215388851, 2582.7804636605724, 2697.9595306070423, 2725.4549090181845, 2967.896123635684, 3136.4197623439736, 11057.447127643665, 11304.886951130466, 11309.434528273554, 11511.48198331077, 11541.365224912626, 1960.5686748915216, 1962.6663467210608, 2029.7158397824317, 2058.9485262868548, 2066.3077868913933, 67707.2760998145, 70628.6468567659, 90072.09927900638, 91425.54287228588, 91482.0, 11418.771624567462, 11861.11041671878, 11927.940360298317, 12067.698307542207, 12220.633380998584, 17364.479065628053, 17380.21789019497, 17382.65234695299, 17391.391301304648, 17420.041897695748, 8458.577071146417, 8586.87119693205, 8834.911650883538, 8901.777455563533, 8976.237019853386, 8319.500829950222, 8369.58152092393, 8493.405461617627, 8587.270082043096, 8712.128787121364, 4771.618270538349, 4859.927101093486, 5056.367954005749, 5203.583713302926, 5304.522592966651, 2055.1779288284506, 2072.3886453496257, 2101.2015434135237, 2117.5764847030655, 2152.2789865394957, 922.6678395777515, 997.7605374710163, 1035.3270374256642, 1057.7091299892438, 1070.8315660786968, 19656.90171549133, 20557.897210513853, 21004.369868903956, 21079.894600527205, 21167.470813229793, 1037.6420135053395, 1039.2361614213546, 1048.308116643012, 1054.9578016879393, 1067.354250678344, 10739.463026848782, 11827.704307392212, 11864.88135118655, 11866.525338986516, 11895.0, 512826.0, 512866.0, 515569.0, 532699.0, 534455.0, 77081.0, 82865.58567207246, 86511.56744216238, 87666.0, 97108.0, 1064.2762921213493, 1099.70308016835, 1103.806833804097, 1105.9557617695202, 1108.5731993182521, 18567.628647426707, 18618.53453663615, 18836.434906952265, 18926.905365473085, 19181.0, 40763.184736304516, 41003.794981024905, 41685.0, 45705.31442028306, 47883.0, 62769.68615157078, 62888.68555657376, 62955.0, 64077.0, 64562.03156952743, 8987.685431009882, 9074.546272686208, 9119.954400227956, 9481.288903332139, 9574.32979691415, 8125.79685507867, 9528.0, 12992.870071299543, 13220.603381898558, 14147.43410263578, 11057.668269951915, 11322.716932076764, 11345.716357091138, 11524.711882203012, 11900.166988310735, 10482.0, 10836.945815271189, 11068.778624427627, 11341.319520828776, 11617.128715346551, 11215.214934954474, 11528.59649912249, 11718.824217636913, 11738.823917641414, 11993.460294286953, 8944.105589441004, 9125.77185570366, 9127.634894604142, 9346.626134954799, 9499.762505937408, 10230.948845255725, 10829.783404332027, 11267.549298027987, 11368.147388946027, 11626.302421854716], "value": 9546.327123373092, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1516.4389176004877, 1531.1196062264198, 1684.7220208665572, 1811.8369346758789, 1830.5606654402939, 8760.167784060512, 9353.064693530643, 9356.064393560657, 9358.11097945695, 9367.81264374713, 8141.715039973602, 8392.748217553482, 8844.601992910319, 9131.726048218547, 9208.447493150416, 2487.577111890974, 2506.410993416546, 2516.5218608464425, 2522.7351128131468, 2524.204875464223, 2167.913283468667, 2230.386643672987, 2230.7657695941934, 2235.0947866114248, 2241.2491815241915, 2377.2749311459997, 2389.139909632531, 2394.7964423024064, 2429.7327293997646, 2433.6592876997233, 2338.298510446859, 2354.152505098163, 2375.904963801446, 2380.7143142822883, 2380.880955952204, 2321.0483701682397, 2330.5921463743775, 2330.755270696586, 2335.322756400642, 2335.5328934213057, 9132.406393584462, 9302.348835581512, 9380.10888965554, 9380.5309734513, 9384.20234280087, 5530.308711411074, 5659.5755318351285, 5668.093105103164, 5677.403872593401, 5678.148277758328, 3418.8290585470627, 3441.6042155152227, 3524.6122926478065, 3542.679544898096, 3546.769459985093, 1208.0456439412853, 1230.8522977242699, 1260.5462033667873, 1278.0414688983262, 1282.4036822877406, 13080.476780928846, 13089.869101309056, 13097.476100956046, 13109.47562097515, 13142.86857131426, 4851.393575803025, 4957.975210123998, 4972.353594032753, 5062.443131255559, 5103.18349064148, 11040.558377664804, 11063.834042489369, 11063.944680276547, 11064.612738554273, 11065.944670276758, 5718.599698021182, 5732.77068917247, 5739.483446489836, 5739.62692424991, 5744.971275143597, 4541.613962813131, 4583.770811459413, 4909.239067944474, 5179.430262671103, 5283.788648454096, 4339.305711086211, 4343.956560434355, 4357.0, 4383.3863259143745, 4438.28987362027, 1356.4641966423208, 1397.4410235905718, 1407.4862675123507, 1416.2706206303762, 1435.454527279627, 999.14073896449, 1008.5159123620704, 1012.4532752313668, 1028.2596530498029, 1035.1304903880775, 6091.0, 6166.537509686791, 6208.4722798561725, 6298.653574053379, 6344.619322840552, 486.4405933176804, 488.3334248750501, 491.4593946658647, 499.3059647090547, 506.71370675568187, 4226.957730422718, 4311.8706438806885, 4411.382406463098, 4471.731696098244, 4495.820167193276, 11083.944580277048, 11531.538738450368, 11560.884391156149, 11578.478968446272, 11622.825657615143, 10509.474526273656, 10787.67636970892, 10928.0, 11499.885001150049, 11538.711532211762, 8431.156884311642, 8477.576121193915, 8686.956565217133, 8690.217880390795, 8704.869426958601, 6411.647359395278, 6447.4197322241225, 6521.119648847345, 6574.539782215199, 6644.335566443317, 10655.30740501865, 10877.564897404332, 10918.23572349928, 10919.454027298762, 10935.726606834893, 10830.133589312678, 10945.179111566506, 11122.0, 11123.110151187724, 11217.775644486901, 7379.594122323324, 7964.800879978047, 8099.14958929304, 8241.546714930737, 8302.086770455366, 9317.673881414388, 9396.577154028222, 9402.764930876783, 9403.529823508661, 9404.435733855991, 7928.7621371358955, 7978.720744773905, 8071.596420179085, 8239.670413183405, 8242.093369729206, 8248.876266856121, 8274.751757447286, 8316.126806685212, 8409.663613455637, 8574.91425085766, 7202.96398518004, 7349.1915889253205, 7428.851422971618, 7462.813429664302, 7605.125410577854, 5342.813001544927, 5377.650452720561, 5638.323401191719, 5645.4072322405555, 5730.369659337553, 5423.810166644149, 5522.917156242579, 5617.382087970402, 5621.353544342453, 5829.883402332014], "value": 4821.801836504869, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.5148791691631, 348.26168522731814, 353.9539859818223, 357.0965457392797, 365.5321188878235, 5620.803271885485, 5634.267545219126, 5639.0, 5648.983183027064, 5656.717164141792, 5224.973875130619, 5343.946560534403, 5423.484768946953, 5470.0, 5519.668819870811, 4371.819608705648, 4380.518143004283, 4381.298992161255, 4389.736615803062, 4391.824327026915, 4391.890202744941, 4396.560343965594, 4406.779661016953, 4408.25059739845, 4409.933850992237, 4100.211855937961, 4321.222180007598, 4340.240457919867, 4347.260965635849, 4372.890677733066, 4309.288967320388, 4330.437043184397, 4340.652747780186, 4347.739135651839, 4349.804258808345, 3823.8146174685935, 3829.329867273244, 3836.635519625659, 3847.4421208924828, 3849.480320156771, 5254.3169387979315, 5350.197470379435, 5401.515302960643, 5411.323584551931, 5416.241726158341, 4971.552560269557, 4975.805806606425, 4980.77586508608, 4989.301497790312, 4998.800047998076, 5821.854453638651, 5827.883442331172, 5835.0372188588835, 5837.270341207349, 5840.88318233633, 4118.75287482752, 4195.412642230091, 4208.831646734127, 4219.135077309144, 4277.572242775728, 6000.549958753111, 6005.249343832021, 6019.217501724792, 6029.939700602981, 6036.879262414727, 4327.156204540084, 4345.500267469219, 4346.978265108717, 4349.586789255016, 4358.978205108954, 4312.784360781949, 4372.475302963665, 4385.693001489929, 4404.713693609905, 4417.293233082692, 4970.478099799541, 4971.65198436106, 4975.875603109879, 4976.651634385558, 4988.7505624718615, 5875.23621929155, 5884.58807883444, 5892.939270931188, 5899.852503687356, 5900.380460051719, 1430.592281199874, 1460.4377314733904, 1461.693044460654, 1513.4551561437875, 1517.324790468231, 1062.5112448273726, 1081.967540973772, 1102.7849569334064, 1107.595727559435, 1120.0, 5571.860703482364, 5677.17680936262, 5712.942870571324, 5755.424457554211, 5770.682612456271, 5790.392008839095, 6050.848728781815, 6060.787872424444, 6066.998945174085, 6067.635941843415, 5757.971210143923, 5759.769609215585, 5775.249217601685, 5779.797707080316, 5789.450002249864, 3182.98408507956, 3200.439923013463, 3211.983940080331, 3213.4055199788113, 3219.404410184123, 6058.697065146725, 6237.625742455467, 6250.4374606285655, 6279.623222606659, 6304.968475157595, 6169.475594574512, 6173.271483984491, 6182.567220294536, 6183.598066125687, 6187.443130118221, 6123.112148738408, 6213.627182369072, 6256.343083976117, 6269.905951410824, 6304.338044505353, 6035.668038257938, 6035.69821508914, 6037.939620603738, 6042.274927008787, 6064.48451881595, 5824.194499705105, 5901.498372638373, 5942.940570594412, 6032.336442991355, 6037.396260373927, 6088.208532890696, 6122.326544080059, 6204.503639708722, 6236.376362363727, 6244.65654389013, 4302.376155457504, 4357.172137293904, 4359.735676653735, 4437.378766972691, 4440.111977604427, 5753.367129615823, 6017.819465416044, 6050.969745151246, 6098.359672234529, 6099.0, 5904.52763778888, 5935.139404786368, 5941.702914854326, 5942.642407040009, 5950.285965683973, 5680.097167448951, 5860.853478663067, 5904.852378690567, 5908.379620139824, 5950.31571369298, 5758.510526605285, 5830.591858569859, 5853.531717462508, 5853.736581853912, 5888.676122813115, 5908.675022873783, 5929.851753706192, 5942.1383899335215, 5992.250968628921, 5993.160957465871, 5672.688002159921, 5730.656160630376, 5785.82642520725, 5788.681622510802, 5811.709414529172], "value": 4499.963238187785, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.80079980005, 836.5106412748542, 840.1556435782041, 858.9863960526576, 900.8783814185083, 15649.843501564981, 16852.0, 16964.575885602837, 17011.57471063221, 17012.4045658402, 15350.769738453931, 15940.920295398506, 16482.505524834243, 16608.916955415236, 16674.833251667478, 826.099551488877, 847.2332539052168, 848.3340577646549, 852.7484392104344, 853.6713365354321, 862.0302160069921, 864.7838040489878, 866.2766589897443, 866.5493943149559, 866.7399780065987, 902.1835239108584, 904.6291020681522, 911.0388540090203, 912.0104686415248, 912.2291663544328, 900.6127365232948, 901.0313912544009, 902.7562558109274, 903.345074820753, 903.3766700976305, 662.3608218069586, 663.3664850068221, 663.6582160187459, 663.7046514301138, 663.7643636509018, 15322.23388830554, 15355.692886142326, 15386.846131538765, 15416.229188540528, 16132.193390330554, 15360.923195383952, 16216.270267837976, 16371.0, 16510.75233871481, 17079.829201707948, 13616.86383136166, 13691.589252322447, 13704.794428083587, 13705.246211458465, 14091.224982625952, 4075.9592404075875, 4165.250254954107, 4173.227952828706, 4234.640055595247, 4278.4010238566625, 82110.0, 83404.16595834025, 84186.0, 84420.99999999939, 84798.15201847964, 12258.877411225774, 12333.198342107913, 12362.567310144103, 12543.059270554744, 12580.4338804754, 22346.55306893853, 22350.55298894013, 22393.55212895733, 22425.55148897013, 22427.32718018462, 8871.689490867788, 9010.50442225684, 9051.683191088281, 9175.128362805523, 9464.384814987005, 5112.795488180431, 5113.233015047773, 5147.253648220987, 5221.765020574007, 5228.302891289346, 3675.7426980111672, 3815.5039844819994, 3816.809159542012, 3817.2556351511744, 3817.923641527154, 657.572577824418, 660.2308310817843, 660.8678264347054, 672.3814091036259, 688.3151264491862, 613.1201725523888, 636.8726254749068, 764.2395816162954, 771.4908160613968, 790.7706765038074, 9850.261230407748, 10219.182465402899, 10289.742756431, 10341.276110672181, 10342.689719308282, 755.7241606813474, 756.2097607999654, 756.6720405687983, 760.6729106484154, 803.1406395157126, 5041.521055499722, 5111.182210846247, 5246.606504512177, 5262.868428289246, 5330.307060082165, 74113.25886741171, 108200.0, 131991.0, 133728.0, 140747.0, 71872.64063679648, 111044.0, 113183.0, 113367.0, 113753.43123284496, 59783.40216597865, 81023.78464323039, 86144.0, 93389.53305233567, 94925.0, 9667.70996870095, 10057.949710251401, 10314.04925635684, 10625.9468702656, 10627.681169564925, 41282.38076428916, 42496.78751606222, 45669.77165114286, 51319.0, 54083.45916540784, 69414.30585694079, 83156.0, 84108.57945710233, 87394.0, 94077.0, 14531.346089426213, 14740.778888316898, 14860.925695371454, 15386.615334616725, 15444.691106178037, 16082.839171608133, 16290.266937988055, 16318.0, 17788.822111778718, 18208.860192802975, 14274.072185307921, 14814.555563333117, 14860.331285091981, 15900.04599723974, 15931.920340398225, 15028.173450459892, 15089.396424142911, 15697.372105115668, 15755.763663545285, 16509.66980660404, 13728.45086196541, 14019.649508762363, 14931.253437328307, 15027.624309392353, 15536.223188840739, 11496.137789665976, 11590.94204528972, 12082.697932551757, 12245.142840001114, 12920.870791291967, 12056.0, 12185.756284874076, 12226.87773122293, 12385.566505172275, 12575.371231438574], "value": 8131.25403919939, "unit": "score"}], "name": "dromaeo_css", "value": 7620.038394441832, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 111.0, 110.0, 111.0, 113.0, 110.0, 110.0, 110.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 120.0, 118.0, 155.0, 122.0, 117.0, 123.0, 117.0, 142.0, 119.0], "value": 127.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 161.0, 160.0, 159.0, 159.0, 161.0, 159.0, 163.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 115.0, 75.0, 75.0, 79.0, 76.0, 97.0, 74.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 123.0, 81.0, 82.0, 82.0, 99.0, 82.0, 82.0, 109.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 49.0, 48.0, 49.0, 48.0, 48.0, 48.0, 50.0, 49.0], "value": 48.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 58.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 73.0, 73.0, 73.0, 77.0, 73.0, 72.0, 73.0, 74.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 122.0, 120.0, 128.0, 123.0, 122.0, 117.0, 127.0, 162.0, 125.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 157.0, 155.0, 152.0, 152.0, 154.0, 154.0, 155.0, 157.0, 155.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 61.0, 62.0, 64.0, 61.0, 61.0, 61.0, 60.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1453.8, "alertThreshold": 2.0}]} 12:44:05 INFO - Return code: 0 12:44:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:44:05 INFO - # TBPL SUCCESS # 12:44:05 INFO - Running post-action listener: _resource_record_post_action 12:44:05 INFO - [mozharness: 2016-11-14 20:44:05.424937Z] Finished run-tests step (success) 12:44:05 INFO - Running post-run listener: _resource_record_post_run 12:44:05 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 309764096; Read time: 24; Write time: 200892 12:44:05 INFO - TinderboxPrint: CPU usage
12.9% 12:44:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 12:44:05 INFO - TinderboxPrint: I/O write bytes / time
309,764,096 / 200,892 12:44:05 INFO - TinderboxPrint: CPU idle
8,240.1 (87.1%) 12:44:05 INFO - TinderboxPrint: CPU user
1,180.0 (12.5%) 12:44:05 INFO - TinderboxPrint: Swap in / out
0 / 0 12:44:05 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 100540416; Read time: 0; Write time: 95796 12:44:05 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 209223680; Read time: 24; Write time: 105096 12:44:06 INFO - Running post-run listener: _upload_blobber_files 12:44:06 INFO - Blob upload gear active. 12:44:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:44:06 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 12:44:06 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:44:06 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:44:06 INFO - (blobuploader) - INFO - Open directory for files ... 12:44:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:44:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:44:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:44:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:44:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:44:07 INFO - (blobuploader) - INFO - Done attempting. 12:44:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:44:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:44:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:44:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:44:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:44:10 INFO - (blobuploader) - INFO - Done attempting. 12:44:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:44:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:44:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:44:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:44:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:44:12 INFO - (blobuploader) - INFO - Done attempting. 12:44:12 INFO - (blobuploader) - INFO - Iteration through files over. 12:44:12 INFO - Return code: 0 12:44:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:44:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:44:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb9d8626d8917aa271b7387b0deb5bf1910b87b9ed85c0f8e61d227dbe6e433aa040fe8d8a84ed2f4dfc9ceecdd2014fddb50164433ec97ca7633949b65c187f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d28d8131bed1f2d62f4e158c06d0f3c689545d030020f4f1864ae24ee4d25c9c7ddf88926fcd808053ef3824f0f5aa2bf910ba0dda5c1a1859ad3bee9669936", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/610b4f82d0d69c2118a7a567333445664c24cf3b5cdfb19de21a0bc444154d715bf5e9ef328ed7302595a2d5d859fe96f6ea1ca80d1a19b49eca9a909383e16f"} 12:44:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:44:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:44:12 INFO - Contents: 12:44:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb9d8626d8917aa271b7387b0deb5bf1910b87b9ed85c0f8e61d227dbe6e433aa040fe8d8a84ed2f4dfc9ceecdd2014fddb50164433ec97ca7633949b65c187f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d28d8131bed1f2d62f4e158c06d0f3c689545d030020f4f1864ae24ee4d25c9c7ddf88926fcd808053ef3824f0f5aa2bf910ba0dda5c1a1859ad3bee9669936", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/610b4f82d0d69c2118a7a567333445664c24cf3b5cdfb19de21a0bc444154d715bf5e9ef328ed7302595a2d5d859fe96f6ea1ca80d1a19b49eca9a909383e16f"} 12:44:12 INFO - Running post-run listener: copy_logs_to_upload_dir 12:44:12 INFO - Copying logs to upload dir... 12:44:12 INFO - mkdir: /builds/slave/test/build/upload/logs 12:44:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.204736 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-11-14 12:44:12.512718) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 12:44:12.516672) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb9d8626d8917aa271b7387b0deb5bf1910b87b9ed85c0f8e61d227dbe6e433aa040fe8d8a84ed2f4dfc9ceecdd2014fddb50164433ec97ca7633949b65c187f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d28d8131bed1f2d62f4e158c06d0f3c689545d030020f4f1864ae24ee4d25c9c7ddf88926fcd808053ef3824f0f5aa2bf910ba0dda5c1a1859ad3bee9669936", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/610b4f82d0d69c2118a7a567333445664c24cf3b5cdfb19de21a0bc444154d715bf5e9ef328ed7302595a2d5d859fe96f6ea1ca80d1a19b49eca9a909383e16f"} build_url:https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011765 build_url: 'https://queue.taskcluster.net/v1/task/WtuqIdHwR4aDkpnraba8tA/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb9d8626d8917aa271b7387b0deb5bf1910b87b9ed85c0f8e61d227dbe6e433aa040fe8d8a84ed2f4dfc9ceecdd2014fddb50164433ec97ca7633949b65c187f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d28d8131bed1f2d62f4e158c06d0f3c689545d030020f4f1864ae24ee4d25c9c7ddf88926fcd808053ef3824f0f5aa2bf910ba0dda5c1a1859ad3bee9669936", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/610b4f82d0d69c2118a7a567333445664c24cf3b5cdfb19de21a0bc444154d715bf5e9ef328ed7302595a2d5d859fe96f6ea1ca80d1a19b49eca9a909383e16f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 12:44:12.542669) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:44:12.543027) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1479155020.757961-1554725673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:44:12.629498) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 12:44:12.629838) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 12:44:12.630196) ========= ========= Total master_lag: 0.18 =========