builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1475348759.02 results: success (0) buildid: 20161001091355 builduid: b3fd73063c7f41d5bcc925543c0897f2 revision: 1341ec6ae0149311e8badce3e4f013e1fcc2869d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 12:05:59.021306) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 12:05:59.021767) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 12:05:59.022099) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 12:05:59.087982) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 12:05:59.088306) ========= 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=c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-01 12:05:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 17.6M=0.001s 2016-10-01 12:05:59 (17.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139941 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 12:05:59.241863) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 12:05:59.242204) ========= 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=c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020811 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 12:05:59.294256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 12:05:59.294684) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1341ec6ae0149311e8badce3e4f013e1fcc2869d --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-aurora --rev 1341ec6ae0149311e8badce3e4f013e1fcc2869d --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=c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-01 12:05:59,625 truncating revision to first 12 chars 2016-10-01 12:05:59,625 Setting DEBUG logging. 2016-10-01 12:05:59,625 attempt 1/10 2016-10-01 12:05:59,625 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1341ec6ae014?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-01 12:06:00,335 unpacking tar archive at: mozilla-aurora-1341ec6ae014/testing/mozharness/ program finished with exit code 0 elapsedTime=1.042588 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 12:06:00.351537) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 12:06:00.351856) ========= script_repo_revision: 1341ec6ae0149311e8badce3e4f013e1fcc2869d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 12:06:00.352282) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 12:06:00.352591) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 12:06:00.362348) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-10-01 12:06:00.362655) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:06:00 INFO - MultiFileLogger online at 20161001 12:06:00 in /builds/slave/test 12:06:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:06:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:06:00 INFO - {'append_to_log': False, 12:06:00 INFO - 'base_work_dir': '/builds/slave/test', 12:06:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:06:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:06:00 INFO - 'branch': 'Mozilla-Aurora', 12:06:00 INFO - 'buildbot_json_path': 'buildprops.json', 12:06:00 INFO - 'config_files': ('talos/linux_config.py',), 12:06:00 INFO - 'default_actions': ('clobber', 12:06:00 INFO - 'read-buildbot-config', 12:06:00 INFO - 'download-and-extract', 12:06:00 INFO - 'populate-webroot', 12:06:00 INFO - 'create-virtualenv', 12:06:00 INFO - 'install', 12:06:00 INFO - 'run-tests'), 12:06:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:06:00 INFO - 'download_minidump_stackwalk': True, 12:06:00 INFO - 'download_symbols': 'ondemand', 12:06:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:06:00 INFO - 'tooltool.py': '/tools/tooltool.py', 12:06:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:06:00 INFO - '/tools/misc-python/virtualenv.py')}, 12:06:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:06:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:06:00 INFO - 'installer_path': 'installer.exe', 12:06:00 INFO - 'log_level': 'info', 12:06:00 INFO - 'log_name': 'talos', 12:06:00 INFO - 'log_to_console': True, 12:06:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:06:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:06:00 INFO - 'opt_config_files': (), 12:06:00 INFO - 'pip_index': False, 12:06:00 INFO - 'sps_profile': False, 12:06:00 INFO - 'sps_profile_interval': 0, 12:06:00 INFO - 'suite': 'dromaeojs', 12:06:00 INFO - 'system_bits': '32', 12:06:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:06:00 INFO - 'title': 'talos-linux64-ix-004', 12:06:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:06:00 INFO - 'use_talos_json': True, 12:06:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:06:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:06:00 INFO - 'work_dir': 'build'} 12:06:00 INFO - [mozharness: 2016-10-01 19:06:00.790984Z] Running clobber step. 12:06:00 INFO - Running pre-action listener: _resource_record_pre_action 12:06:00 INFO - Running main action method: clobber 12:06:00 INFO - rmtree: /builds/slave/test/build 12:06:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:06:01 INFO - Running post-action listener: _resource_record_post_action 12:06:01 INFO - [mozharness: 2016-10-01 19:06:01.248011Z] Finished clobber step (success) 12:06:01 INFO - [mozharness: 2016-10-01 19:06:01.248110Z] Running read-buildbot-config step. 12:06:01 INFO - Running pre-action listener: _resource_record_pre_action 12:06:01 INFO - Running main action method: read_buildbot_config 12:06:01 INFO - Using buildbot properties: 12:06:01 INFO - { 12:06:01 INFO - "project": "", 12:06:01 INFO - "product": "firefox", 12:06:01 INFO - "script_repo_revision": "production", 12:06:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 12:06:01 INFO - "repository": "", 12:06:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 12:06:01 INFO - "buildid": "20161001091355", 12:06:01 INFO - "pgo_build": "True", 12:06:01 INFO - "basedir": "/builds/slave/test", 12:06:01 INFO - "buildnumber": 496, 12:06:01 INFO - "slavename": "talos-linux64-ix-004", 12:06:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:06:01 INFO - "platform": "ubuntu64_hw", 12:06:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:06:01 INFO - "branch": "mozilla-aurora", 12:06:01 INFO - "repo_path": "releases/mozilla-aurora", 12:06:01 INFO - "revision": "1341ec6ae0149311e8badce3e4f013e1fcc2869d", 12:06:01 INFO - "stage_platform": "linux64-pgo", 12:06:01 INFO - "builduid": "b3fd73063c7f41d5bcc925543c0897f2", 12:06:01 INFO - "slavebuilddir": "test" 12:06:01 INFO - } 12:06:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 12:06:01 INFO - Running post-action listener: _resource_record_post_action 12:06:01 INFO - [mozharness: 2016-10-01 19:06:01.250574Z] Finished read-buildbot-config step (success) 12:06:01 INFO - [mozharness: 2016-10-01 19:06:01.250663Z] Running download-and-extract step. 12:06:01 INFO - Running pre-action listener: _resource_record_pre_action 12:06:01 INFO - Running main action method: download_and_extract 12:06:01 INFO - mkdir: /builds/slave/test/build/tests 12:06:01 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:06:01 INFO - trying https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 12:06:01 INFO - Downloading https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 12:06:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:06:01 INFO - Downloaded 1361 bytes. 12:06:01 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 12:06:01 INFO - Using the following test package requirements: 12:06:01 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 12:06:01 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:06:01 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:06:01 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:06:01 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:06:01 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:06:01 INFO - u'jsshell-linux-x86_64.zip'], 12:06:01 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:06:01 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:06:01 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 12:06:01 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:06:01 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:06:01 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:06:01 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:06:01 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:06:01 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:06:01 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:06:01 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:06:01 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:06:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 12:06:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:06:01 INFO - Fetch https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 12:06:02 INFO - Expected file size: 21901677 12:06:06 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:06:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 12:06:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:06:06 INFO - Fetch https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 12:06:07 INFO - Expected file size: 21901677 12:06:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 12:06:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:06:12 INFO - Fetch https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 12:06:12 INFO - Expected file size: 14414059 12:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:13 INFO - trying https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 12:06:13 INFO - Downloading https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 12:06:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:06:15 INFO - Downloaded 63943378 bytes. 12:06:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 12:06:15 INFO - mkdir: /builds/slave/test/properties 12:06:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:06:15 INFO - Writing to file /builds/slave/test/properties/build_url 12:06:15 INFO - Contents: 12:06:15 INFO - build_url:https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 12:06:15 INFO - Running post-action listener: _resource_record_post_action 12:06:15 INFO - Running post-action listener: set_extra_try_arguments 12:06:15 INFO - [mozharness: 2016-10-01 19:06:15.874326Z] Finished download-and-extract step (success) 12:06:15 INFO - [mozharness: 2016-10-01 19:06:15.874554Z] Running populate-webroot step. 12:06:15 INFO - Running pre-action listener: _resource_record_pre_action 12:06:15 INFO - Running main action method: populate_webroot 12:06:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:06:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:06:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:06:15 INFO - '--tppagecycles', 12:06:15 INFO - '7'], 12:06:15 INFO - 'tests': ['tsvgm']}}, 12:06:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:06:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:06:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:06:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:06:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:06:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:06:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:06:15 INFO - 'talos_options': ['--disable-e10s'], 12:06:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:06:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:06:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:06:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:06:15 INFO - 'talos_options': ['--disable-e10s'], 12:06:15 INFO - 'tests': ['damp', 'tps']}, 12:06:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:06:15 INFO - 'tests': ['damp', 'tps']}, 12:06:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:06:15 INFO - 'tests': ['dromaeo_dom']}, 12:06:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:06:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:06:15 INFO - 'tests': ['basic_compositor_video']}, 12:06:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:06:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:06:15 INFO - 'tests': ['a11yr', 12:06:15 INFO - 'ts_paint', 12:06:15 INFO - 'tpaint', 12:06:15 INFO - 'sessionrestore', 12:06:15 INFO - 'sessionrestore_no_auto_restore', 12:06:15 INFO - 'tabpaint']}, 12:06:15 INFO - 'other-e10s': {'tests': ['a11yr', 12:06:15 INFO - 'ts_paint', 12:06:15 INFO - 'tpaint', 12:06:15 INFO - 'sessionrestore', 12:06:15 INFO - 'sessionrestore_no_auto_restore', 12:06:15 INFO - 'tabpaint']}, 12:06:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:06:15 INFO - 'ts_paint', 12:06:15 INFO - 'tpaint', 12:06:15 INFO - 'sessionrestore', 12:06:15 INFO - 'sessionrestore_no_auto_restore', 12:06:15 INFO - 'tabpaint']}, 12:06:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:06:15 INFO - 'ts_paint', 12:06:15 INFO - 'tpaint', 12:06:15 INFO - 'sessionrestore', 12:06:15 INFO - 'sessionrestore_no_auto_restore', 12:06:15 INFO - 'tabpaint']}, 12:06:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:06:15 INFO - 'tests': ['a11yr', 12:06:15 INFO - 'ts_paint', 12:06:15 INFO - 'tpaint', 12:06:15 INFO - 'sessionrestore', 12:06:15 INFO - 'sessionrestore_no_auto_restore', 12:06:15 INFO - 'tabpaint']}, 12:06:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:06:15 INFO - 'tests': ['a11yr', 12:06:15 INFO - 'ts_paint', 12:06:15 INFO - 'tpaint', 12:06:15 INFO - 'sessionrestore', 12:06:15 INFO - 'sessionrestore_no_auto_restore', 12:06:15 INFO - 'tabpaint']}, 12:06:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:06:15 INFO - 'tests': ['tsvgx', 12:06:15 INFO - 'tsvgr_opacity', 12:06:15 INFO - 'tart', 12:06:15 INFO - 'tscrollx', 12:06:15 INFO - 'cart']}, 12:06:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:06:15 INFO - 'tsvgr_opacity', 12:06:15 INFO - 'tart', 12:06:15 INFO - 'tscrollx', 12:06:15 INFO - 'cart']}, 12:06:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:06:15 INFO - 'talos_options': ['--disable-e10s'], 12:06:15 INFO - 'tests': ['tp5o']}, 12:06:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:06:15 INFO - 'tests': ['tp5o']}, 12:06:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:06:15 INFO - 'talos_options': ['--disable-e10s', 12:06:15 INFO - '--xperf_path', 12:06:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:06:15 INFO - 'tests': ['tp5n']}, 12:06:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:06:15 INFO - 'talos_options': ['--xperf_path', 12:06:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:06:15 INFO - 'tests': ['tp5n']}}, 12:06:15 INFO - 'talos.zip': {'path': '', 12:06:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:06:15 INFO - Running post-action listener: _resource_record_post_action 12:06:15 INFO - [mozharness: 2016-10-01 19:06:15.894881Z] Finished populate-webroot step (success) 12:06:15 INFO - [mozharness: 2016-10-01 19:06:15.894970Z] Running create-virtualenv step. 12:06:15 INFO - Running pre-action listener: _resource_record_pre_action 12:06:15 INFO - Running main action method: create_virtualenv 12:06:15 INFO - Creating virtualenv /builds/slave/test/build/venv 12:06:15 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:06:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:06:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:06:15 INFO - Using real prefix '/usr' 12:06:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:06:16 INFO - Installing distribute.............................................................................................................................................................................................done. 12:06:18 INFO - Installing pip.................done. 12:06:18 INFO - Return code: 0 12:06:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a34791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a4f60>, '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 0x12a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a61d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', '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:06:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:06:18 INFO - Using env: {'DISPLAY': ':0', 12:06:18 INFO - 'HOME': '/home/cltbld', 12:06:18 INFO - 'LANG': 'en_US.UTF-8', 12:06:18 INFO - 'LANGUAGE': 'en_US:en', 12:06:18 INFO - 'LOGNAME': 'cltbld', 12:06:18 INFO - 'MAIL': '/var/mail/cltbld', 12:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:18 INFO - 'MOZ_NO_REMOTE': '1', 12:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:18 INFO - 'NO_EM_RESTART': '1', 12:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:18 INFO - 'PWD': '/builds/slave/test', 12:06:18 INFO - 'SHELL': '/bin/bash', 12:06:18 INFO - 'SHLVL': '1', 12:06:18 INFO - 'TERM': 'linux', 12:06:18 INFO - 'TMOUT': '86400', 12:06:18 INFO - 'USER': 'cltbld', 12:06:18 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', 12:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:18 INFO - '_': '/tools/buildbot/bin/python'} 12:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:18 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:06:18 INFO - Cleaning up... 12:06:18 INFO - Return code: 0 12:06:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6a34791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a4f60>, '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 0x12a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a61d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', '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:06:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:06:18 INFO - Using env: {'DISPLAY': ':0', 12:06:18 INFO - 'HOME': '/home/cltbld', 12:06:18 INFO - 'LANG': 'en_US.UTF-8', 12:06:18 INFO - 'LANGUAGE': 'en_US:en', 12:06:18 INFO - 'LOGNAME': 'cltbld', 12:06:18 INFO - 'MAIL': '/var/mail/cltbld', 12:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:18 INFO - 'MOZ_NO_REMOTE': '1', 12:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:18 INFO - 'NO_EM_RESTART': '1', 12:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:18 INFO - 'PWD': '/builds/slave/test', 12:06:18 INFO - 'SHELL': '/bin/bash', 12:06:18 INFO - 'SHLVL': '1', 12:06:18 INFO - 'TERM': 'linux', 12:06:18 INFO - 'TMOUT': '86400', 12:06:18 INFO - 'USER': 'cltbld', 12:06:18 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', 12:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:18 INFO - '_': '/tools/buildbot/bin/python'} 12:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:18 INFO - Downloading/unpacking psutil>=3.1.1 12:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:06:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:06:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:06:20 INFO - Installing collected packages: psutil 12:06:20 INFO - Running setup.py install for psutil 12:06:20 INFO - building 'psutil._psutil_linux' extension 12:06:20 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:06:21 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:06:21 INFO - building 'psutil._psutil_posix' extension 12:06:21 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:06:21 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:06:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:06:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:06:21 INFO - Successfully installed psutil 12:06:21 INFO - Cleaning up... 12:06:21 INFO - Return code: 0 12:06:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a34791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a4f60>, '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 0x12a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a61d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', '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:06:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:06:21 INFO - Using env: {'DISPLAY': ':0', 12:06:21 INFO - 'HOME': '/home/cltbld', 12:06:21 INFO - 'LANG': 'en_US.UTF-8', 12:06:21 INFO - 'LANGUAGE': 'en_US:en', 12:06:21 INFO - 'LOGNAME': 'cltbld', 12:06:21 INFO - 'MAIL': '/var/mail/cltbld', 12:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:21 INFO - 'MOZ_NO_REMOTE': '1', 12:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:21 INFO - 'NO_EM_RESTART': '1', 12:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:21 INFO - 'PWD': '/builds/slave/test', 12:06:21 INFO - 'SHELL': '/bin/bash', 12:06:21 INFO - 'SHLVL': '1', 12:06:21 INFO - 'TERM': 'linux', 12:06:21 INFO - 'TMOUT': '86400', 12:06:21 INFO - 'USER': 'cltbld', 12:06:21 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', 12:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:21 INFO - '_': '/tools/buildbot/bin/python'} 12:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:06:23 INFO - Installing collected packages: mozsystemmonitor 12:06:23 INFO - Running setup.py install for mozsystemmonitor 12:06:23 INFO - Successfully installed mozsystemmonitor 12:06:23 INFO - Cleaning up... 12:06:23 INFO - Return code: 0 12:06:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a34791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a4f60>, '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 0x12a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a61d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', '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:06:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:06:23 INFO - Using env: {'DISPLAY': ':0', 12:06:23 INFO - 'HOME': '/home/cltbld', 12:06:23 INFO - 'LANG': 'en_US.UTF-8', 12:06:23 INFO - 'LANGUAGE': 'en_US:en', 12:06:23 INFO - 'LOGNAME': 'cltbld', 12:06:23 INFO - 'MAIL': '/var/mail/cltbld', 12:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:23 INFO - 'MOZ_NO_REMOTE': '1', 12:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:23 INFO - 'NO_EM_RESTART': '1', 12:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:23 INFO - 'PWD': '/builds/slave/test', 12:06:23 INFO - 'SHELL': '/bin/bash', 12:06:23 INFO - 'SHLVL': '1', 12:06:23 INFO - 'TERM': 'linux', 12:06:23 INFO - 'TMOUT': '86400', 12:06:23 INFO - 'USER': 'cltbld', 12:06:23 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', 12:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:23 INFO - '_': '/tools/buildbot/bin/python'} 12:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:24 INFO - Downloading/unpacking jsonschema==2.5.1 12:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:06:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:26 INFO - Downloading functools32-3.2.3-2.tar.gz 12:06:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:06:26 INFO - warning: no files found matching '*.txt' 12:06:26 INFO - no previously-included directories found matching 'build' 12:06:26 INFO - no previously-included directories found matching 'dist' 12:06:26 INFO - no previously-included directories found matching '.git*' 12:06:26 INFO - Installing collected packages: jsonschema, functools32 12:06:26 INFO - Running setup.py install for functools32 12:06:26 INFO - warning: no files found matching '*.txt' 12:06:26 INFO - no previously-included directories found matching 'build' 12:06:26 INFO - no previously-included directories found matching 'dist' 12:06:26 INFO - no previously-included directories found matching '.git*' 12:06:26 INFO - Successfully installed jsonschema functools32 12:06:26 INFO - Cleaning up... 12:06:26 INFO - Return code: 0 12:06:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:06:26 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:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:26 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:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:26 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 0x7f6a34791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a4f60>, '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 0x12a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a61d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', '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:06:26 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:06:26 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:06:26 INFO - Using env: {'DISPLAY': ':0', 12:06:26 INFO - 'HOME': '/home/cltbld', 12:06:26 INFO - 'LANG': 'en_US.UTF-8', 12:06:26 INFO - 'LANGUAGE': 'en_US:en', 12:06:26 INFO - 'LOGNAME': 'cltbld', 12:06:26 INFO - 'MAIL': '/var/mail/cltbld', 12:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:26 INFO - 'MOZ_NO_REMOTE': '1', 12:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:26 INFO - 'NO_EM_RESTART': '1', 12:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:26 INFO - 'PWD': '/builds/slave/test', 12:06:26 INFO - 'SHELL': '/bin/bash', 12:06:26 INFO - 'SHLVL': '1', 12:06:26 INFO - 'TERM': 'linux', 12:06:26 INFO - 'TMOUT': '86400', 12:06:26 INFO - 'USER': 'cltbld', 12:06:26 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', 12:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:26 INFO - '_': '/tools/buildbot/bin/python'} 12:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:06:26 INFO - Cleaning up... 12:06:26 INFO - Return code: 0 12:06:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:06:26 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:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:26 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:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:26 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 0x7f6a34791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a4f60>, '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 0x12a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a61d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', '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:06:26 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:06:26 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:06:26 INFO - Using env: {'DISPLAY': ':0', 12:06:26 INFO - 'HOME': '/home/cltbld', 12:06:26 INFO - 'LANG': 'en_US.UTF-8', 12:06:26 INFO - 'LANGUAGE': 'en_US:en', 12:06:26 INFO - 'LOGNAME': 'cltbld', 12:06:26 INFO - 'MAIL': '/var/mail/cltbld', 12:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:26 INFO - 'MOZ_NO_REMOTE': '1', 12:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:26 INFO - 'NO_EM_RESTART': '1', 12:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:26 INFO - 'PWD': '/builds/slave/test', 12:06:26 INFO - 'SHELL': '/bin/bash', 12:06:26 INFO - 'SHLVL': '1', 12:06:26 INFO - 'TERM': 'linux', 12:06:26 INFO - 'TMOUT': '86400', 12:06:26 INFO - 'USER': 'cltbld', 12:06:26 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', 12:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:26 INFO - '_': '/tools/buildbot/bin/python'} 12:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:26 INFO - Downloading/unpacking blobuploader==1.2.4 12:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:28 INFO - Downloading blobuploader-1.2.4.tar.gz 12:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:06:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:06:28 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:06:28 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:06:28 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:06:28 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:06:28 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:06:28 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:06:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:06:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:06:29 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:06:29 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:06:29 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:06:29 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:06:29 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:06:29 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:06:29 INFO - Downloading docopt-0.6.1.tar.gz 12:06:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:06:29 INFO - Installing collected packages: blobuploader, requests, docopt 12:06:29 INFO - Running setup.py install for blobuploader 12:06:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:06:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:06:29 INFO - Running setup.py install for requests 12:06:29 INFO - Running setup.py install for docopt 12:06:30 INFO - Successfully installed blobuploader requests docopt 12:06:30 INFO - Cleaning up... 12:06:30 INFO - Return code: 0 12:06:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:30 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 0x7f6a34791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a4f60>, '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 0x12a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a61d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', '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:06:30 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:06:30 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:06:30 INFO - Using env: {'DISPLAY': ':0', 12:06:30 INFO - 'HOME': '/home/cltbld', 12:06:30 INFO - 'LANG': 'en_US.UTF-8', 12:06:30 INFO - 'LANGUAGE': 'en_US:en', 12:06:30 INFO - 'LOGNAME': 'cltbld', 12:06:30 INFO - 'MAIL': '/var/mail/cltbld', 12:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:30 INFO - 'MOZ_NO_REMOTE': '1', 12:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:30 INFO - 'NO_EM_RESTART': '1', 12:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:30 INFO - 'PWD': '/builds/slave/test', 12:06:30 INFO - 'SHELL': '/bin/bash', 12:06:30 INFO - 'SHLVL': '1', 12:06:30 INFO - 'TERM': 'linux', 12:06:30 INFO - 'TMOUT': '86400', 12:06:30 INFO - 'USER': 'cltbld', 12:06:30 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', 12:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:30 INFO - '_': '/tools/buildbot/bin/python'} 12:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:06:30 INFO - Running setup.py (path:/tmp/pip-Zelqwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:06:30 INFO - Running setup.py (path:/tmp/pip-b1eNN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:06:30 INFO - Running setup.py (path:/tmp/pip-D9TU8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:06:30 INFO - Running setup.py (path:/tmp/pip-kBJbr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:06:30 INFO - Running setup.py (path:/tmp/pip-n0nUT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:06:30 INFO - Running setup.py (path:/tmp/pip-Z3M5r_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:06:30 INFO - Running setup.py (path:/tmp/pip-UINiOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:06:30 INFO - Running setup.py (path:/tmp/pip-a1PgqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:06:30 INFO - Running setup.py (path:/tmp/pip-phoF3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:06:30 INFO - Running setup.py (path:/tmp/pip-Z3mxNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:06:31 INFO - Running setup.py (path:/tmp/pip-fbtvS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:06:31 INFO - Running setup.py (path:/tmp/pip-oi7CHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:06:31 INFO - Running setup.py (path:/tmp/pip-VQ06C8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:06:31 INFO - Running setup.py (path:/tmp/pip-gqu9qJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:31 INFO - Running setup.py (path:/tmp/pip-90Et1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:06:31 INFO - Running setup.py (path:/tmp/pip-ZCEi5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:06:31 INFO - Running setup.py (path:/tmp/pip-c_TD4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:06:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:06:31 INFO - Running setup.py install for manifestparser 12:06:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:06:31 INFO - Running setup.py install for mozcrash 12:06:31 INFO - Running setup.py install for mozdebug 12:06:31 INFO - Running setup.py install for mozdevice 12:06:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:06:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:06:31 INFO - Running setup.py install for mozfile 12:06:32 INFO - Running setup.py install for mozhttpd 12:06:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:06:32 INFO - Running setup.py install for mozinfo 12:06:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:06:32 INFO - Running setup.py install for mozInstall 12:06:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:06:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:06:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:06:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:06:32 INFO - Running setup.py install for mozleak 12:06:32 INFO - Running setup.py install for mozlog 12:06:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:06:32 INFO - Running setup.py install for moznetwork 12:06:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:06:32 INFO - Running setup.py install for mozprocess 12:06:32 INFO - Running setup.py install for mozprofile 12:06:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:06:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:06:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:06:32 INFO - Running setup.py install for mozrunner 12:06:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:06:33 INFO - Running setup.py install for mozscreenshot 12:06:33 INFO - Running setup.py install for moztest 12:06:33 INFO - Running setup.py install for mozversion 12:06:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:06:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:06:33 INFO - Cleaning up... 12:06:33 INFO - Return code: 0 12:06:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:06: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:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06: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:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:33 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 0x7f6a34791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a4f60>, '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 0x12a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a61d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', '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:06:33 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:06:33 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:06:33 INFO - Using env: {'DISPLAY': ':0', 12:06:33 INFO - 'HOME': '/home/cltbld', 12:06:33 INFO - 'LANG': 'en_US.UTF-8', 12:06:33 INFO - 'LANGUAGE': 'en_US:en', 12:06:33 INFO - 'LOGNAME': 'cltbld', 12:06:33 INFO - 'MAIL': '/var/mail/cltbld', 12:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:33 INFO - 'MOZ_NO_REMOTE': '1', 12:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:33 INFO - 'NO_EM_RESTART': '1', 12:06:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:33 INFO - 'PWD': '/builds/slave/test', 12:06:33 INFO - 'SHELL': '/bin/bash', 12:06:33 INFO - 'SHLVL': '1', 12:06:33 INFO - 'TERM': 'linux', 12:06:33 INFO - 'TMOUT': '86400', 12:06:33 INFO - 'USER': 'cltbld', 12:06:33 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', 12:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:33 INFO - '_': '/tools/buildbot/bin/python'} 12:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:06:33 INFO - Running setup.py (path:/tmp/pip-SdJBLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:06:33 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:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:06:33 INFO - Running setup.py (path:/tmp/pip-SAbd5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:06:33 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:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:06:33 INFO - Running setup.py (path:/tmp/pip-EieaE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:06:33 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:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:06:33 INFO - Running setup.py (path:/tmp/pip-LNCHZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:06:33 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:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:06:33 INFO - Running setup.py (path:/tmp/pip-hHMBps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:06:33 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:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:06:33 INFO - Running setup.py (path:/tmp/pip-6815jA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:06:34 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:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:06:34 INFO - Running setup.py (path:/tmp/pip-VrWFTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:06:34 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:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:06:34 INFO - Running setup.py (path:/tmp/pip-IKLgsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:06:34 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:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:06:34 INFO - Running setup.py (path:/tmp/pip-AN8fS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:06:34 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:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:06:34 INFO - Running setup.py (path:/tmp/pip-_1zA4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:06:34 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:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:06:34 INFO - Running setup.py (path:/tmp/pip-vSV8xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:06:34 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:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:06:34 INFO - Running setup.py (path:/tmp/pip-rdNNie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:06:34 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:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:06:34 INFO - Running setup.py (path:/tmp/pip-Skxknd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:06:34 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:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:06:34 INFO - Running setup.py (path:/tmp/pip-aI0nDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:06:34 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:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:34 INFO - Running setup.py (path:/tmp/pip-OiWZf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:34 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:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:06:34 INFO - Running setup.py (path:/tmp/pip-7jRi2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:06:34 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:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:06:34 INFO - Running setup.py (path:/tmp/pip-1XE9k7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:06:34 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:06:34 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:06:34 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:06:34 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:06:34 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:06:34 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:06:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:06:34 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:06:34 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:06:34 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:06:34 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:06:34 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:06:34 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:06:36 INFO - Downloading blessings-1.6.tar.gz 12:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:06:36 INFO - Installing collected packages: blessings 12:06:36 INFO - Running setup.py install for blessings 12:06:36 INFO - Successfully installed blessings 12:06:36 INFO - Cleaning up... 12:06:36 INFO - Return code: 0 12:06:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:06:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:06:37 INFO - Reading from file tmpfile_stdout 12:06:37 INFO - Current package versions: 12:06:37 INFO - argparse == 1.2.1 12:06:37 INFO - blessings == 1.6 12:06:37 INFO - blobuploader == 1.2.4 12:06:37 INFO - docopt == 0.6.1 12:06:37 INFO - functools32 == 3.2.3-2 12:06:37 INFO - jsonschema == 2.5.1 12:06:37 INFO - manifestparser == 1.1 12:06:37 INFO - mozInstall == 1.12 12:06:37 INFO - mozcrash == 0.17 12:06:37 INFO - mozdebug == 0.1 12:06:37 INFO - mozdevice == 0.48 12:06:37 INFO - mozfile == 1.2 12:06:37 INFO - mozhttpd == 0.7 12:06:37 INFO - mozinfo == 0.9 12:06:37 INFO - mozleak == 0.1 12:06:37 INFO - mozlog == 3.4 12:06:37 INFO - moznetwork == 0.27 12:06:37 INFO - mozprocess == 0.23 12:06:37 INFO - mozprofile == 0.28 12:06:37 INFO - mozrunner == 6.12 12:06:37 INFO - mozscreenshot == 0.1 12:06:37 INFO - mozsystemmonitor == 0.3 12:06:37 INFO - moztest == 0.7 12:06:37 INFO - mozversion == 1.4 12:06:37 INFO - psutil == 3.1.1 12:06:37 INFO - requests == 1.2.3 12:06:37 INFO - wsgiref == 0.1.2 12:06:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:06:37 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:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:37 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:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:37 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 0x7f6a34791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a4f60>, '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 0x12a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a61d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', '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:06:37 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:06:37 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:06:37 INFO - Using env: {'DISPLAY': ':0', 12:06:37 INFO - 'HOME': '/home/cltbld', 12:06:37 INFO - 'LANG': 'en_US.UTF-8', 12:06:37 INFO - 'LANGUAGE': 'en_US:en', 12:06:37 INFO - 'LOGNAME': 'cltbld', 12:06:37 INFO - 'MAIL': '/var/mail/cltbld', 12:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:37 INFO - 'MOZ_NO_REMOTE': '1', 12:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:37 INFO - 'NO_EM_RESTART': '1', 12:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:37 INFO - 'PWD': '/builds/slave/test', 12:06:37 INFO - 'SHELL': '/bin/bash', 12:06:37 INFO - 'SHLVL': '1', 12:06:37 INFO - 'TERM': 'linux', 12:06:37 INFO - 'TMOUT': '86400', 12:06:37 INFO - 'USER': 'cltbld', 12:06:37 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', 12:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:37 INFO - '_': '/tools/buildbot/bin/python'} 12:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:37 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:06:37 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:06:37 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:06:37 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:06:37 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:06:37 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:06:37 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:06:37 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:06:37 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:06:37 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:06:37 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:06:37 INFO - Cleaning up... 12:06:37 INFO - Return code: 0 12:06:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:06:37 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:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:37 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:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:37 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 0x7f6a34791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a4f60>, '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 0x12a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a61d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', '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:06:37 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:06:37 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:06:37 INFO - Using env: {'DISPLAY': ':0', 12:06:37 INFO - 'HOME': '/home/cltbld', 12:06:37 INFO - 'LANG': 'en_US.UTF-8', 12:06:37 INFO - 'LANGUAGE': 'en_US:en', 12:06:37 INFO - 'LOGNAME': 'cltbld', 12:06:37 INFO - 'MAIL': '/var/mail/cltbld', 12:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:37 INFO - 'MOZ_NO_REMOTE': '1', 12:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:37 INFO - 'NO_EM_RESTART': '1', 12:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:37 INFO - 'PWD': '/builds/slave/test', 12:06:37 INFO - 'SHELL': '/bin/bash', 12:06:37 INFO - 'SHLVL': '1', 12:06:37 INFO - 'TERM': 'linux', 12:06:37 INFO - 'TMOUT': '86400', 12:06:37 INFO - 'USER': 'cltbld', 12:06:37 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', 12:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:37 INFO - '_': '/tools/buildbot/bin/python'} 12:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:06:37 INFO - Cleaning up... 12:06:37 INFO - Return code: 0 12:06:37 INFO - Running post-action listener: _resource_record_post_action 12:06:37 INFO - Running post-action listener: _start_resource_monitoring 12:06:37 INFO - Starting resource monitoring. 12:06:37 INFO - [mozharness: 2016-10-01 19:06:37.656847Z] Finished create-virtualenv step (success) 12:06:37 INFO - [mozharness: 2016-10-01 19:06:37.657310Z] Running install step. 12:06:37 INFO - Running pre-action listener: _resource_record_pre_action 12:06:37 INFO - Running main action method: install 12:06:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:06:37 INFO - Reading from file tmpfile_stdout 12:06:37 INFO - Detecting whether we're running mozinstall >=1.0... 12:06:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:06:37 INFO - Reading from file tmpfile_stdout 12:06:37 INFO - Output received: 12:06:37 INFO - Usage: mozinstall [options] installer 12:06:37 INFO - Options: 12:06:37 INFO - -h, --help show this help message and exit 12:06:37 INFO - -d DEST, --destination=DEST 12:06:37 INFO - Directory to install application into. [default: 12:06:37 INFO - "/builds/slave/test"] 12:06:37 INFO - --app=APP Application being installed. [default: firefox] 12:06:37 INFO - mkdir: /builds/slave/test/build/application 12:06:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:06:54 INFO - Reading from file tmpfile_stdout 12:06:54 INFO - Output received: 12:06:54 INFO - /builds/slave/test/build/application/firefox/firefox 12:06:54 INFO - Running post-action listener: _resource_record_post_action 12:06:54 INFO - [mozharness: 2016-10-01 19:06:54.920697Z] Finished install step (success) 12:06:54 INFO - [mozharness: 2016-10-01 19:06:54.921030Z] Running run-tests step. 12:06:54 INFO - Running pre-action listener: _resource_record_pre_action 12:06:54 INFO - Running main action method: run_tests 12:06:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:06:54 INFO - Python 2.7.3 12:06:54 INFO - Return code: 0 12:06:54 INFO - grabbing minidump binary from tooltool 12:06:54 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:06:54 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 0x12a4f60>, '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 0x12a5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a61d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:06:54 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:06:54 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:06:54 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:06:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:06:55 INFO - Return code: 0 12:06:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:06:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:06:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:06:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:06:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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:06:55 INFO - Using env: {'DISPLAY': ':0', 12:06:55 INFO - 'HOME': '/home/cltbld', 12:06:55 INFO - 'LANG': 'en_US.UTF-8', 12:06:55 INFO - 'LANGUAGE': 'en_US:en', 12:06:55 INFO - 'LOGNAME': 'cltbld', 12:06:55 INFO - 'MAIL': '/var/mail/cltbld', 12:06:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:06:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:55 INFO - 'MOZ_NO_REMOTE': '1', 12:06:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:55 INFO - 'NO_EM_RESTART': '1', 12:06:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:55 INFO - 'PWD': '/builds/slave/test', 12:06:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:06:55 INFO - 'SHELL': '/bin/bash', 12:06:55 INFO - 'SHLVL': '1', 12:06:55 INFO - 'TERM': 'linux', 12:06:55 INFO - 'TMOUT': '86400', 12:06:55 INFO - 'USER': 'cltbld', 12:06:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046', 12:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:55 INFO - '_': '/tools/buildbot/bin/python'} 12:06:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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:06:55 INFO - mozversion application_buildid: 20161001091355 12:06:55 INFO - mozversion application_changeset: 1341ec6ae0149311e8badce3e4f013e1fcc2869d 12:06:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:06:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:06:55 INFO - mozversion application_name: Firefox 12:06:55 INFO - mozversion application_remotingname: firefox-dev 12:06:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:06:55 INFO - mozversion application_vendor: Mozilla 12:06:55 INFO - mozversion application_version: 51.0a2 12:06:55 INFO - mozversion platform_buildid: 20161001091355 12:06:55 INFO - mozversion platform_changeset: 1341ec6ae0149311e8badce3e4f013e1fcc2869d 12:06:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:06:55 INFO - mozversion platform_version: 51.0a2 12:06:55 INFO - using testdate: 1475348815 12:06:55 INFO - actual date: 1475348815 12:06:55 INFO - starting webserver on 'localhost:55428' 12:06:55 INFO - SUITE-START | Running 2 tests 12:06:55 INFO - TEST-START | dromaeo_css 12:06:55 INFO - operating with platform_type : linux_ 12:06:55 INFO - Initialising browser for dromaeo_css test... 12:06:55 INFO - TEST-INFO | started process 2990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpScOirh/profile http://localhost:55428/getInfo.html) 12:06:59 INFO - PROCESS | 2990 | __metrics Screen width/height:1600/1200 12:06:59 INFO - PROCESS | 2990 | colorDepth:24 12:06:59 INFO - PROCESS | 2990 | Browser inner width/height: 1024/697 12:06:59 INFO - PROCESS | 2990 | __metrics 12:06:59 INFO - PROCESS | 2990 | 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:06:59 INFO - PROCESS | 2990 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:07:00 INFO - PROCESS | 2990 | console.error: PushService: 12:07:00 INFO - PROCESS | 2990 | stateChangeProcessEnqueue: Error transitioning state 12:07:00 INFO - PROCESS | 2990 | UnknownError 12:07:00 INFO - TEST-INFO | 2990: exit 0 12:07:00 INFO - Browser initialized. 12:07:00 INFO - Running cycle 1/1 for dromaeo_css test... 12:07:00 INFO - TEST-INFO | started process 3085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpScOirh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:07:12 INFO - PROCESS | 3085 | RSS: Main: 143835136 12:07:12 INFO - PROCESS | 3085 | 12:08:03 INFO - PROCESS | 3085 | 1475348883895 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:10:13 INFO - PROCESS | 3085 | Cycle 1(1): loaded http://localhost:55428/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55428/tests/dromaeo/cssquery-ext.html) 12:10:14 INFO - PROCESS | 3085 | RSS: Main: 246554624 12:10:14 INFO - PROCESS | 3085 | 12:13:16 INFO - PROCESS | 3085 | Cycle 1(1): loaded http://localhost:55428/tests/dromaeo/cssquery-ext.html (next: http://localhost:55428/tests/dromaeo/cssquery-jquery.html) 12:13:16 INFO - PROCESS | 3085 | RSS: Main: 230141952 12:13:16 INFO - PROCESS | 3085 | 12:16:18 INFO - PROCESS | 3085 | Cycle 1(1): loaded http://localhost:55428/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55428/tests/dromaeo/cssquery-mootools.html) 12:16:19 INFO - PROCESS | 3085 | RSS: Main: 198795264 12:16:19 INFO - PROCESS | 3085 | 12:19:21 INFO - PROCESS | 3085 | Cycle 1(1): loaded http://localhost:55428/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55428/tests/dromaeo/cssquery-prototype.html) 12:19:22 INFO - PROCESS | 3085 | RSS: Main: 173969408 12:19:22 INFO - PROCESS | 3085 | 12:22:24 INFO - PROCESS | 3085 | Cycle 1(1): loaded http://localhost:55428/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55428/tests/dromaeo/cssquery-yui.html) 12:22:25 INFO - PROCESS | 3085 | RSS: Main: 173527040 12:22:25 INFO - PROCESS | 3085 | 12:25:27 INFO - PROCESS | 3085 | Cycle 1(1): loaded http://localhost:55428/tests/dromaeo/cssquery-yui.html (next: http://localhost:55428/tests/dromaeo/cssquery-dojo.html) 12:25:28 INFO - PROCESS | 3085 | RSS: Main: 262238208 12:25:28 INFO - PROCESS | 3085 | 12:25:28 INFO - PROCESS | 3085 | __start_tp_report 12:25:28 INFO - PROCESS | 3085 | _x_x_mozilla_page_load 12:25:28 INFO - PROCESS | 3085 | _x_x_mozilla_page_load_details 12:25:28 INFO - PROCESS | 3085 | |i|pagename|runs| 12:25:28 INFO - PROCESS | 3085 | |0;dojo.html;3062.846857657117;3088.3051313454475;3100.7054329838656;3121;3137.8744850205994;5446.2647542581735;5516.531094856932;5528.14313781364;5547.389787123423;5564.916526252105;5603.2715746952945;5631.239782629344;5653.575981801371;5655.604107712462;5657.773689052443;5074.4925507449325;5088.982203559303;5127.66670166438;5168.992046550924;5175.767090480937;4938.2098864181735;4957.702537847723;5139.25480805283;5194.35070616173;5203.219517072432;5031.924521132186;5037.521435463644;5056.696598204119;5081.136206844845;5085.211792172219;5083.974580127113;5087.923681144785;5120.15517439622;5153.56194723449;5168.560672342818;4808.519148085198;5060.721660308682;5067.366579177603;5126.102931986925;5142.845714628567;5363.141897296453;5455;5462.371827239839;5479.671219726789;5519.751611177507;5892.587518873681;5911.083782013795;6035.939640603582;6039.1545183674325;6047.939520604826;5753.021986262345;6008.158857759917;6032.5173986081445;6047.334793172748;6053.182820319289;5423.566114710814;5450.291462109901;5495.587830912697;5500.147477141049;5508.697021663847;6032.577719559677;6046.123312119718;6048.485878700271;6049.062395328731;6054.455099041019;5673.943260567424;5817.88364232713;5820.883582328414;5822.621529600562;5824.271966004249;5775.711214439261;5799.710014499258;5843.29880414353;5858.589898707135;5926.288845338587;5860.267466566679;5870.412958704095;5872.060470324727;5876.941230587725;5878;5792.189093526909;5851.063829787214;5855.180274761537;5875.383084776123;5881.206037185011;4400.933985990213;4430.955690443055;4494.325851122292;4525.592696657251;4536.02475467776;4034.65705415043;4036.2734707752297;4036.5156181258435;4037.1925614876554;4074.796260187038;5518.034343989786;5529.474699903502;5529.668219906738;5529.806456774074;5558;5827.125931110368;5879.823605291848;5901.291844978544;5905.704714764331;5924.881502369928;5639.379668236491;5640.576956728261;5643.125315576092;5652.604317697722;5674;5146.511081447256;5163;5178.145605975047;5181;5202.7918883245;5920.496757775637;5930.258717660293;6013.9699301503215;6167.444929956236;6175.907361389583;5895.94104058954;5942.435468630646;5949.8215053548465;5988.730507127277;5996.310424301261;6086.878262434815;6129.693515324305;6133.417325354084;6135.570510064253;6144.846378840565;5574.888502230014;5588.804391846266;5810.331811841524;5856.765729370777;5862.530997520103;5800.042992906292;5823.621464604787;5857.531397488276;5911.9062973350065;5940.61386009908;5799.333076696234;5799.913001305068;5801.100829371454;5806.912896306643;5811.215485909348;5651.067573850269;5772.6536407815665;5773.3072031356505;5778.36437991829;5781.132830075522;5591.804286849941;5765.4522820332;5780.508656764222;5808.651480911159;5841.269841269841;5832.854178645568;5838.2702162229725;5890.057590785454;5902.970485147547;5903.439173278532;5563.998480273428;5601.495865372136;5756.971215143897;5768.1636162757;5768.3078030634915 12:25:28 INFO - PROCESS | 3085 | |1;ext.html;602.3614968133778;636.538509580554;652.7291174162723;653.9967300163499;673.2560520624712;34602.82698586507;35227.64772352276;46427.76786116073;46955.53044469554;47192;45584.54415455845;49699.50300496994;49702;49755;49764;8527.360447966395;9411.529423528813;9468.147866691996;9577.138057574817;9579.568919398609;8559.315254779603;8854.911450885473;8859.025507194203;10968.341899486057;11297.717557061056;11511.884881151207;11564.59523916663;11566.479508422099;11575.073994080496;11575.36335501547;11340.319580825135;11446.027087697556;11448.599299024536;11456.94271528637;11461.426928653535;11236.101111911028;11258.493367798468;11269.718257043558;11275.210735248536;11286.435678216138;45342.77328613336;45587.54412455866;45612.08775824465;45686.543134568565;45714.77142614299;3934.1148241645687;4060.817263223162;4088.0393107619684;4294.978525107385;4596.632269418438;34864.47703284453;34888.47667284993;35047.4742878857;35085.82457087698;35108.297834043435;4501.819927202908;4642.141203877293;4789.449213340441;4854.805807767721;4963.280324352949;403224;404008;405619;406456;406812.99999999703;66664.33335666679;66917.33082669208;67089.66455167693;67093.32906670871;67105;41021.17957640831;41752;42033;42751.572484275384;42777;17612.295508179785;17698.5575360617;17706.20322085509;17744.20151093178;17748.467545973643;15018.174000429863;15080;15080.170590617401;15084.472043478425;15085.24573771307;18527.351542695942;19004.904975475034;20327.186912523335;20906.26828061041;21016.36950891476;7781.688732450752;7791.104023037423;7835.373170146375;7895.763127106196;7947.801304967422;940.247801758604;990.3315262197988;1007.6573964851839;1030.9278350515392;1068.2682362581656;25440.74559254421;25582.616260756102;25761.61357579638;25795.355116122246;26068.73931260701;1076.3272954403499;1132.2810015639964;1139.0716565998684;1170.104869774623;1184.1710802438156;13509.932450337685;13534.390952406968;13563.389647465889;13652.385642646104;13742.725145497034;552047;555875;558215;558732;559621;64356;64724.35275647183;64728.35271647317;64855.35144648493;64857.35142648607;1320.907536472457;1369.760291948925;1369.9315034248448;1400.4888215801159;1436.5977526292654;25216.873915630305;27792;27816.72183278141;28043.298917527223;28452.85773571119;53398.73300633472;54041.45958540522;54074;54085.18872216999;54141.729291353295;336300;336353;336805;337198;337288;30455.390892182477;32050.519242211853;32189.517157242193;33236.335273294884;33262.168445788084;51316.486835132666;51339;51411.742941285054;51863;52090.47909520856;43556.56443435525;43609.56390436182;44370.55629443664;44605;45085;43652;43762.34356484719;44347.2261109552;44400.33399498946;44852;37723.43414848725;38394.42408363933;38445.846624601305;38907.22185556329;38965;37777;38284.61715382922;39045.60954390533;39562;39706;26655.200343989713;26728.732712672623;26789.526576038505;27011.864940675958;27184 12:25:28 INFO - PROCESS | 3085 | |2;jquery.html;393.72832745405685;403.731518540171;429.3602532226982;429.83881044608273;441.30494471207857;14650.780238296435;16567.33730650774;20484.89757551212;21221.257255996043;21768.12927482899;20344.59310813783;20410.489737756565;20840.47898802527;21041.368758937257;21148.471288217803;5837.854053648661;5875.089361149029;6044.546659000571;6077.058056001327;6089.847753806146;4303.634191093761;4526.07215520819;5939.079442686369;6031;6031.185789918371;4474.395956545874;4563.4752003519525;6630.138082049351;6724.125863637721;6743.696533655972;6431.903521447182;6511.479081673455;6706.362895524917;6729.192496900354;6737.865242695168;5780.1907732917425;5800.7679692812235;5807.070868660994;5818.1272809078555;5823.854403639901;24168.15411460608;24365.390865228335;24616.753832461625;24701.25896223116;25460.872695636404;2527.734587868284;2564.3717289264064;2570.3317137544373;2624.2520881548858;3193.850213922986;13630.931845340809;15733.134677592729;15803.525894223192;15852.52442426729;16058.678826423524;1978.6339527187517;2055.0341339570377;2060.814526692605;2062.2060506704875;2073.9111966217856;59459.70270148665;85671.5716421414;86074;87368;87702.56148719216;11034;11065.723356916142;11346.829797553044;11356.716082097848;11570.537178512934;14873.70252594942;14880.851191488164;14896.106233626017;14907.552773416815;14910.92544537292;8933.419327743675;8964.462132272085;9000.63997440095;9007.549622518847;9124.726258212264;8477.152284771597;8492.065872753992;8530.786730331667;8728.825423491495;9259.814803703888;6949;6979.790606281718;6986.650667466606;7033.296670332926;7153.213146553979;1848.4177484092468;1927.4506765572025;1956.5108722819296;1978.0999645161417;2049.825764809978;982.4645568165367;1051.4374809477047;1067.2689207892618;1075.5213929801164;1096.6224029987618;19640.70538941917;20139.59720805576;20298.89850550738;20490.692639610417;20560.38318850437;1000.3197825478599;1014.1177175857051;1043.113353649392;1086.5219303506433;1100.8238681810872;10735.785284294427;11749.647510574696;11787.528498860122;11818.704532386588;11829.704257393461;161013;209503;494817;496408;497690;73397;80480.59759701164;84551.5772421134;85840;86191.56904215564;1060.5174645536263;1085.7719878825378;1098.774751176007;1112.5216157052546;1114.3035602748282;17080.57298567496;17329.566760830578;17758.91120544389;18173.182206800462;18209.45371638853;45119.548804511534;45191.32213016873;45358.319625206306;45657.54342456533;46636;56716.71641641765;57949;60362;60580.69709651423;60921.39078609157;6009.008513595208;7297.963510182415;8523.891894053733;8839;9152.58813353414;9101.726948191565;11162.716287626701;12405.379731013594;13662.658433539242;14504.202268875313;12208.572699955459;12325.551193294657;12371.75256494883;12462.688432789253;12539.93730031344;11832.76334473323;11968.341741204318;11976.28142311464;12432.254064756144;12688.492460301484;12294.893459588322;12424.378781061092;12568.497260109492;12601.747965040831;12657.430415631134;9046.095390460901;9071.682491112779;9329;9430.387024843638;9537.046295370408;12005.099617528545;12487.750244994868;12495.687607809878;12588.937055314665;12604.298419713221 12:25:28 INFO - PROCESS | 3085 | |3;mootools.html;1401.1382999455338;1500.7823865539501;1540.5147378575748;1678.9580260493485;1783.536280567053;7717.189695082013;8485.448445851023;8801.515916624583;8840.204381605654;9046.09539046095;8841.16008979146;8920.197182253596;8925.55372231389;8925.910740892588;8932.151445612657;2387.7134743830766;2413.6379543068592;2416.347586151738;2417.697787776528;2418.2503423938547;2411.397150712322;2412.6984126984125;2470.407102295454;2478.4051827561434;2479.219046000504;2390.5935990881503;2397.7961873240797;2444.2056331692183;2484.4782595654933;2485.2420011896365;2393.066703985447;2410.4696966667307;2415.0581273303424;2421.079989603948;2423.7212720537186;2346.9061237550477;2388.952220955571;2391.796697280733;2400.615901455776;2401.351635058542;8579.957100214522;8820.514871682055;8896.955515222382;8921.063288354695;8936.955315223448;5241.86895327616;5466.480684334982;5472.452754724496;5474.260974768435;5479.780808767645;3441.3117376524797;3461.826908654557;3482.181687303482;3521.1725244567506;3528.5060091587197;1130.3895896216034;1133.3879704959313;1140.8402823604702;1154.3016475032568;1156.5142640091183;12001.399930003465;12038.87961120395;12078.758424831542;12096.153269271155;12100;4348.173846969065;4350.825966961349;4513.88715282114;4517.09658068381;4569.29175977724;9703.12671859536;9723.173530249867;9737.07497787709;9739.65911193119;9745.902540974641;5288.9735551322;5297.337832770903;5301.628885978022;5302.787888484495;5308.548773354308;4144.152146343146;4384.978075109668;4385.934210986838;4515.367848501212;4942.5304596063315;3601.729870259741;4064.349704047338;4070.898227544276;4073.2260870434525;4087.4073259377224;1162.2096974057722;1192.7852986462347;1197.988020119805;1204.7891618966646;1207.3178654060428;793.2979313307765;869.7695110795644;926.6756635177634;930.0374112793227;938.5119737736476;5503.642263252956;5564.248826408464;5965.731542080617;5986.670733109634;6027.186329845503;950.538988590533;951.9048095190564;979.6816034788723;993.1558175550869;1030.9639162629271;3851.9229615407535;4090.2024105299774;4151.12826306479;4187.24629566681;4230.386593943861;10870.728231794268;11007.174461915229;11082.058025067798;11086.944565277123;11231.26996745209;11019.504122314514;11022.338659680445;11029.61396351124;11031;11040.503177357039;7935.246151615587;8288.088310285864;8289.502629842229;8358.080611132771;8475.321974242046;5955.493783028318;6066.696665166813;6112.205413296421;6114.266288045463;6135.938640613536;9940.850887236553;10065.295429319878;10072.446015469219;10090.293679442662;10137.493125343555;9254.676086337215;9929.255305851946;10414.114800241761;10414.843777343194;10430.37417754937;6915.757948471779;7616.504927179715;7920.564368959763;7923.84152316962;8148.429609927248;8602.096779838277;8615.827683446421;8625.353098517762;8681.479111253093;8751.474911505331;7805.258500442449;7808.149456603105;7908.960455197687;7927.960360198393;7998.240167184108;7700.422468314787;7735.149133595188;7780.299773020455;7818.726344577913;7882.487638303492;6754.696038678173;6821.863562728817;6878.931210687829;6882.311768823078;6912.930870691229;4857.101436234308;4957.182064959241;5010.649254552146;5035.697858128524;5142.537171654569;4997.8750531235555;5074.188129899198;5137.51193636604;5179.792808287626;5280.023195708806 12:25:28 INFO - PROCESS | 3085 | |4;prototype.html;340.5912904514583;358.61986294527804;358.7685942567044;362.1850835619854;366.2345697492241;5530.6128571000045;5579.191017302489;5582.190582365554;5588.944110558893;5624.578156638248;5446.346438427385;5450.264214331064;5544.528715059215;5558.666480011202;5568.9443105568935;3818.9427158592503;4070.8778736637946;4249.6387807036435;4322.675799315049;4347.586979236968;4334.869953901388;4336.544662810406;4349.238883195444;4358.171947330013;4361.411209486726;4306.095719898809;4323.286657701476;4325.653947684178;4326.956730432703;4338.370936214263;4114.19773144237;4178.39413285075;4228.006418491636;4295.763732994684;4312.310030395153;3809.9809500952597;3834.0223243072837;3838.174792419615;3844.9042023023585;3859.9035024124623;5325.4940780625775;5333.853221557384;5336.146216605324;5343.946560534384;5345.732713364355;4827.806887724487;4956.909479914413;4963.70217786934;4969.465572557985;4984.551390374883;5601.859953501154;5637.154426835967;5669.6314739541795;5687.971560142173;5706.400827913051;4236.533981262059;4242.596953289432;4257.297545904922;4260.957390426118;4261.488621365425;5629.155626655994;5690.776483056163;5803.390643982363;5894;5897.673023569705;4246.363045543193;4370.978145109254;4372.3878656988045;4372.497162826252;4387.407699960529;4406.228909940747;4415.492218394926;4419.204543182258;4421.53573874745;4423.690341676116;4829.13075646387;4926.285688575208;4941.160002799533;4943.703377797344;4946.109700253989;5673.8297851064535;5716.1997320375185;5720.856978575569;5744.454276843693;5748.166515855178;1514.8257950335633;1534.3479021415853;1534.8465153484563;1544.3590909772543;1545.7990461240192;956.5982287439292;993.9762045093565;1001.234055947201;1016.5781200801584;1021.7496713305288;4966.428860680996;4966.8758281043265;4971.403431588233;4974.228994505857;4985.9501404985485;5120.692758434506;5145.9485405146215;5174.741262936838;5220.712860792617;5241.449647787003;4935.136351138536;4940.7035577865445;4949.628777841676;5206.921896171561;5602.215689803431;3120.547520609499;3137.4038932602734;3140.7173354397755;3154.9684503155136;3172.6351469581296;6119.2350956130485;6122.785702500391;6124.295705993779;6128.754849806047;6138.877222455526;5770.221020162308;6063.333033366326;6133.264008318941;6156.26124865019;6173.197484327009;6142.324344322121;6178.938210617926;6181.84545386369;6187.257529096537;6198.535109866778;5666.829995100154;5865.9441300566305;5951.315598706205;5994.880102398015;6002.309734380602;5851.239338886088;5865.530757539302;5892.970535147469;5897.203877476657;5910.408959104056;5668.744906479136;5867.970660146842;6025.517958563392;6027.939720602738;6086.360932102242;4258;4298.140371925565;4316.762578058111;4324.416203812445;4345.608895199447;5687.687177205294;5779.768809247583;5797.188393624811;5799.217105690678;5811.518062893935;5647.209390685225;5688.658680479184;5700.3444603871085;5703.804035446466;5705.714714264187;5624.634398764068;5656.349519805275;5674.77300907959;5675.205471234113;5676.971615141898;5430.755615997368;5614.24207731951;5632.605717599728;5655.264815573949;5676.4323567642905;5705.714714264187;5720.11338242573;5724.484796368347;5725;5739.196512488338;5596.216529685766;5603.887922241451;5607.579431542569;5613.522850557748;5619.550435965031 12:25:28 INFO - PROCESS | 3085 | |5;yui.html;779.8986131802865;805.9435839491234;808.7573727881634;846.7798372423171;850.6937502499101;15886.205689715525;16568;16907;17920.551986200353;17939.461816145522;14908.478203262888;15047.24763761813;15176.392944282243;15193.620159496018;15217.39130434784;695.4158506854242;735.2794261623612;844.5566077809153;865.523961820999;868.9956550217272;828.5774255129867;869.0223498564116;877.214892671059;883.4610887358706;883.8099808541162;911.6991392840347;913.3332667152982;914.3736540469799;914.38279161566;914.5655813488606;728.4318231779167;767.2097739328444;906.2206502407923;906.8322360363321;906.9093090690944;638.4126603524768;667.4860357524727;671.6574546981026;671.7346648073983;672.4855485553555;15703.607409814731;15733.763993540106;15740.606484837856;15743.448979285784;15795.21023948798;14912.403503859832;15181.544553663407;15188.46840360582;15268.541943741706;15658.68682626341;12881.742365152739;13269.933650331783;13943.651408714863;14050.85949140516;14115.364808583638;4696.084263568606;4741.146593613148;4742.905141897178;4801.063792560452;4877;75362;77032;82316.58841705813;82805.58597207036;84000.57999709963;11518.308901465938;11566.65300041;11687.474063667156;11720.120990925714;11858.703532411586;22208.333749987527;22220.333389998326;22236.444088897908;22252.443688907908;22258;8596.78508037304;8695.826083478294;8855.690050848189;9102.817943641223;9454;4825.179719447702;4959.404871415453;5069.974650126799;5143.434222235551;5184.040952423738;3435.4159792835276;3544.521489598871;3559.626239244842;3560.0565850049757;3574.303010912899;573.8135106090538;580.1095318685797;593.2643522032648;595.3986473661633;597.3727586034646;658.9637569933603;666.866626674667;677.8644271145691;686.6738299307789;704.306258335539;8606.5696715164;8780.78048048804;8804.515751633593;8936;9033.954830225806;627.0803613884912;697.7557854750899;697.8464737757686;721.3688022979893;733.695516360715;4003.499562554681;4123.299039163349;4282;4320.287152619845;4360.411344468456;103755.48122259491;104625.47687261667;129928;135594.32202838923;135688.3215583916;63826;88686;91520.0847991525;102695;103548.48225758823;90285;91926.08073919175;92034.53982730178;92076;92704.53647731718;9002.189802917768;9735.853962190431;9796.853047204155;9828.459434731158;9885;40673;53490;55479.445205547425;55651.44348556625;56946.7152664234;80429;83540;83859.5807020961;84552;85555;12129.818052729039;12406.193597416139;12429.12996090265;12433.626991190278;12828.230306181658;13881.889448843865;14809.718940368437;15649;15695.607609809846;15850.7622385662;11816.70458238551;11889.227200232302;12058.15592908488;13969.511067112602;14512.1292722437;11906.34515101643;12901.290429026494;13345.266010369523;13411.597652070453;13635.727285454037;12948.546800861925;13792.172469651852;13807;14670.193139377438;15463.768043479582;11357.54569817198;11667.824982625438;11988.64034078979;12130.75738485243;12279.815802762787;10701.562414122422;10778.13774898022;10987.066099381642;11155.888441115485;11514 12:25:28 INFO - PROCESS | 3085 | __end_tp_report 12:25:28 INFO - PROCESS | 3085 | __start_cc_report 12:25:28 INFO - PROCESS | 3085 | _x_x_mozilla_cycle_collect,881 12:25:28 INFO - PROCESS | 3085 | __end_cc_report 12:25:28 INFO - PROCESS | 3085 | __startTimestamp1475349928169__endTimestamp 12:25:28 INFO - PROCESS | 3085 | 12:25:28 INFO - PROCESS | 3085 | ------- Summary: start ------- 12:25:28 INFO - PROCESS | 3085 | Number of tests: 6 12:25:28 INFO - PROCESS | 3085 | 12:25:28 INFO - PROCESS | 3085 | [#0] dojo.html Cycles:165 Average:5496.01 Median:5753.02 stddev:627.19 (10.9%) stddev-sans-first:599.37 12:25:28 INFO - PROCESS | 3085 | Values: 3062.8 3088.3 3100.7 3121.0 3137.9 5446.3 5516.5 5528.1 5547.4 5564.9 5603.3 5631.2 5653.6 5655.6 5657.8 5074.5 5089.0 5127.7 5169.0 5175.8 4938.2 4957.7 5139.3 5194.4 5203.2 5031.9 5037.5 5056.7 5081.1 5085.2 5084.0 5087.9 5120.2 5153.6 5168.6 4808.5 5060.7 5067.4 5126.1 5142.8 5363.1 5455.0 5462.4 5479.7 5519.8 5892.6 5911.1 6035.9 6039.2 6047.9 5753.0 6008.2 6032.5 6047.3 6053.2 5423.6 5450.3 5495.6 5500.1 5508.7 6032.6 6046.1 6048.5 6049.1 6054.5 5673.9 5817.9 5820.9 5822.6 5824.3 5775.7 5799.7 5843.3 5858.6 5926.3 5860.3 5870.4 5872.1 5876.9 5878.0 5792.2 5851.1 5855.2 5875.4 5881.2 4400.9 4431.0 4494.3 4525.6 4536.0 4034.7 4036.3 4036.5 4037.2 4074.8 5518.0 5529.5 5529.7 5529.8 5558.0 5827.1 5879.8 5901.3 5905.7 5924.9 5639.4 5640.6 5643.1 5652.6 5674.0 5146.5 5163.0 5178.1 5181.0 5202.8 5920.5 5930.3 6014.0 6167.4 6175.9 5895.9 5942.4 5949.8 5988.7 5996.3 6086.9 6129.7 6133.4 6135.6 6144.8 5574.9 5588.8 5810.3 5856.8 5862.5 5800.0 5823.6 5857.5 5911.9 5940.6 5799.3 5799.9 5801.1 5806.9 5811.2 5651.1 5772.7 5773.3 5778.4 5781.1 5591.8 5765.5 5780.5 5808.7 5841.3 5832.9 5838.3 5890.1 5903.0 5903.4 5564.0 5601.5 5757.0 5768.2 5768.3 12:25:28 INFO - PROCESS | 3085 | 12:25:28 INFO - PROCESS | 3085 | [#1] ext.html Cycles:180 Average:60235.16 Median:21748.06 stddev:117298.40 (539.4%) stddev-sans-first:117542.00 12:25:28 INFO - PROCESS | 3085 | Values: 602.4 636.5 652.7 654.0 673.3 34602.8 35227.6 46427.8 46955.5 47192.0 45584.5 49699.5 49702.0 49755.0 49764.0 8527.4 9411.5 9468.1 9577.1 9579.6 8559.3 8854.9 8859.0 10968.3 11297.7 11511.9 11564.6 11566.5 11575.1 11575.4 11340.3 11446.0 11448.6 11456.9 11461.4 11236.1 11258.5 11269.7 11275.2 11286.4 45342.8 45587.5 45612.1 45686.5 45714.8 3934.1 4060.8 4088.0 4295.0 4596.6 34864.5 34888.5 35047.5 35085.8 35108.3 4501.8 4642.1 4789.4 4854.8 4963.3 403224.0 404008.0 405619.0 406456.0 406813.0 66664.3 66917.3 67089.7 67093.3 67105.0 41021.2 41752.0 42033.0 42751.6 42777.0 17612.3 17698.6 17706.2 17744.2 17748.5 15018.2 15080.0 15080.2 15084.5 15085.2 18527.4 19004.9 20327.2 20906.3 21016.4 7781.7 7791.1 7835.4 7895.8 7947.8 940.2 990.3 1007.7 1030.9 1068.3 25440.7 25582.6 25761.6 25795.4 26068.7 1076.3 1132.3 1139.1 1170.1 1184.2 13509.9 13534.4 13563.4 13652.4 13742.7 552047.0 555875.0 558215.0 558732.0 559621.0 64356.0 64724.4 64728.4 64855.4 64857.4 1320.9 1369.8 1369.9 1400.5 1436.6 25216.9 27792.0 27816.7 28043.3 28452.9 53398.7 54041.5 54074.0 54085.2 54141.7 336300.0 336353.0 336805.0 337198.0 337288.0 30455.4 32050.5 32189.5 33236.3 33262.2 51316.5 51339.0 51411.7 51863.0 52090.5 43556.6 43609.6 44370.6 44605.0 45085.0 43652.0 43762.3 44347.2 44400.3 44852.0 37723.4 38394.4 38445.8 38907.2 38965.0 37777.0 38284.6 39045.6 39562.0 39706.0 26655.2 26728.7 26789.5 27011.9 27184.0 12:25:28 INFO - PROCESS | 3085 | 12:25:28 INFO - PROCESS | 3085 | [#2] jquery.html Cycles:180 Average:26087.79 Median:24266.77 stddev:66958.48 (275.9%) stddev-sans-first:67118.53 12:25:28 INFO - PROCESS | 3085 | Values: 393.7 403.7 429.4 429.8 441.3 14650.8 16567.3 20484.9 21221.3 21768.1 20344.6 20410.5 20840.5 21041.4 21148.5 5837.9 5875.1 6044.5 6077.1 6089.8 4303.6 4526.1 5939.1 6031.0 6031.2 4474.4 4563.5 6630.1 6724.1 6743.7 6431.9 6511.5 6706.4 6729.2 6737.9 5780.2 5800.8 5807.1 5818.1 5823.9 24168.2 24365.4 24616.8 24701.3 25460.9 2527.7 2564.4 2570.3 2624.3 3193.9 13630.9 15733.1 15803.5 15852.5 16058.7 1978.6 2055.0 2060.8 2062.2 2073.9 59459.7 85671.6 86074.0 87368.0 87702.6 11034.0 11065.7 11346.8 11356.7 11570.5 14873.7 14880.9 14896.1 14907.6 14910.9 8933.4 8964.5 9000.6 9007.5 9124.7 8477.2 8492.1 8530.8 8728.8 9259.8 6949.0 6979.8 6986.7 7033.3 7153.2 1848.4 1927.5 1956.5 1978.1 2049.8 982.5 1051.4 1067.3 1075.5 1096.6 19640.7 20139.6 20298.9 20490.7 20560.4 1000.3 1014.1 1043.1 1086.5 1100.8 10735.8 11749.6 11787.5 11818.7 11829.7 161013.0 209503.0 494817.0 496408.0 497690.0 73397.0 80480.6 84551.6 85840.0 86191.6 1060.5 1085.8 1098.8 1112.5 1114.3 17080.6 17329.6 17758.9 18173.2 18209.5 45119.5 45191.3 45358.3 45657.5 46636.0 56716.7 57949.0 60362.0 60580.7 60921.4 6009.0 7298.0 8523.9 8839.0 9152.6 9101.7 11162.7 12405.4 13662.7 14504.2 12208.6 12325.6 12371.8 12462.7 12539.9 11832.8 11968.3 11976.3 12432.3 12688.5 12294.9 12424.4 12568.5 12601.7 12657.4 9046.1 9071.7 9329.0 9430.4 9537.0 12005.1 12487.8 12495.7 12588.9 12604.3 12:25:28 INFO - PROCESS | 3085 | 12:25:28 INFO - PROCESS | 3085 | [#3] mootools.html Cycles:180 Average:5795.53 Median:5004.26 stddev:3269.83 (65.3%) stddev-sans-first:3262.32 12:25:28 INFO - PROCESS | 3085 | Values: 1401.1 1500.8 1540.5 1679.0 1783.5 7717.2 8485.4 8801.5 8840.2 9046.1 8841.2 8920.2 8925.6 8925.9 8932.2 2387.7 2413.6 2416.3 2417.7 2418.3 2411.4 2412.7 2470.4 2478.4 2479.2 2390.6 2397.8 2444.2 2484.5 2485.2 2393.1 2410.5 2415.1 2421.1 2423.7 2346.9 2389.0 2391.8 2400.6 2401.4 8580.0 8820.5 8897.0 8921.1 8937.0 5241.9 5466.5 5472.5 5474.3 5479.8 3441.3 3461.8 3482.2 3521.2 3528.5 1130.4 1133.4 1140.8 1154.3 1156.5 12001.4 12038.9 12078.8 12096.2 12100.0 4348.2 4350.8 4513.9 4517.1 4569.3 9703.1 9723.2 9737.1 9739.7 9745.9 5289.0 5297.3 5301.6 5302.8 5308.5 4144.2 4385.0 4385.9 4515.4 4942.5 3601.7 4064.3 4070.9 4073.2 4087.4 1162.2 1192.8 1198.0 1204.8 1207.3 793.3 869.8 926.7 930.0 938.5 5503.6 5564.2 5965.7 5986.7 6027.2 950.5 951.9 979.7 993.2 1031.0 3851.9 4090.2 4151.1 4187.2 4230.4 10870.7 11007.2 11082.1 11086.9 11231.3 11019.5 11022.3 11029.6 11031.0 11040.5 7935.2 8288.1 8289.5 8358.1 8475.3 5955.5 6066.7 6112.2 6114.3 6135.9 9940.9 10065.3 10072.4 10090.3 10137.5 9254.7 9929.3 10414.1 10414.8 10430.4 6915.8 7616.5 7920.6 7923.8 8148.4 8602.1 8615.8 8625.4 8681.5 8751.5 7805.3 7808.1 7909.0 7928.0 7998.2 7700.4 7735.1 7780.3 7818.7 7882.5 6754.7 6821.9 6878.9 6882.3 6912.9 4857.1 4957.2 5010.6 5035.7 5142.5 4997.9 5074.2 5137.5 5179.8 5280.0 12:25:28 INFO - PROCESS | 3085 | 12:25:28 INFO - PROCESS | 3085 | [#4] prototype.html Cycles:180 Average:4809.23 Median:5344.84 stddev:1384.34 (25.9%) stddev-sans-first:1346.98 12:25:28 INFO - PROCESS | 3085 | Values: 340.6 358.6 358.8 362.2 366.2 5530.6 5579.2 5582.2 5588.9 5624.6 5446.3 5450.3 5544.5 5558.7 5568.9 3818.9 4070.9 4249.6 4322.7 4347.6 4334.9 4336.5 4349.2 4358.2 4361.4 4306.1 4323.3 4325.7 4327.0 4338.4 4114.2 4178.4 4228.0 4295.8 4312.3 3810.0 3834.0 3838.2 3844.9 3859.9 5325.5 5333.9 5336.1 5343.9 5345.7 4827.8 4956.9 4963.7 4969.5 4984.6 5601.9 5637.2 5669.6 5688.0 5706.4 4236.5 4242.6 4257.3 4261.0 4261.5 5629.2 5690.8 5803.4 5894.0 5897.7 4246.4 4371.0 4372.4 4372.5 4387.4 4406.2 4415.5 4419.2 4421.5 4423.7 4829.1 4926.3 4941.2 4943.7 4946.1 5673.8 5716.2 5720.9 5744.5 5748.2 1514.8 1534.3 1534.8 1544.4 1545.8 956.6 994.0 1001.2 1016.6 1021.7 4966.4 4966.9 4971.4 4974.2 4986.0 5120.7 5145.9 5174.7 5220.7 5241.4 4935.1 4940.7 4949.6 5206.9 5602.2 3120.5 3137.4 3140.7 3155.0 3172.6 6119.2 6122.8 6124.3 6128.8 6138.9 5770.2 6063.3 6133.3 6156.3 6173.2 6142.3 6178.9 6181.8 6187.3 6198.5 5666.8 5865.9 5951.3 5994.9 6002.3 5851.2 5865.5 5893.0 5897.2 5910.4 5668.7 5868.0 6025.5 6027.9 6086.4 4258.0 4298.1 4316.8 4324.4 4345.6 5687.7 5779.8 5797.2 5799.2 5811.5 5647.2 5688.7 5700.3 5703.8 5705.7 5624.6 5656.3 5674.8 5675.2 5677.0 5430.8 5614.2 5632.6 5655.3 5676.4 5705.7 5720.1 5724.5 5725.0 5739.2 5596.2 5603.9 5607.6 5613.5 5619.6 12:25:28 INFO - PROCESS | 3085 | 12:25:28 INFO - PROCESS | 3085 | [#5] yui.html Cycles:180 Average:21478.61 Median:4771.98 stddev:31173.91 (653.3%) stddev-sans-first:31222.62 12:25:28 INFO - PROCESS | 3085 | Values: 779.9 805.9 808.8 846.8 850.7 15886.2 16568.0 16907.0 17920.6 17939.5 14908.5 15047.2 15176.4 15193.6 15217.4 695.4 735.3 844.6 865.5 869.0 828.6 869.0 877.2 883.5 883.8 911.7 913.3 914.4 914.4 914.6 728.4 767.2 906.2 906.8 906.9 638.4 667.5 671.7 671.7 672.5 15703.6 15733.8 15740.6 15743.4 15795.2 14912.4 15181.5 15188.5 15268.5 15658.7 12881.7 13269.9 13943.7 14050.9 14115.4 4696.1 4741.1 4742.9 4801.1 4877.0 75362.0 77032.0 82316.6 82805.6 84000.6 11518.3 11566.7 11687.5 11720.1 11858.7 22208.3 22220.3 22236.4 22252.4 22258.0 8596.8 8695.8 8855.7 9102.8 9454.0 4825.2 4959.4 5070.0 5143.4 5184.0 3435.4 3544.5 3559.6 3560.1 3574.3 573.8 580.1 593.3 595.4 597.4 659.0 666.9 677.9 686.7 704.3 8606.6 8780.8 8804.5 8936.0 9034.0 627.1 697.8 697.8 721.4 733.7 4003.5 4123.3 4282.0 4320.3 4360.4 103755.5 104625.5 129928.0 135594.3 135688.3 63826.0 88686.0 91520.1 102695.0 103548.5 90285.0 91926.1 92034.5 92076.0 92704.5 9002.2 9735.9 9796.9 9828.5 9885.0 40673.0 53490.0 55479.4 55651.4 56946.7 80429.0 83540.0 83859.6 84552.0 85555.0 12129.8 12406.2 12429.1 12433.6 12828.2 13881.9 14809.7 15649.0 15695.6 15850.8 11816.7 11889.2 12058.2 13969.5 14512.1 11906.3 12901.3 13345.3 13411.6 13635.7 12948.5 13792.2 13807.0 14670.2 15463.8 11357.5 11667.8 11988.6 12130.8 12279.8 10701.6 10778.1 10987.1 11155.9 11514.0 12:25:28 INFO - PROCESS | 3085 | -------- Summary: end -------- 12:25:28 INFO - PROCESS | 3085 | 12:25:28 INFO - TEST-INFO | 3085: exit 0 12:25:28 INFO - TEST-OK | dromaeo_css | took 1113765ms 12:25:28 INFO - TEST-START | kraken 12:25:28 INFO - operating with platform_type : linux_ 12:25:28 INFO - Initialising browser for kraken test... 12:25:28 INFO - TEST-INFO | started process 3411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy2EXng/profile http://localhost:55428/getInfo.html) 12:25:32 INFO - PROCESS | 3411 | __metrics Screen width/height:1600/1200 12:25:32 INFO - PROCESS | 3411 | colorDepth:24 12:25:32 INFO - PROCESS | 3411 | Browser inner width/height: 1024/697 12:25:32 INFO - PROCESS | 3411 | __metrics 12:25:33 INFO - PROCESS | 3411 | 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:25:33 INFO - PROCESS | 3411 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:25:33 INFO - PROCESS | 3411 | console.error: PushService: 12:25:33 INFO - PROCESS | 3411 | stateChangeProcessEnqueue: Error transitioning state 12:25:33 INFO - PROCESS | 3411 | UnknownError 12:25:34 INFO - TEST-INFO | 3411: exit 0 12:25:34 INFO - Browser initialized. 12:25:34 INFO - Running cycle 1/1 for kraken test... 12:25:34 INFO - TEST-INFO | started process 3503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy2EXng/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:25:46 INFO - PROCESS | 3503 | RSS: Main: 144011264 12:25:46 INFO - PROCESS | 3503 | 12:25:48 INFO - PROCESS | 3503 | Cycle 1(1): loaded http://localhost:55428/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55428/tests/kraken/driver.html?testName=audio-beat-detection) 12:25:49 INFO - PROCESS | 3503 | RSS: Main: 186138624 12:25:49 INFO - PROCESS | 3503 | 12:25:52 INFO - PROCESS | 3503 | Cycle 1(1): loaded http://localhost:55428/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55428/tests/kraken/driver.html?testName=audio-dft) 12:25:52 INFO - PROCESS | 3503 | RSS: Main: 174821376 12:25:52 INFO - PROCESS | 3503 | 12:25:55 INFO - PROCESS | 3503 | Cycle 1(1): loaded http://localhost:55428/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55428/tests/kraken/driver.html?testName=audio-fft) 12:25:56 INFO - PROCESS | 3503 | RSS: Main: 266403840 12:25:56 INFO - PROCESS | 3503 | 12:25:58 INFO - PROCESS | 3503 | Cycle 1(1): loaded http://localhost:55428/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55428/tests/kraken/driver.html?testName=audio-oscillator) 12:25:58 INFO - PROCESS | 3503 | RSS: Main: 173391872 12:25:58 INFO - PROCESS | 3503 | 12:26:00 INFO - PROCESS | 3503 | Cycle 1(1): loaded http://localhost:55428/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55428/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:26:01 INFO - PROCESS | 3503 | RSS: Main: 174436352 12:26:01 INFO - PROCESS | 3503 | 12:26:04 INFO - PROCESS | 3503 | Cycle 1(1): loaded http://localhost:55428/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55428/tests/kraken/driver.html?testName=imaging-darkroom) 12:26:04 INFO - PROCESS | 3503 | RSS: Main: 210857984 12:26:04 INFO - PROCESS | 3503 | 12:26:08 INFO - PROCESS | 3503 | Cycle 1(1): loaded http://localhost:55428/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55428/tests/kraken/driver.html?testName=imaging-desaturate) 12:26:08 INFO - PROCESS | 3503 | RSS: Main: 209637376 12:26:08 INFO - PROCESS | 3503 | 12:26:11 INFO - PROCESS | 3503 | Cycle 1(1): loaded http://localhost:55428/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55428/tests/kraken/driver.html?testName=json-parse-financial) 12:26:12 INFO - PROCESS | 3503 | RSS: Main: 208699392 12:26:12 INFO - PROCESS | 3503 | 12:26:13 INFO - PROCESS | 3503 | Cycle 1(1): loaded http://localhost:55428/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55428/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:26:14 INFO - PROCESS | 3503 | RSS: Main: 171266048 12:26:14 INFO - PROCESS | 3503 | 12:26:16 INFO - PROCESS | 3503 | Cycle 1(1): loaded http://localhost:55428/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55428/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:26:16 INFO - PROCESS | 3503 | RSS: Main: 178831360 12:26:16 INFO - PROCESS | 3503 | 12:26:18 INFO - PROCESS | 3503 | Cycle 1(1): loaded http://localhost:55428/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55428/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:26:19 INFO - PROCESS | 3503 | RSS: Main: 183390208 12:26:19 INFO - PROCESS | 3503 | 12:26:21 INFO - PROCESS | 3503 | Cycle 1(1): loaded http://localhost:55428/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55428/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:26:22 INFO - PROCESS | 3503 | RSS: Main: 184717312 12:26:22 INFO - PROCESS | 3503 | 12:26:25 INFO - PROCESS | 3503 | Cycle 1(1): loaded http://localhost:55428/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55428/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:26:25 INFO - PROCESS | 3503 | RSS: Main: 181710848 12:26:25 INFO - PROCESS | 3503 | 12:26:27 INFO - PROCESS | 3503 | Cycle 1(1): loaded http://localhost:55428/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55428/tests/kraken/driver.html?testName=ai-astar) 12:26:27 INFO - PROCESS | 3503 | RSS: Main: 234176512 12:26:27 INFO - PROCESS | 3503 | 12:26:27 INFO - PROCESS | 3503 | __start_tp_report 12:26:27 INFO - PROCESS | 3503 | _x_x_mozilla_page_load 12:26:27 INFO - PROCESS | 3503 | _x_x_mozilla_page_load_details 12:26:27 INFO - PROCESS | 3503 | |i|pagename|runs| 12:26:27 INFO - PROCESS | 3503 | |0;ai-astar;109;111;112;110;113;113;112;111;112;113 12:26:27 INFO - PROCESS | 3503 | |1;audio-beat-detection;148;117;117;162;118;120;117;118;146;117 12:26:27 INFO - PROCESS | 3503 | |2;audio-dft;161;163;160;162;159;160;160;161;160;161 12:26:27 INFO - PROCESS | 3503 | |3;audio-fft;74;76;75;107;76;76;76;76;103;75 12:26:27 INFO - PROCESS | 3503 | |4;audio-oscillator;82;82;125;81;81;81;100;80;81;112 12:26:27 INFO - PROCESS | 3503 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;116;117;117 12:26:27 INFO - PROCESS | 3503 | |6;imaging-darkroom;145;147;147;146;146;146;147;148;146;146 12:26:27 INFO - PROCESS | 3503 | |7;imaging-desaturate;94;95;95;95;94;94;95;95;95;95 12:26:27 INFO - PROCESS | 3503 | |8;json-parse-financial;51;55;48;49;48;50;59;48;48;49 12:26:27 INFO - PROCESS | 3503 | |9;json-stringify-tinderbox;58;59;59;59;59;59;59;60;58;59 12:26:27 INFO - PROCESS | 3503 | |10;stanford-crypto-aes;73;74;83;76;77;76;73;77;73;80 12:26:27 INFO - PROCESS | 3503 | |11;stanford-crypto-ccm;121;120;128;119;127;115;118;129;151;119 12:26:27 INFO - PROCESS | 3503 | |12;stanford-crypto-pbkdf2;157;153;154;152;152;153;156;157;163;151 12:26:27 INFO - PROCESS | 3503 | |13;stanford-crypto-sha256-iterative;63;62;62;62;62;64;65;65;63;65 12:26:27 INFO - PROCESS | 3503 | __end_tp_report 12:26:27 INFO - PROCESS | 3503 | __start_cc_report 12:26:27 INFO - PROCESS | 3503 | _x_x_mozilla_cycle_collect,1566 12:26:27 INFO - PROCESS | 3503 | __end_cc_report 12:26:27 INFO - PROCESS | 3503 | __startTimestamp1475349987544__endTimestamp 12:26:27 INFO - PROCESS | 3503 | 12:26:27 INFO - PROCESS | 3503 | ------- Summary: start ------- 12:26:27 INFO - PROCESS | 3503 | Number of tests: 14 12:26:27 INFO - PROCESS | 3503 | 12:26:27 INFO - PROCESS | 3503 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:1.35 (1.2%) stddev-sans-first:1.05 12:26:27 INFO - PROCESS | 3503 | Values: 109.0 111.0 112.0 110.0 113.0 113.0 112.0 111.0 112.0 113.0 12:26:27 INFO - PROCESS | 3503 | 12:26:27 INFO - PROCESS | 3503 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:119.00 stddev:17.09 (14.4%) stddev-sans-first:16.52 12:26:27 INFO - PROCESS | 3503 | Values: 148.0 117.0 117.0 162.0 118.0 120.0 117.0 118.0 146.0 117.0 12:26:27 INFO - PROCESS | 3503 | 12:26:27 INFO - PROCESS | 3503 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 12:26:27 INFO - PROCESS | 3503 | Values: 161.0 163.0 160.0 162.0 159.0 160.0 160.0 161.0 160.0 161.0 12:26:27 INFO - PROCESS | 3503 | 12:26:27 INFO - PROCESS | 3503 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.00 stddev:12.49 (16.4%) stddev-sans-first:12.96 12:26:27 INFO - PROCESS | 3503 | Values: 74.0 76.0 75.0 107.0 76.0 76.0 76.0 76.0 103.0 75.0 12:26:27 INFO - PROCESS | 3503 | 12:26:27 INFO - PROCESS | 3503 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:81.00 stddev:16.19 (20.0%) stddev-sans-first:16.88 12:26:27 INFO - PROCESS | 3503 | Values: 82.0 82.0 125.0 81.0 81.0 81.0 100.0 80.0 81.0 112.0 12:26:27 INFO - PROCESS | 3503 | 12:26:27 INFO - PROCESS | 3503 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:26:27 INFO - PROCESS | 3503 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 12:26:27 INFO - PROCESS | 3503 | 12:26:27 INFO - PROCESS | 3503 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.73 12:26:27 INFO - PROCESS | 3503 | Values: 145.0 147.0 147.0 146.0 146.0 146.0 147.0 148.0 146.0 146.0 12:26:27 INFO - PROCESS | 3503 | 12:26:27 INFO - PROCESS | 3503 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 12:26:27 INFO - PROCESS | 3503 | Values: 94.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 12:26:27 INFO - PROCESS | 3503 | 12:26:27 INFO - PROCESS | 3503 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:49.50 stddev:3.69 (7.5%) stddev-sans-first:3.91 12:26:27 INFO - PROCESS | 3503 | Values: 51.0 55.0 48.0 49.0 48.0 50.0 59.0 48.0 48.0 49.0 12:26:27 INFO - PROCESS | 3503 | 12:26:27 INFO - PROCESS | 3503 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.50 12:26:27 INFO - PROCESS | 3503 | Values: 58.0 59.0 59.0 59.0 59.0 59.0 59.0 60.0 58.0 59.0 12:26:27 INFO - PROCESS | 3503 | 12:26:27 INFO - PROCESS | 3503 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.50 stddev:3.29 (4.3%) stddev-sans-first:3.28 12:26:27 INFO - PROCESS | 3503 | Values: 73.0 74.0 83.0 76.0 77.0 76.0 73.0 77.0 73.0 80.0 12:26:27 INFO - PROCESS | 3503 | 12:26:27 INFO - PROCESS | 3503 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:124.00 stddev:10.36 (8.4%) stddev-sans-first:10.90 12:26:27 INFO - PROCESS | 3503 | Values: 121.0 120.0 128.0 119.0 127.0 115.0 118.0 129.0 151.0 119.0 12:26:27 INFO - PROCESS | 3503 | 12:26:27 INFO - PROCESS | 3503 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:155.00 stddev:3.58 (2.3%) stddev-sans-first:3.71 12:26:27 INFO - PROCESS | 3503 | Values: 157.0 153.0 154.0 152.0 152.0 153.0 156.0 157.0 163.0 151.0 12:26:27 INFO - PROCESS | 3503 | 12:26:27 INFO - PROCESS | 3503 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:1.34 (2.1%) stddev-sans-first:1.41 12:26:27 INFO - PROCESS | 3503 | Values: 63.0 62.0 62.0 62.0 62.0 64.0 65.0 65.0 63.0 65.0 12:26:27 INFO - PROCESS | 3503 | -------- Summary: end -------- 12:26:27 INFO - PROCESS | 3503 | 12:26:28 INFO - TEST-INFO | 3503: exit 0 12:26:28 INFO - TEST-OK | kraken | took 59780ms 12:26:28 INFO - SUITE-END | took 1173s 12:26:29 INFO - Completed test suite (00:19:34) 12:26:29 INFO - javascript benchmark 12:26:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3062.846857657117, 3088.3051313454475, 3100.7054329838656, 3121.0, 3137.8744850205994, 5446.2647542581735, 5516.531094856932, 5528.14313781364, 5547.389787123423, 5564.916526252105, 5603.2715746952945, 5631.239782629344, 5653.575981801371, 5655.604107712462, 5657.773689052443, 5074.4925507449325, 5088.982203559303, 5127.66670166438, 5168.992046550924, 5175.767090480937, 4938.2098864181735, 4957.702537847723, 5139.25480805283, 5194.35070616173, 5203.219517072432, 5031.924521132186, 5037.521435463644, 5056.696598204119, 5081.136206844845, 5085.211792172219, 5083.974580127113, 5087.923681144785, 5120.15517439622, 5153.56194723449, 5168.560672342818, 4808.519148085198, 5060.721660308682, 5067.366579177603, 5126.102931986925, 5142.845714628567, 5363.141897296453, 5455.0, 5462.371827239839, 5479.671219726789, 5519.751611177507, 5892.587518873681, 5911.083782013795, 6035.939640603582, 6039.1545183674325, 6047.939520604826, 5753.021986262345, 6008.158857759917, 6032.5173986081445, 6047.334793172748, 6053.182820319289, 5423.566114710814, 5450.291462109901, 5495.587830912697, 5500.147477141049, 5508.697021663847, 6032.577719559677, 6046.123312119718, 6048.485878700271, 6049.062395328731, 6054.455099041019, 5673.943260567424, 5817.88364232713, 5820.883582328414, 5822.621529600562, 5824.271966004249, 5775.711214439261, 5799.710014499258, 5843.29880414353, 5858.589898707135, 5926.288845338587, 5860.267466566679, 5870.412958704095, 5872.060470324727, 5876.941230587725, 5878.0, 5792.189093526909, 5851.063829787214, 5855.180274761537, 5875.383084776123, 5881.206037185011, 4400.933985990213, 4430.955690443055, 4494.325851122292, 4525.592696657251, 4536.02475467776, 4034.65705415043, 4036.2734707752297, 4036.5156181258435, 4037.1925614876554, 4074.796260187038, 5518.034343989786, 5529.474699903502, 5529.668219906738, 5529.806456774074, 5558.0, 5827.125931110368, 5879.823605291848, 5901.291844978544, 5905.704714764331, 5924.881502369928, 5639.379668236491, 5640.576956728261, 5643.125315576092, 5652.604317697722, 5674.0, 5146.511081447256, 5163.0, 5178.145605975047, 5181.0, 5202.7918883245, 5920.496757775637, 5930.258717660293, 6013.9699301503215, 6167.444929956236, 6175.907361389583, 5895.94104058954, 5942.435468630646, 5949.8215053548465, 5988.730507127277, 5996.310424301261, 6086.878262434815, 6129.693515324305, 6133.417325354084, 6135.570510064253, 6144.846378840565, 5574.888502230014, 5588.804391846266, 5810.331811841524, 5856.765729370777, 5862.530997520103, 5800.042992906292, 5823.621464604787, 5857.531397488276, 5911.9062973350065, 5940.61386009908, 5799.333076696234, 5799.913001305068, 5801.100829371454, 5806.912896306643, 5811.215485909348, 5651.067573850269, 5772.6536407815665, 5773.3072031356505, 5778.36437991829, 5781.132830075522, 5591.804286849941, 5765.4522820332, 5780.508656764222, 5808.651480911159, 5841.269841269841, 5832.854178645568, 5838.2702162229725, 5890.057590785454, 5902.970485147547, 5903.439173278532, 5563.998480273428, 5601.495865372136, 5756.971215143897, 5768.1636162757, 5768.3078030634915], "value": 5452.632899227453, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.3614968133778, 636.538509580554, 652.7291174162723, 653.9967300163499, 673.2560520624712, 34602.82698586507, 35227.64772352276, 46427.76786116073, 46955.53044469554, 47192.0, 45584.54415455845, 49699.50300496994, 49702.0, 49755.0, 49764.0, 8527.360447966395, 9411.529423528813, 9468.147866691996, 9577.138057574817, 9579.568919398609, 8559.315254779603, 8854.911450885473, 8859.025507194203, 10968.341899486057, 11297.717557061056, 11511.884881151207, 11564.59523916663, 11566.479508422099, 11575.073994080496, 11575.36335501547, 11340.319580825135, 11446.027087697556, 11448.599299024536, 11456.94271528637, 11461.426928653535, 11236.101111911028, 11258.493367798468, 11269.718257043558, 11275.210735248536, 11286.435678216138, 45342.77328613336, 45587.54412455866, 45612.08775824465, 45686.543134568565, 45714.77142614299, 3934.1148241645687, 4060.817263223162, 4088.0393107619684, 4294.978525107385, 4596.632269418438, 34864.47703284453, 34888.47667284993, 35047.4742878857, 35085.82457087698, 35108.297834043435, 4501.819927202908, 4642.141203877293, 4789.449213340441, 4854.805807767721, 4963.280324352949, 403224.0, 404008.0, 405619.0, 406456.0, 406812.99999999703, 66664.33335666679, 66917.33082669208, 67089.66455167693, 67093.32906670871, 67105.0, 41021.17957640831, 41752.0, 42033.0, 42751.572484275384, 42777.0, 17612.295508179785, 17698.5575360617, 17706.20322085509, 17744.20151093178, 17748.467545973643, 15018.174000429863, 15080.0, 15080.170590617401, 15084.472043478425, 15085.24573771307, 18527.351542695942, 19004.904975475034, 20327.186912523335, 20906.26828061041, 21016.36950891476, 7781.688732450752, 7791.104023037423, 7835.373170146375, 7895.763127106196, 7947.801304967422, 940.247801758604, 990.3315262197988, 1007.6573964851839, 1030.9278350515392, 1068.2682362581656, 25440.74559254421, 25582.616260756102, 25761.61357579638, 25795.355116122246, 26068.73931260701, 1076.3272954403499, 1132.2810015639964, 1139.0716565998684, 1170.104869774623, 1184.1710802438156, 13509.932450337685, 13534.390952406968, 13563.389647465889, 13652.385642646104, 13742.725145497034, 552047.0, 555875.0, 558215.0, 558732.0, 559621.0, 64356.0, 64724.35275647183, 64728.35271647317, 64855.35144648493, 64857.35142648607, 1320.907536472457, 1369.760291948925, 1369.9315034248448, 1400.4888215801159, 1436.5977526292654, 25216.873915630305, 27792.0, 27816.72183278141, 28043.298917527223, 28452.85773571119, 53398.73300633472, 54041.45958540522, 54074.0, 54085.18872216999, 54141.729291353295, 336300.0, 336353.0, 336805.0, 337198.0, 337288.0, 30455.390892182477, 32050.519242211853, 32189.517157242193, 33236.335273294884, 33262.168445788084, 51316.486835132666, 51339.0, 51411.742941285054, 51863.0, 52090.47909520856, 43556.56443435525, 43609.56390436182, 44370.55629443664, 44605.0, 45085.0, 43652.0, 43762.34356484719, 44347.2261109552, 44400.33399498946, 44852.0, 37723.43414848725, 38394.42408363933, 38445.846624601305, 38907.22185556329, 38965.0, 37777.0, 38284.61715382922, 39045.60954390533, 39562.0, 39706.0, 26655.200343989713, 26728.732712672623, 26789.526576038505, 27011.864940675958, 27184.0], "value": 20932.270764793822, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.72832745405685, 403.731518540171, 429.3602532226982, 429.83881044608273, 441.30494471207857, 14650.780238296435, 16567.33730650774, 20484.89757551212, 21221.257255996043, 21768.12927482899, 20344.59310813783, 20410.489737756565, 20840.47898802527, 21041.368758937257, 21148.471288217803, 5837.854053648661, 5875.089361149029, 6044.546659000571, 6077.058056001327, 6089.847753806146, 4303.634191093761, 4526.07215520819, 5939.079442686369, 6031.0, 6031.185789918371, 4474.395956545874, 4563.4752003519525, 6630.138082049351, 6724.125863637721, 6743.696533655972, 6431.903521447182, 6511.479081673455, 6706.362895524917, 6729.192496900354, 6737.865242695168, 5780.1907732917425, 5800.7679692812235, 5807.070868660994, 5818.1272809078555, 5823.854403639901, 24168.15411460608, 24365.390865228335, 24616.753832461625, 24701.25896223116, 25460.872695636404, 2527.734587868284, 2564.3717289264064, 2570.3317137544373, 2624.2520881548858, 3193.850213922986, 13630.931845340809, 15733.134677592729, 15803.525894223192, 15852.52442426729, 16058.678826423524, 1978.6339527187517, 2055.0341339570377, 2060.814526692605, 2062.2060506704875, 2073.9111966217856, 59459.70270148665, 85671.5716421414, 86074.0, 87368.0, 87702.56148719216, 11034.0, 11065.723356916142, 11346.829797553044, 11356.716082097848, 11570.537178512934, 14873.70252594942, 14880.851191488164, 14896.106233626017, 14907.552773416815, 14910.92544537292, 8933.419327743675, 8964.462132272085, 9000.63997440095, 9007.549622518847, 9124.726258212264, 8477.152284771597, 8492.065872753992, 8530.786730331667, 8728.825423491495, 9259.814803703888, 6949.0, 6979.790606281718, 6986.650667466606, 7033.296670332926, 7153.213146553979, 1848.4177484092468, 1927.4506765572025, 1956.5108722819296, 1978.0999645161417, 2049.825764809978, 982.4645568165367, 1051.4374809477047, 1067.2689207892618, 1075.5213929801164, 1096.6224029987618, 19640.70538941917, 20139.59720805576, 20298.89850550738, 20490.692639610417, 20560.38318850437, 1000.3197825478599, 1014.1177175857051, 1043.113353649392, 1086.5219303506433, 1100.8238681810872, 10735.785284294427, 11749.647510574696, 11787.528498860122, 11818.704532386588, 11829.704257393461, 161013.0, 209503.0, 494817.0, 496408.0, 497690.0, 73397.0, 80480.59759701164, 84551.5772421134, 85840.0, 86191.56904215564, 1060.5174645536263, 1085.7719878825378, 1098.774751176007, 1112.5216157052546, 1114.3035602748282, 17080.57298567496, 17329.566760830578, 17758.91120544389, 18173.182206800462, 18209.45371638853, 45119.548804511534, 45191.32213016873, 45358.319625206306, 45657.54342456533, 46636.0, 56716.71641641765, 57949.0, 60362.0, 60580.69709651423, 60921.39078609157, 6009.008513595208, 7297.963510182415, 8523.891894053733, 8839.0, 9152.58813353414, 9101.726948191565, 11162.716287626701, 12405.379731013594, 13662.658433539242, 14504.202268875313, 12208.572699955459, 12325.551193294657, 12371.75256494883, 12462.688432789253, 12539.93730031344, 11832.76334473323, 11968.341741204318, 11976.28142311464, 12432.254064756144, 12688.492460301484, 12294.893459588322, 12424.378781061092, 12568.497260109492, 12601.747965040831, 12657.430415631134, 9046.095390460901, 9071.682491112779, 9329.0, 9430.387024843638, 9537.046295370408, 12005.099617528545, 12487.750244994868, 12495.687607809878, 12588.937055314665, 12604.298419713221], "value": 9689.196193869186, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.1382999455338, 1500.7823865539501, 1540.5147378575748, 1678.9580260493485, 1783.536280567053, 7717.189695082013, 8485.448445851023, 8801.515916624583, 8840.204381605654, 9046.09539046095, 8841.16008979146, 8920.197182253596, 8925.55372231389, 8925.910740892588, 8932.151445612657, 2387.7134743830766, 2413.6379543068592, 2416.347586151738, 2417.697787776528, 2418.2503423938547, 2411.397150712322, 2412.6984126984125, 2470.407102295454, 2478.4051827561434, 2479.219046000504, 2390.5935990881503, 2397.7961873240797, 2444.2056331692183, 2484.4782595654933, 2485.2420011896365, 2393.066703985447, 2410.4696966667307, 2415.0581273303424, 2421.079989603948, 2423.7212720537186, 2346.9061237550477, 2388.952220955571, 2391.796697280733, 2400.615901455776, 2401.351635058542, 8579.957100214522, 8820.514871682055, 8896.955515222382, 8921.063288354695, 8936.955315223448, 5241.86895327616, 5466.480684334982, 5472.452754724496, 5474.260974768435, 5479.780808767645, 3441.3117376524797, 3461.826908654557, 3482.181687303482, 3521.1725244567506, 3528.5060091587197, 1130.3895896216034, 1133.3879704959313, 1140.8402823604702, 1154.3016475032568, 1156.5142640091183, 12001.399930003465, 12038.87961120395, 12078.758424831542, 12096.153269271155, 12100.0, 4348.173846969065, 4350.825966961349, 4513.88715282114, 4517.09658068381, 4569.29175977724, 9703.12671859536, 9723.173530249867, 9737.07497787709, 9739.65911193119, 9745.902540974641, 5288.9735551322, 5297.337832770903, 5301.628885978022, 5302.787888484495, 5308.548773354308, 4144.152146343146, 4384.978075109668, 4385.934210986838, 4515.367848501212, 4942.5304596063315, 3601.729870259741, 4064.349704047338, 4070.898227544276, 4073.2260870434525, 4087.4073259377224, 1162.2096974057722, 1192.7852986462347, 1197.988020119805, 1204.7891618966646, 1207.3178654060428, 793.2979313307765, 869.7695110795644, 926.6756635177634, 930.0374112793227, 938.5119737736476, 5503.642263252956, 5564.248826408464, 5965.731542080617, 5986.670733109634, 6027.186329845503, 950.538988590533, 951.9048095190564, 979.6816034788723, 993.1558175550869, 1030.9639162629271, 3851.9229615407535, 4090.2024105299774, 4151.12826306479, 4187.24629566681, 4230.386593943861, 10870.728231794268, 11007.174461915229, 11082.058025067798, 11086.944565277123, 11231.26996745209, 11019.504122314514, 11022.338659680445, 11029.61396351124, 11031.0, 11040.503177357039, 7935.246151615587, 8288.088310285864, 8289.502629842229, 8358.080611132771, 8475.321974242046, 5955.493783028318, 6066.696665166813, 6112.205413296421, 6114.266288045463, 6135.938640613536, 9940.850887236553, 10065.295429319878, 10072.446015469219, 10090.293679442662, 10137.493125343555, 9254.676086337215, 9929.255305851946, 10414.114800241761, 10414.843777343194, 10430.37417754937, 6915.757948471779, 7616.504927179715, 7920.564368959763, 7923.84152316962, 8148.429609927248, 8602.096779838277, 8615.827683446421, 8625.353098517762, 8681.479111253093, 8751.474911505331, 7805.258500442449, 7808.149456603105, 7908.960455197687, 7927.960360198393, 7998.240167184108, 7700.422468314787, 7735.149133595188, 7780.299773020455, 7818.726344577913, 7882.487638303492, 6754.696038678173, 6821.863562728817, 6878.931210687829, 6882.311768823078, 6912.930870691229, 4857.101436234308, 4957.182064959241, 5010.649254552146, 5035.697858128524, 5142.537171654569, 4997.8750531235555, 5074.188129899198, 5137.51193636604, 5179.792808287626, 5280.023195708806], "value": 4648.776740456377, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.5912904514583, 358.61986294527804, 358.7685942567044, 362.1850835619854, 366.2345697492241, 5530.6128571000045, 5579.191017302489, 5582.190582365554, 5588.944110558893, 5624.578156638248, 5446.346438427385, 5450.264214331064, 5544.528715059215, 5558.666480011202, 5568.9443105568935, 3818.9427158592503, 4070.8778736637946, 4249.6387807036435, 4322.675799315049, 4347.586979236968, 4334.869953901388, 4336.544662810406, 4349.238883195444, 4358.171947330013, 4361.411209486726, 4306.095719898809, 4323.286657701476, 4325.653947684178, 4326.956730432703, 4338.370936214263, 4114.19773144237, 4178.39413285075, 4228.006418491636, 4295.763732994684, 4312.310030395153, 3809.9809500952597, 3834.0223243072837, 3838.174792419615, 3844.9042023023585, 3859.9035024124623, 5325.4940780625775, 5333.853221557384, 5336.146216605324, 5343.946560534384, 5345.732713364355, 4827.806887724487, 4956.909479914413, 4963.70217786934, 4969.465572557985, 4984.551390374883, 5601.859953501154, 5637.154426835967, 5669.6314739541795, 5687.971560142173, 5706.400827913051, 4236.533981262059, 4242.596953289432, 4257.297545904922, 4260.957390426118, 4261.488621365425, 5629.155626655994, 5690.776483056163, 5803.390643982363, 5894.0, 5897.673023569705, 4246.363045543193, 4370.978145109254, 4372.3878656988045, 4372.497162826252, 4387.407699960529, 4406.228909940747, 4415.492218394926, 4419.204543182258, 4421.53573874745, 4423.690341676116, 4829.13075646387, 4926.285688575208, 4941.160002799533, 4943.703377797344, 4946.109700253989, 5673.8297851064535, 5716.1997320375185, 5720.856978575569, 5744.454276843693, 5748.166515855178, 1514.8257950335633, 1534.3479021415853, 1534.8465153484563, 1544.3590909772543, 1545.7990461240192, 956.5982287439292, 993.9762045093565, 1001.234055947201, 1016.5781200801584, 1021.7496713305288, 4966.428860680996, 4966.8758281043265, 4971.403431588233, 4974.228994505857, 4985.9501404985485, 5120.692758434506, 5145.9485405146215, 5174.741262936838, 5220.712860792617, 5241.449647787003, 4935.136351138536, 4940.7035577865445, 4949.628777841676, 5206.921896171561, 5602.215689803431, 3120.547520609499, 3137.4038932602734, 3140.7173354397755, 3154.9684503155136, 3172.6351469581296, 6119.2350956130485, 6122.785702500391, 6124.295705993779, 6128.754849806047, 6138.877222455526, 5770.221020162308, 6063.333033366326, 6133.264008318941, 6156.26124865019, 6173.197484327009, 6142.324344322121, 6178.938210617926, 6181.84545386369, 6187.257529096537, 6198.535109866778, 5666.829995100154, 5865.9441300566305, 5951.315598706205, 5994.880102398015, 6002.309734380602, 5851.239338886088, 5865.530757539302, 5892.970535147469, 5897.203877476657, 5910.408959104056, 5668.744906479136, 5867.970660146842, 6025.517958563392, 6027.939720602738, 6086.360932102242, 4258.0, 4298.140371925565, 4316.762578058111, 4324.416203812445, 4345.608895199447, 5687.687177205294, 5779.768809247583, 5797.188393624811, 5799.217105690678, 5811.518062893935, 5647.209390685225, 5688.658680479184, 5700.3444603871085, 5703.804035446466, 5705.714714264187, 5624.634398764068, 5656.349519805275, 5674.77300907959, 5675.205471234113, 5676.971615141898, 5430.755615997368, 5614.24207731951, 5632.605717599728, 5655.264815573949, 5676.4323567642905, 5705.714714264187, 5720.11338242573, 5724.484796368347, 5725.0, 5739.196512488338, 5596.216529685766, 5603.887922241451, 5607.579431542569, 5613.522850557748, 5619.550435965031], "value": 4376.277776101543, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.8986131802865, 805.9435839491234, 808.7573727881634, 846.7798372423171, 850.6937502499101, 15886.205689715525, 16568.0, 16907.0, 17920.551986200353, 17939.461816145522, 14908.478203262888, 15047.24763761813, 15176.392944282243, 15193.620159496018, 15217.39130434784, 695.4158506854242, 735.2794261623612, 844.5566077809153, 865.523961820999, 868.9956550217272, 828.5774255129867, 869.0223498564116, 877.214892671059, 883.4610887358706, 883.8099808541162, 911.6991392840347, 913.3332667152982, 914.3736540469799, 914.38279161566, 914.5655813488606, 728.4318231779167, 767.2097739328444, 906.2206502407923, 906.8322360363321, 906.9093090690944, 638.4126603524768, 667.4860357524727, 671.6574546981026, 671.7346648073983, 672.4855485553555, 15703.607409814731, 15733.763993540106, 15740.606484837856, 15743.448979285784, 15795.21023948798, 14912.403503859832, 15181.544553663407, 15188.46840360582, 15268.541943741706, 15658.68682626341, 12881.742365152739, 13269.933650331783, 13943.651408714863, 14050.85949140516, 14115.364808583638, 4696.084263568606, 4741.146593613148, 4742.905141897178, 4801.063792560452, 4877.0, 75362.0, 77032.0, 82316.58841705813, 82805.58597207036, 84000.57999709963, 11518.308901465938, 11566.65300041, 11687.474063667156, 11720.120990925714, 11858.703532411586, 22208.333749987527, 22220.333389998326, 22236.444088897908, 22252.443688907908, 22258.0, 8596.78508037304, 8695.826083478294, 8855.690050848189, 9102.817943641223, 9454.0, 4825.179719447702, 4959.404871415453, 5069.974650126799, 5143.434222235551, 5184.040952423738, 3435.4159792835276, 3544.521489598871, 3559.626239244842, 3560.0565850049757, 3574.303010912899, 573.8135106090538, 580.1095318685797, 593.2643522032648, 595.3986473661633, 597.3727586034646, 658.9637569933603, 666.866626674667, 677.8644271145691, 686.6738299307789, 704.306258335539, 8606.5696715164, 8780.78048048804, 8804.515751633593, 8936.0, 9033.954830225806, 627.0803613884912, 697.7557854750899, 697.8464737757686, 721.3688022979893, 733.695516360715, 4003.499562554681, 4123.299039163349, 4282.0, 4320.287152619845, 4360.411344468456, 103755.48122259491, 104625.47687261667, 129928.0, 135594.32202838923, 135688.3215583916, 63826.0, 88686.0, 91520.0847991525, 102695.0, 103548.48225758823, 90285.0, 91926.08073919175, 92034.53982730178, 92076.0, 92704.53647731718, 9002.189802917768, 9735.853962190431, 9796.853047204155, 9828.459434731158, 9885.0, 40673.0, 53490.0, 55479.445205547425, 55651.44348556625, 56946.7152664234, 80429.0, 83540.0, 83859.5807020961, 84552.0, 85555.0, 12129.818052729039, 12406.193597416139, 12429.12996090265, 12433.626991190278, 12828.230306181658, 13881.889448843865, 14809.718940368437, 15649.0, 15695.607609809846, 15850.7622385662, 11816.70458238551, 11889.227200232302, 12058.15592908488, 13969.511067112602, 14512.1292722437, 11906.34515101643, 12901.290429026494, 13345.266010369523, 13411.597652070453, 13635.727285454037, 12948.546800861925, 13792.172469651852, 13807.0, 14670.193139377438, 15463.768043479582, 11357.54569817198, 11667.824982625438, 11988.64034078979, 12130.75738485243, 12279.815802762787, 10701.562414122422, 10778.13774898022, 10987.066099381642, 11155.888441115485, 11514.0], "value": 7746.287406674305, "unit": "score"}], "name": "dromaeo_css", "value": 7473.926148760467, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 112.0, 110.0, 113.0, 113.0, 112.0, 111.0, 112.0, 113.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 117.0, 162.0, 118.0, 120.0, 117.0, 118.0, 146.0, 117.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 160.0, 162.0, 159.0, 160.0, 160.0, 161.0, 160.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 107.0, 76.0, 76.0, 76.0, 76.0, 103.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 125.0, 81.0, 81.0, 81.0, 100.0, 80.0, 81.0, 112.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 148.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 55.0, 48.0, 49.0, 48.0, 50.0, 59.0, 48.0, 48.0, 49.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 58.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 83.0, 76.0, 77.0, 76.0, 73.0, 77.0, 73.0, 80.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 120.0, 128.0, 119.0, 127.0, 115.0, 118.0, 129.0, 151.0, 119.0], "value": 124.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 153.0, 154.0, 152.0, 152.0, 153.0, 156.0, 157.0, 163.0, 151.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 62.0, 64.0, 65.0, 65.0, 63.0, 65.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1458.5, "alertThreshold": 2.0}]} 12:26:29 INFO - Return code: 0 12:26:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:26:29 INFO - # TBPL SUCCESS # 12:26:29 INFO - Running post-action listener: _resource_record_post_action 12:26:29 INFO - [mozharness: 2016-10-01 19:26:29.314268Z] Finished run-tests step (success) 12:26:29 INFO - Running post-run listener: _resource_record_post_run 12:26:29 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 369266688; Read time: 0; Write time: 391168 12:26:29 INFO - TinderboxPrint: CPU usage
12.9% 12:26:29 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:26:29 INFO - TinderboxPrint: I/O write bytes / time
369,266,688 / 391,168 12:26:29 INFO - TinderboxPrint: CPU idle
8,275.4 (87.0%) 12:26:29 INFO - TinderboxPrint: CPU user
1,183.8 (12.5%) 12:26:29 INFO - TinderboxPrint: Swap in / out
0 / 0 12:26:29 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 119193600; Read time: 0; Write time: 150860 12:26:29 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 249458688; Read time: 0; Write time: 240308 12:26:29 INFO - Running post-run listener: _upload_blobber_files 12:26:29 INFO - Blob upload gear active. 12:26:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:26:29 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:26:29 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:26:29 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:26:30 INFO - (blobuploader) - INFO - Open directory for files ... 12:26:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:26:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:26:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:26:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:26:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:26:31 INFO - (blobuploader) - INFO - Done attempting. 12:26:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:26:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:26:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:26:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:26:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:26:32 INFO - (blobuploader) - INFO - Done attempting. 12:26:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:26:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:26:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:26:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:26:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:26:35 INFO - (blobuploader) - INFO - Done attempting. 12:26:35 INFO - (blobuploader) - INFO - Iteration through files over. 12:26:35 INFO - Return code: 0 12:26:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:26:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:26:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34e5f0afa11c0ef6cfd23ed2dcda0e8bba720942669fb3d98ef23eae47a77fe47c4893d6891e7c03eca58b604a64563674bfc0bde6e1a59c3f4c76fa8e1b7849", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c462817b8d389640b5c362e34c6873835bd4e37e72e098f533e7ee42b60da5218246196425dc19bb4bf1f33dff467dd3d3358a6616c735c426bc22a9ea4f2f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f48ba3f35e3b155e017478c522f53a9f1d4a8abc17c55c1cb679372430ee5d87ef9378bcecbb4323aa9cdf1176491a821410b18eabd2af6519f00055b1f5454"} 12:26:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:26:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:26:35 INFO - Contents: 12:26:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34e5f0afa11c0ef6cfd23ed2dcda0e8bba720942669fb3d98ef23eae47a77fe47c4893d6891e7c03eca58b604a64563674bfc0bde6e1a59c3f4c76fa8e1b7849", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c462817b8d389640b5c362e34c6873835bd4e37e72e098f533e7ee42b60da5218246196425dc19bb4bf1f33dff467dd3d3358a6616c735c426bc22a9ea4f2f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f48ba3f35e3b155e017478c522f53a9f1d4a8abc17c55c1cb679372430ee5d87ef9378bcecbb4323aa9cdf1176491a821410b18eabd2af6519f00055b1f5454"} 12:26:35 INFO - Running post-run listener: copy_logs_to_upload_dir 12:26:35 INFO - Copying logs to upload dir... 12:26:35 INFO - mkdir: /builds/slave/test/build/upload/logs 12:26:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.795087 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-10-01 12:26:35.267134) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 12:26:35.277566) ========= 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=c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046 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-Aurora/sha512/34e5f0afa11c0ef6cfd23ed2dcda0e8bba720942669fb3d98ef23eae47a77fe47c4893d6891e7c03eca58b604a64563674bfc0bde6e1a59c3f4c76fa8e1b7849", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c462817b8d389640b5c362e34c6873835bd4e37e72e098f533e7ee42b60da5218246196425dc19bb4bf1f33dff467dd3d3358a6616c735c426bc22a9ea4f2f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f48ba3f35e3b155e017478c522f53a9f1d4a8abc17c55c1cb679372430ee5d87ef9378bcecbb4323aa9cdf1176491a821410b18eabd2af6519f00055b1f5454"} build_url:https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/DxNkunvpSy6Hxh9JbTzzNA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34e5f0afa11c0ef6cfd23ed2dcda0e8bba720942669fb3d98ef23eae47a77fe47c4893d6891e7c03eca58b604a64563674bfc0bde6e1a59c3f4c76fa8e1b7849", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c462817b8d389640b5c362e34c6873835bd4e37e72e098f533e7ee42b60da5218246196425dc19bb4bf1f33dff467dd3d3358a6616c735c426bc22a9ea4f2f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f48ba3f35e3b155e017478c522f53a9f1d4a8abc17c55c1cb679372430ee5d87ef9378bcecbb4323aa9cdf1176491a821410b18eabd2af6519f00055b1f5454"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 12:26:35.307919) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 12:26:35.308291) ========= 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=c6927cf182745ad25b1d38b9000001fe-1475346534.752916-939936046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004607 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 12:26:35.367891) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 12:26:35.371247) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 12:26:35.371561) ========= ========= Total master_lag: 0.24 =========