builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-049 starttime: 1477910683.66 results: success (0) buildid: 20161031004002 builduid: f2174131e219431d869ab3bd0ee3e95d revision: b7070c905172e3ead8ee610fff35f86bf9ff9c42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 03:44:43.655895) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 03:44:43.657392) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 03:44:43.657674) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 03:44:43.673073) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 03:44:43.673571) ========= 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=db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-31 03:44:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 15.8M=0.001s 2016-10-31 03:44:44 (15.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097622 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 03:44:43.785452) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 03:44:43.785810) ========= 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=db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018081 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 03:44:43.837504) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 03:44:43.838073) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b7070c905172e3ead8ee610fff35f86bf9ff9c42 --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 b7070c905172e3ead8ee610fff35f86bf9ff9c42 --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=db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-31 03:44:44,537 truncating revision to first 12 chars 2016-10-31 03:44:44,537 Setting DEBUG logging. 2016-10-31 03:44:44,537 attempt 1/10 2016-10-31 03:44:44,537 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b7070c905172?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 03:44:44,989 unpacking tar archive at: mozilla-aurora-b7070c905172/testing/mozharness/ program finished with exit code 0 elapsedTime=0.804830 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 03:44:44.657458) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 03:44:44.657777) ========= script_repo_revision: b7070c905172e3ead8ee610fff35f86bf9ff9c42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 03:44:44.658193) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 03:44:44.658482) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 03:44:44.667702) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-31 03:44:44.668050) ========= /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=db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:44:45 INFO - MultiFileLogger online at 20161031 03:44:45 in /builds/slave/test 03:44:45 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 03:44:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:44:45 INFO - {'append_to_log': False, 03:44:45 INFO - 'base_work_dir': '/builds/slave/test', 03:44:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:44:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:44:45 INFO - 'branch': 'Mozilla-Aurora', 03:44:45 INFO - 'buildbot_json_path': 'buildprops.json', 03:44:45 INFO - 'config_files': ('talos/linux_config.py',), 03:44:45 INFO - 'default_actions': ('clobber', 03:44:45 INFO - 'read-buildbot-config', 03:44:45 INFO - 'download-and-extract', 03:44:45 INFO - 'populate-webroot', 03:44:45 INFO - 'create-virtualenv', 03:44:45 INFO - 'install', 03:44:45 INFO - 'run-tests'), 03:44:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:44:45 INFO - 'download_minidump_stackwalk': True, 03:44:45 INFO - 'download_symbols': 'ondemand', 03:44:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:44:45 INFO - 'tooltool.py': '/tools/tooltool.py', 03:44:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:44:45 INFO - '/tools/misc-python/virtualenv.py')}, 03:44:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:44:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:44:45 INFO - 'installer_path': 'installer.exe', 03:44:45 INFO - 'log_level': 'info', 03:44:45 INFO - 'log_name': 'talos', 03:44:45 INFO - 'log_to_console': True, 03:44:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:44:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:44:45 INFO - 'opt_config_files': (), 03:44:45 INFO - 'pip_index': False, 03:44:45 INFO - 'sps_profile': False, 03:44:45 INFO - 'sps_profile_interval': 0, 03:44:45 INFO - 'suite': 'dromaeojs', 03:44:45 INFO - 'system_bits': '32', 03:44:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:44:45 INFO - 'title': 'talos-linux64-ix-049', 03:44:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:44:45 INFO - 'use_talos_json': True, 03:44:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:44:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:44:45 INFO - 'work_dir': 'build'} 03:44:45 INFO - [mozharness: 2016-10-31 10:44:45.462303Z] Running clobber step. 03:44:45 INFO - Running pre-action listener: _resource_record_pre_action 03:44:45 INFO - Running main action method: clobber 03:44:45 INFO - rmtree: /builds/slave/test/build 03:44:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:44:45 INFO - Running post-action listener: _resource_record_post_action 03:44:45 INFO - [mozharness: 2016-10-31 10:44:45.927700Z] Finished clobber step (success) 03:44:45 INFO - [mozharness: 2016-10-31 10:44:45.927800Z] Running read-buildbot-config step. 03:44:45 INFO - Running pre-action listener: _resource_record_pre_action 03:44:45 INFO - Running main action method: read_buildbot_config 03:44:45 INFO - Using buildbot properties: 03:44:45 INFO - { 03:44:45 INFO - "project": "", 03:44:45 INFO - "product": "firefox", 03:44:45 INFO - "script_repo_revision": "production", 03:44:45 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:44:45 INFO - "repository": "", 03:44:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:44:45 INFO - "buildid": "20161031004002", 03:44:45 INFO - "stage_platform": "linux64-pgo", 03:44:45 INFO - "basedir": "/builds/slave/test", 03:44:45 INFO - "nightly_build": "True", 03:44:45 INFO - "buildnumber": 843, 03:44:45 INFO - "slavename": "talos-linux64-ix-049", 03:44:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:44:45 INFO - "platform": "ubuntu64_hw", 03:44:45 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:44:45 INFO - "branch": "mozilla-aurora", 03:44:45 INFO - "repo_path": "releases/mozilla-aurora", 03:44:45 INFO - "revision": "b7070c905172e3ead8ee610fff35f86bf9ff9c42", 03:44:45 INFO - "pgo_build": "True", 03:44:45 INFO - "builduid": "f2174131e219431d869ab3bd0ee3e95d", 03:44:45 INFO - "slavebuilddir": "test" 03:44:45 INFO - } 03:44:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/E9mDJZOyS7yzO1kGwwYvrA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 03:44:45 INFO - Running post-action listener: _resource_record_post_action 03:44:45 INFO - [mozharness: 2016-10-31 10:44:45.930311Z] Finished read-buildbot-config step (success) 03:44:45 INFO - [mozharness: 2016-10-31 10:44:45.930400Z] Running download-and-extract step. 03:44:45 INFO - Running pre-action listener: _resource_record_pre_action 03:44:45 INFO - Running main action method: download_and_extract 03:44:45 INFO - mkdir: /builds/slave/test/build/tests 03:44:45 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')]} 03:44:45 INFO - trying https://queue.taskcluster.net/v1/task/E9mDJZOyS7yzO1kGwwYvrA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:44:45 INFO - Downloading https://queue.taskcluster.net/v1/task/E9mDJZOyS7yzO1kGwwYvrA/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 03:44:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E9mDJZOyS7yzO1kGwwYvrA/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 03:44:46 INFO - Downloaded 1361 bytes. 03:44:46 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:44:46 INFO - Using the following test package requirements: 03:44:46 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:44:46 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:44:46 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:44:46 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:46 INFO - u'jsshell-linux-x86_64.zip'], 03:44:46 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:44:46 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:44:46 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:44:46 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:44:46 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:44:46 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:44:46 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:44:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E9mDJZOyS7yzO1kGwwYvrA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:44:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E9mDJZOyS7yzO1kGwwYvrA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:44:46 INFO - Fetch https://queue.taskcluster.net/v1/task/E9mDJZOyS7yzO1kGwwYvrA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:44:47 INFO - Expected file size: 21895637 03:44:52 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 03:44:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E9mDJZOyS7yzO1kGwwYvrA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:44:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E9mDJZOyS7yzO1kGwwYvrA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:44:52 INFO - Fetch https://queue.taskcluster.net/v1/task/E9mDJZOyS7yzO1kGwwYvrA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:44:52 INFO - Expected file size: 21895637 03:44:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E9mDJZOyS7yzO1kGwwYvrA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 03:44:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E9mDJZOyS7yzO1kGwwYvrA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:44:57 INFO - Fetch https://queue.taskcluster.net/v1/task/E9mDJZOyS7yzO1kGwwYvrA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:44:58 INFO - Expected file size: 14414089 03:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:59 INFO - trying https://queue.taskcluster.net/v1/task/E9mDJZOyS7yzO1kGwwYvrA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:44:59 INFO - Downloading https://queue.taskcluster.net/v1/task/E9mDJZOyS7yzO1kGwwYvrA/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 03:44:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E9mDJZOyS7yzO1kGwwYvrA/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 03:45:01 INFO - Downloaded 63968306 bytes. 03:45:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E9mDJZOyS7yzO1kGwwYvrA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:45:01 INFO - mkdir: /builds/slave/test/properties 03:45:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:45:01 INFO - Writing to file /builds/slave/test/properties/build_url 03:45:01 INFO - Contents: 03:45:01 INFO - build_url:https://queue.taskcluster.net/v1/task/E9mDJZOyS7yzO1kGwwYvrA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:45:02 INFO - Running post-action listener: _resource_record_post_action 03:45:02 INFO - Running post-action listener: set_extra_try_arguments 03:45:02 INFO - [mozharness: 2016-10-31 10:45:02.454344Z] Finished download-and-extract step (success) 03:45:02 INFO - [mozharness: 2016-10-31 10:45:02.454571Z] Running populate-webroot step. 03:45:02 INFO - Running pre-action listener: _resource_record_pre_action 03:45:02 INFO - Running main action method: populate_webroot 03:45:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:45:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:45:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:45:02 INFO - '--tppagecycles', 03:45:02 INFO - '7'], 03:45:02 INFO - 'tests': ['tsvgm']}}, 03:45:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:45:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:45:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:45:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:45:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:45:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:45:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:02 INFO - 'talos_options': ['--disable-e10s'], 03:45:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:45:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:45:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:02 INFO - 'talos_options': ['--disable-e10s'], 03:45:02 INFO - 'tests': ['damp', 'tps']}, 03:45:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:02 INFO - 'tests': ['damp', 'tps']}, 03:45:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:45:02 INFO - 'tests': ['dromaeo_dom']}, 03:45:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:45:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:45:02 INFO - 'tests': ['basic_compositor_video']}, 03:45:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:45:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:45:02 INFO - 'tests': ['a11yr', 03:45:02 INFO - 'ts_paint', 03:45:02 INFO - 'tpaint', 03:45:02 INFO - 'sessionrestore', 03:45:02 INFO - 'sessionrestore_no_auto_restore', 03:45:02 INFO - 'tabpaint']}, 03:45:02 INFO - 'other-e10s': {'tests': ['a11yr', 03:45:02 INFO - 'ts_paint', 03:45:02 INFO - 'tpaint', 03:45:02 INFO - 'sessionrestore', 03:45:02 INFO - 'sessionrestore_no_auto_restore', 03:45:02 INFO - 'tabpaint']}, 03:45:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:45:02 INFO - 'ts_paint', 03:45:02 INFO - 'tpaint', 03:45:02 INFO - 'sessionrestore', 03:45:02 INFO - 'sessionrestore_no_auto_restore', 03:45:02 INFO - 'tabpaint']}, 03:45:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:45:02 INFO - 'ts_paint', 03:45:02 INFO - 'tpaint', 03:45:02 INFO - 'sessionrestore', 03:45:02 INFO - 'sessionrestore_no_auto_restore', 03:45:02 INFO - 'tabpaint']}, 03:45:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:45:02 INFO - 'tests': ['a11yr', 03:45:02 INFO - 'ts_paint', 03:45:02 INFO - 'tpaint', 03:45:02 INFO - 'sessionrestore', 03:45:02 INFO - 'sessionrestore_no_auto_restore', 03:45:02 INFO - 'tabpaint']}, 03:45:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:45:02 INFO - 'tests': ['a11yr', 03:45:02 INFO - 'ts_paint', 03:45:02 INFO - 'tpaint', 03:45:02 INFO - 'sessionrestore', 03:45:02 INFO - 'sessionrestore_no_auto_restore', 03:45:02 INFO - 'tabpaint']}, 03:45:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:45:02 INFO - 'tests': ['tsvgx', 03:45:02 INFO - 'tsvgr_opacity', 03:45:02 INFO - 'tart', 03:45:02 INFO - 'tscrollx', 03:45:02 INFO - 'cart']}, 03:45:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:45:02 INFO - 'tsvgr_opacity', 03:45:02 INFO - 'tart', 03:45:02 INFO - 'tscrollx', 03:45:02 INFO - 'cart']}, 03:45:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:02 INFO - 'talos_options': ['--disable-e10s'], 03:45:02 INFO - 'tests': ['tp5o']}, 03:45:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:02 INFO - 'tests': ['tp5o']}, 03:45:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:02 INFO - 'talos_options': ['--disable-e10s', 03:45:02 INFO - '--xperf_path', 03:45:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:45:02 INFO - 'tests': ['tp5n']}, 03:45:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:02 INFO - 'talos_options': ['--xperf_path', 03:45:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:45:02 INFO - 'tests': ['tp5n']}}, 03:45:02 INFO - 'talos.zip': {'path': '', 03:45:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:45:02 INFO - Running post-action listener: _resource_record_post_action 03:45:02 INFO - [mozharness: 2016-10-31 10:45:02.473481Z] Finished populate-webroot step (success) 03:45:02 INFO - [mozharness: 2016-10-31 10:45:02.473569Z] Running create-virtualenv step. 03:45:02 INFO - Running pre-action listener: _resource_record_pre_action 03:45:02 INFO - Running main action method: create_virtualenv 03:45:02 INFO - Creating virtualenv /builds/slave/test/build/venv 03:45:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:45:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:45:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:45:02 INFO - Using real prefix '/usr' 03:45:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:45:03 INFO - Installing distribute.............................................................................................................................................................................................done. 03:45:05 INFO - Installing pip.................done. 03:45:05 INFO - Return code: 0 03:45:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8089853f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', '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 03:45:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:45:05 INFO - Using env: {'DISPLAY': ':0', 03:45:05 INFO - 'HOME': '/home/cltbld', 03:45:05 INFO - 'LANG': 'en_US.UTF-8', 03:45:05 INFO - 'LANGUAGE': 'en_US:en', 03:45:05 INFO - 'LOGNAME': 'cltbld', 03:45:05 INFO - 'MAIL': '/var/mail/cltbld', 03:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:05 INFO - 'MOZ_NO_REMOTE': '1', 03:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:05 INFO - 'NO_EM_RESTART': '1', 03:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:05 INFO - 'PWD': '/builds/slave/test', 03:45:05 INFO - 'SHELL': '/bin/bash', 03:45:05 INFO - 'SHLVL': '1', 03:45:05 INFO - 'TERM': 'linux', 03:45:05 INFO - 'TMOUT': '86400', 03:45:05 INFO - 'USER': 'cltbld', 03:45:05 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', 03:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:05 INFO - '_': '/tools/buildbot/bin/python'} 03:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:45:05 INFO - Cleaning up... 03:45:05 INFO - Return code: 0 03:45:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8089853f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', '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 03:45:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:45:05 INFO - Using env: {'DISPLAY': ':0', 03:45:05 INFO - 'HOME': '/home/cltbld', 03:45:05 INFO - 'LANG': 'en_US.UTF-8', 03:45:05 INFO - 'LANGUAGE': 'en_US:en', 03:45:05 INFO - 'LOGNAME': 'cltbld', 03:45:05 INFO - 'MAIL': '/var/mail/cltbld', 03:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:05 INFO - 'MOZ_NO_REMOTE': '1', 03:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:05 INFO - 'NO_EM_RESTART': '1', 03:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:05 INFO - 'PWD': '/builds/slave/test', 03:45:05 INFO - 'SHELL': '/bin/bash', 03:45:05 INFO - 'SHLVL': '1', 03:45:05 INFO - 'TERM': 'linux', 03:45:05 INFO - 'TMOUT': '86400', 03:45:05 INFO - 'USER': 'cltbld', 03:45:05 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', 03:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:05 INFO - '_': '/tools/buildbot/bin/python'} 03:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:05 INFO - Downloading/unpacking psutil>=3.1.1 03:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:45:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:45:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:45:07 INFO - Installing collected packages: psutil 03:45:07 INFO - Running setup.py install for psutil 03:45:07 INFO - building 'psutil._psutil_linux' extension 03:45:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:45:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:45:07 INFO - building 'psutil._psutil_posix' extension 03:45:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:45:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:45:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:45:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:45:08 INFO - Successfully installed psutil 03:45:08 INFO - Cleaning up... 03:45:08 INFO - Return code: 0 03:45:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8089853f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', '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 03:45:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:45:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:45:08 INFO - Using env: {'DISPLAY': ':0', 03:45:08 INFO - 'HOME': '/home/cltbld', 03:45:08 INFO - 'LANG': 'en_US.UTF-8', 03:45:08 INFO - 'LANGUAGE': 'en_US:en', 03:45:08 INFO - 'LOGNAME': 'cltbld', 03:45:08 INFO - 'MAIL': '/var/mail/cltbld', 03:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:08 INFO - 'MOZ_NO_REMOTE': '1', 03:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:08 INFO - 'NO_EM_RESTART': '1', 03:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:08 INFO - 'PWD': '/builds/slave/test', 03:45:08 INFO - 'SHELL': '/bin/bash', 03:45:08 INFO - 'SHLVL': '1', 03:45:08 INFO - 'TERM': 'linux', 03:45:08 INFO - 'TMOUT': '86400', 03:45:08 INFO - 'USER': 'cltbld', 03:45:08 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', 03:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:08 INFO - '_': '/tools/buildbot/bin/python'} 03:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:45:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:45:11 INFO - Installing collected packages: mozsystemmonitor 03:45:11 INFO - Running setup.py install for mozsystemmonitor 03:45:11 INFO - Successfully installed mozsystemmonitor 03:45:11 INFO - Cleaning up... 03:45:11 INFO - Return code: 0 03:45:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:45:11 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')]} 03:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:11 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')]} 03:45:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:11 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 0x7f8089853f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', '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 03:45:11 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 03:45:11 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 03:45:11 INFO - Using env: {'DISPLAY': ':0', 03:45:11 INFO - 'HOME': '/home/cltbld', 03:45:11 INFO - 'LANG': 'en_US.UTF-8', 03:45:11 INFO - 'LANGUAGE': 'en_US:en', 03:45:11 INFO - 'LOGNAME': 'cltbld', 03:45:11 INFO - 'MAIL': '/var/mail/cltbld', 03:45:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:11 INFO - 'MOZ_NO_REMOTE': '1', 03:45:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:11 INFO - 'NO_EM_RESTART': '1', 03:45:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:11 INFO - 'PWD': '/builds/slave/test', 03:45:11 INFO - 'SHELL': '/bin/bash', 03:45:11 INFO - 'SHLVL': '1', 03:45:11 INFO - 'TERM': 'linux', 03:45:11 INFO - 'TMOUT': '86400', 03:45:11 INFO - 'USER': 'cltbld', 03:45:11 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', 03:45:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:11 INFO - '_': '/tools/buildbot/bin/python'} 03:45:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:11 INFO - Downloading/unpacking jsonschema==2.5.1 03:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:45:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:13 INFO - Downloading functools32-3.2.3-2.tar.gz 03:45:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:45:13 INFO - warning: no files found matching '*.txt' 03:45:13 INFO - no previously-included directories found matching 'build' 03:45:13 INFO - no previously-included directories found matching 'dist' 03:45:13 INFO - no previously-included directories found matching '.git*' 03:45:13 INFO - Installing collected packages: jsonschema, functools32 03:45:13 INFO - Running setup.py install for functools32 03:45:13 INFO - warning: no files found matching '*.txt' 03:45:13 INFO - no previously-included directories found matching 'build' 03:45:13 INFO - no previously-included directories found matching 'dist' 03:45:13 INFO - no previously-included directories found matching '.git*' 03:45:13 INFO - Successfully installed jsonschema functools32 03:45:13 INFO - Cleaning up... 03:45:14 INFO - Return code: 0 03:45:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8089853f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', '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 03:45:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:45:14 INFO - Using env: {'DISPLAY': ':0', 03:45:14 INFO - 'HOME': '/home/cltbld', 03:45:14 INFO - 'LANG': 'en_US.UTF-8', 03:45:14 INFO - 'LANGUAGE': 'en_US:en', 03:45:14 INFO - 'LOGNAME': 'cltbld', 03:45:14 INFO - 'MAIL': '/var/mail/cltbld', 03:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:14 INFO - 'MOZ_NO_REMOTE': '1', 03:45:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:14 INFO - 'NO_EM_RESTART': '1', 03:45:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:14 INFO - 'PWD': '/builds/slave/test', 03:45:14 INFO - 'SHELL': '/bin/bash', 03:45:14 INFO - 'SHLVL': '1', 03:45:14 INFO - 'TERM': 'linux', 03:45:14 INFO - 'TMOUT': '86400', 03:45:14 INFO - 'USER': 'cltbld', 03:45:14 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', 03:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:14 INFO - '_': '/tools/buildbot/bin/python'} 03:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:45:14 INFO - Cleaning up... 03:45:14 INFO - Return code: 0 03:45:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8089853f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', '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 03:45:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:45:14 INFO - Using env: {'DISPLAY': ':0', 03:45:14 INFO - 'HOME': '/home/cltbld', 03:45:14 INFO - 'LANG': 'en_US.UTF-8', 03:45:14 INFO - 'LANGUAGE': 'en_US:en', 03:45:14 INFO - 'LOGNAME': 'cltbld', 03:45:14 INFO - 'MAIL': '/var/mail/cltbld', 03:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:14 INFO - 'MOZ_NO_REMOTE': '1', 03:45:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:14 INFO - 'NO_EM_RESTART': '1', 03:45:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:14 INFO - 'PWD': '/builds/slave/test', 03:45:14 INFO - 'SHELL': '/bin/bash', 03:45:14 INFO - 'SHLVL': '1', 03:45:14 INFO - 'TERM': 'linux', 03:45:14 INFO - 'TMOUT': '86400', 03:45:14 INFO - 'USER': 'cltbld', 03:45:14 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', 03:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:14 INFO - '_': '/tools/buildbot/bin/python'} 03:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:14 INFO - Downloading/unpacking blobuploader==1.2.4 03:45:14 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 03:45:14 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 03:45:14 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 03:45:14 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 03:45:14 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 03:45:14 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 03:45:16 INFO - Downloading blobuploader-1.2.4.tar.gz 03:45:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:45:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:45:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:17 INFO - Downloading docopt-0.6.1.tar.gz 03:45:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:45:17 INFO - Installing collected packages: blobuploader, requests, docopt 03:45:17 INFO - Running setup.py install for blobuploader 03:45:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:45:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:45:17 INFO - Running setup.py install for requests 03:45:17 INFO - Running setup.py install for docopt 03:45:17 INFO - Successfully installed blobuploader requests docopt 03:45:17 INFO - Cleaning up... 03:45:17 INFO - Return code: 0 03:45:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:17 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')]} 03:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:17 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')]} 03:45:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:17 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 0x7f8089853f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', '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 03:45:17 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 03:45:17 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 03:45:17 INFO - Using env: {'DISPLAY': ':0', 03:45:17 INFO - 'HOME': '/home/cltbld', 03:45:17 INFO - 'LANG': 'en_US.UTF-8', 03:45:17 INFO - 'LANGUAGE': 'en_US:en', 03:45:17 INFO - 'LOGNAME': 'cltbld', 03:45:17 INFO - 'MAIL': '/var/mail/cltbld', 03:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:17 INFO - 'MOZ_NO_REMOTE': '1', 03:45:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:17 INFO - 'NO_EM_RESTART': '1', 03:45:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:17 INFO - 'PWD': '/builds/slave/test', 03:45:17 INFO - 'SHELL': '/bin/bash', 03:45:17 INFO - 'SHLVL': '1', 03:45:17 INFO - 'TERM': 'linux', 03:45:17 INFO - 'TMOUT': '86400', 03:45:17 INFO - 'USER': 'cltbld', 03:45:17 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', 03:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:17 INFO - '_': '/tools/buildbot/bin/python'} 03:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:45:17 INFO - Running setup.py (path:/tmp/pip-94oDDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:45:18 INFO - Running setup.py (path:/tmp/pip-WP7dGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:45:18 INFO - Running setup.py (path:/tmp/pip-tQ_3K2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:45:18 INFO - Running setup.py (path:/tmp/pip-RZ6aDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:45:18 INFO - Running setup.py (path:/tmp/pip-RtLZAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:45:18 INFO - Running setup.py (path:/tmp/pip-7n71VC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:45:18 INFO - Running setup.py (path:/tmp/pip-5r7GWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:45:18 INFO - Running setup.py (path:/tmp/pip-XOgyb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:45:18 INFO - Running setup.py (path:/tmp/pip-uCZwiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:45:18 INFO - Running setup.py (path:/tmp/pip-amBscM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:45:18 INFO - Running setup.py (path:/tmp/pip-hM9CKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:45:18 INFO - Running setup.py (path:/tmp/pip-P_rGdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:45:18 INFO - Running setup.py (path:/tmp/pip-IVoLMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:45:18 INFO - Running setup.py (path:/tmp/pip-jVX8Oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:18 INFO - Running setup.py (path:/tmp/pip-GOUrZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:45:19 INFO - Running setup.py (path:/tmp/pip-RkKRjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:45:19 INFO - Running setup.py (path:/tmp/pip-yZP2R5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:45:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:45:19 INFO - Running setup.py install for manifestparser 03:45:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:45:19 INFO - Running setup.py install for mozcrash 03:45:19 INFO - Running setup.py install for mozdebug 03:45:19 INFO - Running setup.py install for mozdevice 03:45:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:45:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:45:19 INFO - Running setup.py install for mozfile 03:45:19 INFO - Running setup.py install for mozhttpd 03:45:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:45:19 INFO - Running setup.py install for mozinfo 03:45:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:45:19 INFO - Running setup.py install for mozInstall 03:45:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:45:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:45:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:45:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:45:20 INFO - Running setup.py install for mozleak 03:45:20 INFO - Running setup.py install for mozlog 03:45:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:45:20 INFO - Running setup.py install for moznetwork 03:45:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:45:20 INFO - Running setup.py install for mozprocess 03:45:20 INFO - Running setup.py install for mozprofile 03:45:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:45:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:45:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:45:20 INFO - Running setup.py install for mozrunner 03:45:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:45:20 INFO - Running setup.py install for mozscreenshot 03:45:20 INFO - Running setup.py install for moztest 03:45:20 INFO - Running setup.py install for mozversion 03:45:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:45:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:45:20 INFO - Cleaning up... 03:45:21 INFO - Return code: 0 03:45:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45: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')]} 03:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45: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')]} 03:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:21 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 0x7f8089853f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', '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 03:45:21 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 03:45:21 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 03:45:21 INFO - Using env: {'DISPLAY': ':0', 03:45:21 INFO - 'HOME': '/home/cltbld', 03:45:21 INFO - 'LANG': 'en_US.UTF-8', 03:45:21 INFO - 'LANGUAGE': 'en_US:en', 03:45:21 INFO - 'LOGNAME': 'cltbld', 03:45:21 INFO - 'MAIL': '/var/mail/cltbld', 03:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:21 INFO - 'MOZ_NO_REMOTE': '1', 03:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:21 INFO - 'NO_EM_RESTART': '1', 03:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:21 INFO - 'PWD': '/builds/slave/test', 03:45:21 INFO - 'SHELL': '/bin/bash', 03:45:21 INFO - 'SHLVL': '1', 03:45:21 INFO - 'TERM': 'linux', 03:45:21 INFO - 'TMOUT': '86400', 03:45:21 INFO - 'USER': 'cltbld', 03:45:21 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', 03:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:21 INFO - '_': '/tools/buildbot/bin/python'} 03:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:45:21 INFO - Running setup.py (path:/tmp/pip-d4W5jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:45:21 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)) 03:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:45:21 INFO - Running setup.py (path:/tmp/pip-77HStz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:45:21 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)) 03:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:45:21 INFO - Running setup.py (path:/tmp/pip-SWjiqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:45:21 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)) 03:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:45:21 INFO - Running setup.py (path:/tmp/pip-CUWJ12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:45:21 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)) 03:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:45:21 INFO - Running setup.py (path:/tmp/pip-tPS9wU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:45:21 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)) 03:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:45:21 INFO - Running setup.py (path:/tmp/pip-AoQz2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:45:21 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)) 03:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:45:21 INFO - Running setup.py (path:/tmp/pip-9V14f7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:45:21 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)) 03:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:45:21 INFO - Running setup.py (path:/tmp/pip-7dXNMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:45:21 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)) 03:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:45:21 INFO - Running setup.py (path:/tmp/pip-S67BLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:45:21 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)) 03:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:45:21 INFO - Running setup.py (path:/tmp/pip-UaqV8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:45:21 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)) 03:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:45:21 INFO - Running setup.py (path:/tmp/pip-yJt7hA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:45:22 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)) 03:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:45:22 INFO - Running setup.py (path:/tmp/pip-uTmwJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:45:22 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)) 03:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:45:22 INFO - Running setup.py (path:/tmp/pip-w9v8cT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:45:22 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)) 03:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:45:22 INFO - Running setup.py (path:/tmp/pip-VnnTQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:45:22 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)) 03:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:22 INFO - Running setup.py (path:/tmp/pip-3q08Vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:22 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)) 03:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:45:22 INFO - Running setup.py (path:/tmp/pip-ECwpPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:45:22 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)) 03:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:45:22 INFO - Running setup.py (path:/tmp/pip-F_Ywy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:45:22 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)) 03:45:22 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)) 03:45:22 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)) 03:45:22 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)) 03:45:22 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)) 03:45:22 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)) 03:45:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:24 INFO - Downloading blessings-1.6.tar.gz 03:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:45:24 INFO - Installing collected packages: blessings 03:45:24 INFO - Running setup.py install for blessings 03:45:24 INFO - Successfully installed blessings 03:45:24 INFO - Cleaning up... 03:45:24 INFO - Return code: 0 03:45:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:45:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:45:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:45:24 INFO - Reading from file tmpfile_stdout 03:45:24 INFO - Current package versions: 03:45:24 INFO - argparse == 1.2.1 03:45:24 INFO - blessings == 1.6 03:45:24 INFO - blobuploader == 1.2.4 03:45:24 INFO - docopt == 0.6.1 03:45:24 INFO - functools32 == 3.2.3-2 03:45:24 INFO - jsonschema == 2.5.1 03:45:24 INFO - manifestparser == 1.1 03:45:24 INFO - mozInstall == 1.12 03:45:24 INFO - mozcrash == 0.17 03:45:24 INFO - mozdebug == 0.1 03:45:24 INFO - mozdevice == 0.48 03:45:24 INFO - mozfile == 1.2 03:45:24 INFO - mozhttpd == 0.7 03:45:24 INFO - mozinfo == 0.9 03:45:24 INFO - mozleak == 0.1 03:45:24 INFO - mozlog == 3.4 03:45:24 INFO - moznetwork == 0.27 03:45:24 INFO - mozprocess == 0.23 03:45:24 INFO - mozprofile == 0.28 03:45:24 INFO - mozrunner == 6.12 03:45:24 INFO - mozscreenshot == 0.1 03:45:24 INFO - mozsystemmonitor == 0.3 03:45:24 INFO - moztest == 0.7 03:45:24 INFO - mozversion == 1.4 03:45:24 INFO - psutil == 3.1.1 03:45:24 INFO - requests == 1.2.3 03:45:24 INFO - wsgiref == 0.1.2 03:45:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:24 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 0x7f8089853f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', '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 03:45:24 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 03:45:24 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 03:45:24 INFO - Using env: {'DISPLAY': ':0', 03:45:24 INFO - 'HOME': '/home/cltbld', 03:45:24 INFO - 'LANG': 'en_US.UTF-8', 03:45:24 INFO - 'LANGUAGE': 'en_US:en', 03:45:24 INFO - 'LOGNAME': 'cltbld', 03:45:24 INFO - 'MAIL': '/var/mail/cltbld', 03:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:24 INFO - 'MOZ_NO_REMOTE': '1', 03:45:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:24 INFO - 'NO_EM_RESTART': '1', 03:45:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:24 INFO - 'PWD': '/builds/slave/test', 03:45:24 INFO - 'SHELL': '/bin/bash', 03:45:24 INFO - 'SHLVL': '1', 03:45:24 INFO - 'TERM': 'linux', 03:45:24 INFO - 'TMOUT': '86400', 03:45:24 INFO - 'USER': 'cltbld', 03:45:24 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', 03:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:24 INFO - '_': '/tools/buildbot/bin/python'} 03:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:25 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)) 03:45:25 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)) 03:45:25 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)) 03:45:25 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)) 03:45:25 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)) 03:45:25 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)) 03:45:25 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)) 03:45:25 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)) 03:45:25 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)) 03:45:25 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)) 03:45:25 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)) 03:45:25 INFO - Cleaning up... 03:45:25 INFO - Return code: 0 03:45:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:45:25 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')]} 03:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:25 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')]} 03:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:25 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 0x7f8089853f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d55ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', '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 03:45:25 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 03:45:25 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 03:45:25 INFO - Using env: {'DISPLAY': ':0', 03:45:25 INFO - 'HOME': '/home/cltbld', 03:45:25 INFO - 'LANG': 'en_US.UTF-8', 03:45:25 INFO - 'LANGUAGE': 'en_US:en', 03:45:25 INFO - 'LOGNAME': 'cltbld', 03:45:25 INFO - 'MAIL': '/var/mail/cltbld', 03:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:25 INFO - 'MOZ_NO_REMOTE': '1', 03:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:25 INFO - 'NO_EM_RESTART': '1', 03:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:25 INFO - 'PWD': '/builds/slave/test', 03:45:25 INFO - 'SHELL': '/bin/bash', 03:45:25 INFO - 'SHLVL': '1', 03:45:25 INFO - 'TERM': 'linux', 03:45:25 INFO - 'TMOUT': '86400', 03:45:25 INFO - 'USER': 'cltbld', 03:45:25 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', 03:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:25 INFO - '_': '/tools/buildbot/bin/python'} 03:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:45:25 INFO - Cleaning up... 03:45:25 INFO - Return code: 0 03:45:25 INFO - Running post-action listener: _resource_record_post_action 03:45:25 INFO - Running post-action listener: _start_resource_monitoring 03:45:25 INFO - Starting resource monitoring. 03:45:25 INFO - [mozharness: 2016-10-31 10:45:25.351193Z] Finished create-virtualenv step (success) 03:45:25 INFO - [mozharness: 2016-10-31 10:45:25.351759Z] Running install step. 03:45:25 INFO - Running pre-action listener: _resource_record_pre_action 03:45:25 INFO - Running main action method: install 03:45:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:45:25 INFO - Reading from file tmpfile_stdout 03:45:25 INFO - Detecting whether we're running mozinstall >=1.0... 03:45:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:45:25 INFO - Reading from file tmpfile_stdout 03:45:25 INFO - Output received: 03:45:25 INFO - Usage: mozinstall [options] installer 03:45:25 INFO - Options: 03:45:25 INFO - -h, --help show this help message and exit 03:45:25 INFO - -d DEST, --destination=DEST 03:45:25 INFO - Directory to install application into. [default: 03:45:25 INFO - "/builds/slave/test"] 03:45:25 INFO - --app=APP Application being installed. [default: firefox] 03:45:25 INFO - mkdir: /builds/slave/test/build/application 03:45:25 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'] 03:45:25 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 03:45:41 INFO - Reading from file tmpfile_stdout 03:45:41 INFO - Output received: 03:45:41 INFO - /builds/slave/test/build/application/firefox/firefox 03:45:41 INFO - Running post-action listener: _resource_record_post_action 03:45:41 INFO - [mozharness: 2016-10-31 10:45:41.606167Z] Finished install step (success) 03:45:41 INFO - [mozharness: 2016-10-31 10:45:41.606409Z] Running run-tests step. 03:45:41 INFO - Running pre-action listener: _resource_record_pre_action 03:45:41 INFO - Running main action method: run_tests 03:45:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:45:41 INFO - Python 2.7.3 03:45:41 INFO - Return code: 0 03:45:41 INFO - grabbing minidump binary from tooltool 03:45:41 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')]} 03:45:41 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 0x1d52f60>, '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 0x1d53d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d541d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:45:41 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 03:45:41 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 03:45:41 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 03:45:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:45:41 INFO - Return code: 0 03:45:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:45:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:45:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:45:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:45:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:45:41 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/E9mDJZOyS7yzO1kGwwYvrA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 03:45:41 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/E9mDJZOyS7yzO1kGwwYvrA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 03:45:41 INFO - Using env: {'DISPLAY': ':0', 03:45:41 INFO - 'HOME': '/home/cltbld', 03:45:41 INFO - 'LANG': 'en_US.UTF-8', 03:45:41 INFO - 'LANGUAGE': 'en_US:en', 03:45:41 INFO - 'LOGNAME': 'cltbld', 03:45:41 INFO - 'MAIL': '/var/mail/cltbld', 03:45:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:45:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:41 INFO - 'MOZ_NO_REMOTE': '1', 03:45:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:41 INFO - 'NO_EM_RESTART': '1', 03:45:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:41 INFO - 'PWD': '/builds/slave/test', 03:45:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:45:41 INFO - 'SHELL': '/bin/bash', 03:45:41 INFO - 'SHLVL': '1', 03:45:41 INFO - 'TERM': 'linux', 03:45:41 INFO - 'TMOUT': '86400', 03:45:41 INFO - 'USER': 'cltbld', 03:45:41 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470', 03:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:41 INFO - '_': '/tools/buildbot/bin/python'} 03:45:41 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/E9mDJZOyS7yzO1kGwwYvrA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 03:45:41 INFO - mozversion application_buildid: 20161031004002 03:45:41 INFO - mozversion application_changeset: b7070c905172e3ead8ee610fff35f86bf9ff9c42 03:45:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:45:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:45:41 INFO - mozversion application_name: Firefox 03:45:41 INFO - mozversion application_remotingname: firefox-dev 03:45:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:45:41 INFO - mozversion application_vendor: Mozilla 03:45:41 INFO - mozversion application_version: 51.0a2 03:45:41 INFO - mozversion platform_buildid: 20161031004002 03:45:41 INFO - mozversion platform_changeset: b7070c905172e3ead8ee610fff35f86bf9ff9c42 03:45:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:45:41 INFO - mozversion platform_version: 51.0a2 03:45:41 INFO - using testdate: 1477910741 03:45:41 INFO - actual date: 1477910741 03:45:41 INFO - starting webserver on 'localhost:33312' 03:45:41 INFO - SUITE-START | Running 2 tests 03:45:41 INFO - TEST-START | dromaeo_css 03:45:41 INFO - operating with platform_type : linux_ 03:45:41 INFO - Initialising browser for dromaeo_css test... 03:45:41 INFO - TEST-INFO | started process 4606 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzfsIxv/profile http://localhost:33312/getInfo.html) 03:45:46 INFO - PROCESS | 4606 | __metrics Screen width/height:1600/1200 03:45:46 INFO - PROCESS | 4606 | colorDepth:24 03:45:46 INFO - PROCESS | 4606 | Browser inner width/height: 1024/697 03:45:46 INFO - PROCESS | 4606 | __metrics 03:45:46 INFO - PROCESS | 4606 | 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" 03:45:46 INFO - PROCESS | 4606 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:45:47 INFO - PROCESS | 4606 | console.error: PushService: 03:45:47 INFO - PROCESS | 4606 | stateChangeProcessEnqueue: Error transitioning state 03:45:47 INFO - PROCESS | 4606 | UnknownError 03:45:47 INFO - TEST-INFO | 4606: exit 0 03:45:47 INFO - Browser initialized. 03:45:47 INFO - Running cycle 1/1 for dromaeo_css test... 03:45:47 INFO - TEST-INFO | started process 4698 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzfsIxv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:59 INFO - PROCESS | 4698 | RSS: Main: 144355328 03:45:59 INFO - PROCESS | 4698 | 03:46:50 INFO - PROCESS | 4698 | 1477910810791 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] 03:48:59 INFO - PROCESS | 4698 | Cycle 1(1): loaded http://localhost:33312/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33312/tests/dromaeo/cssquery-ext.html) 03:49:01 INFO - PROCESS | 4698 | RSS: Main: 228089856 03:49:01 INFO - PROCESS | 4698 | 03:52:03 INFO - PROCESS | 4698 | Cycle 1(1): loaded http://localhost:33312/tests/dromaeo/cssquery-ext.html (next: http://localhost:33312/tests/dromaeo/cssquery-jquery.html) 03:52:03 INFO - PROCESS | 4698 | RSS: Main: 231247872 03:52:03 INFO - PROCESS | 4698 | 03:55:05 INFO - PROCESS | 4698 | Cycle 1(1): loaded http://localhost:33312/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33312/tests/dromaeo/cssquery-mootools.html) 03:55:06 INFO - PROCESS | 4698 | RSS: Main: 174592000 03:55:06 INFO - PROCESS | 4698 | 03:58:08 INFO - PROCESS | 4698 | Cycle 1(1): loaded http://localhost:33312/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33312/tests/dromaeo/cssquery-prototype.html) 03:58:08 INFO - PROCESS | 4698 | RSS: Main: 226394112 03:58:08 INFO - PROCESS | 4698 | 04:01:11 INFO - PROCESS | 4698 | Cycle 1(1): loaded http://localhost:33312/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33312/tests/dromaeo/cssquery-yui.html) 04:01:12 INFO - PROCESS | 4698 | RSS: Main: 175607808 04:01:12 INFO - PROCESS | 4698 | 04:04:14 INFO - PROCESS | 4698 | Cycle 1(1): loaded http://localhost:33312/tests/dromaeo/cssquery-yui.html (next: http://localhost:33312/tests/dromaeo/cssquery-dojo.html) 04:04:14 INFO - PROCESS | 4698 | RSS: Main: 264474624 04:04:14 INFO - PROCESS | 4698 | 04:04:14 INFO - PROCESS | 4698 | __start_tp_report 04:04:14 INFO - PROCESS | 4698 | _x_x_mozilla_page_load 04:04:14 INFO - PROCESS | 4698 | _x_x_mozilla_page_load_details 04:04:14 INFO - PROCESS | 4698 | |i|pagename|runs| 04:04:14 INFO - PROCESS | 4698 | |0;dojo.html;3168.4930411134214;3208.839558022098;3216.485362342026;3231.8384080795954;3246.3020450603117;5630.436956304373;5699.373068962411;5705.629134106291;5733.369329373765;5742.368339482654;5635.746391412386;5679.233303504026;5689.687067211312;5690.345610254822;5737.598368114233;5127.230915362688;5130.769115389817;5154.433012368637;5178.378594568657;5232.764525596338;5046.520580544842;5215.713135777531;5228.816991405301;5240.816571420001;5266.210068489719;5031.371078615173;5097.923531147036;5102.260172275037;5142.6914385137015;5170.327857378536;5137.897242055156;5162.406323272815;5166.250893620441;5225.137852254374;5225.895482090375;5075.746212689388;5127.1796512558185;5183.870403239912;5192.454792246797;5220.895582088375;5516.034693928546;5535.446455354472;5612.102063669793;5613.663180209201;5622.971885140548;6060;6071.696415179224;6079.300880398722;6082.148499210114;6087.05650624154;6103.084537319393;6117.847053823645;6127.4791642710425;6129.724162412702;6130.325664176937;5491.258680078178;5540.584456165804;5660.150977353348;5684.573656975661;5692.260006199209;6281.528885333618;6287.056941458818;6292.056191571301;6294.685265736694;6298.496120310364;6021.307549631761;6030.095485677183;6037.72830222641;6040.365761595057;6040.848978775566;5891.204687367151;5941.049432090845;5993.160957465958;6067.969660151671;6140.785072522441;5866.70666466675;5965.045592705146;5966.582339236299;6003.099535069687;6011.849703757441;5968.8806223876145;5970.5223582114195;5971.820845374646;5972.940270597239;6005.6997150142315;4537.047220083819;4545.250033744462;4614.330922016289;4615.2384856498975;4622.815087396534;4094.9590504094576;4116;4134.503859536875;4142.544320124784;4172.3532852407925;5764.365919748824;5772.134179872969;5772.336181339199;5782.2483077199695;5789.88420231593;5937.2578427696535;6083.300420451616;6130.754769809158;6131.294901086343;6135.263768347827;5602.187682785973;5615.129654903497;5641.153826925994;5656;5720.685362305113;5207.6875387476875;5209.322788037531;5210.374755029345;5217.060929032735;5249.947500525022;6149.661768602769;6202.875942481125;6207.751689932443;6215.689215539295;6223.751049958041;5923.644581325134;5995.490383317292;6024.246969128859;6042.577019608585;6069.119977603134;6275.058741188858;6326.778562750282;6327.4305312520255;6332.366763323631;6350.555461117678;6033.879322413615;6037.245344331958;6039.607425517327;6040.395960403925;6051.788187413419;5859.824205273849;5903.91144132847;6106.297775755845;6136.753076119853;6144.525313924537;5947.583669143119;5963.403659634002;5989.341172470938;6050.394960503914;6072.696365181811;6009;6017.909731353946;6021;6021.337652858269;6023.638581684938;5669.6314739541795;5952.315483719428;6003.339632640319;6018.969905150446;6022.488088512526;5767.365589785204;5924.229850119457;5945.078512830518;5988.940110598838;6072;5874.412558744091;5888.852778680567;5899.262592175978;5913.408659134224;5915.40845915405 04:04:14 INFO - PROCESS | 4698 | |1;ext.html;592.6769910398835;625.1029772276784;629.4209327418771;641.4259237982005;651.1437459740438;34723.13192170194;47099.52900470994;48066.75966620162;48181.759091204585;48206;49590;50007.24989125166;50064.49935500644;50072.49927500724;50102.74948625261;8498.830023399529;9296.116868897443;9450.85823712645;9452.621895124186;9455.196308313802;8515.23362897339;8787.956060219722;8789.033206347329;10846.566137354497;11168.720781980433;11361.091112710963;11412.942935285311;11419.714507137347;11432.314061156358;11442.084633229364;11272.210945233837;11292.20954533183;11319.377434241114;11350.262232954832;11362.943185284063;11068.059214966737;11131.944340278327;11136.220464567483;11138.053265472445;11142.665720028332;45839;45874;46091.76954115242;46369.53630463719;46426.76786616079;3817.828783687808;3847.0190101524213;3904.7461914975434;3926.8625598104213;4301.161273551658;34724;34763.65236347629;35046.82476587626;35092.12269693253;36032.81983590092;4580.519045500241;4641.559051890065;4656.860294191146;4728.598069164125;4758.381410416659;401478;402576;405796;406767;406986;39236.80381598074;40173.39739903904;40366.79816600898;42039.78980105141;62625;41197.176056478704;41375.586244137776;41432;41468.58531414707;41477;16863.15684215784;17058;17059.744103838453;17064.829351706572;17076.402325918534;14144.151350918977;14233.28833558318;14244;14245.572632820824;14419.42322307117;8924.330675199386;9066.320025997944;9098.954505227432;9341.766455838659;9668.75828104289;3574.249407624428;3624.619414961391;3640.7997560133917;3641.362761516724;3684.7604905681583;1089.9073578745738;1095.5782023920688;1095.7917995580815;1103.8951299626522;1126.1778901401858;33544.66455335464;33623.663763362056;33955.32089358199;34100.82949585286;34757.65242347544;1153.5558809858096;1169.4328250798355;1173.501261963662;1180.451090243041;1193.5762804204555;17361.913190433967;18059.54851128732;18324.725129123075;18331;18425.355112570996;638736;642489;643005.1398971995;643198;644069;62515;62658;63159;63237.36762632407;63320;1414.1444426122048;1414.1868425655289;1438.1443041390564;1444.9205293708947;1451.332387101945;31954.840225799653;33749.493757594144;34083.31833363369;34108;34217.21433535134;55052.449475504734;55162.17256741232;55583.44416555783;55713.72143139259;55721.721391392784;487145;487884;488307;490191;490833;27677.861610692624;28241.43517129605;31538.526922095727;31961.360772783948;31977;49945.500544995535;52414.47585524096;53901.19148212702;57220;57416.71291643515;44247.557524424345;44990;45051;45717.314240285756;45774;44373.33439998467;44683;45109;45571.08857822759;45668.77165614151;43830;44598;44823;44921;45045.32432013588;36461.27077458489;39086.78627082687;39627.2074558513;39953.80023099866;40111;29757.404851902407;29903.100967010298;29946;30140.84929575338;30196 04:04:14 INFO - PROCESS | 4698 | |2;jquery.html;397.59066008973025;429.5949743272866;432.2996745272659;438.7871882137163;441.90940857124275;16857;20195.39413817586;20230.190792368307;20750.27374041909;21734.89132554335;19982.100805463753;20135.49661258469;20141.395758127244;20148.395548133543;20362.287319943767;5868.559858010645;5889.646621202731;6053.697315134248;6087.086936959469;6094.390560943914;5953.136795164699;6014.789482368118;6032.758689652409;6047.244094488189;6061.818145455622;5879.617824841393;5989.730462129193;5998.28020637522;6002.939970600281;6010.248718910137;5807.941920580783;5971.850703732398;5997.130416089664;6002.249718785152;6003.30961939376;5389.78440862365;5402.297701298845;5406.459354064601;5412.9458705412835;5414.7834086636485;23762.524749505086;24088;24315.270541883772;24374.146904858244;24788.50422991548;2501.9888623707275;2578.084779903145;2580.7032191298053;2581.4707984863057;3204.5513628092085;14358.138511689333;15381.230938453033;15396;15795.921020394939;16075.276612552463;1805.5937414081857;1873.9437816865516;1941.5825597496605;2001.2278686576674;2067.700183473403;61212.69393653048;76225.61887190584;76869.61565192194;89057;90389;11161.720956975978;11262.831057534144;11306;11419.657410277705;11634.418279086012;15409.229538523028;15548.067115973077;15593.376264949502;15755.842441575438;15884.205789710468;8613.22480976715;8853.46879187238;8924;9056.184943354998;9072.637094516278;8874.423162494417;8900.554972251492;8912.910870891337;9110.772230694152;9127.817443651222;6927;6968.233494315723;7031.718731250795;7064.7527336544;7085.362317391459;1961.744973153481;2001.4896201468532;2034.9287774927807;2037.3582321568658;2056.5578400643935;970.3013830042358;1021.8824835143905;1079.3038490173794;1103.5089385223498;1103.536514663843;20877.798521321056;21237.787622123582;21475.892620536797;21488.57022859534;21531.892340538197;1013.9087482126644;1045.8901815309434;1084.7559299157626;1116.268843907242;1121.545773961547;11131.944340278247;12079.27524348542;12148.757024859453;12252.877471225353;12371.938140309241;391597;395328;395677;555212;555372;90145.54927225322;101517.49241253747;104611.47694261633;106854;108247.45876270726;1066.3814987307499;1074.3714926767927;1099.1536516881956;1104.6962085426571;1123.1239633086207;18021.189046492676;18403.815961840744;18435;18641.53396165107;18917.337893173673;40354;43332;43357.56642433535;43614.78192609017;44746.77626611846;55762.44237557572;61638.69180654068;63220.36779632145;63762;63863.68068159629;8618.224359807647;8749.343799215212;8794;8851.424657397249;9000.954995225244;12949.287789171685;13685.863141368856;13738.862611374157;13883.375248113656;14014.299285035911;11166;11406.885931140583;11589;11628.883711163118;11764.470598823245;11228.270162439416;11643;11781.705457363634;11984;12102.878971210528;11588;11626;11763.353015583883;11967.854363011655;12073.335966521925;8444.619992100494;8601.698940537051;8632.482051076955;8786.604602792762;8872.24585910205;11656.125790565911;11863.881361186623;11945.581904633296;11978.880211197777;12310.384480775747 04:04:14 INFO - PROCESS | 4698 | |3;mootools.html;1437.4250299880052;1536.7003434330306;1560.54744124204;1728.135932033983;1871.1860340751766;8758.824823503526;9457.196138328241;9738.415695058302;9745.56144973477;9929.851052234222;9697.175740062103;9754.707358779231;9782;9785.07041831025;9791.755206119851;2562.3722188063903;2565.525377805103;2586.3921978335075;2594.714581396045;2596.298999270196;2463.938401539967;2557.271177714352;2558.2069558436942;2561.3852675357966;2567.550678631241;2516.245126462063;2521.420073383123;2558.334832943439;2560.3087166465043;2562.500312439075;2394.078279862248;2404.4589967257316;2413.879306034691;2452.31335226137;2459.4712136890475;2341.157183413987;2368.27767530903;2392.6411038344386;2393.5093305872256;2415.553122672311;9573.946865844751;9659.517024148834;9710.17463515602;9731.902680973171;9864.210863130933;5805.854853628651;5945.108233764927;5957.106434034886;5957.791477298317;5960.374160713106;3607.9512811674094;3698.2048859495067;3703.7962912039825;3802.258559580883;3809.3904975204114;1215.1615385384057;1227.0858210633046;1274.4838340472124;1276.1258537901567;1304.2956803326192;13688.247146406944;13958.860411395857;13972.091814032157;13975;13985.79021314681;4888.877778055577;4904.509549045067;4973.154563724175;5056.873578160502;5101.183810590288;10938.234323597271;10955;10958.068564172134;10963.287386319864;10964;5780.653160810365;5800.622959507618;5807.448292412214;5808.970955145197;5812.534997200299;4742.288656701522;4768.976155119271;5117.8720531987;5170.793168273227;5420.891582168335;4114.629683328515;4179.874603761892;4188.85339013133;4298.742075475419;4371.366151907955;1225.0154749306182;1288.8195652608642;1297.0531511996296;1297.9610611681665;1306.046585992231;739.7226040234912;956.6173530587821;1013.4020927652721;1052.7841792432532;1055.4775386183887;6466.773662921775;6521.706523206467;6554.672266386661;6706.5640733352175;6729.22613899398;524.4519477146315;531.1634176172544;535.4458135829476;544.5099410530476;662.1689779327011;4416.911661766747;4592.816287348469;4625.884352891205;4656.930146047812;4694.577488026026;12145.63563093091;12731.745365092831;12771;12773.489060437665;12774.041946853837;11607.709807254887;12673.92271656901;12684.619461416172;12697.174683645533;12701.174423662433;8490.490570565786;8889.73330800077;8903.510306933182;8904.73285801427;8908.06465321145;6477.838054048498;6508.479321654161;6585.506087043395;6763.12079429671;6786.59280443175;10917.39954302521;11295.887041129483;11484.310941343547;11544.884551154717;11568.537258509901;11385.146114041645;11655.475503602189;11659.650210493699;11731.41342932867;11784.82322765142;8275.917240827755;8651.134886511298;8686.261667758059;8783.209511144029;8791.252743516618;9400.388974716621;9500.524973751146;9576.856347154659;9595.184409325006;9602.807943840944;8456.40805143634;8496.192861678132;8526.872096918427;8626.309895208242;8699.521526316114;8023.237792409712;8047.1550487198;8202.917970820454;8285.130061343472;8346.582670866554;7671.1561728208735;7684.231576842495;7728.7681369559;7744.65149068282;7764.572948487661;5406.7296635167295;5482.23248745184;5584.7207639617045;5677.630953987978;5748.626339287933;5505.394406615189;5688.11834165705;5692.48767610917;5718.485336319751;5788.334341550775 04:04:14 INFO - PROCESS | 4698 | |4;prototype.html;331.07865819812656;339.7316120264991;344.5073544830892;344.91032331593794;346.07597714103343;5355;5449.073657478229;5464.398916119224;5576.888462230758;5587.944120558793;5276.736163191844;5403.378611459683;5404.189371594262;5418.972905135469;5432.348118225808;4282.094467961759;4299.44107266055;4311.892202694927;4326.8269269229195;4354.608085272325;4143.585641435848;4267.167902259061;4313;4340.652747780186;4363.170997510463;4219.810108545123;4234.280172370689;4239.516169340737;4254;4262.083652014816;4245.554216807222;4245.766482843443;4262.381954616563;4267.807948642303;4281.165172791307;3571.2857428514403;3674.8318492089797;3692.778433293984;3695.648913353254;3698.9815050924844;5256.8685782855355;5267;5277.234800953878;5277.419483856773;5284.180951952453;4809.749465139054;4834.250691142844;4855.635827312965;4868.464468908417;4885;5522.66863988162;5594.720263986825;5611.8877622447735;5616.382197958222;5651.886962260773;4050.0887300357476;4061.9187616247805;4066.1664358806374;4070.3690927906223;4071.1247081877536;5843.8539036524;5930.703464826742;5976.862147372621;6021.458068773832;6026.758929642809;4188.036751547101;4190.811413486401;4198.1393814268;4202.621764041251;4216.093539888877;4255.468066491689;4255.8084886180195;4256.638185754246;4257.574242575718;4267.445232119804;4893.681910675795;4898.632602554751;4899.387576552931;4905.037984806035;4925.335079764258;5445.646033007842;5667.489925906688;5717.714114294352;5741.081426971748;5780.971095144581;1398.3707331700775;1421.722764060998;1436.590571687064;1451.2380999974887;1459.3870574358796;958.3579002068631;976.7400053930493;992.1120597065586;999.480270259461;1001.3691374434205;5486.31421072366;5502.614816962774;5509.724513774296;5526;5531.944680553143;5781.739821708034;5787.913181302284;5791.305043394819;5811.93676244927;5851.0053290939795;5303.655262407931;5541.251930989345;5553.1670249462095;5553.611247212656;5591;3090.7836451448184;3112.859921303547;3121.219695076231;3122.625284965773;3127.6715944825464;5795.33353664334;6047.516198704093;6059.6364218147055;6064.696765161724;6068.908966365508;6012.759489620454;6025;6037.245344331958;6045.6070355426755;6057.3336932937345;6041.821844740233;6061.242344706911;6068.544859135583;6076.483498902554;6077.665728384981;5649.887002260014;5874.441928016831;5893.322267939242;5925.792597259076;5926.436988486087;5849.94150058511;5862.648241105548;5865.442782935615;5865.648061116347;5889.234399528034;5852.707364631837;6069.696515174312;6074.271087469532;6079.452849243589;6086.3000754913755;4252.638525725348;4261.595148460891;4264.5309016007595;4269.316909294498;4282.443282373271;5764.971175144097;5903.350631430625;5948.512871782054;5976.013957696931;6041.305249896318;5607.635503692247;5744.885102298014;5756.251687280626;5768.2501274834;5776.393478684846;5743.9138412923;5745.798897038583;5756.222909907109;5769.94230057694;5771.769129234784;5610;5675.68783716883;5677.176809362537;5690.630109042899;5734.283214598176;5719.942800571941;5746.299239357495;5758.366579676149;5759.39526349744;5779.7862448884525;5434;5581.330240371181;5616.269884914935;5623.550115990793;5651.886962260814 04:04:14 INFO - PROCESS | 4698 | |5;yui.html;665.9234188068374;668.6255696809787;709.1631874388221;720.1394333771142;724.5037149552556;14162.787558186623;15058.39766409345;15431.614209644764;15485.612859678513;15494.147821869807;13580.388882500287;13627.250501222454;13669.521566745167;13686.178829270251;13714.794278085838;690.4372936057098;693.3032302535944;804.4730701390598;821.2362502872327;823.8640624296984;802.2859654907137;803.1366281247653;818.3862103422433;838.786109542069;839.5130824122025;887.077439462961;890.5013192612125;890.6392910871075;890.9509976951265;891.2246345679268;716.3767522255671;725.6081715873422;888.0897080492482;888.3071204460531;888.537960260664;541.7074779619;542.3708498142137;613.2028363127915;624.2851934534932;630.5428564290899;14126.940479463978;14156.150630962073;14167.362468688934;14177.220252886087;14275.286235688278;12989.155704879153;13028.153170043917;13090.47638094475;13347.112801925061;13867.514636987657;11637.35994520301;11822.467988940518;12028.278303301742;12050.698732531757;12101.93949030258;4448.822047118144;4487.691018633059;4530.59224669778;4680.882977925545;4682.461516925563;86076.56961715152;89791;89989.55005225063;92723;95342.52328738381;10147.847782283272;10510.159187265;10561.788764224673;10739.35563866155;10768.515416806262;22543.098276068773;22550.548989020128;22635.886820565793;22718;22939.426514337276;8155.306798922158;8213.260806527442;8367.023207474844;8455.788605284917;8485.660573576988;4644.292364620188;4649.488556258809;4708.011317623337;4711.104890070876;4865.172920603435;3554.182538016271;3662.7802331860175;3666.834992425347;3667.2482141161;3669.3578623740736;599.4065874783932;606.7985388929856;607.180306586114;607.2925042325642;607.7325976570384;599.8170557979859;606.5390303369383;656.5490266510968;704.8695991241636;720.2437440687257;8662.30701543875;8863.157999989991;8881.111888811067;8917.286617070618;9189.77025574366;620.314552419579;637.1048676609371;640.6668532363145;650.4698670583459;672.085963090197;4176;4229.703920725519;4243.596858298457;4247.299195632686;4480.7145272622465;106034;107931.46034269936;110133.44933275282;135783;138921.3053934744;101322;104622;105291.4735426318;105672.47163764131;113659;92766.53616731873;92832.53583732173;93746;93878.53060734789;94029;9576.808463830825;9887.653932112342;10020.398776073458;10049.410264584032;10148.188144948239;39588.60411395964;41823.37264941089;55471.44528554663;56070.43929560652;57189.42810571841;72655.27344726484;79909;80547.19452805631;81341;82958.17041829505;13261;13311.80032299497;13527.188368697909;13700.65748356299;14045;13541.796873046715;13663.316834158053;13686.04197706151;13840.307984600528;13995.440182392591;13510.72978540404;13946.023778335419;14030.719385612027;14167.858321416654;14297.213653249171;12565.497380105058;13530.391132399263;13566.321683915567;13711;14165.858341416453;13294;13357.599272021855;13550.728985420039;13725.45098196061;13853.653658658211;11469.08247340194;11555.075593952295;11595.678319235607;11749.647510574696;11927.165098443025;11583.6524904253;11712.70718232051;11757.353345566076;11804.881951180378;12116.21244619097 04:04:14 INFO - PROCESS | 4698 | __end_tp_report 04:04:14 INFO - PROCESS | 4698 | __start_cc_report 04:04:14 INFO - PROCESS | 4698 | _x_x_mozilla_cycle_collect,1056 04:04:14 INFO - PROCESS | 4698 | __end_cc_report 04:04:14 INFO - PROCESS | 4698 | __startTimestamp1477911854892__endTimestamp 04:04:14 INFO - PROCESS | 4698 | 04:04:14 INFO - PROCESS | 4698 | ------- Summary: start ------- 04:04:14 INFO - PROCESS | 4698 | Number of tests: 6 04:04:14 INFO - PROCESS | 4698 | 04:04:14 INFO - PROCESS | 4698 | [#0] dojo.html Cycles:165 Average:5634.15 Median:5899.26 stddev:653.50 (11.1%) stddev-sans-first:626.22 04:04:14 INFO - PROCESS | 4698 | Values: 3168.5 3208.8 3216.5 3231.8 3246.3 5630.4 5699.4 5705.6 5733.4 5742.4 5635.7 5679.2 5689.7 5690.3 5737.6 5127.2 5130.8 5154.4 5178.4 5232.8 5046.5 5215.7 5228.8 5240.8 5266.2 5031.4 5097.9 5102.3 5142.7 5170.3 5137.9 5162.4 5166.3 5225.1 5225.9 5075.7 5127.2 5183.9 5192.5 5220.9 5516.0 5535.4 5612.1 5613.7 5623.0 6060.0 6071.7 6079.3 6082.1 6087.1 6103.1 6117.8 6127.5 6129.7 6130.3 5491.3 5540.6 5660.2 5684.6 5692.3 6281.5 6287.1 6292.1 6294.7 6298.5 6021.3 6030.1 6037.7 6040.4 6040.8 5891.2 5941.0 5993.2 6068.0 6140.8 5866.7 5965.0 5966.6 6003.1 6011.8 5968.9 5970.5 5971.8 5972.9 6005.7 4537.0 4545.3 4614.3 4615.2 4622.8 4095.0 4116.0 4134.5 4142.5 4172.4 5764.4 5772.1 5772.3 5782.2 5789.9 5937.3 6083.3 6130.8 6131.3 6135.3 5602.2 5615.1 5641.2 5656.0 5720.7 5207.7 5209.3 5210.4 5217.1 5249.9 6149.7 6202.9 6207.8 6215.7 6223.8 5923.6 5995.5 6024.2 6042.6 6069.1 6275.1 6326.8 6327.4 6332.4 6350.6 6033.9 6037.2 6039.6 6040.4 6051.8 5859.8 5903.9 6106.3 6136.8 6144.5 5947.6 5963.4 5989.3 6050.4 6072.7 6009.0 6017.9 6021.0 6021.3 6023.6 5669.6 5952.3 6003.3 6019.0 6022.5 5767.4 5924.2 5945.1 5988.9 6072.0 5874.4 5888.9 5899.3 5913.4 5915.4 04:04:14 INFO - PROCESS | 4698 | 04:04:14 INFO - PROCESS | 4698 | [#1] ext.html Cycles:180 Average:66693.85 Median:221471.40 stddev:138847.13 (62.7%) stddev-sans-first:139147.93 04:04:14 INFO - PROCESS | 4698 | Values: 592.7 625.1 629.4 641.4 651.1 34723.1 47099.5 48066.8 48181.8 48206.0 49590.0 50007.2 50064.5 50072.5 50102.7 8498.8 9296.1 9450.9 9452.6 9455.2 8515.2 8788.0 8789.0 10846.6 11168.7 11361.1 11412.9 11419.7 11432.3 11442.1 11272.2 11292.2 11319.4 11350.3 11362.9 11068.1 11131.9 11136.2 11138.1 11142.7 45839.0 45874.0 46091.8 46369.5 46426.8 3817.8 3847.0 3904.7 3926.9 4301.2 34724.0 34763.7 35046.8 35092.1 36032.8 4580.5 4641.6 4656.9 4728.6 4758.4 401478.0 402576.0 405796.0 406767.0 406986.0 39236.8 40173.4 40366.8 42039.8 62625.0 41197.2 41375.6 41432.0 41468.6 41477.0 16863.2 17058.0 17059.7 17064.8 17076.4 14144.2 14233.3 14244.0 14245.6 14419.4 8924.3 9066.3 9099.0 9341.8 9668.8 3574.2 3624.6 3640.8 3641.4 3684.8 1089.9 1095.6 1095.8 1103.9 1126.2 33544.7 33623.7 33955.3 34100.8 34757.7 1153.6 1169.4 1173.5 1180.5 1193.6 17361.9 18059.5 18324.7 18331.0 18425.4 638736.0 642489.0 643005.1 643198.0 644069.0 62515.0 62658.0 63159.0 63237.4 63320.0 1414.1 1414.2 1438.1 1444.9 1451.3 31954.8 33749.5 34083.3 34108.0 34217.2 55052.4 55162.2 55583.4 55713.7 55721.7 487145.0 487884.0 488307.0 490191.0 490833.0 27677.9 28241.4 31538.5 31961.4 31977.0 49945.5 52414.5 53901.2 57220.0 57416.7 44247.6 44990.0 45051.0 45717.3 45774.0 44373.3 44683.0 45109.0 45571.1 45668.8 43830.0 44598.0 44823.0 44921.0 45045.3 36461.3 39086.8 39627.2 39953.8 40111.0 29757.4 29903.1 29946.0 30140.8 30196.0 04:04:14 INFO - PROCESS | 4698 | 04:04:14 INFO - PROCESS | 4698 | [#2] jquery.html Cycles:180 Average:29046.32 Median:21510.23 stddev:77121.71 (358.5%) stddev-sans-first:77308.06 04:04:14 INFO - PROCESS | 4698 | Values: 397.6 429.6 432.3 438.8 441.9 16857.0 20195.4 20230.2 20750.3 21734.9 19982.1 20135.5 20141.4 20148.4 20362.3 5868.6 5889.6 6053.7 6087.1 6094.4 5953.1 6014.8 6032.8 6047.2 6061.8 5879.6 5989.7 5998.3 6002.9 6010.2 5807.9 5971.9 5997.1 6002.2 6003.3 5389.8 5402.3 5406.5 5412.9 5414.8 23762.5 24088.0 24315.3 24374.1 24788.5 2502.0 2578.1 2580.7 2581.5 3204.6 14358.1 15381.2 15396.0 15795.9 16075.3 1805.6 1873.9 1941.6 2001.2 2067.7 61212.7 76225.6 76869.6 89057.0 90389.0 11161.7 11262.8 11306.0 11419.7 11634.4 15409.2 15548.1 15593.4 15755.8 15884.2 8613.2 8853.5 8924.0 9056.2 9072.6 8874.4 8900.6 8912.9 9110.8 9127.8 6927.0 6968.2 7031.7 7064.8 7085.4 1961.7 2001.5 2034.9 2037.4 2056.6 970.3 1021.9 1079.3 1103.5 1103.5 20877.8 21237.8 21475.9 21488.6 21531.9 1013.9 1045.9 1084.8 1116.3 1121.5 11131.9 12079.3 12148.8 12252.9 12371.9 391597.0 395328.0 395677.0 555212.0 555372.0 90145.5 101517.5 104611.5 106854.0 108247.5 1066.4 1074.4 1099.2 1104.7 1123.1 18021.2 18403.8 18435.0 18641.5 18917.3 40354.0 43332.0 43357.6 43614.8 44746.8 55762.4 61638.7 63220.4 63762.0 63863.7 8618.2 8749.3 8794.0 8851.4 9001.0 12949.3 13685.9 13738.9 13883.4 14014.3 11166.0 11406.9 11589.0 11628.9 11764.5 11228.3 11643.0 11781.7 11984.0 12102.9 11588.0 11626.0 11763.4 11967.9 12073.3 8444.6 8601.7 8632.5 8786.6 8872.2 11656.1 11863.9 11945.6 11978.9 12310.4 04:04:14 INFO - PROCESS | 4698 | 04:04:14 INFO - PROCESS | 4698 | [#3] mootools.html Cycles:180 Average:6399.76 Median:4896.69 stddev:3753.70 (76.7%) stddev-sans-first:3745.70 04:04:14 INFO - PROCESS | 4698 | Values: 1437.4 1536.7 1560.5 1728.1 1871.2 8758.8 9457.2 9738.4 9745.6 9929.9 9697.2 9754.7 9782.0 9785.1 9791.8 2562.4 2565.5 2586.4 2594.7 2596.3 2463.9 2557.3 2558.2 2561.4 2567.6 2516.2 2521.4 2558.3 2560.3 2562.5 2394.1 2404.5 2413.9 2452.3 2459.5 2341.2 2368.3 2392.6 2393.5 2415.6 9573.9 9659.5 9710.2 9731.9 9864.2 5805.9 5945.1 5957.1 5957.8 5960.4 3608.0 3698.2 3703.8 3802.3 3809.4 1215.2 1227.1 1274.5 1276.1 1304.3 13688.2 13958.9 13972.1 13975.0 13985.8 4888.9 4904.5 4973.2 5056.9 5101.2 10938.2 10955.0 10958.1 10963.3 10964.0 5780.7 5800.6 5807.4 5809.0 5812.5 4742.3 4769.0 5117.9 5170.8 5420.9 4114.6 4179.9 4188.9 4298.7 4371.4 1225.0 1288.8 1297.1 1298.0 1306.0 739.7 956.6 1013.4 1052.8 1055.5 6466.8 6521.7 6554.7 6706.6 6729.2 524.5 531.2 535.4 544.5 662.2 4416.9 4592.8 4625.9 4656.9 4694.6 12145.6 12731.7 12771.0 12773.5 12774.0 11607.7 12673.9 12684.6 12697.2 12701.2 8490.5 8889.7 8903.5 8904.7 8908.1 6477.8 6508.5 6585.5 6763.1 6786.6 10917.4 11295.9 11484.3 11544.9 11568.5 11385.1 11655.5 11659.7 11731.4 11784.8 8275.9 8651.1 8686.3 8783.2 8791.3 9400.4 9500.5 9576.9 9595.2 9602.8 8456.4 8496.2 8526.9 8626.3 8699.5 8023.2 8047.2 8202.9 8285.1 8346.6 7671.2 7684.2 7728.8 7744.7 7764.6 5406.7 5482.2 5584.7 5677.6 5748.6 5505.4 5688.1 5692.5 5718.5 5788.3 04:04:14 INFO - PROCESS | 4698 | 04:04:14 INFO - PROCESS | 4698 | [#4] prototype.html Cycles:180 Average:4824.35 Median:5524.33 stddev:1418.76 (25.7%) stddev-sans-first:1382.07 04:04:14 INFO - PROCESS | 4698 | Values: 331.1 339.7 344.5 344.9 346.1 5355.0 5449.1 5464.4 5576.9 5587.9 5276.7 5403.4 5404.2 5419.0 5432.3 4282.1 4299.4 4311.9 4326.8 4354.6 4143.6 4267.2 4313.0 4340.7 4363.2 4219.8 4234.3 4239.5 4254.0 4262.1 4245.6 4245.8 4262.4 4267.8 4281.2 3571.3 3674.8 3692.8 3695.6 3699.0 5256.9 5267.0 5277.2 5277.4 5284.2 4809.7 4834.3 4855.6 4868.5 4885.0 5522.7 5594.7 5611.9 5616.4 5651.9 4050.1 4061.9 4066.2 4070.4 4071.1 5843.9 5930.7 5976.9 6021.5 6026.8 4188.0 4190.8 4198.1 4202.6 4216.1 4255.5 4255.8 4256.6 4257.6 4267.4 4893.7 4898.6 4899.4 4905.0 4925.3 5445.6 5667.5 5717.7 5741.1 5781.0 1398.4 1421.7 1436.6 1451.2 1459.4 958.4 976.7 992.1 999.5 1001.4 5486.3 5502.6 5509.7 5526.0 5531.9 5781.7 5787.9 5791.3 5811.9 5851.0 5303.7 5541.3 5553.2 5553.6 5591.0 3090.8 3112.9 3121.2 3122.6 3127.7 5795.3 6047.5 6059.6 6064.7 6068.9 6012.8 6025.0 6037.2 6045.6 6057.3 6041.8 6061.2 6068.5 6076.5 6077.7 5649.9 5874.4 5893.3 5925.8 5926.4 5849.9 5862.6 5865.4 5865.6 5889.2 5852.7 6069.7 6074.3 6079.5 6086.3 4252.6 4261.6 4264.5 4269.3 4282.4 5765.0 5903.4 5948.5 5976.0 6041.3 5607.6 5744.9 5756.3 5768.3 5776.4 5743.9 5745.8 5756.2 5769.9 5771.8 5610.0 5675.7 5677.2 5690.6 5734.3 5719.9 5746.3 5758.4 5759.4 5779.8 5434.0 5581.3 5616.3 5623.6 5651.9 04:04:14 INFO - PROCESS | 4698 | 04:04:14 INFO - PROCESS | 4698 | [#5] yui.html Cycles:180 Average:21769.21 Median:23026.54 stddev:32469.41 (141.0%) stddev-sans-first:32521.83 04:04:14 INFO - PROCESS | 4698 | Values: 665.9 668.6 709.2 720.1 724.5 14162.8 15058.4 15431.6 15485.6 15494.1 13580.4 13627.3 13669.5 13686.2 13714.8 690.4 693.3 804.5 821.2 823.9 802.3 803.1 818.4 838.8 839.5 887.1 890.5 890.6 891.0 891.2 716.4 725.6 888.1 888.3 888.5 541.7 542.4 613.2 624.3 630.5 14126.9 14156.2 14167.4 14177.2 14275.3 12989.2 13028.2 13090.5 13347.1 13867.5 11637.4 11822.5 12028.3 12050.7 12101.9 4448.8 4487.7 4530.6 4680.9 4682.5 86076.6 89791.0 89989.6 92723.0 95342.5 10147.8 10510.2 10561.8 10739.4 10768.5 22543.1 22550.5 22635.9 22718.0 22939.4 8155.3 8213.3 8367.0 8455.8 8485.7 4644.3 4649.5 4708.0 4711.1 4865.2 3554.2 3662.8 3666.8 3667.2 3669.4 599.4 606.8 607.2 607.3 607.7 599.8 606.5 656.5 704.9 720.2 8662.3 8863.2 8881.1 8917.3 9189.8 620.3 637.1 640.7 650.5 672.1 4176.0 4229.7 4243.6 4247.3 4480.7 106034.0 107931.5 110133.4 135783.0 138921.3 101322.0 104622.0 105291.5 105672.5 113659.0 92766.5 92832.5 93746.0 93878.5 94029.0 9576.8 9887.7 10020.4 10049.4 10148.2 39588.6 41823.4 55471.4 56070.4 57189.4 72655.3 79909.0 80547.2 81341.0 82958.2 13261.0 13311.8 13527.2 13700.7 14045.0 13541.8 13663.3 13686.0 13840.3 13995.4 13510.7 13946.0 14030.7 14167.9 14297.2 12565.5 13530.4 13566.3 13711.0 14165.9 13294.0 13357.6 13550.7 13725.5 13853.7 11469.1 11555.1 11595.7 11749.6 11927.2 11583.7 11712.7 11757.4 11804.9 12116.2 04:04:14 INFO - PROCESS | 4698 | -------- Summary: end -------- 04:04:14 INFO - PROCESS | 4698 | 04:04:15 INFO - TEST-INFO | 4698: exit 0 04:04:15 INFO - TEST-OK | dromaeo_css | took 1113652ms 04:04:15 INFO - TEST-START | kraken 04:04:15 INFO - operating with platform_type : linux_ 04:04:15 INFO - Initialising browser for kraken test... 04:04:15 INFO - TEST-INFO | started process 5018 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPbxwXB/profile http://localhost:33312/getInfo.html) 04:04:19 INFO - PROCESS | 5018 | __metrics Screen width/height:1600/1200 04:04:19 INFO - PROCESS | 5018 | colorDepth:24 04:04:19 INFO - PROCESS | 5018 | Browser inner width/height: 1024/697 04:04:19 INFO - PROCESS | 5018 | __metrics 04:04:20 INFO - PROCESS | 5018 | 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" 04:04:20 INFO - PROCESS | 5018 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:04:20 INFO - PROCESS | 5018 | console.error: PushService: 04:04:20 INFO - PROCESS | 5018 | stateChangeProcessEnqueue: Error transitioning state 04:04:20 INFO - PROCESS | 5018 | UnknownError 04:04:21 INFO - TEST-INFO | 5018: exit 0 04:04:21 INFO - Browser initialized. 04:04:21 INFO - Running cycle 1/1 for kraken test... 04:04:21 INFO - TEST-INFO | started process 5111 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPbxwXB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:04:33 INFO - PROCESS | 5111 | RSS: Main: 144691200 04:04:33 INFO - PROCESS | 5111 | 04:04:35 INFO - PROCESS | 5111 | Cycle 1(1): loaded http://localhost:33312/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33312/tests/kraken/driver.html?testName=audio-beat-detection) 04:04:36 INFO - PROCESS | 5111 | RSS: Main: 186593280 04:04:36 INFO - PROCESS | 5111 | 04:04:39 INFO - PROCESS | 5111 | Cycle 1(1): loaded http://localhost:33312/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33312/tests/kraken/driver.html?testName=audio-dft) 04:04:39 INFO - PROCESS | 5111 | RSS: Main: 175878144 04:04:39 INFO - PROCESS | 5111 | 04:04:42 INFO - PROCESS | 5111 | Cycle 1(1): loaded http://localhost:33312/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33312/tests/kraken/driver.html?testName=audio-fft) 04:04:43 INFO - PROCESS | 5111 | RSS: Main: 267128832 04:04:43 INFO - PROCESS | 5111 | 04:04:45 INFO - PROCESS | 5111 | Cycle 1(1): loaded http://localhost:33312/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33312/tests/kraken/driver.html?testName=audio-oscillator) 04:04:45 INFO - PROCESS | 5111 | RSS: Main: 173752320 04:04:45 INFO - PROCESS | 5111 | 04:04:47 INFO - PROCESS | 5111 | Cycle 1(1): loaded http://localhost:33312/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33312/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:04:48 INFO - PROCESS | 5111 | RSS: Main: 175783936 04:04:48 INFO - PROCESS | 5111 | 04:04:51 INFO - PROCESS | 5111 | Cycle 1(1): loaded http://localhost:33312/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33312/tests/kraken/driver.html?testName=imaging-darkroom) 04:04:51 INFO - PROCESS | 5111 | RSS: Main: 211804160 04:04:51 INFO - PROCESS | 5111 | 04:04:55 INFO - PROCESS | 5111 | Cycle 1(1): loaded http://localhost:33312/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33312/tests/kraken/driver.html?testName=imaging-desaturate) 04:04:55 INFO - PROCESS | 5111 | RSS: Main: 209653760 04:04:55 INFO - PROCESS | 5111 | 04:04:58 INFO - PROCESS | 5111 | Cycle 1(1): loaded http://localhost:33312/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33312/tests/kraken/driver.html?testName=json-parse-financial) 04:04:59 INFO - PROCESS | 5111 | RSS: Main: 209903616 04:04:59 INFO - PROCESS | 5111 | 04:05:00 INFO - PROCESS | 5111 | Cycle 1(1): loaded http://localhost:33312/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33312/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:05:01 INFO - PROCESS | 5111 | RSS: Main: 171798528 04:05:01 INFO - PROCESS | 5111 | 04:05:03 INFO - PROCESS | 5111 | Cycle 1(1): loaded http://localhost:33312/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33312/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:05:03 INFO - PROCESS | 5111 | RSS: Main: 178364416 04:05:03 INFO - PROCESS | 5111 | 04:05:05 INFO - PROCESS | 5111 | Cycle 1(1): loaded http://localhost:33312/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33312/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:05:06 INFO - PROCESS | 5111 | RSS: Main: 188272640 04:05:06 INFO - PROCESS | 5111 | 04:05:08 INFO - PROCESS | 5111 | Cycle 1(1): loaded http://localhost:33312/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33312/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:05:09 INFO - PROCESS | 5111 | RSS: Main: 197070848 04:05:09 INFO - PROCESS | 5111 | 04:05:12 INFO - PROCESS | 5111 | Cycle 1(1): loaded http://localhost:33312/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33312/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:05:12 INFO - PROCESS | 5111 | RSS: Main: 193720320 04:05:12 INFO - PROCESS | 5111 | 04:05:14 INFO - PROCESS | 5111 | Cycle 1(1): loaded http://localhost:33312/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33312/tests/kraken/driver.html?testName=ai-astar) 04:05:14 INFO - PROCESS | 5111 | RSS: Main: 244551680 04:05:14 INFO - PROCESS | 5111 | 04:05:14 INFO - PROCESS | 5111 | __start_tp_report 04:05:14 INFO - PROCESS | 5111 | _x_x_mozilla_page_load 04:05:14 INFO - PROCESS | 5111 | _x_x_mozilla_page_load_details 04:05:14 INFO - PROCESS | 5111 | |i|pagename|runs| 04:05:14 INFO - PROCESS | 5111 | |0;ai-astar;108;109;111;111;112;111;110;110;110;110 04:05:14 INFO - PROCESS | 5111 | |1;audio-beat-detection;144;117;118;146;117;118;118;116;142;116 04:05:14 INFO - PROCESS | 5111 | |2;audio-dft;162;159;161;160;159;161;159;161;160;161 04:05:14 INFO - PROCESS | 5111 | |3;audio-fft;75;76;76;121;77;76;76;75;100;75 04:05:14 INFO - PROCESS | 5111 | |4;audio-oscillator;81;81;132;81;81;81;106;82;82;114 04:05:14 INFO - PROCESS | 5111 | |5;imaging-gaussian-blur;117;117;116;116;116;117;118;117;117;116 04:05:14 INFO - PROCESS | 5111 | |6;imaging-darkroom;146;145;147;146;146;146;147;147;145;145 04:05:14 INFO - PROCESS | 5111 | |7;imaging-desaturate;95;95;95;95;94;95;95;94;94;94 04:05:14 INFO - PROCESS | 5111 | |8;json-parse-financial;49;48;49;47;61;47;48;47;48;49 04:05:14 INFO - PROCESS | 5111 | |9;json-stringify-tinderbox;58;59;60;59;59;60;62;59;58;60 04:05:14 INFO - PROCESS | 5111 | |10;stanford-crypto-aes;82;77;73;73;73;73;74;73;73;73 04:05:14 INFO - PROCESS | 5111 | |11;stanford-crypto-ccm;121;123;122;123;128;121;121;119;162;121 04:05:14 INFO - PROCESS | 5111 | |12;stanford-crypto-pbkdf2;159;159;157;158;155;153;155;153;153;155 04:05:14 INFO - PROCESS | 5111 | |13;stanford-crypto-sha256-iterative;64;63;62;63;63;61;63;65;62;61 04:05:14 INFO - PROCESS | 5111 | __end_tp_report 04:05:14 INFO - PROCESS | 5111 | __start_cc_report 04:05:14 INFO - PROCESS | 5111 | _x_x_mozilla_cycle_collect,1590 04:05:14 INFO - PROCESS | 5111 | __end_cc_report 04:05:14 INFO - PROCESS | 5111 | __startTimestamp1477911914564__endTimestamp 04:05:14 INFO - PROCESS | 5111 | 04:05:14 INFO - PROCESS | 5111 | ------- Summary: start ------- 04:05:14 INFO - PROCESS | 5111 | Number of tests: 14 04:05:14 INFO - PROCESS | 5111 | 04:05:14 INFO - PROCESS | 5111 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.50 stddev:1.14 (1.0%) stddev-sans-first:0.88 04:05:14 INFO - PROCESS | 5111 | Values: 108.0 109.0 111.0 111.0 112.0 111.0 110.0 110.0 110.0 110.0 04:05:14 INFO - PROCESS | 5111 | 04:05:14 INFO - PROCESS | 5111 | [#1] audio-beat-detection Cycles:10 Average:125.20 Median:118.00 stddev:13.03 (11.0%) stddev-sans-first:11.91 04:05:14 INFO - PROCESS | 5111 | Values: 144.0 117.0 118.0 146.0 117.0 118.0 118.0 116.0 142.0 116.0 04:05:14 INFO - PROCESS | 5111 | 04:05:14 INFO - PROCESS | 5111 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:0.93 04:05:14 INFO - PROCESS | 5111 | Values: 162.0 159.0 161.0 160.0 159.0 161.0 159.0 161.0 160.0 161.0 04:05:14 INFO - PROCESS | 5111 | 04:05:14 INFO - PROCESS | 5111 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:15.48 (20.4%) stddev-sans-first:16.16 04:05:14 INFO - PROCESS | 5111 | Values: 75.0 76.0 76.0 121.0 77.0 76.0 76.0 75.0 100.0 75.0 04:05:14 INFO - PROCESS | 5111 | 04:05:14 INFO - PROCESS | 5111 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:81.00 stddev:18.51 (22.9%) stddev-sans-first:19.20 04:05:14 INFO - PROCESS | 5111 | Values: 81.0 81.0 132.0 81.0 81.0 81.0 106.0 82.0 82.0 114.0 04:05:14 INFO - PROCESS | 5111 | 04:05:14 INFO - PROCESS | 5111 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 04:05:14 INFO - PROCESS | 5111 | Values: 117.0 117.0 116.0 116.0 116.0 117.0 118.0 117.0 117.0 116.0 04:05:14 INFO - PROCESS | 5111 | 04:05:14 INFO - PROCESS | 5111 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 04:05:14 INFO - PROCESS | 5111 | Values: 146.0 145.0 147.0 146.0 146.0 146.0 147.0 147.0 145.0 145.0 04:05:14 INFO - PROCESS | 5111 | 04:05:14 INFO - PROCESS | 5111 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:05:14 INFO - PROCESS | 5111 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 94.0 04:05:14 INFO - PROCESS | 5111 | 04:05:14 INFO - PROCESS | 5111 | [#8] json-parse-financial Cycles:10 Average:49.30 Median:48.50 stddev:4.19 (8.6%) stddev-sans-first:4.44 04:05:14 INFO - PROCESS | 5111 | Values: 49.0 48.0 49.0 47.0 61.0 47.0 48.0 47.0 48.0 49.0 04:05:14 INFO - PROCESS | 5111 | 04:05:14 INFO - PROCESS | 5111 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:1.17 (2.0%) stddev-sans-first:1.13 04:05:14 INFO - PROCESS | 5111 | Values: 58.0 59.0 60.0 59.0 59.0 60.0 62.0 59.0 58.0 60.0 04:05:14 INFO - PROCESS | 5111 | 04:05:14 INFO - PROCESS | 5111 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:73.00 stddev:2.95 (4.0%) stddev-sans-first:1.33 04:05:14 INFO - PROCESS | 5111 | Values: 82.0 77.0 73.0 73.0 73.0 73.0 74.0 73.0 73.0 73.0 04:05:14 INFO - PROCESS | 5111 | 04:05:14 INFO - PROCESS | 5111 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:122.50 stddev:12.84 (10.5%) stddev-sans-first:13.48 04:05:14 INFO - PROCESS | 5111 | Values: 121.0 123.0 122.0 123.0 128.0 121.0 121.0 119.0 162.0 121.0 04:05:14 INFO - PROCESS | 5111 | 04:05:14 INFO - PROCESS | 5111 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:156.00 stddev:2.41 (1.5%) stddev-sans-first:2.24 04:05:14 INFO - PROCESS | 5111 | Values: 159.0 159.0 157.0 158.0 155.0 153.0 155.0 153.0 153.0 155.0 04:05:14 INFO - PROCESS | 5111 | 04:05:14 INFO - PROCESS | 5111 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.25 (2.0%) stddev-sans-first:1.24 04:05:14 INFO - PROCESS | 5111 | Values: 64.0 63.0 62.0 63.0 63.0 61.0 63.0 65.0 62.0 61.0 04:05:14 INFO - PROCESS | 5111 | -------- Summary: end -------- 04:05:14 INFO - PROCESS | 5111 | 04:05:15 INFO - TEST-INFO | 5111: exit 0 04:05:15 INFO - TEST-OK | kraken | took 59939ms 04:05:15 INFO - SUITE-END | took 1173s 04:05:15 INFO - Completed test suite (00:19:33) 04:05:15 INFO - javascript benchmark 04:05:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3168.4930411134214, 3208.839558022098, 3216.485362342026, 3231.8384080795954, 3246.3020450603117, 5630.436956304373, 5699.373068962411, 5705.629134106291, 5733.369329373765, 5742.368339482654, 5635.746391412386, 5679.233303504026, 5689.687067211312, 5690.345610254822, 5737.598368114233, 5127.230915362688, 5130.769115389817, 5154.433012368637, 5178.378594568657, 5232.764525596338, 5046.520580544842, 5215.713135777531, 5228.816991405301, 5240.816571420001, 5266.210068489719, 5031.371078615173, 5097.923531147036, 5102.260172275037, 5142.6914385137015, 5170.327857378536, 5137.897242055156, 5162.406323272815, 5166.250893620441, 5225.137852254374, 5225.895482090375, 5075.746212689388, 5127.1796512558185, 5183.870403239912, 5192.454792246797, 5220.895582088375, 5516.034693928546, 5535.446455354472, 5612.102063669793, 5613.663180209201, 5622.971885140548, 6060.0, 6071.696415179224, 6079.300880398722, 6082.148499210114, 6087.05650624154, 6103.084537319393, 6117.847053823645, 6127.4791642710425, 6129.724162412702, 6130.325664176937, 5491.258680078178, 5540.584456165804, 5660.150977353348, 5684.573656975661, 5692.260006199209, 6281.528885333618, 6287.056941458818, 6292.056191571301, 6294.685265736694, 6298.496120310364, 6021.307549631761, 6030.095485677183, 6037.72830222641, 6040.365761595057, 6040.848978775566, 5891.204687367151, 5941.049432090845, 5993.160957465958, 6067.969660151671, 6140.785072522441, 5866.70666466675, 5965.045592705146, 5966.582339236299, 6003.099535069687, 6011.849703757441, 5968.8806223876145, 5970.5223582114195, 5971.820845374646, 5972.940270597239, 6005.6997150142315, 4537.047220083819, 4545.250033744462, 4614.330922016289, 4615.2384856498975, 4622.815087396534, 4094.9590504094576, 4116.0, 4134.503859536875, 4142.544320124784, 4172.3532852407925, 5764.365919748824, 5772.134179872969, 5772.336181339199, 5782.2483077199695, 5789.88420231593, 5937.2578427696535, 6083.300420451616, 6130.754769809158, 6131.294901086343, 6135.263768347827, 5602.187682785973, 5615.129654903497, 5641.153826925994, 5656.0, 5720.685362305113, 5207.6875387476875, 5209.322788037531, 5210.374755029345, 5217.060929032735, 5249.947500525022, 6149.661768602769, 6202.875942481125, 6207.751689932443, 6215.689215539295, 6223.751049958041, 5923.644581325134, 5995.490383317292, 6024.246969128859, 6042.577019608585, 6069.119977603134, 6275.058741188858, 6326.778562750282, 6327.4305312520255, 6332.366763323631, 6350.555461117678, 6033.879322413615, 6037.245344331958, 6039.607425517327, 6040.395960403925, 6051.788187413419, 5859.824205273849, 5903.91144132847, 6106.297775755845, 6136.753076119853, 6144.525313924537, 5947.583669143119, 5963.403659634002, 5989.341172470938, 6050.394960503914, 6072.696365181811, 6009.0, 6017.909731353946, 6021.0, 6021.337652858269, 6023.638581684938, 5669.6314739541795, 5952.315483719428, 6003.339632640319, 6018.969905150446, 6022.488088512526, 5767.365589785204, 5924.229850119457, 5945.078512830518, 5988.940110598838, 6072.0, 5874.412558744091, 5888.852778680567, 5899.262592175978, 5913.408659134224, 5915.40845915405], "value": 5588.701758488926, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.6769910398835, 625.1029772276784, 629.4209327418771, 641.4259237982005, 651.1437459740438, 34723.13192170194, 47099.52900470994, 48066.75966620162, 48181.759091204585, 48206.0, 49590.0, 50007.24989125166, 50064.49935500644, 50072.49927500724, 50102.74948625261, 8498.830023399529, 9296.116868897443, 9450.85823712645, 9452.621895124186, 9455.196308313802, 8515.23362897339, 8787.956060219722, 8789.033206347329, 10846.566137354497, 11168.720781980433, 11361.091112710963, 11412.942935285311, 11419.714507137347, 11432.314061156358, 11442.084633229364, 11272.210945233837, 11292.20954533183, 11319.377434241114, 11350.262232954832, 11362.943185284063, 11068.059214966737, 11131.944340278327, 11136.220464567483, 11138.053265472445, 11142.665720028332, 45839.0, 45874.0, 46091.76954115242, 46369.53630463719, 46426.76786616079, 3817.828783687808, 3847.0190101524213, 3904.7461914975434, 3926.8625598104213, 4301.161273551658, 34724.0, 34763.65236347629, 35046.82476587626, 35092.12269693253, 36032.81983590092, 4580.519045500241, 4641.559051890065, 4656.860294191146, 4728.598069164125, 4758.381410416659, 401478.0, 402576.0, 405796.0, 406767.0, 406986.0, 39236.80381598074, 40173.39739903904, 40366.79816600898, 42039.78980105141, 62625.0, 41197.176056478704, 41375.586244137776, 41432.0, 41468.58531414707, 41477.0, 16863.15684215784, 17058.0, 17059.744103838453, 17064.829351706572, 17076.402325918534, 14144.151350918977, 14233.28833558318, 14244.0, 14245.572632820824, 14419.42322307117, 8924.330675199386, 9066.320025997944, 9098.954505227432, 9341.766455838659, 9668.75828104289, 3574.249407624428, 3624.619414961391, 3640.7997560133917, 3641.362761516724, 3684.7604905681583, 1089.9073578745738, 1095.5782023920688, 1095.7917995580815, 1103.8951299626522, 1126.1778901401858, 33544.66455335464, 33623.663763362056, 33955.32089358199, 34100.82949585286, 34757.65242347544, 1153.5558809858096, 1169.4328250798355, 1173.501261963662, 1180.451090243041, 1193.5762804204555, 17361.913190433967, 18059.54851128732, 18324.725129123075, 18331.0, 18425.355112570996, 638736.0, 642489.0, 643005.1398971995, 643198.0, 644069.0, 62515.0, 62658.0, 63159.0, 63237.36762632407, 63320.0, 1414.1444426122048, 1414.1868425655289, 1438.1443041390564, 1444.9205293708947, 1451.332387101945, 31954.840225799653, 33749.493757594144, 34083.31833363369, 34108.0, 34217.21433535134, 55052.449475504734, 55162.17256741232, 55583.44416555783, 55713.72143139259, 55721.721391392784, 487145.0, 487884.0, 488307.0, 490191.0, 490833.0, 27677.861610692624, 28241.43517129605, 31538.526922095727, 31961.360772783948, 31977.0, 49945.500544995535, 52414.47585524096, 53901.19148212702, 57220.0, 57416.71291643515, 44247.557524424345, 44990.0, 45051.0, 45717.314240285756, 45774.0, 44373.33439998467, 44683.0, 45109.0, 45571.08857822759, 45668.77165614151, 43830.0, 44598.0, 44823.0, 44921.0, 45045.32432013588, 36461.27077458489, 39086.78627082687, 39627.2074558513, 39953.80023099866, 40111.0, 29757.404851902407, 29903.100967010298, 29946.0, 30140.84929575338, 30196.0], "value": 20718.7742183847, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.59066008973025, 429.5949743272866, 432.2996745272659, 438.7871882137163, 441.90940857124275, 16857.0, 20195.39413817586, 20230.190792368307, 20750.27374041909, 21734.89132554335, 19982.100805463753, 20135.49661258469, 20141.395758127244, 20148.395548133543, 20362.287319943767, 5868.559858010645, 5889.646621202731, 6053.697315134248, 6087.086936959469, 6094.390560943914, 5953.136795164699, 6014.789482368118, 6032.758689652409, 6047.244094488189, 6061.818145455622, 5879.617824841393, 5989.730462129193, 5998.28020637522, 6002.939970600281, 6010.248718910137, 5807.941920580783, 5971.850703732398, 5997.130416089664, 6002.249718785152, 6003.30961939376, 5389.78440862365, 5402.297701298845, 5406.459354064601, 5412.9458705412835, 5414.7834086636485, 23762.524749505086, 24088.0, 24315.270541883772, 24374.146904858244, 24788.50422991548, 2501.9888623707275, 2578.084779903145, 2580.7032191298053, 2581.4707984863057, 3204.5513628092085, 14358.138511689333, 15381.230938453033, 15396.0, 15795.921020394939, 16075.276612552463, 1805.5937414081857, 1873.9437816865516, 1941.5825597496605, 2001.2278686576674, 2067.700183473403, 61212.69393653048, 76225.61887190584, 76869.61565192194, 89057.0, 90389.0, 11161.720956975978, 11262.831057534144, 11306.0, 11419.657410277705, 11634.418279086012, 15409.229538523028, 15548.067115973077, 15593.376264949502, 15755.842441575438, 15884.205789710468, 8613.22480976715, 8853.46879187238, 8924.0, 9056.184943354998, 9072.637094516278, 8874.423162494417, 8900.554972251492, 8912.910870891337, 9110.772230694152, 9127.817443651222, 6927.0, 6968.233494315723, 7031.718731250795, 7064.7527336544, 7085.362317391459, 1961.744973153481, 2001.4896201468532, 2034.9287774927807, 2037.3582321568658, 2056.5578400643935, 970.3013830042358, 1021.8824835143905, 1079.3038490173794, 1103.5089385223498, 1103.536514663843, 20877.798521321056, 21237.787622123582, 21475.892620536797, 21488.57022859534, 21531.892340538197, 1013.9087482126644, 1045.8901815309434, 1084.7559299157626, 1116.268843907242, 1121.545773961547, 11131.944340278247, 12079.27524348542, 12148.757024859453, 12252.877471225353, 12371.938140309241, 391597.0, 395328.0, 395677.0, 555212.0, 555372.0, 90145.54927225322, 101517.49241253747, 104611.47694261633, 106854.0, 108247.45876270726, 1066.3814987307499, 1074.3714926767927, 1099.1536516881956, 1104.6962085426571, 1123.1239633086207, 18021.189046492676, 18403.815961840744, 18435.0, 18641.53396165107, 18917.337893173673, 40354.0, 43332.0, 43357.56642433535, 43614.78192609017, 44746.77626611846, 55762.44237557572, 61638.69180654068, 63220.36779632145, 63762.0, 63863.68068159629, 8618.224359807647, 8749.343799215212, 8794.0, 8851.424657397249, 9000.954995225244, 12949.287789171685, 13685.863141368856, 13738.862611374157, 13883.375248113656, 14014.299285035911, 11166.0, 11406.885931140583, 11589.0, 11628.883711163118, 11764.470598823245, 11228.270162439416, 11643.0, 11781.705457363634, 11984.0, 12102.878971210528, 11588.0, 11626.0, 11763.353015583883, 11967.854363011655, 12073.335966521925, 8444.619992100494, 8601.698940537051, 8632.482051076955, 8786.604602792762, 8872.24585910205, 11656.125790565911, 11863.881361186623, 11945.581904633296, 11978.880211197777, 12310.384480775747], "value": 9830.325369573744, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.4250299880052, 1536.7003434330306, 1560.54744124204, 1728.135932033983, 1871.1860340751766, 8758.824823503526, 9457.196138328241, 9738.415695058302, 9745.56144973477, 9929.851052234222, 9697.175740062103, 9754.707358779231, 9782.0, 9785.07041831025, 9791.755206119851, 2562.3722188063903, 2565.525377805103, 2586.3921978335075, 2594.714581396045, 2596.298999270196, 2463.938401539967, 2557.271177714352, 2558.2069558436942, 2561.3852675357966, 2567.550678631241, 2516.245126462063, 2521.420073383123, 2558.334832943439, 2560.3087166465043, 2562.500312439075, 2394.078279862248, 2404.4589967257316, 2413.879306034691, 2452.31335226137, 2459.4712136890475, 2341.157183413987, 2368.27767530903, 2392.6411038344386, 2393.5093305872256, 2415.553122672311, 9573.946865844751, 9659.517024148834, 9710.17463515602, 9731.902680973171, 9864.210863130933, 5805.854853628651, 5945.108233764927, 5957.106434034886, 5957.791477298317, 5960.374160713106, 3607.9512811674094, 3698.2048859495067, 3703.7962912039825, 3802.258559580883, 3809.3904975204114, 1215.1615385384057, 1227.0858210633046, 1274.4838340472124, 1276.1258537901567, 1304.2956803326192, 13688.247146406944, 13958.860411395857, 13972.091814032157, 13975.0, 13985.79021314681, 4888.877778055577, 4904.509549045067, 4973.154563724175, 5056.873578160502, 5101.183810590288, 10938.234323597271, 10955.0, 10958.068564172134, 10963.287386319864, 10964.0, 5780.653160810365, 5800.622959507618, 5807.448292412214, 5808.970955145197, 5812.534997200299, 4742.288656701522, 4768.976155119271, 5117.8720531987, 5170.793168273227, 5420.891582168335, 4114.629683328515, 4179.874603761892, 4188.85339013133, 4298.742075475419, 4371.366151907955, 1225.0154749306182, 1288.8195652608642, 1297.0531511996296, 1297.9610611681665, 1306.046585992231, 739.7226040234912, 956.6173530587821, 1013.4020927652721, 1052.7841792432532, 1055.4775386183887, 6466.773662921775, 6521.706523206467, 6554.672266386661, 6706.5640733352175, 6729.22613899398, 524.4519477146315, 531.1634176172544, 535.4458135829476, 544.5099410530476, 662.1689779327011, 4416.911661766747, 4592.816287348469, 4625.884352891205, 4656.930146047812, 4694.577488026026, 12145.63563093091, 12731.745365092831, 12771.0, 12773.489060437665, 12774.041946853837, 11607.709807254887, 12673.92271656901, 12684.619461416172, 12697.174683645533, 12701.174423662433, 8490.490570565786, 8889.73330800077, 8903.510306933182, 8904.73285801427, 8908.06465321145, 6477.838054048498, 6508.479321654161, 6585.506087043395, 6763.12079429671, 6786.59280443175, 10917.39954302521, 11295.887041129483, 11484.310941343547, 11544.884551154717, 11568.537258509901, 11385.146114041645, 11655.475503602189, 11659.650210493699, 11731.41342932867, 11784.82322765142, 8275.917240827755, 8651.134886511298, 8686.261667758059, 8783.209511144029, 8791.252743516618, 9400.388974716621, 9500.524973751146, 9576.856347154659, 9595.184409325006, 9602.807943840944, 8456.40805143634, 8496.192861678132, 8526.872096918427, 8626.309895208242, 8699.521526316114, 8023.237792409712, 8047.1550487198, 8202.917970820454, 8285.130061343472, 8346.582670866554, 7671.1561728208735, 7684.231576842495, 7728.7681369559, 7744.65149068282, 7764.572948487661, 5406.7296635167295, 5482.23248745184, 5584.7207639617045, 5677.630953987978, 5748.626339287933, 5505.394406615189, 5688.11834165705, 5692.48767610917, 5718.485336319751, 5788.334341550775], "value": 4988.523209739267, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.07865819812656, 339.7316120264991, 344.5073544830892, 344.91032331593794, 346.07597714103343, 5355.0, 5449.073657478229, 5464.398916119224, 5576.888462230758, 5587.944120558793, 5276.736163191844, 5403.378611459683, 5404.189371594262, 5418.972905135469, 5432.348118225808, 4282.094467961759, 4299.44107266055, 4311.892202694927, 4326.8269269229195, 4354.608085272325, 4143.585641435848, 4267.167902259061, 4313.0, 4340.652747780186, 4363.170997510463, 4219.810108545123, 4234.280172370689, 4239.516169340737, 4254.0, 4262.083652014816, 4245.554216807222, 4245.766482843443, 4262.381954616563, 4267.807948642303, 4281.165172791307, 3571.2857428514403, 3674.8318492089797, 3692.778433293984, 3695.648913353254, 3698.9815050924844, 5256.8685782855355, 5267.0, 5277.234800953878, 5277.419483856773, 5284.180951952453, 4809.749465139054, 4834.250691142844, 4855.635827312965, 4868.464468908417, 4885.0, 5522.66863988162, 5594.720263986825, 5611.8877622447735, 5616.382197958222, 5651.886962260773, 4050.0887300357476, 4061.9187616247805, 4066.1664358806374, 4070.3690927906223, 4071.1247081877536, 5843.8539036524, 5930.703464826742, 5976.862147372621, 6021.458068773832, 6026.758929642809, 4188.036751547101, 4190.811413486401, 4198.1393814268, 4202.621764041251, 4216.093539888877, 4255.468066491689, 4255.8084886180195, 4256.638185754246, 4257.574242575718, 4267.445232119804, 4893.681910675795, 4898.632602554751, 4899.387576552931, 4905.037984806035, 4925.335079764258, 5445.646033007842, 5667.489925906688, 5717.714114294352, 5741.081426971748, 5780.971095144581, 1398.3707331700775, 1421.722764060998, 1436.590571687064, 1451.2380999974887, 1459.3870574358796, 958.3579002068631, 976.7400053930493, 992.1120597065586, 999.480270259461, 1001.3691374434205, 5486.31421072366, 5502.614816962774, 5509.724513774296, 5526.0, 5531.944680553143, 5781.739821708034, 5787.913181302284, 5791.305043394819, 5811.93676244927, 5851.0053290939795, 5303.655262407931, 5541.251930989345, 5553.1670249462095, 5553.611247212656, 5591.0, 3090.7836451448184, 3112.859921303547, 3121.219695076231, 3122.625284965773, 3127.6715944825464, 5795.33353664334, 6047.516198704093, 6059.6364218147055, 6064.696765161724, 6068.908966365508, 6012.759489620454, 6025.0, 6037.245344331958, 6045.6070355426755, 6057.3336932937345, 6041.821844740233, 6061.242344706911, 6068.544859135583, 6076.483498902554, 6077.665728384981, 5649.887002260014, 5874.441928016831, 5893.322267939242, 5925.792597259076, 5926.436988486087, 5849.94150058511, 5862.648241105548, 5865.442782935615, 5865.648061116347, 5889.234399528034, 5852.707364631837, 6069.696515174312, 6074.271087469532, 6079.452849243589, 6086.3000754913755, 4252.638525725348, 4261.595148460891, 4264.5309016007595, 4269.316909294498, 4282.443282373271, 5764.971175144097, 5903.350631430625, 5948.512871782054, 5976.013957696931, 6041.305249896318, 5607.635503692247, 5744.885102298014, 5756.251687280626, 5768.2501274834, 5776.393478684846, 5743.9138412923, 5745.798897038583, 5756.222909907109, 5769.94230057694, 5771.769129234784, 5610.0, 5675.68783716883, 5677.176809362537, 5690.630109042899, 5734.283214598176, 5719.942800571941, 5746.299239357495, 5758.366579676149, 5759.39526349744, 5779.7862448884525, 5434.0, 5581.330240371181, 5616.269884914935, 5623.550115990793, 5651.886962260814], "value": 4370.85636494622, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.9234188068374, 668.6255696809787, 709.1631874388221, 720.1394333771142, 724.5037149552556, 14162.787558186623, 15058.39766409345, 15431.614209644764, 15485.612859678513, 15494.147821869807, 13580.388882500287, 13627.250501222454, 13669.521566745167, 13686.178829270251, 13714.794278085838, 690.4372936057098, 693.3032302535944, 804.4730701390598, 821.2362502872327, 823.8640624296984, 802.2859654907137, 803.1366281247653, 818.3862103422433, 838.786109542069, 839.5130824122025, 887.077439462961, 890.5013192612125, 890.6392910871075, 890.9509976951265, 891.2246345679268, 716.3767522255671, 725.6081715873422, 888.0897080492482, 888.3071204460531, 888.537960260664, 541.7074779619, 542.3708498142137, 613.2028363127915, 624.2851934534932, 630.5428564290899, 14126.940479463978, 14156.150630962073, 14167.362468688934, 14177.220252886087, 14275.286235688278, 12989.155704879153, 13028.153170043917, 13090.47638094475, 13347.112801925061, 13867.514636987657, 11637.35994520301, 11822.467988940518, 12028.278303301742, 12050.698732531757, 12101.93949030258, 4448.822047118144, 4487.691018633059, 4530.59224669778, 4680.882977925545, 4682.461516925563, 86076.56961715152, 89791.0, 89989.55005225063, 92723.0, 95342.52328738381, 10147.847782283272, 10510.159187265, 10561.788764224673, 10739.35563866155, 10768.515416806262, 22543.098276068773, 22550.548989020128, 22635.886820565793, 22718.0, 22939.426514337276, 8155.306798922158, 8213.260806527442, 8367.023207474844, 8455.788605284917, 8485.660573576988, 4644.292364620188, 4649.488556258809, 4708.011317623337, 4711.104890070876, 4865.172920603435, 3554.182538016271, 3662.7802331860175, 3666.834992425347, 3667.2482141161, 3669.3578623740736, 599.4065874783932, 606.7985388929856, 607.180306586114, 607.2925042325642, 607.7325976570384, 599.8170557979859, 606.5390303369383, 656.5490266510968, 704.8695991241636, 720.2437440687257, 8662.30701543875, 8863.157999989991, 8881.111888811067, 8917.286617070618, 9189.77025574366, 620.314552419579, 637.1048676609371, 640.6668532363145, 650.4698670583459, 672.085963090197, 4176.0, 4229.703920725519, 4243.596858298457, 4247.299195632686, 4480.7145272622465, 106034.0, 107931.46034269936, 110133.44933275282, 135783.0, 138921.3053934744, 101322.0, 104622.0, 105291.4735426318, 105672.47163764131, 113659.0, 92766.53616731873, 92832.53583732173, 93746.0, 93878.53060734789, 94029.0, 9576.808463830825, 9887.653932112342, 10020.398776073458, 10049.410264584032, 10148.188144948239, 39588.60411395964, 41823.37264941089, 55471.44528554663, 56070.43929560652, 57189.42810571841, 72655.27344726484, 79909.0, 80547.19452805631, 81341.0, 82958.17041829505, 13261.0, 13311.80032299497, 13527.188368697909, 13700.65748356299, 14045.0, 13541.796873046715, 13663.316834158053, 13686.04197706151, 13840.307984600528, 13995.440182392591, 13510.72978540404, 13946.023778335419, 14030.719385612027, 14167.858321416654, 14297.213653249171, 12565.497380105058, 13530.391132399263, 13566.321683915567, 13711.0, 14165.858341416453, 13294.0, 13357.599272021855, 13550.728985420039, 13725.45098196061, 13853.653658658211, 11469.08247340194, 11555.075593952295, 11595.678319235607, 11749.647510574696, 11927.165098443025, 11583.6524904253, 11712.70718232051, 11757.353345566076, 11804.881951180378, 12116.21244619097], "value": 7536.882607420391, "unit": "score"}], "name": "dromaeo_css", "value": 7562.567221289842, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 109.0, 111.0, 111.0, 112.0, 111.0, 110.0, 110.0, 110.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 118.0, 146.0, 117.0, 118.0, 118.0, 116.0, 142.0, 116.0], "value": 125.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 161.0, 160.0, 159.0, 161.0, 159.0, 161.0, 160.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 121.0, 77.0, 76.0, 76.0, 75.0, 100.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 132.0, 81.0, 81.0, 81.0, 106.0, 82.0, 82.0, 114.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 118.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 145.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 49.0, 47.0, 61.0, 47.0, 48.0, 47.0, 48.0, 49.0], "value": 49.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 60.0, 59.0, 59.0, 60.0, 62.0, 59.0, 58.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 73.0, 73.0, 73.0, 73.0, 74.0, 73.0, 73.0, 73.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 123.0, 122.0, 123.0, 128.0, 121.0, 121.0, 119.0, 162.0, 121.0], "value": 126.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 157.0, 158.0, 155.0, 153.0, 155.0, 153.0, 153.0, 155.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 63.0, 63.0, 61.0, 63.0, 65.0, 62.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1455.4, "alertThreshold": 2.0}]} 04:05:15 INFO - Return code: 0 04:05:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:05:15 INFO - # TBPL SUCCESS # 04:05:15 INFO - Running post-action listener: _resource_record_post_action 04:05:15 INFO - [mozharness: 2016-10-31 11:05:15.861746Z] Finished run-tests step (success) 04:05:15 INFO - Running post-run listener: _resource_record_post_run 04:05:15 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 2134016; Write bytes: 356524032; Read time: 828; Write time: 244424 04:05:15 INFO - TinderboxPrint: CPU usage
12.9% 04:05:15 INFO - TinderboxPrint: I/O read bytes / time
2,134,016 / 828 04:05:15 INFO - TinderboxPrint: I/O write bytes / time
356,524,032 / 244,424 04:05:15 INFO - TinderboxPrint: CPU idle
8,270.2 (87.1%) 04:05:15 INFO - TinderboxPrint: CPU user
1,182.7 (12.5%) 04:05:15 INFO - TinderboxPrint: Swap in / out
0 / 0 04:05:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108187648; Read time: 0; Write time: 91824 04:05:15 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248336384; Read time: 20; Write time: 152600 04:05:16 INFO - Running post-run listener: _upload_blobber_files 04:05:16 INFO - Blob upload gear active. 04:05:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:05:16 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 04:05:16 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'] 04:05:16 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 04:05:16 INFO - (blobuploader) - INFO - Open directory for files ... 04:05:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:05:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:05:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:17 INFO - (blobuploader) - INFO - Done attempting. 04:05:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:05:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:05:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:18 INFO - (blobuploader) - INFO - Done attempting. 04:05:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:05:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:05:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:21 INFO - (blobuploader) - INFO - Done attempting. 04:05:21 INFO - (blobuploader) - INFO - Iteration through files over. 04:05:21 INFO - Return code: 0 04:05:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:05:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:05:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dcc0707547cfe63ae408378b63df5b46f2e8de96e4462836ab3b4054216142e8a900c968b1779846756cca2e85f7b1fe94c971361d5511fb024e9d1a019cea38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3fc366c4380ac6dad9bf3c94cd59962f8c59838c8b3386001ab4a852d0e124fa2cab8bd7acda9e624dfbeec06db6edbe43ff1a06c6da972cfd36b0cf8a8304e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d282ec3d9a8e98e60d41a7ca4ec8bceb6dbfa44820ff6cf7bf833750875639a7dd34b43df77c2bacef8e667d138584fefd064fdb49551a41c8d818d555060222"} 04:05:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:05:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:05:21 INFO - Contents: 04:05:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dcc0707547cfe63ae408378b63df5b46f2e8de96e4462836ab3b4054216142e8a900c968b1779846756cca2e85f7b1fe94c971361d5511fb024e9d1a019cea38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3fc366c4380ac6dad9bf3c94cd59962f8c59838c8b3386001ab4a852d0e124fa2cab8bd7acda9e624dfbeec06db6edbe43ff1a06c6da972cfd36b0cf8a8304e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d282ec3d9a8e98e60d41a7ca4ec8bceb6dbfa44820ff6cf7bf833750875639a7dd34b43df77c2bacef8e667d138584fefd064fdb49551a41c8d818d555060222"} 04:05:21 INFO - Running post-run listener: copy_logs_to_upload_dir 04:05:21 INFO - Copying logs to upload dir... 04:05:21 INFO - mkdir: /builds/slave/test/build/upload/logs 04:05:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.528309 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-31 04:05:21.387661) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 04:05:21.390716) ========= 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=db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470 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/dcc0707547cfe63ae408378b63df5b46f2e8de96e4462836ab3b4054216142e8a900c968b1779846756cca2e85f7b1fe94c971361d5511fb024e9d1a019cea38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3fc366c4380ac6dad9bf3c94cd59962f8c59838c8b3386001ab4a852d0e124fa2cab8bd7acda9e624dfbeec06db6edbe43ff1a06c6da972cfd36b0cf8a8304e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d282ec3d9a8e98e60d41a7ca4ec8bceb6dbfa44820ff6cf7bf833750875639a7dd34b43df77c2bacef8e667d138584fefd064fdb49551a41c8d818d555060222"} build_url:https://queue.taskcluster.net/v1/task/E9mDJZOyS7yzO1kGwwYvrA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/E9mDJZOyS7yzO1kGwwYvrA/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/dcc0707547cfe63ae408378b63df5b46f2e8de96e4462836ab3b4054216142e8a900c968b1779846756cca2e85f7b1fe94c971361d5511fb024e9d1a019cea38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3fc366c4380ac6dad9bf3c94cd59962f8c59838c8b3386001ab4a852d0e124fa2cab8bd7acda9e624dfbeec06db6edbe43ff1a06c6da972cfd36b0cf8a8304e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d282ec3d9a8e98e60d41a7ca4ec8bceb6dbfa44820ff6cf7bf833750875639a7dd34b43df77c2bacef8e667d138584fefd064fdb49551a41c8d818d555060222"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 04:05:21.415467) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 04:05:21.415793) ========= 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=db7e7c15f3ca076d53731445000001ba-1477910610.125982-1833765470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 04:05:21.466213) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 04:05:21.466534) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 04:05:21.466829) ========= ========= Total master_lag: 0.31 =========