builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1475685905.48 results: success (0) buildid: 20161005064100 builduid: 39057611c7cb49e69257f49fe56ae0fe revision: f4eca83603d1891caf183f8e7bed1760caef144f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 09:45:05.477841) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 09:45:05.478291) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 09:45:05.478562) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 09:45:05.493336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 09:45:05.493918) ========= 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=fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-05 09:45:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.3M=0s 2016-10-05 09:45:05 (51.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148728 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 09:45:05.657792) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 09:45:05.658394) ========= 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=fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019094 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 09:45:05.709250) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-05 09:45:05.709608) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f4eca83603d1891caf183f8e7bed1760caef144f --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 f4eca83603d1891caf183f8e7bed1760caef144f --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=fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-05 09:45:05,881 truncating revision to first 12 chars 2016-10-05 09:45:05,881 Setting DEBUG logging. 2016-10-05 09:45:05,881 attempt 1/10 2016-10-05 09:45:05,882 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f4eca83603d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-05 09:45:06,252 unpacking tar archive at: mozilla-aurora-f4eca83603d1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.797644 ========= master_lag: 0.67 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-05 09:45:07.174543) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 09:45:07.175078) ========= script_repo_revision: f4eca83603d1891caf183f8e7bed1760caef144f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 09:45:07.175763) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 09:45:07.176091) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 09:45:07.193198) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 9 secs) (at 2016-10-05 09:45:07.193613) ========= /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=fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:45:07 INFO - MultiFileLogger online at 20161005 09:45:07 in /builds/slave/test 09:45:07 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 09:45:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:45:07 INFO - {'append_to_log': False, 09:45:07 INFO - 'base_work_dir': '/builds/slave/test', 09:45:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:45:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:45:07 INFO - 'branch': 'Mozilla-Aurora', 09:45:07 INFO - 'buildbot_json_path': 'buildprops.json', 09:45:07 INFO - 'config_files': ('talos/linux_config.py',), 09:45:07 INFO - 'default_actions': ('clobber', 09:45:07 INFO - 'read-buildbot-config', 09:45:07 INFO - 'download-and-extract', 09:45:07 INFO - 'populate-webroot', 09:45:07 INFO - 'create-virtualenv', 09:45:07 INFO - 'install', 09:45:07 INFO - 'run-tests'), 09:45:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:45:07 INFO - 'download_minidump_stackwalk': True, 09:45:07 INFO - 'download_symbols': 'ondemand', 09:45:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:45:07 INFO - 'tooltool.py': '/tools/tooltool.py', 09:45:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:45:07 INFO - '/tools/misc-python/virtualenv.py')}, 09:45:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:45:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:45:07 INFO - 'installer_path': 'installer.exe', 09:45:07 INFO - 'log_level': 'info', 09:45:07 INFO - 'log_name': 'talos', 09:45:07 INFO - 'log_to_console': True, 09:45:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:45:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:45:07 INFO - 'opt_config_files': (), 09:45:07 INFO - 'pip_index': False, 09:45:07 INFO - 'sps_profile': False, 09:45:07 INFO - 'sps_profile_interval': 0, 09:45:07 INFO - 'suite': 'dromaeojs', 09:45:07 INFO - 'system_bits': '32', 09:45:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:45:07 INFO - 'title': 'talos-linux64-ix-048', 09:45:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:45:07 INFO - 'use_talos_json': True, 09:45:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:45:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:45:07 INFO - 'work_dir': 'build'} 09:45:07 INFO - [mozharness: 2016-10-05 16:45:07.462725Z] Running clobber step. 09:45:07 INFO - Running pre-action listener: _resource_record_pre_action 09:45:07 INFO - Running main action method: clobber 09:45:07 INFO - rmtree: /builds/slave/test/build 09:45:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:45:08 INFO - Running post-action listener: _resource_record_post_action 09:45:08 INFO - [mozharness: 2016-10-05 16:45:08.439980Z] Finished clobber step (success) 09:45:08 INFO - [mozharness: 2016-10-05 16:45:08.440079Z] Running read-buildbot-config step. 09:45:08 INFO - Running pre-action listener: _resource_record_pre_action 09:45:08 INFO - Running main action method: read_buildbot_config 09:45:08 INFO - Using buildbot properties: 09:45:08 INFO - { 09:45:08 INFO - "project": "", 09:45:08 INFO - "product": "firefox", 09:45:08 INFO - "script_repo_revision": "production", 09:45:08 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:45:08 INFO - "repository": "", 09:45:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:45:08 INFO - "buildid": "20161005064100", 09:45:08 INFO - "pgo_build": "True", 09:45:08 INFO - "basedir": "/builds/slave/test", 09:45:08 INFO - "buildnumber": 808, 09:45:08 INFO - "slavename": "talos-linux64-ix-048", 09:45:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:45:08 INFO - "platform": "ubuntu64_hw", 09:45:08 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:45:08 INFO - "branch": "mozilla-aurora", 09:45:08 INFO - "repo_path": "releases/mozilla-aurora", 09:45:08 INFO - "revision": "f4eca83603d1891caf183f8e7bed1760caef144f", 09:45:08 INFO - "stage_platform": "linux64-pgo", 09:45:08 INFO - "builduid": "39057611c7cb49e69257f49fe56ae0fe", 09:45:08 INFO - "slavebuilddir": "test" 09:45:08 INFO - } 09:45:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/eP0uvdQ6SIuVZDp_q8PWZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 09:45:08 INFO - Running post-action listener: _resource_record_post_action 09:45:08 INFO - [mozharness: 2016-10-05 16:45:08.442542Z] Finished read-buildbot-config step (success) 09:45:08 INFO - [mozharness: 2016-10-05 16:45:08.442630Z] Running download-and-extract step. 09:45:08 INFO - Running pre-action listener: _resource_record_pre_action 09:45:08 INFO - Running main action method: download_and_extract 09:45:08 INFO - mkdir: /builds/slave/test/build/tests 09: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')]} 09:45:08 INFO - trying https://queue.taskcluster.net/v1/task/eP0uvdQ6SIuVZDp_q8PWZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 09:45:08 INFO - Downloading https://queue.taskcluster.net/v1/task/eP0uvdQ6SIuVZDp_q8PWZg/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 09:45:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eP0uvdQ6SIuVZDp_q8PWZg/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 09:45:09 INFO - Downloaded 1361 bytes. 09:45:09 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 09:45:09 INFO - Using the following test package requirements: 09:45:09 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 09:45:09 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:45:09 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:45:09 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:45:09 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:45:09 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:45:09 INFO - u'jsshell-linux-x86_64.zip'], 09:45:09 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:45:09 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:45:09 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 09:45:09 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:45:09 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:45:09 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:45:09 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:45:09 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:45:09 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:45:09 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:45:09 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:45:09 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:45:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eP0uvdQ6SIuVZDp_q8PWZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 09:45:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eP0uvdQ6SIuVZDp_q8PWZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:45:09 INFO - Fetch https://queue.taskcluster.net/v1/task/eP0uvdQ6SIuVZDp_q8PWZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:45:09 INFO - Expected file size: 21906314 09:45:13 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 09:45:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eP0uvdQ6SIuVZDp_q8PWZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 09:45:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eP0uvdQ6SIuVZDp_q8PWZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:45:13 INFO - Fetch https://queue.taskcluster.net/v1/task/eP0uvdQ6SIuVZDp_q8PWZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:45:14 INFO - Expected file size: 21906314 09:45:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eP0uvdQ6SIuVZDp_q8PWZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 09:45:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eP0uvdQ6SIuVZDp_q8PWZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:45:19 INFO - Fetch https://queue.taskcluster.net/v1/task/eP0uvdQ6SIuVZDp_q8PWZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:45:19 INFO - Expected file size: 14414059 09:45:20 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')]} 09:45:20 INFO - trying https://queue.taskcluster.net/v1/task/eP0uvdQ6SIuVZDp_q8PWZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 09:45:20 INFO - Downloading https://queue.taskcluster.net/v1/task/eP0uvdQ6SIuVZDp_q8PWZg/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 09:45:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eP0uvdQ6SIuVZDp_q8PWZg/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 09:45:21 INFO - Downloaded 63925287 bytes. 09:45:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eP0uvdQ6SIuVZDp_q8PWZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 09:45:21 INFO - mkdir: /builds/slave/test/properties 09:45:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:45:21 INFO - Writing to file /builds/slave/test/properties/build_url 09:45:21 INFO - Contents: 09:45:21 INFO - build_url:https://queue.taskcluster.net/v1/task/eP0uvdQ6SIuVZDp_q8PWZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 09:45:22 INFO - Running post-action listener: _resource_record_post_action 09:45:22 INFO - Running post-action listener: set_extra_try_arguments 09:45:22 INFO - [mozharness: 2016-10-05 16:45:22.042653Z] Finished download-and-extract step (success) 09:45:22 INFO - [mozharness: 2016-10-05 16:45:22.042884Z] Running populate-webroot step. 09:45:22 INFO - Running pre-action listener: _resource_record_pre_action 09:45:22 INFO - Running main action method: populate_webroot 09:45:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:45:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:45:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:45:22 INFO - '--tppagecycles', 09:45:22 INFO - '7'], 09:45:22 INFO - 'tests': ['tsvgm']}}, 09:45:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:45:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:45:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:45:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:45:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:45:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:45:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:22 INFO - 'talos_options': ['--disable-e10s'], 09:45:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:22 INFO - 'talos_options': ['--disable-e10s'], 09:45:22 INFO - 'tests': ['damp', 'tps']}, 09:45:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:22 INFO - 'tests': ['damp', 'tps']}, 09:45:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:45:22 INFO - 'tests': ['dromaeo_dom']}, 09:45:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:45:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:45:22 INFO - 'tests': ['basic_compositor_video']}, 09:45:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:45:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:45:22 INFO - 'tests': ['a11yr', 09:45:22 INFO - 'ts_paint', 09:45:22 INFO - 'tpaint', 09:45:22 INFO - 'sessionrestore', 09:45:22 INFO - 'sessionrestore_no_auto_restore', 09:45:22 INFO - 'tabpaint']}, 09:45:22 INFO - 'other-e10s': {'tests': ['a11yr', 09:45:22 INFO - 'ts_paint', 09:45:22 INFO - 'tpaint', 09:45:22 INFO - 'sessionrestore', 09:45:22 INFO - 'sessionrestore_no_auto_restore', 09:45:22 INFO - 'tabpaint']}, 09:45:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:45:22 INFO - 'ts_paint', 09:45:22 INFO - 'tpaint', 09:45:22 INFO - 'sessionrestore', 09:45:22 INFO - 'sessionrestore_no_auto_restore', 09:45:22 INFO - 'tabpaint']}, 09:45:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:45:22 INFO - 'ts_paint', 09:45:22 INFO - 'tpaint', 09:45:22 INFO - 'sessionrestore', 09:45:22 INFO - 'sessionrestore_no_auto_restore', 09:45:22 INFO - 'tabpaint']}, 09:45:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:45:22 INFO - 'tests': ['a11yr', 09:45:22 INFO - 'ts_paint', 09:45:22 INFO - 'tpaint', 09:45:22 INFO - 'sessionrestore', 09:45:22 INFO - 'sessionrestore_no_auto_restore', 09:45:22 INFO - 'tabpaint']}, 09:45:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:45:22 INFO - 'tests': ['a11yr', 09:45:22 INFO - 'ts_paint', 09:45:22 INFO - 'tpaint', 09:45:22 INFO - 'sessionrestore', 09:45:22 INFO - 'sessionrestore_no_auto_restore', 09:45:22 INFO - 'tabpaint']}, 09:45:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:45:22 INFO - 'tests': ['tsvgx', 09:45:22 INFO - 'tsvgr_opacity', 09:45:22 INFO - 'tart', 09:45:22 INFO - 'tscrollx', 09:45:22 INFO - 'cart']}, 09:45:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:45:22 INFO - 'tsvgr_opacity', 09:45:22 INFO - 'tart', 09:45:22 INFO - 'tscrollx', 09:45:22 INFO - 'cart']}, 09:45:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:22 INFO - 'talos_options': ['--disable-e10s'], 09:45:22 INFO - 'tests': ['tp5o']}, 09:45:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:22 INFO - 'tests': ['tp5o']}, 09:45:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:22 INFO - 'talos_options': ['--disable-e10s', 09:45:22 INFO - '--xperf_path', 09:45:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:22 INFO - 'tests': ['tp5n']}, 09:45:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:22 INFO - 'talos_options': ['--xperf_path', 09:45:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:22 INFO - 'tests': ['tp5n']}}, 09:45:22 INFO - 'talos.zip': {'path': '', 09:45:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:45:22 INFO - Running post-action listener: _resource_record_post_action 09:45:22 INFO - [mozharness: 2016-10-05 16:45:22.062342Z] Finished populate-webroot step (success) 09:45:22 INFO - [mozharness: 2016-10-05 16:45:22.062431Z] Running create-virtualenv step. 09:45:22 INFO - Running pre-action listener: _resource_record_pre_action 09:45:22 INFO - Running main action method: create_virtualenv 09:45:22 INFO - Creating virtualenv /builds/slave/test/build/venv 09:45:22 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 09:45:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:45:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:45:22 INFO - Using real prefix '/usr' 09:45:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:45:22 INFO - Installing distribute.............................................................................................................................................................................................done. 09:45:24 INFO - Installing pip.................done. 09:45:24 INFO - Return code: 0 09:45:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09: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')]} 09:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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')]} 09:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8dc627f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c23f60>, '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 0x1c24d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c251d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', '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 09:45:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:45:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:45:24 INFO - Using env: {'DISPLAY': ':0', 09:45:24 INFO - 'HOME': '/home/cltbld', 09:45:24 INFO - 'LANG': 'en_US.UTF-8', 09:45:24 INFO - 'LANGUAGE': 'en_US:en', 09:45:24 INFO - 'LOGNAME': 'cltbld', 09:45:24 INFO - 'MAIL': '/var/mail/cltbld', 09:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:24 INFO - 'MOZ_NO_REMOTE': '1', 09:45:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:24 INFO - 'NO_EM_RESTART': '1', 09:45:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:24 INFO - 'PWD': '/builds/slave/test', 09:45:24 INFO - 'SHELL': '/bin/bash', 09:45:24 INFO - 'SHLVL': '1', 09:45:24 INFO - 'TERM': 'linux', 09:45:24 INFO - 'TMOUT': '86400', 09:45:24 INFO - 'USER': 'cltbld', 09:45:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', 09:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:24 INFO - '_': '/tools/buildbot/bin/python'} 09:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:24 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 09:45:24 INFO - Cleaning up... 09:45:24 INFO - Return code: 0 09:45:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09: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')]} 09:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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')]} 09:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb8dc627f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c23f60>, '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 0x1c24d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c251d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', '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 09:45:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:45:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:45:24 INFO - Using env: {'DISPLAY': ':0', 09:45:24 INFO - 'HOME': '/home/cltbld', 09:45:24 INFO - 'LANG': 'en_US.UTF-8', 09:45:24 INFO - 'LANGUAGE': 'en_US:en', 09:45:24 INFO - 'LOGNAME': 'cltbld', 09:45:24 INFO - 'MAIL': '/var/mail/cltbld', 09:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:24 INFO - 'MOZ_NO_REMOTE': '1', 09:45:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:24 INFO - 'NO_EM_RESTART': '1', 09:45:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:24 INFO - 'PWD': '/builds/slave/test', 09:45:24 INFO - 'SHELL': '/bin/bash', 09:45:24 INFO - 'SHLVL': '1', 09:45:24 INFO - 'TERM': 'linux', 09:45:24 INFO - 'TMOUT': '86400', 09:45:24 INFO - 'USER': 'cltbld', 09:45:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', 09:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:24 INFO - '_': '/tools/buildbot/bin/python'} 09:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:25 INFO - Downloading/unpacking psutil>=3.1.1 09:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:47:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:47:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:47:32 INFO - Installing collected packages: psutil 09:47:32 INFO - Running setup.py install for psutil 09:47:32 INFO - building 'psutil._psutil_linux' extension 09:47:32 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 09:47:32 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 09:47:32 INFO - building 'psutil._psutil_posix' extension 09:47:32 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 09:47:32 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 09:47:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:47:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:47:32 INFO - Successfully installed psutil 09:47:32 INFO - Cleaning up... 09:47:32 INFO - Return code: 0 09:47:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:47:32 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')]} 09:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:32 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')]} 09:47:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:32 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 0x7fb8dc627f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c23f60>, '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 0x1c24d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c251d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', '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 09:47:32 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 09:47:32 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 09:47:32 INFO - Using env: {'DISPLAY': ':0', 09:47:32 INFO - 'HOME': '/home/cltbld', 09:47:32 INFO - 'LANG': 'en_US.UTF-8', 09:47:32 INFO - 'LANGUAGE': 'en_US:en', 09:47:32 INFO - 'LOGNAME': 'cltbld', 09:47:32 INFO - 'MAIL': '/var/mail/cltbld', 09:47:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:32 INFO - 'MOZ_NO_REMOTE': '1', 09:47:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:32 INFO - 'NO_EM_RESTART': '1', 09:47:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:32 INFO - 'PWD': '/builds/slave/test', 09:47:32 INFO - 'SHELL': '/bin/bash', 09:47:32 INFO - 'SHLVL': '1', 09:47:32 INFO - 'TERM': 'linux', 09:47:32 INFO - 'TMOUT': '86400', 09:47:32 INFO - 'USER': 'cltbld', 09:47:32 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', 09:47:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:32 INFO - '_': '/tools/buildbot/bin/python'} 09:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:47:33 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 09:47:33 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 09:47:33 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 09:47:33 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 09:47:33 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 09:47:33 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 09:48:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:48:06 INFO - Installing collected packages: mozsystemmonitor 09:48:06 INFO - Running setup.py install for mozsystemmonitor 09:48:06 INFO - Successfully installed mozsystemmonitor 09:48:06 INFO - Cleaning up... 09:48:06 INFO - Return code: 0 09:48:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:48:06 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')]} 09:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:06 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')]} 09:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:06 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 0x7fb8dc627f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c23f60>, '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 0x1c24d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c251d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', '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 09:48:06 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 09:48:06 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 09:48:06 INFO - Using env: {'DISPLAY': ':0', 09:48:06 INFO - 'HOME': '/home/cltbld', 09:48:06 INFO - 'LANG': 'en_US.UTF-8', 09:48:06 INFO - 'LANGUAGE': 'en_US:en', 09:48:06 INFO - 'LOGNAME': 'cltbld', 09:48:06 INFO - 'MAIL': '/var/mail/cltbld', 09:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:06 INFO - 'MOZ_NO_REMOTE': '1', 09:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:06 INFO - 'NO_EM_RESTART': '1', 09:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:06 INFO - 'PWD': '/builds/slave/test', 09:48:06 INFO - 'SHELL': '/bin/bash', 09:48:06 INFO - 'SHLVL': '1', 09:48:06 INFO - 'TERM': 'linux', 09:48:06 INFO - 'TMOUT': '86400', 09:48:06 INFO - 'USER': 'cltbld', 09:48:06 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', 09:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:06 INFO - '_': '/tools/buildbot/bin/python'} 09:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:06 INFO - Downloading/unpacking jsonschema==2.5.1 09:48:06 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 09:48:06 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 09:48:06 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 09:48:06 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 09:48:06 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 09:48:06 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 09:48:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:48:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:08 INFO - Downloading functools32-3.2.3-2.tar.gz 09:48:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:48:08 INFO - warning: no files found matching '*.txt' 09:48:08 INFO - no previously-included directories found matching 'build' 09:48:08 INFO - no previously-included directories found matching 'dist' 09:48:08 INFO - no previously-included directories found matching '.git*' 09:48:08 INFO - Installing collected packages: jsonschema, functools32 09:48:08 INFO - Running setup.py install for functools32 09:48:08 INFO - warning: no files found matching '*.txt' 09:48:08 INFO - no previously-included directories found matching 'build' 09:48:08 INFO - no previously-included directories found matching 'dist' 09:48:08 INFO - no previously-included directories found matching '.git*' 09:48:08 INFO - Successfully installed jsonschema functools32 09:48:08 INFO - Cleaning up... 09:48:08 INFO - Return code: 0 09:48:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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')]} 09:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8dc627f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c23f60>, '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 0x1c24d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c251d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', '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 09:48:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:48:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:48:08 INFO - Using env: {'DISPLAY': ':0', 09:48:08 INFO - 'HOME': '/home/cltbld', 09:48:08 INFO - 'LANG': 'en_US.UTF-8', 09:48:08 INFO - 'LANGUAGE': 'en_US:en', 09:48:08 INFO - 'LOGNAME': 'cltbld', 09:48:08 INFO - 'MAIL': '/var/mail/cltbld', 09:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:08 INFO - 'MOZ_NO_REMOTE': '1', 09:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:08 INFO - 'NO_EM_RESTART': '1', 09:48:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:08 INFO - 'PWD': '/builds/slave/test', 09:48:08 INFO - 'SHELL': '/bin/bash', 09:48:08 INFO - 'SHLVL': '1', 09:48:08 INFO - 'TERM': 'linux', 09:48:08 INFO - 'TMOUT': '86400', 09:48:08 INFO - 'USER': 'cltbld', 09:48:08 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', 09:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:08 INFO - '_': '/tools/buildbot/bin/python'} 09:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:48:09 INFO - Cleaning up... 09:48:09 INFO - Return code: 0 09:48:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:09 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 0x7fb8dc627f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c23f60>, '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 0x1c24d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c251d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', '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 09:48:09 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 09:48:09 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 09:48:09 INFO - Using env: {'DISPLAY': ':0', 09:48:09 INFO - 'HOME': '/home/cltbld', 09:48:09 INFO - 'LANG': 'en_US.UTF-8', 09:48:09 INFO - 'LANGUAGE': 'en_US:en', 09:48:09 INFO - 'LOGNAME': 'cltbld', 09:48:09 INFO - 'MAIL': '/var/mail/cltbld', 09:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:09 INFO - 'MOZ_NO_REMOTE': '1', 09:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:09 INFO - 'NO_EM_RESTART': '1', 09:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:09 INFO - 'PWD': '/builds/slave/test', 09:48:09 INFO - 'SHELL': '/bin/bash', 09:48:09 INFO - 'SHLVL': '1', 09:48:09 INFO - 'TERM': 'linux', 09:48:09 INFO - 'TMOUT': '86400', 09:48:09 INFO - 'USER': 'cltbld', 09:48:09 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', 09:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:09 INFO - '_': '/tools/buildbot/bin/python'} 09:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:09 INFO - Downloading/unpacking blobuploader==1.2.4 09:48:09 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 09:48:09 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 09:48:09 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 09:48:09 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 09:48:09 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 09:48:09 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 09:48:11 INFO - Downloading blobuploader-1.2.4.tar.gz 09:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:48:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:48:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:11 INFO - Downloading docopt-0.6.1.tar.gz 09:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:48:11 INFO - Installing collected packages: blobuploader, requests, docopt 09:48:11 INFO - Running setup.py install for blobuploader 09:48:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:48:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:48:12 INFO - Running setup.py install for requests 09:48:12 INFO - Running setup.py install for docopt 09:48:12 INFO - Successfully installed blobuploader requests docopt 09:48:12 INFO - Cleaning up... 09:48:12 INFO - Return code: 0 09:48:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8dc627f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c23f60>, '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 0x1c24d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c251d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', '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 09:48:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:48:12 INFO - Using env: {'DISPLAY': ':0', 09:48:12 INFO - 'HOME': '/home/cltbld', 09:48:12 INFO - 'LANG': 'en_US.UTF-8', 09:48:12 INFO - 'LANGUAGE': 'en_US:en', 09:48:12 INFO - 'LOGNAME': 'cltbld', 09:48:12 INFO - 'MAIL': '/var/mail/cltbld', 09:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:12 INFO - 'MOZ_NO_REMOTE': '1', 09:48:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:12 INFO - 'NO_EM_RESTART': '1', 09:48:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:12 INFO - 'PWD': '/builds/slave/test', 09:48:12 INFO - 'SHELL': '/bin/bash', 09:48:12 INFO - 'SHLVL': '1', 09:48:12 INFO - 'TERM': 'linux', 09:48:12 INFO - 'TMOUT': '86400', 09:48:12 INFO - 'USER': 'cltbld', 09:48:12 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', 09:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:12 INFO - '_': '/tools/buildbot/bin/python'} 09:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:12 INFO - Running setup.py (path:/tmp/pip-guJwfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:12 INFO - Running setup.py (path:/tmp/pip-uhCLbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:12 INFO - Running setup.py (path:/tmp/pip-9zCBc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:13 INFO - Running setup.py (path:/tmp/pip-HR_Esg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:13 INFO - Running setup.py (path:/tmp/pip-a1BlNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:13 INFO - Running setup.py (path:/tmp/pip-DNHjvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:13 INFO - Running setup.py (path:/tmp/pip-LRb3qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:13 INFO - Running setup.py (path:/tmp/pip-ljZYRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:13 INFO - Running setup.py (path:/tmp/pip-gyaETI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:13 INFO - Running setup.py (path:/tmp/pip-O0onEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:13 INFO - Running setup.py (path:/tmp/pip-HOwFvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:13 INFO - Running setup.py (path:/tmp/pip-t7tSTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:13 INFO - Running setup.py (path:/tmp/pip-pProXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:13 INFO - Running setup.py (path:/tmp/pip-Yes9UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:13 INFO - Running setup.py (path:/tmp/pip-d3YLkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:13 INFO - Running setup.py (path:/tmp/pip-7GHCI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:13 INFO - Running setup.py (path:/tmp/pip-aGV5l3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:48:14 INFO - Running setup.py install for manifestparser 09:48:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:48:14 INFO - Running setup.py install for mozcrash 09:48:14 INFO - Running setup.py install for mozdebug 09:48:14 INFO - Running setup.py install for mozdevice 09:48:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:48:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:48:14 INFO - Running setup.py install for mozfile 09:48:14 INFO - Running setup.py install for mozhttpd 09:48:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:48:14 INFO - Running setup.py install for mozinfo 09:48:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:48:14 INFO - Running setup.py install for mozInstall 09:48:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:48:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:48:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:48:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:48:14 INFO - Running setup.py install for mozleak 09:48:14 INFO - Running setup.py install for mozlog 09:48:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:48:15 INFO - Running setup.py install for moznetwork 09:48:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:48:15 INFO - Running setup.py install for mozprocess 09:48:15 INFO - Running setup.py install for mozprofile 09:48:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:48:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:48:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:48:15 INFO - Running setup.py install for mozrunner 09:48:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:48:15 INFO - Running setup.py install for mozscreenshot 09:48:15 INFO - Running setup.py install for moztest 09:48:15 INFO - Running setup.py install for mozversion 09:48:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:48:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:48:15 INFO - Cleaning up... 09:48:15 INFO - Return code: 0 09:48:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8dc627f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c23f60>, '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 0x1c24d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c251d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', '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 09:48:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:48:15 INFO - Using env: {'DISPLAY': ':0', 09:48:15 INFO - 'HOME': '/home/cltbld', 09:48:15 INFO - 'LANG': 'en_US.UTF-8', 09:48:15 INFO - 'LANGUAGE': 'en_US:en', 09:48:15 INFO - 'LOGNAME': 'cltbld', 09:48:15 INFO - 'MAIL': '/var/mail/cltbld', 09:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:15 INFO - 'MOZ_NO_REMOTE': '1', 09:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:15 INFO - 'NO_EM_RESTART': '1', 09:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:15 INFO - 'PWD': '/builds/slave/test', 09:48:15 INFO - 'SHELL': '/bin/bash', 09:48:15 INFO - 'SHLVL': '1', 09:48:15 INFO - 'TERM': 'linux', 09:48:15 INFO - 'TMOUT': '86400', 09:48:15 INFO - 'USER': 'cltbld', 09:48:15 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', 09:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:15 INFO - '_': '/tools/buildbot/bin/python'} 09:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:16 INFO - Running setup.py (path:/tmp/pip-hLCUrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:16 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)) 09:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:16 INFO - Running setup.py (path:/tmp/pip-7QQ1_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:16 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)) 09:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:16 INFO - Running setup.py (path:/tmp/pip-GIgCt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:16 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)) 09:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:16 INFO - Running setup.py (path:/tmp/pip-zZm3IE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:16 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)) 09:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:16 INFO - Running setup.py (path:/tmp/pip-7ffVnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:16 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)) 09:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:16 INFO - Running setup.py (path:/tmp/pip-jw6StN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:16 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)) 09:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:16 INFO - Running setup.py (path:/tmp/pip-0HVW1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:16 INFO - Running setup.py (path:/tmp/pip-gtu6Fo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:16 INFO - Running setup.py (path:/tmp/pip-hbMPBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:16 INFO - Running setup.py (path:/tmp/pip-p1e7__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:16 INFO - Running setup.py (path:/tmp/pip-D8M90o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:16 INFO - Running setup.py (path:/tmp/pip-7_3dCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:16 INFO - Running setup.py (path:/tmp/pip-fyev1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:16 INFO - Running setup.py (path:/tmp/pip-bHTsWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:17 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)) 09:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:17 INFO - Running setup.py (path:/tmp/pip-5KHjaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:17 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)) 09:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:17 INFO - Running setup.py (path:/tmp/pip-4r55dB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:17 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)) 09:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:17 INFO - Running setup.py (path:/tmp/pip-mRWHX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:17 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)) 09:48:17 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)) 09:48:17 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)) 09:48:17 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)) 09:48:17 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)) 09:48:17 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)) 09:48:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:48:17 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 09:48:17 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 09:48:17 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 09:48:17 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 09:48:17 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 09:48:17 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 09:48:19 INFO - Downloading blessings-1.6.tar.gz 09:48:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:48:19 INFO - Installing collected packages: blessings 09:48:19 INFO - Running setup.py install for blessings 09:48:19 INFO - Successfully installed blessings 09:48:19 INFO - Cleaning up... 09:48:19 INFO - Return code: 0 09:48:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:48:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:19 INFO - Reading from file tmpfile_stdout 09:48:19 INFO - Current package versions: 09:48:19 INFO - argparse == 1.2.1 09:48:19 INFO - blessings == 1.6 09:48:19 INFO - blobuploader == 1.2.4 09:48:19 INFO - docopt == 0.6.1 09:48:19 INFO - functools32 == 3.2.3-2 09:48:19 INFO - jsonschema == 2.5.1 09:48:19 INFO - manifestparser == 1.1 09:48:19 INFO - mozInstall == 1.12 09:48:19 INFO - mozcrash == 0.17 09:48:19 INFO - mozdebug == 0.1 09:48:19 INFO - mozdevice == 0.48 09:48:19 INFO - mozfile == 1.2 09:48:19 INFO - mozhttpd == 0.7 09:48:19 INFO - mozinfo == 0.9 09:48:19 INFO - mozleak == 0.1 09:48:19 INFO - mozlog == 3.4 09:48:19 INFO - moznetwork == 0.27 09:48:19 INFO - mozprocess == 0.23 09:48:19 INFO - mozprofile == 0.28 09:48:19 INFO - mozrunner == 6.12 09:48:19 INFO - mozscreenshot == 0.1 09:48:19 INFO - mozsystemmonitor == 0.3 09:48:19 INFO - moztest == 0.7 09:48:19 INFO - mozversion == 1.4 09:48:19 INFO - psutil == 3.1.1 09:48:19 INFO - requests == 1.2.3 09:48:19 INFO - wsgiref == 0.1.2 09:48:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8dc627f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c23f60>, '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 0x1c24d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c251d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', '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 09:48:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:48:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:48:19 INFO - Using env: {'DISPLAY': ':0', 09:48:19 INFO - 'HOME': '/home/cltbld', 09:48:19 INFO - 'LANG': 'en_US.UTF-8', 09:48:19 INFO - 'LANGUAGE': 'en_US:en', 09:48:19 INFO - 'LOGNAME': 'cltbld', 09:48:19 INFO - 'MAIL': '/var/mail/cltbld', 09:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:19 INFO - 'MOZ_NO_REMOTE': '1', 09:48:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:19 INFO - 'NO_EM_RESTART': '1', 09:48:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:19 INFO - 'PWD': '/builds/slave/test', 09:48:19 INFO - 'SHELL': '/bin/bash', 09:48:19 INFO - 'SHLVL': '1', 09:48:19 INFO - 'TERM': 'linux', 09:48:19 INFO - 'TMOUT': '86400', 09:48:19 INFO - 'USER': 'cltbld', 09:48:19 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', 09:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:19 INFO - '_': '/tools/buildbot/bin/python'} 09:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:48:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:48:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:48:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:48:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:48:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:48:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:48:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:48:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:48:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:48:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:48:19 INFO - Cleaning up... 09:48:19 INFO - Return code: 0 09:48:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8dc627f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c23f60>, '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 0x1c24d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c251d0>, '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': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', '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 09:48:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:48:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:48:19 INFO - Using env: {'DISPLAY': ':0', 09:48:19 INFO - 'HOME': '/home/cltbld', 09:48:19 INFO - 'LANG': 'en_US.UTF-8', 09:48:19 INFO - 'LANGUAGE': 'en_US:en', 09:48:19 INFO - 'LOGNAME': 'cltbld', 09:48:19 INFO - 'MAIL': '/var/mail/cltbld', 09:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:19 INFO - 'MOZ_NO_REMOTE': '1', 09:48:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:19 INFO - 'NO_EM_RESTART': '1', 09:48:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:19 INFO - 'PWD': '/builds/slave/test', 09:48:19 INFO - 'SHELL': '/bin/bash', 09:48:19 INFO - 'SHLVL': '1', 09:48:19 INFO - 'TERM': 'linux', 09:48:19 INFO - 'TMOUT': '86400', 09:48:19 INFO - 'USER': 'cltbld', 09:48:19 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', 09:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:19 INFO - '_': '/tools/buildbot/bin/python'} 09:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:48:20 INFO - Cleaning up... 09:48:20 INFO - Return code: 0 09:48:20 INFO - Running post-action listener: _resource_record_post_action 09:48:20 INFO - Running post-action listener: _start_resource_monitoring 09:48:20 INFO - Starting resource monitoring. 09:48:20 INFO - [mozharness: 2016-10-05 16:48:20.062497Z] Finished create-virtualenv step (success) 09:48:20 INFO - [mozharness: 2016-10-05 16:48:20.062996Z] Running install step. 09:48:20 INFO - Running pre-action listener: _resource_record_pre_action 09:48:20 INFO - Running main action method: install 09:48:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:20 INFO - Reading from file tmpfile_stdout 09:48:20 INFO - Detecting whether we're running mozinstall >=1.0... 09:48:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:48:20 INFO - Reading from file tmpfile_stdout 09:48:20 INFO - Output received: 09:48:20 INFO - Usage: mozinstall [options] installer 09:48:20 INFO - Options: 09:48:20 INFO - -h, --help show this help message and exit 09:48:20 INFO - -d DEST, --destination=DEST 09:48:20 INFO - Directory to install application into. [default: 09:48:20 INFO - "/builds/slave/test"] 09:48:20 INFO - --app=APP Application being installed. [default: firefox] 09:48:20 INFO - mkdir: /builds/slave/test/build/application 09:48:20 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'] 09:48:20 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 09:48:36 INFO - Reading from file tmpfile_stdout 09:48:36 INFO - Output received: 09:48:36 INFO - /builds/slave/test/build/application/firefox/firefox 09:48:36 INFO - Running post-action listener: _resource_record_post_action 09:48:36 INFO - [mozharness: 2016-10-05 16:48:36.297053Z] Finished install step (success) 09:48:36 INFO - [mozharness: 2016-10-05 16:48:36.297388Z] Running run-tests step. 09:48:36 INFO - Running pre-action listener: _resource_record_pre_action 09:48:36 INFO - Running main action method: run_tests 09:48:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:48:36 INFO - Python 2.7.3 09:48:36 INFO - Return code: 0 09:48:36 INFO - grabbing minidump binary from tooltool 09:48:36 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')]} 09:48:36 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 0x1c23f60>, '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 0x1c24d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c251d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:48:36 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 09:48:36 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 09:48:36 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 09:48:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:48:36 INFO - Return code: 0 09:48:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:48:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:48:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:48:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:48:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:48:36 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/eP0uvdQ6SIuVZDp_q8PWZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 09:48:36 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/eP0uvdQ6SIuVZDp_q8PWZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 09:48:36 INFO - Using env: {'DISPLAY': ':0', 09:48:36 INFO - 'HOME': '/home/cltbld', 09:48:36 INFO - 'LANG': 'en_US.UTF-8', 09:48:36 INFO - 'LANGUAGE': 'en_US:en', 09:48:36 INFO - 'LOGNAME': 'cltbld', 09:48:36 INFO - 'MAIL': '/var/mail/cltbld', 09:48:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:48:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:36 INFO - 'MOZ_NO_REMOTE': '1', 09:48:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:48:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:36 INFO - 'NO_EM_RESTART': '1', 09:48:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:36 INFO - 'PWD': '/builds/slave/test', 09:48:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:48:36 INFO - 'SHELL': '/bin/bash', 09:48:36 INFO - 'SHLVL': '1', 09:48:36 INFO - 'TERM': 'linux', 09:48:36 INFO - 'TMOUT': '86400', 09:48:36 INFO - 'USER': 'cltbld', 09:48:36 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765', 09:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:36 INFO - '_': '/tools/buildbot/bin/python'} 09:48:36 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/eP0uvdQ6SIuVZDp_q8PWZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 09:48:36 INFO - mozversion application_buildid: 20161005064100 09:48:36 INFO - mozversion application_changeset: f4eca83603d1891caf183f8e7bed1760caef144f 09:48:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:48:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:48:36 INFO - mozversion application_name: Firefox 09:48:36 INFO - mozversion application_remotingname: firefox-dev 09:48:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:48:36 INFO - mozversion application_vendor: Mozilla 09:48:36 INFO - mozversion application_version: 51.0a2 09:48:36 INFO - mozversion platform_buildid: 20161005064100 09:48:36 INFO - mozversion platform_changeset: f4eca83603d1891caf183f8e7bed1760caef144f 09:48:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:48:36 INFO - mozversion platform_version: 51.0a2 09:48:36 INFO - using testdate: 1475686116 09:48:36 INFO - actual date: 1475686116 09:48:36 INFO - starting webserver on 'localhost:49711' 09:48:36 INFO - SUITE-START | Running 2 tests 09:48:36 INFO - TEST-START | dromaeo_css 09:48:36 INFO - operating with platform_type : linux_ 09:48:36 INFO - Initialising browser for dromaeo_css test... 09:48:36 INFO - TEST-INFO | started process 20582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpueE2gi/profile http://localhost:49711/getInfo.html) 09:48:41 INFO - PROCESS | 20582 | __metrics Screen width/height:1600/1200 09:48:41 INFO - PROCESS | 20582 | colorDepth:24 09:48:41 INFO - PROCESS | 20582 | Browser inner width/height: 1024/697 09:48:41 INFO - PROCESS | 20582 | __metrics 09:48:41 INFO - PROCESS | 20582 | 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" 09:48:41 INFO - PROCESS | 20582 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:48:42 INFO - PROCESS | 20582 | console.error: PushService: 09:48:42 INFO - PROCESS | 20582 | stateChangeProcessEnqueue: Error transitioning state 09:48:42 INFO - PROCESS | 20582 | UnknownError 09:48:42 INFO - TEST-INFO | 20582: exit 0 09:48:42 INFO - Browser initialized. 09:48:42 INFO - Running cycle 1/1 for dromaeo_css test... 09:48:42 INFO - TEST-INFO | started process 20675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpueE2gi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:48:54 INFO - PROCESS | 20675 | RSS: Main: 144576512 09:48:54 INFO - PROCESS | 20675 | 09:49:45 INFO - PROCESS | 20675 | 1475686185405 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] 09:51:54 INFO - PROCESS | 20675 | Cycle 1(1): loaded http://localhost:49711/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49711/tests/dromaeo/cssquery-ext.html) 09:51:55 INFO - PROCESS | 20675 | RSS: Main: 237064192 09:51:55 INFO - PROCESS | 20675 | 09:54:57 INFO - PROCESS | 20675 | Cycle 1(1): loaded http://localhost:49711/tests/dromaeo/cssquery-ext.html (next: http://localhost:49711/tests/dromaeo/cssquery-jquery.html) 09:54:58 INFO - PROCESS | 20675 | RSS: Main: 231960576 09:54:58 INFO - PROCESS | 20675 | 09:58:00 INFO - PROCESS | 20675 | Cycle 1(1): loaded http://localhost:49711/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49711/tests/dromaeo/cssquery-mootools.html) 09:58:01 INFO - PROCESS | 20675 | RSS: Main: 172199936 09:58:01 INFO - PROCESS | 20675 | 10:01:03 INFO - PROCESS | 20675 | Cycle 1(1): loaded http://localhost:49711/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49711/tests/dromaeo/cssquery-prototype.html) 10:01:03 INFO - PROCESS | 20675 | RSS: Main: 173989888 10:01:03 INFO - PROCESS | 20675 | 10:04:06 INFO - PROCESS | 20675 | Cycle 1(1): loaded http://localhost:49711/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49711/tests/dromaeo/cssquery-yui.html) 10:04:06 INFO - PROCESS | 20675 | RSS: Main: 175579136 10:04:06 INFO - PROCESS | 20675 | 10:07:09 INFO - PROCESS | 20675 | Cycle 1(1): loaded http://localhost:49711/tests/dromaeo/cssquery-yui.html (next: http://localhost:49711/tests/dromaeo/cssquery-dojo.html) 10:07:09 INFO - PROCESS | 20675 | RSS: Main: 264814592 10:07:09 INFO - PROCESS | 20675 | 10:07:09 INFO - PROCESS | 20675 | __start_tp_report 10:07:09 INFO - PROCESS | 20675 | _x_x_mozilla_page_load 10:07:09 INFO - PROCESS | 20675 | _x_x_mozilla_page_load_details 10:07:09 INFO - PROCESS | 20675 | |i|pagename|runs| 10:07:09 INFO - PROCESS | 20675 | |0;dojo.html;3060.892868749594;3089.6601373848857;3098.628164620246;3101.72084512394;3143.1827724791547;5334.119870221413;5442.482964118407;5466.262054622624;5517.117261238202;5527.91708124378;5526.143447765593;5537;5539.667619942807;5543.25166102576;5546.195801608765;5013.222950442687;5028.270900719412;5031.924521132186;5060.316857224283;5128.153854614003;4987.301777751118;5062.594992400599;5109.795608175668;5113.437521872591;5141.30592370029;4946.282788995593;4997.500249974992;5020.39755229373;5038.521340472649;5051.722155281458;5037.546620804145;5043.117454445457;5062.645614806984;5116.2069879168785;5147.330846989905;4973.825916092919;5046.369203849519;5085.644004919657;5096;5107.106256405114;5357.651752636066;5368.275282836806;5377.327834020747;5381.865453363658;5405.540529055035;5785.0454674979;5814.389489103625;5823.854403639901;5964.582479226456;5978.671173085479;6006.399360063959;6010.188624535675;6011.729472173763;6017.398260173992;6018.368071352489;5386.91919621206;5404.32445944257;5450.04624190769;5450.945490545084;5478.287822583039;6024.246969128859;6042.486388657014;6046.879062418727;6052.606580572248;6060.818175454743;5792.391798861143;5797.739101740432;5798.1302804579655;5808.273965754281;5822.3304320003745;5737.799177028784;5758.049921762862;5793.159991801165;5829.650220986754;5865.237519122486;5771.278590176228;5776.740046697909;5777.480026797524;5806.506446951972;5810.622309549865;5749.281339832521;5794.449527294901;5811.506021988178;5817.7091145442555;5835.328937172279;4440.911181776411;4473.329000649928;4478.081993191388;4483.641308695296;4488.102379524108;3989.6409323160474;4008.5390180129075;4021.4168945503325;4036.394540818842;4047.3321901886447;5617.21359009739;5618.410066942994;5619.634723742944;5622.987862184764;5628.662280263197;5857.297124345021;5887.558433117448;5922.407759224043;5941.58408911372;5944.375840536768;5542.501174894279;5585.3297604287745;5589.8602534936135;5643.097104463266;5688.715564221772;5140.691558506502;5144.408393034774;5144.614153938394;5148.510891465305;5151.072806894795;5898.705064746659;6065.575409721366;6077.36187700294;6093.4529067417;6118.663473509;5826.417358264309;5848.327442344014;5878.588498805043;5904.409559044061;5987.5808693391045;6091.451769340781;6110.26676798787;6110.480609148272;6114.938850611437;6117.571769976059;5797.101449275369;5802.65184088956;5823.534117270693;5833.737481813413;5849.444302791228;5769.192313076089;5774.422557744192;5878.617889837147;5898.174255604133;5921.585489015728;5872.853178670567;5880.353161152356;5883;5901.852453688693;5925.229720136354;5805.680687562224;5854.853628659318;5858.794942177004;5862.882742345044;5871.735771890189;5626.943730562642;5630.4369563043365;5680.261565996394;5682.147677848356;5823.126531020212;5743.396943320891;5749.338826035059;5756.568257380797;5784.595078344475;5786.6528008317955;5603.299587551556;5632.436756324335;5636.4927156556105;5642.097264437671;5646.322441306905 10:07:09 INFO - PROCESS | 20675 | |1;ext.html;590.8079874040935;607.875385545963;624.1511544299749;629.9842503937401;644.2687549631167;35070.29859402811;37683;45861.54138458615;46929.76535117328;46969.76515117428;48216.75891620537;48450;48539.02921941568;48581.51418485814;48623.27065094026;8384.329253659724;9280.118388753057;9445.338826282163;9446.149846513812;9475.62097516102;8307.37694672899;8588;8589.226969572737;10955.233133680646;11189.44052797361;11389.316641001526;11415.657530274064;11418.54325826966;11431.485583148778;11439.142064345166;11091;11125.666230013112;11160.832587511193;11164.497597608128;11169.441527923653;10873.891261087367;10973.23187376884;10987.175961802897;10993.120550355952;10993.890061099366;45790.54209457896;45940.54059459429;46080;46091.30863037057;46184.76907615441;3608.4226523756074;3673.338799016176;3750.456183853326;3833.041739565109;3893.8902412812213;33504.32991340184;33794.49308260378;33875.83062084674;33946.94477497037;33970;4665.486796452387;4760.809567617292;4795.6163506919365;4846.975765121152;4856.660033797635;263382;265549;265794.9999999981;266438;267847;60039;60510.39489605136;60629;60629.69685151634;60734;40400;41266.58733412628;41633;43298;63873;18866.622667546846;19115.23539058422;19122.139503722366;19125.13936872844;19138.61722765537;13623.455061797615;13625.727485450236;13646.931765341309;13647.863521364858;13649.522266720816;18069.096545172688;18462;18484.907575462035;19337.447543816343;20828.687569686466;7327.340539351484;7334.4499162563025;7359.337659610661;7446.218147094585;7593.886091708629;1018.2668478695327;1058.7776566921034;1072.4208927179236;1118.0217309853879;1147.9560115989323;33837.32325353529;33938.32123357519;34042;34331.31337373288;34525.827370862986;1102.525913857049;1116.5868628607304;1136.676047326508;1163.3427113680743;1205.3912774049224;18026.188821503063;18050.90974545119;18197.36309229197;18215.817841821678;18275.543111422056;567342;574433;574529;575223;576794;62482.37517624856;62907;63080.36919630837;63099.16053777591;63119;1399.9580012599436;1415.3984556563214;1427.06527224668;1441.9495317663832;1454.243793227537;32041.6795832048;33542.83228583939;33773.32453350969;34112;34375.31249375048;54272;59207.70396148164;60571.39428605657;60797;65119.348806513226;487001;489536;493650;495573;495776;36468.27063458769;37066.81466592757;47102.76448617872;47530.76234618805;47965.76017119892;44021.55978440303;49911;50843.74578127086;51340.486595135066;51486;41955;43860.342094869244;43989.34015989699;44639.33041004323;45520;42760.78619606882;42853.357199642654;43358.34962475502;43935;45249.54750452585;42856.5714342865;43247.56752432561;44302.55697442984;44551.77724111488;44588.33117503305;36453.81773091118;38938;38978.80510597429;39547.802260989665;39568.60431395649;28895.5665665011;29032.854835725688;29280.41439171162;29340.70659293465;29906.252343691584 10:07:09 INFO - PROCESS | 20675 | |2;jquery.html;391.26700000496544;417.59076105416693;422.73790250044965;427.9721818081824;447.31560712110485;15505.922470387646;19727.704084438745;21231.57536849262;21382.679259811095;21415.357539273846;19156.329528466507;19651.5087122822;20193.697094543593;21257.68113478299;21399.57200855986;5933.465988061073;5990.460858522732;6216.440520353167;6223.906641400383;6224.968875155618;6029.487493563052;6030.698465076751;6061.45446909778;6095.116208149816;6124.112003759452;5814.680192589406;5936.732847021873;6050.515958723314;6051.939480605203;6059.545534084961;5970.910436343436;5974.61165024272;5983.192269043667;6001.699915004254;6022.488088512482;5338.946610533883;5382.811601593926;5427.9185812212845;5439.048166570834;5462.2079798429;24880.626790598155;24989.62515562268;25062.24813255605;25183.496330073296;25342.493150137077;2268.4782500025085;2409.674693916334;2454.202384225116;2503.7871780898645;2585.8234503300955;10661.680149595524;10943.781124377547;11108.222424430292;11248.718782030433;11297.435128243555;2058.3001779394926;2112.408525612831;2118.3327251915753;2130.3821891651555;2146.098638571804;96584.51707741487;97491;98355.50822245915;98775.50612246964;99003;10433.426161561036;11791.646250612495;11835.763284734257;11974.341411222467;12043.698907527381;14197;15543.766843497357;15712.842871571138;15929.840701593068;16656.33374665024;8298.958505207434;8436.198561136682;8443.95778021106;8570.914290857136;8583.957080214685;8364.874526882102;8391.454555453876;8412.915870841212;8527.147285271423;8556;5118.872028199325;5159.458256882973;5176.223566465061;5185.714785686823;5248.3701955765555;2016.7882372350984;2056.3830850744716;2069.88615626139;2085.4160834966233;2108.5572029873592;1042.6559235452282;1048.475826807324;1072.3726619927274;1075.639660713654;1108.4236197177422;20203.696944545845;21107.577848442947;21294.25470108539;21485.52203298717;21681.783182168292;1000.3397757480028;1033.3316725624154;1053.3048188195908;1059.332620449112;1061.8301071828625;10839.620613278497;11735.823962640396;11889.227200231957;11896.167268291136;11955.880441195477;530367;543538;546092;551658;552763;93628;96081;96582;98138.509307453;102720.48639756754;1051.4322265976286;1066.8559744434558;1084.511969613677;1088.6026600290995;1096.9670909872716;14256.572302830931;16552.75170872462;17715.025673588076;18307.26770929148;18528.44414667562;41960.16079678328;44030.779846100566;45317.32024019576;45760.7711961438;47056.52943470521;59584;59929.700351497966;60996.69501652463;61682.38317616766;62364.37635623767;9186.464655458185;9266.814663706553;9324.813503729752;9337.926138493889;9453.905460945303;13370.866291336963;13779.862201377859;14151.221682807545;14414.639634008814;14631.26843657834;11935;12089;12327.815082773586;12448.875511245134;12769.361531923181;11441.199116061796;11919.702007449536;11949.64151075469;12136.39318034077;12187.085968552572;11576.36330001858;11784.41077946082;11954.641360759191;12127.575534856238;12317.876821231674;9096.317776166681;9097.090290971115;9287.071292870658;9361.625534978524;9498.477583732962;8444.07115217338;9467.573959171716;11154.55381784752;11529.423528823692;12093.093018023508 10:07:09 INFO - PROCESS | 20675 | |3;mootools.html;1513.4929798517499;1546.7834503169554;1675.2042779679655;1775.6271183051558;1785.8124896885818;7775.105862825777;8105.3110485608795;8717;9366.578503967321;9379.577918993644;8170;8535.146485351477;8542.103079176675;8676.47941123533;8727.432716873414;2432.3189506938043;2477.182529765173;2478.1698131126095;2483.2301986384186;2486.875656217191;2072.285061653727;2153.7092492513466;2404.6032404653297;2491.5515207262683;2501.5997440409537;2120.4804822818433;2147.7315335583053;2384.8688322142275;2454.2391858523824;2468.3829042739317;2416.6375043743406;2418.6372044193336;2418.7460316666848;2426.502566973766;2432.063655492639;2383.880805959695;2396.329027872181;2409.3133456964856;2416.5287768885073;2418.5525677749674;9132.08679132088;9305;9306.395084319498;9346.299027572892;9353.485558294291;5439.265699130607;5589;5621.959937411592;5628.127640215773;5630.0428927082085;3422.161570415239;3463.7229021678204;3622.7645203061716;3631.7457777955556;3636.3636363636256;1258.1004581724112;1262.984940191328;1287.575100216926;1292.9527083062749;1303.2766814417994;12818.87181128186;12860.935695321557;12865.485380584765;12907.548235811702;12921.289329086896;4721.814981343189;4745.525447455227;4873.585745211697;4918.532739389752;4988.426330971912;10885.129189664807;10889.891101088888;10910.5090270938;10923.289986150874;10947.124230061736;5617.9719101404235;5621.297337832771;5627.268455100892;5628.352739434936;5628.943710562842;5082.110630639623;5184.7407629618365;5195.818146364859;5196.92204616931;5241.344831896013;4232.217039847638;4258.318669012943;4299.527052024275;4337.392765012901;4345.869623911288;1329.6144118205805;1330.5742162508097;1355.0988592586018;1374.3677908162158;1396.36465408239;822.8642274024719;870.7605408512583;944.9669261575812;1013.45780007697;1025.410389026313;6091.725872335755;6118.174046503754;6227.06594010902;6303.527235457359;6312.652804095819;978.7455261632027;1030.588423089973;1039.9636012739518;1064.0689396777818;1071.7910007548453;4337.327714204303;4369.235383807884;4373.715708478939;4374.737515749065;4403.4495688039;11234.10127189823;11459.083273338112;11523.366214858095;11561.942190288995;11570.42147892602;11253.324800511995;11353.886461135447;11420.086393088533;11426.857314268673;11481.942590287163;8597.441166324168;8727.738167854974;8750.906136732909;8758.036615972238;8766.868496972551;6108.358622344767;6207.615806466129;6208.255009398901;6244.781432649836;6310.810675679737;10550.155987521133;10577.9471102644;10665.946670266909;10682.57269709203;10704.143668506345;10329.12202462769;10352.068313851789;10476.790464190826;10544.736381590215;10630.399299335066;7423.925760742323;7627.847443051219;7642.3504002158215;7643.197464266172;7643.503172293783;8405.95797021011;8428.831423371621;8451.492910425393;8459.238668519863;9032.36773425854;7727.536347819148;7971.44199906001;8036.919630803617;8045.11503734577;8049.87925181111;7644.617769111411;7718.575478348745;7740.806479838049;7824.256695613907;8136.511809291462;6846.520743547904;6941.861162776817;6994.860102798018;7192.784216473514;7325.047743793273;5092.719900405513;5164.380274366949;5249.238860365302;5264.394594621514;5305.708186049805;5434.728263586726;5459.542228406837;5526.088195447867;5621.8594535136945;5623.015972204766 10:07:09 INFO - PROCESS | 20675 | |4;prototype.html;358.19406335744577;364.50791431567404;365.2184325543338;370.0415922760051;372.7539823716348;5562.304711911016;5589.357223919245;5591.273134492515;5613.578981576377;5617.595601099725;5407.621466497347;5531.9723401382935;5548.195511650808;5549.890021995607;5552.361478429982;4341.720596686749;4353.564643535645;4356.89107772305;4383.59724888036;4390.297552391618;4327.891802704942;4357.760323182224;4360.037982907688;4362.411074504948;4362.716423432483;4336.241157797389;4339.826406943718;4342.6742994275555;4348.847790327339;4382.539833317488;4239.7668128252935;4327.285997810358;4343.913121737563;4345.456817897762;4362.47650281965;3880.06878349197;3884.941725874114;3886.3587508061137;3886.378179491268;3894.7342113813124;5381.381141168777;5397.676139431607;5419.268398766195;5428.185772134172;5428.4300148484235;4898.673130263132;4922.621981271563;4973.726445045521;4978.751062446863;4979.825706100305;5740.512056475204;5777.959967205901;5783.277090363705;5819.214406055171;5820.505257053155;4264.402983582301;4266.210751011073;4267.829286828523;4269.893252668677;4275.46556680415;5702.4582664647205;5762.452567006169;5853.531717462635;6022.698865056774;6040.879182416327;4211.599898009684;4311.913761724748;4318.5033721121845;4320.1359728053885;4329.134173165379;4347.804348804311;4348;4362;4362.956370436318;4373.037931655031;4629.305604159403;4707;4911.607071434277;4934.432540257844;4943.28322393251;5574.637648552913;5771.153230966134;5782.335031471351;5786.826395208151;5790.218320526759;1497.7304085264539;1509.939602415913;1514.8411465229108;1515.1742300446283;1517.8482151784954;937.5312343828086;991.8908920018793;994.7811481474064;996.2179688944144;1024.1704219582161;4917.754112294371;4942.57988071018;4945.505449455098;4967.453580106186;4978.601711863114;5200.8959820803375;5209.661372010807;5227.60792940531;5228.555572776357;5263.921041184385;4951.579115775199;4959.677620954626;4966.1061009018;5242.580593552507;5683.943160568341;3153.936921261562;3169.4453470642547;3173.6667649896426;3177.68223177685;3186.633537143212;6027.668478233739;6058.666773327421;6081.415398455639;6148.1392605035335;6177.972793331235;5964;6006.909896351558;6061.030235162441;6079.969600151971;6099.329073801879;6109.236345456818;6110.625109350361;6131;6133.815985520441;6133.815985520441;5676.83624856895;5934.9406505934385;5974.2830860297045;6001.579889407874;6044.758209671564;5856.920793118382;5901.29184497863;5922.437368449991;5941.970290148694;5963.403659634176;5861.824145275648;6006.969965150146;6011.248593925759;6131.84670383244;6183.5671502994355;4256.063665993476;4274.422952901443;4278.101598664315;4287.228298906227;4288.292431748727;5780.381493181916;5951.404859514014;5956.255468066492;5959.463648271676;5989.011813050972;5784.004518441131;5819.738111785065;5849.034909239927;5850.853728656818;5853.970730146492;5819;5826.038703613856;5848.766049357978;5852.970735146297;5872.588918775645;5576.470235327637;5798.246227990334;5819.301683797971;5824.504917081926;5857.159277750373;5864.648121112747;5870.853228669317;5883.823485295448;5889;5898.64608123514;5571.275734154534;5738.225339579103;5739.139129130664;5783.826485205451;5786.855328616818 10:07:09 INFO - PROCESS | 20675 | |5;yui.html;805.2430715127783;813.6704634622976;845.2223953962354;848.4824257203105;907.4192516789255;16314.592135196626;17602.767806253567;17625.82374176258;17717.7342339865;17741.11294435278;15940.362385504566;16013;16048.75926861098;16055.91972040141;16062.27719752611;718.985620287594;734.8162959260159;850.706506255341;867.0765634599131;870.7344260000697;870.843248215321;873.724776695339;874.3224001398935;875.7329014650529;876.548577482597;753.2392283793354;921.3642586615248;927.5594092805931;929.4051806843626;930.4882314726873;768.9615519224044;774.6939958716332;775.798292443963;887.32563251929;905.3707673167152;671.3823282580038;673.1719984419192;673.3905815237218;673.4948788408693;673.5318953327439;16102;16111.838881611151;16158.434454794144;16172.75740863888;16202.918985404998;15772.447964321309;15830.920845395814;15972.201389930573;16274.75587866183;16451.67096658072;14032.789508157386;14137.151770893779;14147.787783183261;14379.496717614833;14521.564353069425;4660.464046634646;4668.579827815479;4717.669763116583;4764.8332308369045;4807.807687692488;88483.55758221232;88554;89754.5512272441;90608.09391906128;91084;12729.299888506035;12825.294608796607;12856.485740570273;13045.543405980745;13344.866551334362;24837;25257.62113568298;25261.74738252594;25294.241172764847;25308.49383012366;9418.858717119248;9538;9579.568919398644;9606.903930960741;9829.164521015651;5183.766730497136;5288;5390.353157621111;5445.564354851603;5559.499645031967;3750.7937063461227;3884.7863367515056;3885.86399476017;3886.2810380079777;3893.162969961472;727.3853593713304;736.1901907901266;736.9115706115193;742.5136535569211;758.7192738686721;634.9238091429058;766.6665000724703;774.6591499740097;783.9216078392229;785.3246208260891;10251.333663311862;10938.234323597271;11302.604408845651;11325.886741132648;11755.235909666015;712.1774350625036;741.0144507804607;763.5571368606195;808.1837344282317;822.4777266435856;5145.151050076695;5228.398734145622;5237.476252374732;5239;5306.628536002443;107484.46257768817;115324;132579.33710331385;133477.3326133363;138490;113983.43008284905;114589;115737;115922;117630.41184794021;89152.5542372284;101809.99999999852;103038.48480757549;103825.48087259516;105169;9931.219258607602;10044.296899217277;10091.596336146471;10261.435621040915;10266.897331026594;58932.705336474755;59751.701241493516;60902;62869.685651571446;64512.03231951618;80987.19012810032;83987;87325;90062;91539.54230228806;13524.526641567498;13560.186388816703;13573.577168854072;14074.225917574631;14095.506657266946;13313.733725325634;13407.798883016567;13437.395317210554;13554.390052447467;13687.315634218448;13672.86327136716;13965.231912244517;13991.370388332345;14215.786763198354;14689.706205876037;13053.543125990545;13425.932870335586;13656.317184140951;13659.112157709716;13881.583552493441;13490.730185396433;13523.188608683511;14336.354864030935;14694.11835289886;14738.189399583125;10619;10809.459527023775;11004.559817607205;11450.713732156762;11551.768964620493;11276.267042642203;11562.94218528902;11743.17797754149;11764.411779410824;11837.46731397072 10:07:09 INFO - PROCESS | 20675 | __end_tp_report 10:07:09 INFO - PROCESS | 20675 | __start_cc_report 10:07:09 INFO - PROCESS | 20675 | _x_x_mozilla_cycle_collect,871 10:07:09 INFO - PROCESS | 20675 | __end_cc_report 10:07:09 INFO - PROCESS | 20675 | __startTimestamp1475687229814__endTimestamp 10:07:09 INFO - PROCESS | 20675 | 10:07:09 INFO - PROCESS | 20675 | ------- Summary: start ------- 10:07:09 INFO - PROCESS | 20675 | Number of tests: 6 10:07:09 INFO - PROCESS | 20675 | 10:07:09 INFO - PROCESS | 20675 | [#0] dojo.html Cycles:165 Average:5474.14 Median:5682.15 stddev:626.35 (11.0%) stddev-sans-first:598.98 10:07:09 INFO - PROCESS | 20675 | Values: 3060.9 3089.7 3098.6 3101.7 3143.2 5334.1 5442.5 5466.3 5517.1 5527.9 5526.1 5537.0 5539.7 5543.3 5546.2 5013.2 5028.3 5031.9 5060.3 5128.2 4987.3 5062.6 5109.8 5113.4 5141.3 4946.3 4997.5 5020.4 5038.5 5051.7 5037.5 5043.1 5062.6 5116.2 5147.3 4973.8 5046.4 5085.6 5096.0 5107.1 5357.7 5368.3 5377.3 5381.9 5405.5 5785.0 5814.4 5823.9 5964.6 5978.7 6006.4 6010.2 6011.7 6017.4 6018.4 5386.9 5404.3 5450.0 5450.9 5478.3 6024.2 6042.5 6046.9 6052.6 6060.8 5792.4 5797.7 5798.1 5808.3 5822.3 5737.8 5758.0 5793.2 5829.7 5865.2 5771.3 5776.7 5777.5 5806.5 5810.6 5749.3 5794.4 5811.5 5817.7 5835.3 4440.9 4473.3 4478.1 4483.6 4488.1 3989.6 4008.5 4021.4 4036.4 4047.3 5617.2 5618.4 5619.6 5623.0 5628.7 5857.3 5887.6 5922.4 5941.6 5944.4 5542.5 5585.3 5589.9 5643.1 5688.7 5140.7 5144.4 5144.6 5148.5 5151.1 5898.7 6065.6 6077.4 6093.5 6118.7 5826.4 5848.3 5878.6 5904.4 5987.6 6091.5 6110.3 6110.5 6114.9 6117.6 5797.1 5802.7 5823.5 5833.7 5849.4 5769.2 5774.4 5878.6 5898.2 5921.6 5872.9 5880.4 5883.0 5901.9 5925.2 5805.7 5854.9 5858.8 5862.9 5871.7 5626.9 5630.4 5680.3 5682.1 5823.1 5743.4 5749.3 5756.6 5784.6 5786.7 5603.3 5632.4 5636.5 5642.1 5646.3 10:07:09 INFO - PROCESS | 20675 | 10:07:09 INFO - PROCESS | 20675 | [#1] ext.html Cycles:180 Average:62069.03 Median:39984.30 stddev:122928.74 (307.4%) stddev-sans-first:123186.93 10:07:09 INFO - PROCESS | 20675 | Values: 590.8 607.9 624.2 630.0 644.3 35070.3 37683.0 45861.5 46929.8 46969.8 48216.8 48450.0 48539.0 48581.5 48623.3 8384.3 9280.1 9445.3 9446.1 9475.6 8307.4 8588.0 8589.2 10955.2 11189.4 11389.3 11415.7 11418.5 11431.5 11439.1 11091.0 11125.7 11160.8 11164.5 11169.4 10873.9 10973.2 10987.2 10993.1 10993.9 45790.5 45940.5 46080.0 46091.3 46184.8 3608.4 3673.3 3750.5 3833.0 3893.9 33504.3 33794.5 33875.8 33946.9 33970.0 4665.5 4760.8 4795.6 4847.0 4856.7 263382.0 265549.0 265795.0 266438.0 267847.0 60039.0 60510.4 60629.0 60629.7 60734.0 40400.0 41266.6 41633.0 43298.0 63873.0 18866.6 19115.2 19122.1 19125.1 19138.6 13623.5 13625.7 13646.9 13647.9 13649.5 18069.1 18462.0 18484.9 19337.4 20828.7 7327.3 7334.4 7359.3 7446.2 7593.9 1018.3 1058.8 1072.4 1118.0 1148.0 33837.3 33938.3 34042.0 34331.3 34525.8 1102.5 1116.6 1136.7 1163.3 1205.4 18026.2 18050.9 18197.4 18215.8 18275.5 567342.0 574433.0 574529.0 575223.0 576794.0 62482.4 62907.0 63080.4 63099.2 63119.0 1400.0 1415.4 1427.1 1441.9 1454.2 32041.7 33542.8 33773.3 34112.0 34375.3 54272.0 59207.7 60571.4 60797.0 65119.3 487001.0 489536.0 493650.0 495573.0 495776.0 36468.3 37066.8 47102.8 47530.8 47965.8 44021.6 49911.0 50843.7 51340.5 51486.0 41955.0 43860.3 43989.3 44639.3 45520.0 42760.8 42853.4 43358.3 43935.0 45249.5 42856.6 43247.6 44302.6 44551.8 44588.3 36453.8 38938.0 38978.8 39547.8 39568.6 28895.6 29032.9 29280.4 29340.7 29906.3 10:07:09 INFO - PROCESS | 20675 | 10:07:09 INFO - PROCESS | 20675 | [#2] jquery.html Cycles:180 Average:31689.33 Median:2431.94 stddev:89965.22 (3699.3%) stddev-sans-first:90186.90 10:07:09 INFO - PROCESS | 20675 | Values: 391.3 417.6 422.7 428.0 447.3 15505.9 19727.7 21231.6 21382.7 21415.4 19156.3 19651.5 20193.7 21257.7 21399.6 5933.5 5990.5 6216.4 6223.9 6225.0 6029.5 6030.7 6061.5 6095.1 6124.1 5814.7 5936.7 6050.5 6051.9 6059.5 5970.9 5974.6 5983.2 6001.7 6022.5 5338.9 5382.8 5427.9 5439.0 5462.2 24880.6 24989.6 25062.2 25183.5 25342.5 2268.5 2409.7 2454.2 2503.8 2585.8 10661.7 10943.8 11108.2 11248.7 11297.4 2058.3 2112.4 2118.3 2130.4 2146.1 96584.5 97491.0 98355.5 98775.5 99003.0 10433.4 11791.6 11835.8 11974.3 12043.7 14197.0 15543.8 15712.8 15929.8 16656.3 8299.0 8436.2 8444.0 8570.9 8584.0 8364.9 8391.5 8412.9 8527.1 8556.0 5118.9 5159.5 5176.2 5185.7 5248.4 2016.8 2056.4 2069.9 2085.4 2108.6 1042.7 1048.5 1072.4 1075.6 1108.4 20203.7 21107.6 21294.3 21485.5 21681.8 1000.3 1033.3 1053.3 1059.3 1061.8 10839.6 11735.8 11889.2 11896.2 11955.9 530367.0 543538.0 546092.0 551658.0 552763.0 93628.0 96081.0 96582.0 98138.5 102720.5 1051.4 1066.9 1084.5 1088.6 1097.0 14256.6 16552.8 17715.0 18307.3 18528.4 41960.2 44030.8 45317.3 45760.8 47056.5 59584.0 59929.7 60996.7 61682.4 62364.4 9186.5 9266.8 9324.8 9337.9 9453.9 13370.9 13779.9 14151.2 14414.6 14631.3 11935.0 12089.0 12327.8 12448.9 12769.4 11441.2 11919.7 11949.6 12136.4 12187.1 11576.4 11784.4 11954.6 12127.6 12317.9 9096.3 9097.1 9287.1 9361.6 9498.5 8444.1 9467.6 11154.6 11529.4 12093.1 10:07:09 INFO - PROCESS | 20675 | 10:07:09 INFO - PROCESS | 20675 | [#3] mootools.html Cycles:180 Average:6021.85 Median:4562.63 stddev:3403.10 (74.6%) stddev-sans-first:3395.78 10:07:09 INFO - PROCESS | 20675 | Values: 1513.5 1546.8 1675.2 1775.6 1785.8 7775.1 8105.3 8717.0 9366.6 9379.6 8170.0 8535.1 8542.1 8676.5 8727.4 2432.3 2477.2 2478.2 2483.2 2486.9 2072.3 2153.7 2404.6 2491.6 2501.6 2120.5 2147.7 2384.9 2454.2 2468.4 2416.6 2418.6 2418.7 2426.5 2432.1 2383.9 2396.3 2409.3 2416.5 2418.6 9132.1 9305.0 9306.4 9346.3 9353.5 5439.3 5589.0 5622.0 5628.1 5630.0 3422.2 3463.7 3622.8 3631.7 3636.4 1258.1 1263.0 1287.6 1293.0 1303.3 12818.9 12860.9 12865.5 12907.5 12921.3 4721.8 4745.5 4873.6 4918.5 4988.4 10885.1 10889.9 10910.5 10923.3 10947.1 5618.0 5621.3 5627.3 5628.4 5628.9 5082.1 5184.7 5195.8 5196.9 5241.3 4232.2 4258.3 4299.5 4337.4 4345.9 1329.6 1330.6 1355.1 1374.4 1396.4 822.9 870.8 945.0 1013.5 1025.4 6091.7 6118.2 6227.1 6303.5 6312.7 978.7 1030.6 1040.0 1064.1 1071.8 4337.3 4369.2 4373.7 4374.7 4403.4 11234.1 11459.1 11523.4 11561.9 11570.4 11253.3 11353.9 11420.1 11426.9 11481.9 8597.4 8727.7 8750.9 8758.0 8766.9 6108.4 6207.6 6208.3 6244.8 6310.8 10550.2 10577.9 10665.9 10682.6 10704.1 10329.1 10352.1 10476.8 10544.7 10630.4 7423.9 7627.8 7642.4 7643.2 7643.5 8406.0 8428.8 8451.5 8459.2 9032.4 7727.5 7971.4 8036.9 8045.1 8049.9 7644.6 7718.6 7740.8 7824.3 8136.5 6846.5 6941.9 6994.9 7192.8 7325.0 5092.7 5164.4 5249.2 5264.4 5305.7 5434.7 5459.5 5526.1 5621.9 5623.0 10:07:09 INFO - PROCESS | 20675 | 10:07:09 INFO - PROCESS | 20675 | [#4] prototype.html Cycles:180 Average:4852.61 Median:5480.20 stddev:1405.61 (25.6%) stddev-sans-first:1368.48 10:07:09 INFO - PROCESS | 20675 | Values: 358.2 364.5 365.2 370.0 372.8 5562.3 5589.4 5591.3 5613.6 5617.6 5407.6 5532.0 5548.2 5549.9 5552.4 4341.7 4353.6 4356.9 4383.6 4390.3 4327.9 4357.8 4360.0 4362.4 4362.7 4336.2 4339.8 4342.7 4348.8 4382.5 4239.8 4327.3 4343.9 4345.5 4362.5 3880.1 3884.9 3886.4 3886.4 3894.7 5381.4 5397.7 5419.3 5428.2 5428.4 4898.7 4922.6 4973.7 4978.8 4979.8 5740.5 5778.0 5783.3 5819.2 5820.5 4264.4 4266.2 4267.8 4269.9 4275.5 5702.5 5762.5 5853.5 6022.7 6040.9 4211.6 4311.9 4318.5 4320.1 4329.1 4347.8 4348.0 4362.0 4363.0 4373.0 4629.3 4707.0 4911.6 4934.4 4943.3 5574.6 5771.2 5782.3 5786.8 5790.2 1497.7 1509.9 1514.8 1515.2 1517.8 937.5 991.9 994.8 996.2 1024.2 4917.8 4942.6 4945.5 4967.5 4978.6 5200.9 5209.7 5227.6 5228.6 5263.9 4951.6 4959.7 4966.1 5242.6 5683.9 3153.9 3169.4 3173.7 3177.7 3186.6 6027.7 6058.7 6081.4 6148.1 6178.0 5964.0 6006.9 6061.0 6080.0 6099.3 6109.2 6110.6 6131.0 6133.8 6133.8 5676.8 5934.9 5974.3 6001.6 6044.8 5856.9 5901.3 5922.4 5942.0 5963.4 5861.8 6007.0 6011.2 6131.8 6183.6 4256.1 4274.4 4278.1 4287.2 4288.3 5780.4 5951.4 5956.3 5959.5 5989.0 5784.0 5819.7 5849.0 5850.9 5854.0 5819.0 5826.0 5848.8 5853.0 5872.6 5576.5 5798.2 5819.3 5824.5 5857.2 5864.6 5870.9 5883.8 5889.0 5898.6 5571.3 5738.2 5739.1 5783.8 5786.9 10:07:09 INFO - PROCESS | 20675 | 10:07:09 INFO - PROCESS | 20675 | [#5] yui.html Cycles:180 Average:23513.96 Median:25277.99 stddev:34484.90 (136.4%) stddev-sans-first:34539.48 10:07:09 INFO - PROCESS | 20675 | Values: 805.2 813.7 845.2 848.5 907.4 16314.6 17602.8 17625.8 17717.7 17741.1 15940.4 16013.0 16048.8 16055.9 16062.3 719.0 734.8 850.7 867.1 870.7 870.8 873.7 874.3 875.7 876.5 753.2 921.4 927.6 929.4 930.5 769.0 774.7 775.8 887.3 905.4 671.4 673.2 673.4 673.5 673.5 16102.0 16111.8 16158.4 16172.8 16202.9 15772.4 15830.9 15972.2 16274.8 16451.7 14032.8 14137.2 14147.8 14379.5 14521.6 4660.5 4668.6 4717.7 4764.8 4807.8 88483.6 88554.0 89754.6 90608.1 91084.0 12729.3 12825.3 12856.5 13045.5 13344.9 24837.0 25257.6 25261.7 25294.2 25308.5 9418.9 9538.0 9579.6 9606.9 9829.2 5183.8 5288.0 5390.4 5445.6 5559.5 3750.8 3884.8 3885.9 3886.3 3893.2 727.4 736.2 736.9 742.5 758.7 634.9 766.7 774.7 783.9 785.3 10251.3 10938.2 11302.6 11325.9 11755.2 712.2 741.0 763.6 808.2 822.5 5145.2 5228.4 5237.5 5239.0 5306.6 107484.5 115324.0 132579.3 133477.3 138490.0 113983.4 114589.0 115737.0 115922.0 117630.4 89152.6 101810.0 103038.5 103825.5 105169.0 9931.2 10044.3 10091.6 10261.4 10266.9 58932.7 59751.7 60902.0 62869.7 64512.0 80987.2 83987.0 87325.0 90062.0 91539.5 13524.5 13560.2 13573.6 14074.2 14095.5 13313.7 13407.8 13437.4 13554.4 13687.3 13672.9 13965.2 13991.4 14215.8 14689.7 13053.5 13425.9 13656.3 13659.1 13881.6 13490.7 13523.2 14336.4 14694.1 14738.2 10619.0 10809.5 11004.6 11450.7 11551.8 11276.3 11562.9 11743.2 11764.4 11837.5 10:07:09 INFO - PROCESS | 20675 | -------- Summary: end -------- 10:07:09 INFO - PROCESS | 20675 | 10:07:10 INFO - TEST-INFO | 20675: exit 0 10:07:10 INFO - TEST-OK | dromaeo_css | took 1113915ms 10:07:10 INFO - TEST-START | kraken 10:07:10 INFO - operating with platform_type : linux_ 10:07:10 INFO - Initialising browser for kraken test... 10:07:10 INFO - TEST-INFO | started process 20994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBDbC_J/profile http://localhost:49711/getInfo.html) 10:07:14 INFO - PROCESS | 20994 | __metrics Screen width/height:1600/1200 10:07:14 INFO - PROCESS | 20994 | colorDepth:24 10:07:14 INFO - PROCESS | 20994 | Browser inner width/height: 1024/697 10:07:14 INFO - PROCESS | 20994 | __metrics 10:07:15 INFO - PROCESS | 20994 | 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" 10:07:15 INFO - PROCESS | 20994 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:07:15 INFO - PROCESS | 20994 | console.error: PushService: 10:07:15 INFO - PROCESS | 20994 | stateChangeProcessEnqueue: Error transitioning state 10:07:15 INFO - PROCESS | 20994 | UnknownError 10:07:16 INFO - TEST-INFO | 20994: exit 0 10:07:16 INFO - Browser initialized. 10:07:16 INFO - Running cycle 1/1 for kraken test... 10:07:16 INFO - TEST-INFO | started process 21085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBDbC_J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:28 INFO - PROCESS | 21085 | RSS: Main: 144293888 10:07:28 INFO - PROCESS | 21085 | 10:07:30 INFO - PROCESS | 21085 | Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49711/tests/kraken/driver.html?testName=audio-beat-detection) 10:07:31 INFO - PROCESS | 21085 | RSS: Main: 186544128 10:07:31 INFO - PROCESS | 21085 | 10:07:34 INFO - PROCESS | 21085 | Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49711/tests/kraken/driver.html?testName=audio-dft) 10:07:34 INFO - PROCESS | 21085 | RSS: Main: 175185920 10:07:34 INFO - PROCESS | 21085 | 10:07:37 INFO - PROCESS | 21085 | Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49711/tests/kraken/driver.html?testName=audio-fft) 10:07:38 INFO - PROCESS | 21085 | RSS: Main: 266821632 10:07:38 INFO - PROCESS | 21085 | 10:07:40 INFO - PROCESS | 21085 | Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49711/tests/kraken/driver.html?testName=audio-oscillator) 10:07:40 INFO - PROCESS | 21085 | RSS: Main: 173580288 10:07:40 INFO - PROCESS | 21085 | 10:07:42 INFO - PROCESS | 21085 | Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49711/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:07:43 INFO - PROCESS | 21085 | RSS: Main: 175591424 10:07:43 INFO - PROCESS | 21085 | 10:07:46 INFO - PROCESS | 21085 | Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49711/tests/kraken/driver.html?testName=imaging-darkroom) 10:07:47 INFO - PROCESS | 21085 | RSS: Main: 211075072 10:07:47 INFO - PROCESS | 21085 | 10:07:50 INFO - PROCESS | 21085 | Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49711/tests/kraken/driver.html?testName=imaging-desaturate) 10:07:50 INFO - PROCESS | 21085 | RSS: Main: 209764352 10:07:50 INFO - PROCESS | 21085 | 10:07:53 INFO - PROCESS | 21085 | Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49711/tests/kraken/driver.html?testName=json-parse-financial) 10:07:54 INFO - PROCESS | 21085 | RSS: Main: 209739776 10:07:54 INFO - PROCESS | 21085 | 10:07:55 INFO - PROCESS | 21085 | Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49711/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:07:56 INFO - PROCESS | 21085 | RSS: Main: 171925504 10:07:56 INFO - PROCESS | 21085 | 10:07:58 INFO - PROCESS | 21085 | Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49711/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:07:58 INFO - PROCESS | 21085 | RSS: Main: 180125696 10:07:58 INFO - PROCESS | 21085 | 10:08:00 INFO - PROCESS | 21085 | Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49711/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:08:01 INFO - PROCESS | 21085 | RSS: Main: 188571648 10:08:01 INFO - PROCESS | 21085 | 10:08:03 INFO - PROCESS | 21085 | Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49711/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:08:04 INFO - PROCESS | 21085 | RSS: Main: 196898816 10:08:04 INFO - PROCESS | 21085 | 10:08:07 INFO - PROCESS | 21085 | Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49711/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:08:07 INFO - PROCESS | 21085 | RSS: Main: 193384448 10:08:07 INFO - PROCESS | 21085 | 10:08:09 INFO - PROCESS | 21085 | Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49711/tests/kraken/driver.html?testName=ai-astar) 10:08:09 INFO - PROCESS | 21085 | RSS: Main: 244199424 10:08:09 INFO - PROCESS | 21085 | 10:08:09 INFO - PROCESS | 21085 | __start_tp_report 10:08:09 INFO - PROCESS | 21085 | _x_x_mozilla_page_load 10:08:09 INFO - PROCESS | 21085 | _x_x_mozilla_page_load_details 10:08:09 INFO - PROCESS | 21085 | |i|pagename|runs| 10:08:09 INFO - PROCESS | 21085 | |0;ai-astar;109;113;110;112;112;110;111;111;109;110 10:08:09 INFO - PROCESS | 21085 | |1;audio-beat-detection;146;116;115;162;122;117;116;115;150;124 10:08:09 INFO - PROCESS | 21085 | |2;audio-dft;160;160;160;162;161;161;161;161;161;160 10:08:09 INFO - PROCESS | 21085 | |3;audio-fft;78;74;74;105;76;76;76;76;102;75 10:08:09 INFO - PROCESS | 21085 | |4;audio-oscillator;80;81;123;82;82;82;100;81;82;103 10:08:09 INFO - PROCESS | 21085 | |5;imaging-gaussian-blur;117;116;116;117;117;116;116;117;117;117 10:08:09 INFO - PROCESS | 21085 | |6;imaging-darkroom;146;146;146;146;147;145;145;147;145;146 10:08:09 INFO - PROCESS | 21085 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;95 10:08:09 INFO - PROCESS | 21085 | |8;json-parse-financial;52;50;51;50;51;51;50;51;50;51 10:08:09 INFO - PROCESS | 21085 | |9;json-stringify-tinderbox;59;59;58;59;58;60;57;59;59;59 10:08:09 INFO - PROCESS | 21085 | |10;stanford-crypto-aes;73;74;74;73;72;75;79;73;73;74 10:08:09 INFO - PROCESS | 21085 | |11;stanford-crypto-ccm;123;131;119;120;125;117;127;121;162;124 10:08:09 INFO - PROCESS | 21085 | |12;stanford-crypto-pbkdf2;157;154;154;157;153;155;155;157;151;151 10:08:09 INFO - PROCESS | 21085 | |13;stanford-crypto-sha256-iterative;61;63;61;67;62;64;63;61;61;61 10:08:09 INFO - PROCESS | 21085 | __end_tp_report 10:08:09 INFO - PROCESS | 21085 | __start_cc_report 10:08:09 INFO - PROCESS | 21085 | _x_x_mozilla_cycle_collect,1605 10:08:09 INFO - PROCESS | 21085 | __end_cc_report 10:08:09 INFO - PROCESS | 21085 | __startTimestamp1475687289632__endTimestamp 10:08:09 INFO - PROCESS | 21085 | 10:08:09 INFO - PROCESS | 21085 | ------- Summary: start ------- 10:08:09 INFO - PROCESS | 21085 | Number of tests: 14 10:08:09 INFO - PROCESS | 21085 | 10:08:09 INFO - PROCESS | 21085 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.34 (1.2%) stddev-sans-first:1.27 10:08:09 INFO - PROCESS | 21085 | Values: 109.0 113.0 110.0 112.0 112.0 110.0 111.0 111.0 109.0 110.0 10:08:09 INFO - PROCESS | 21085 | 10:08:09 INFO - PROCESS | 21085 | [#1] audio-beat-detection Cycles:10 Average:128.30 Median:123.00 stddev:17.52 (14.2%) stddev-sans-first:17.37 10:08:09 INFO - PROCESS | 21085 | Values: 146.0 116.0 115.0 162.0 122.0 117.0 116.0 115.0 150.0 124.0 10:08:09 INFO - PROCESS | 21085 | 10:08:09 INFO - PROCESS | 21085 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 10:08:09 INFO - PROCESS | 21085 | Values: 160.0 160.0 160.0 162.0 161.0 161.0 161.0 161.0 161.0 160.0 10:08:09 INFO - PROCESS | 21085 | 10:08:09 INFO - PROCESS | 21085 | [#3] audio-fft Cycles:10 Average:81.20 Median:76.00 stddev:11.83 (15.6%) stddev-sans-first:12.49 10:08:09 INFO - PROCESS | 21085 | Values: 78.0 74.0 74.0 105.0 76.0 76.0 76.0 76.0 102.0 75.0 10:08:09 INFO - PROCESS | 21085 | 10:08:09 INFO - PROCESS | 21085 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:81.50 stddev:14.43 (17.7%) stddev-sans-first:14.88 10:08:09 INFO - PROCESS | 21085 | Values: 80.0 81.0 123.0 82.0 82.0 82.0 100.0 81.0 82.0 103.0 10:08:09 INFO - PROCESS | 21085 | 10:08:09 INFO - PROCESS | 21085 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:08:09 INFO - PROCESS | 21085 | Values: 117.0 116.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 10:08:09 INFO - PROCESS | 21085 | 10:08:09 INFO - PROCESS | 21085 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 10:08:09 INFO - PROCESS | 21085 | Values: 146.0 146.0 146.0 146.0 147.0 145.0 145.0 147.0 145.0 146.0 10:08:09 INFO - PROCESS | 21085 | 10:08:09 INFO - PROCESS | 21085 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 10:08:09 INFO - PROCESS | 21085 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 10:08:09 INFO - PROCESS | 21085 | 10:08:09 INFO - PROCESS | 21085 | [#8] json-parse-financial Cycles:10 Average:50.70 Median:51.00 stddev:0.67 (1.3%) stddev-sans-first:0.53 10:08:09 INFO - PROCESS | 21085 | Values: 52.0 50.0 51.0 50.0 51.0 51.0 50.0 51.0 50.0 51.0 10:08:09 INFO - PROCESS | 21085 | 10:08:09 INFO - PROCESS | 21085 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 10:08:09 INFO - PROCESS | 21085 | Values: 59.0 59.0 58.0 59.0 58.0 60.0 57.0 59.0 59.0 59.0 10:08:09 INFO - PROCESS | 21085 | 10:08:09 INFO - PROCESS | 21085 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:74.00 stddev:1.94 (2.6%) stddev-sans-first:2.03 10:08:09 INFO - PROCESS | 21085 | Values: 73.0 74.0 74.0 73.0 72.0 75.0 79.0 73.0 73.0 74.0 10:08:09 INFO - PROCESS | 21085 | 10:08:09 INFO - PROCESS | 21085 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:124.50 stddev:12.99 (10.4%) stddev-sans-first:13.70 10:08:09 INFO - PROCESS | 21085 | Values: 123.0 131.0 119.0 120.0 125.0 117.0 127.0 121.0 162.0 124.0 10:08:09 INFO - PROCESS | 21085 | 10:08:09 INFO - PROCESS | 21085 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.40 Median:155.00 stddev:2.27 (1.5%) stddev-sans-first:2.20 10:08:09 INFO - PROCESS | 21085 | Values: 157.0 154.0 154.0 157.0 153.0 155.0 155.0 157.0 151.0 151.0 10:08:09 INFO - PROCESS | 21085 | 10:08:09 INFO - PROCESS | 21085 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.50 stddev:1.96 (3.1%) stddev-sans-first:2.01 10:08:09 INFO - PROCESS | 21085 | Values: 61.0 63.0 61.0 67.0 62.0 64.0 63.0 61.0 61.0 61.0 10:08:09 INFO - PROCESS | 21085 | -------- Summary: end -------- 10:08:09 INFO - PROCESS | 21085 | 10:08:10 INFO - TEST-INFO | 21085: exit 0 10:08:10 INFO - TEST-OK | kraken | took 60141ms 10:08:10 INFO - SUITE-END | took 1174s 10:08:10 INFO - Completed test suite (00:19:34) 10:08:10 INFO - javascript benchmark 10:08:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3060.892868749594, 3089.6601373848857, 3098.628164620246, 3101.72084512394, 3143.1827724791547, 5334.119870221413, 5442.482964118407, 5466.262054622624, 5517.117261238202, 5527.91708124378, 5526.143447765593, 5537.0, 5539.667619942807, 5543.25166102576, 5546.195801608765, 5013.222950442687, 5028.270900719412, 5031.924521132186, 5060.316857224283, 5128.153854614003, 4987.301777751118, 5062.594992400599, 5109.795608175668, 5113.437521872591, 5141.30592370029, 4946.282788995593, 4997.500249974992, 5020.39755229373, 5038.521340472649, 5051.722155281458, 5037.546620804145, 5043.117454445457, 5062.645614806984, 5116.2069879168785, 5147.330846989905, 4973.825916092919, 5046.369203849519, 5085.644004919657, 5096.0, 5107.106256405114, 5357.651752636066, 5368.275282836806, 5377.327834020747, 5381.865453363658, 5405.540529055035, 5785.0454674979, 5814.389489103625, 5823.854403639901, 5964.582479226456, 5978.671173085479, 6006.399360063959, 6010.188624535675, 6011.729472173763, 6017.398260173992, 6018.368071352489, 5386.91919621206, 5404.32445944257, 5450.04624190769, 5450.945490545084, 5478.287822583039, 6024.246969128859, 6042.486388657014, 6046.879062418727, 6052.606580572248, 6060.818175454743, 5792.391798861143, 5797.739101740432, 5798.1302804579655, 5808.273965754281, 5822.3304320003745, 5737.799177028784, 5758.049921762862, 5793.159991801165, 5829.650220986754, 5865.237519122486, 5771.278590176228, 5776.740046697909, 5777.480026797524, 5806.506446951972, 5810.622309549865, 5749.281339832521, 5794.449527294901, 5811.506021988178, 5817.7091145442555, 5835.328937172279, 4440.911181776411, 4473.329000649928, 4478.081993191388, 4483.641308695296, 4488.102379524108, 3989.6409323160474, 4008.5390180129075, 4021.4168945503325, 4036.394540818842, 4047.3321901886447, 5617.21359009739, 5618.410066942994, 5619.634723742944, 5622.987862184764, 5628.662280263197, 5857.297124345021, 5887.558433117448, 5922.407759224043, 5941.58408911372, 5944.375840536768, 5542.501174894279, 5585.3297604287745, 5589.8602534936135, 5643.097104463266, 5688.715564221772, 5140.691558506502, 5144.408393034774, 5144.614153938394, 5148.510891465305, 5151.072806894795, 5898.705064746659, 6065.575409721366, 6077.36187700294, 6093.4529067417, 6118.663473509, 5826.417358264309, 5848.327442344014, 5878.588498805043, 5904.409559044061, 5987.5808693391045, 6091.451769340781, 6110.26676798787, 6110.480609148272, 6114.938850611437, 6117.571769976059, 5797.101449275369, 5802.65184088956, 5823.534117270693, 5833.737481813413, 5849.444302791228, 5769.192313076089, 5774.422557744192, 5878.617889837147, 5898.174255604133, 5921.585489015728, 5872.853178670567, 5880.353161152356, 5883.0, 5901.852453688693, 5925.229720136354, 5805.680687562224, 5854.853628659318, 5858.794942177004, 5862.882742345044, 5871.735771890189, 5626.943730562642, 5630.4369563043365, 5680.261565996394, 5682.147677848356, 5823.126531020212, 5743.396943320891, 5749.338826035059, 5756.568257380797, 5784.595078344475, 5786.6528008317955, 5603.299587551556, 5632.436756324335, 5636.4927156556105, 5642.097264437671, 5646.322441306905], "value": 5430.669744227373, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.8079874040935, 607.875385545963, 624.1511544299749, 629.9842503937401, 644.2687549631167, 35070.29859402811, 37683.0, 45861.54138458615, 46929.76535117328, 46969.76515117428, 48216.75891620537, 48450.0, 48539.02921941568, 48581.51418485814, 48623.27065094026, 8384.329253659724, 9280.118388753057, 9445.338826282163, 9446.149846513812, 9475.62097516102, 8307.37694672899, 8588.0, 8589.226969572737, 10955.233133680646, 11189.44052797361, 11389.316641001526, 11415.657530274064, 11418.54325826966, 11431.485583148778, 11439.142064345166, 11091.0, 11125.666230013112, 11160.832587511193, 11164.497597608128, 11169.441527923653, 10873.891261087367, 10973.23187376884, 10987.175961802897, 10993.120550355952, 10993.890061099366, 45790.54209457896, 45940.54059459429, 46080.0, 46091.30863037057, 46184.76907615441, 3608.4226523756074, 3673.338799016176, 3750.456183853326, 3833.041739565109, 3893.8902412812213, 33504.32991340184, 33794.49308260378, 33875.83062084674, 33946.94477497037, 33970.0, 4665.486796452387, 4760.809567617292, 4795.6163506919365, 4846.975765121152, 4856.660033797635, 263382.0, 265549.0, 265794.9999999981, 266438.0, 267847.0, 60039.0, 60510.39489605136, 60629.0, 60629.69685151634, 60734.0, 40400.0, 41266.58733412628, 41633.0, 43298.0, 63873.0, 18866.622667546846, 19115.23539058422, 19122.139503722366, 19125.13936872844, 19138.61722765537, 13623.455061797615, 13625.727485450236, 13646.931765341309, 13647.863521364858, 13649.522266720816, 18069.096545172688, 18462.0, 18484.907575462035, 19337.447543816343, 20828.687569686466, 7327.340539351484, 7334.4499162563025, 7359.337659610661, 7446.218147094585, 7593.886091708629, 1018.2668478695327, 1058.7776566921034, 1072.4208927179236, 1118.0217309853879, 1147.9560115989323, 33837.32325353529, 33938.32123357519, 34042.0, 34331.31337373288, 34525.827370862986, 1102.525913857049, 1116.5868628607304, 1136.676047326508, 1163.3427113680743, 1205.3912774049224, 18026.188821503063, 18050.90974545119, 18197.36309229197, 18215.817841821678, 18275.543111422056, 567342.0, 574433.0, 574529.0, 575223.0, 576794.0, 62482.37517624856, 62907.0, 63080.36919630837, 63099.16053777591, 63119.0, 1399.9580012599436, 1415.3984556563214, 1427.06527224668, 1441.9495317663832, 1454.243793227537, 32041.6795832048, 33542.83228583939, 33773.32453350969, 34112.0, 34375.31249375048, 54272.0, 59207.70396148164, 60571.39428605657, 60797.0, 65119.348806513226, 487001.0, 489536.0, 493650.0, 495573.0, 495776.0, 36468.27063458769, 37066.81466592757, 47102.76448617872, 47530.76234618805, 47965.76017119892, 44021.55978440303, 49911.0, 50843.74578127086, 51340.486595135066, 51486.0, 41955.0, 43860.342094869244, 43989.34015989699, 44639.33041004323, 45520.0, 42760.78619606882, 42853.357199642654, 43358.34962475502, 43935.0, 45249.54750452585, 42856.5714342865, 43247.56752432561, 44302.55697442984, 44551.77724111488, 44588.33117503305, 36453.81773091118, 38938.0, 38978.80510597429, 39547.802260989665, 39568.60431395649, 28895.5665665011, 29032.854835725688, 29280.41439171162, 29340.70659293465, 29906.252343691584], "value": 21518.316705096073, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.26700000496544, 417.59076105416693, 422.73790250044965, 427.9721818081824, 447.31560712110485, 15505.922470387646, 19727.704084438745, 21231.57536849262, 21382.679259811095, 21415.357539273846, 19156.329528466507, 19651.5087122822, 20193.697094543593, 21257.68113478299, 21399.57200855986, 5933.465988061073, 5990.460858522732, 6216.440520353167, 6223.906641400383, 6224.968875155618, 6029.487493563052, 6030.698465076751, 6061.45446909778, 6095.116208149816, 6124.112003759452, 5814.680192589406, 5936.732847021873, 6050.515958723314, 6051.939480605203, 6059.545534084961, 5970.910436343436, 5974.61165024272, 5983.192269043667, 6001.699915004254, 6022.488088512482, 5338.946610533883, 5382.811601593926, 5427.9185812212845, 5439.048166570834, 5462.2079798429, 24880.626790598155, 24989.62515562268, 25062.24813255605, 25183.496330073296, 25342.493150137077, 2268.4782500025085, 2409.674693916334, 2454.202384225116, 2503.7871780898645, 2585.8234503300955, 10661.680149595524, 10943.781124377547, 11108.222424430292, 11248.718782030433, 11297.435128243555, 2058.3001779394926, 2112.408525612831, 2118.3327251915753, 2130.3821891651555, 2146.098638571804, 96584.51707741487, 97491.0, 98355.50822245915, 98775.50612246964, 99003.0, 10433.426161561036, 11791.646250612495, 11835.763284734257, 11974.341411222467, 12043.698907527381, 14197.0, 15543.766843497357, 15712.842871571138, 15929.840701593068, 16656.33374665024, 8298.958505207434, 8436.198561136682, 8443.95778021106, 8570.914290857136, 8583.957080214685, 8364.874526882102, 8391.454555453876, 8412.915870841212, 8527.147285271423, 8556.0, 5118.872028199325, 5159.458256882973, 5176.223566465061, 5185.714785686823, 5248.3701955765555, 2016.7882372350984, 2056.3830850744716, 2069.88615626139, 2085.4160834966233, 2108.5572029873592, 1042.6559235452282, 1048.475826807324, 1072.3726619927274, 1075.639660713654, 1108.4236197177422, 20203.696944545845, 21107.577848442947, 21294.25470108539, 21485.52203298717, 21681.783182168292, 1000.3397757480028, 1033.3316725624154, 1053.3048188195908, 1059.332620449112, 1061.8301071828625, 10839.620613278497, 11735.823962640396, 11889.227200231957, 11896.167268291136, 11955.880441195477, 530367.0, 543538.0, 546092.0, 551658.0, 552763.0, 93628.0, 96081.0, 96582.0, 98138.509307453, 102720.48639756754, 1051.4322265976286, 1066.8559744434558, 1084.511969613677, 1088.6026600290995, 1096.9670909872716, 14256.572302830931, 16552.75170872462, 17715.025673588076, 18307.26770929148, 18528.44414667562, 41960.16079678328, 44030.779846100566, 45317.32024019576, 45760.7711961438, 47056.52943470521, 59584.0, 59929.700351497966, 60996.69501652463, 61682.38317616766, 62364.37635623767, 9186.464655458185, 9266.814663706553, 9324.813503729752, 9337.926138493889, 9453.905460945303, 13370.866291336963, 13779.862201377859, 14151.221682807545, 14414.639634008814, 14631.26843657834, 11935.0, 12089.0, 12327.815082773586, 12448.875511245134, 12769.361531923181, 11441.199116061796, 11919.702007449536, 11949.64151075469, 12136.39318034077, 12187.085968552572, 11576.36330001858, 11784.41077946082, 11954.641360759191, 12127.575534856238, 12317.876821231674, 9096.317776166681, 9097.090290971115, 9287.071292870658, 9361.625534978524, 9498.477583732962, 8444.07115217338, 9467.573959171716, 11154.55381784752, 11529.423528823692, 12093.093018023508], "value": 9745.481109129729, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1513.4929798517499, 1546.7834503169554, 1675.2042779679655, 1775.6271183051558, 1785.8124896885818, 7775.105862825777, 8105.3110485608795, 8717.0, 9366.578503967321, 9379.577918993644, 8170.0, 8535.146485351477, 8542.103079176675, 8676.47941123533, 8727.432716873414, 2432.3189506938043, 2477.182529765173, 2478.1698131126095, 2483.2301986384186, 2486.875656217191, 2072.285061653727, 2153.7092492513466, 2404.6032404653297, 2491.5515207262683, 2501.5997440409537, 2120.4804822818433, 2147.7315335583053, 2384.8688322142275, 2454.2391858523824, 2468.3829042739317, 2416.6375043743406, 2418.6372044193336, 2418.7460316666848, 2426.502566973766, 2432.063655492639, 2383.880805959695, 2396.329027872181, 2409.3133456964856, 2416.5287768885073, 2418.5525677749674, 9132.08679132088, 9305.0, 9306.395084319498, 9346.299027572892, 9353.485558294291, 5439.265699130607, 5589.0, 5621.959937411592, 5628.127640215773, 5630.0428927082085, 3422.161570415239, 3463.7229021678204, 3622.7645203061716, 3631.7457777955556, 3636.3636363636256, 1258.1004581724112, 1262.984940191328, 1287.575100216926, 1292.9527083062749, 1303.2766814417994, 12818.87181128186, 12860.935695321557, 12865.485380584765, 12907.548235811702, 12921.289329086896, 4721.814981343189, 4745.525447455227, 4873.585745211697, 4918.532739389752, 4988.426330971912, 10885.129189664807, 10889.891101088888, 10910.5090270938, 10923.289986150874, 10947.124230061736, 5617.9719101404235, 5621.297337832771, 5627.268455100892, 5628.352739434936, 5628.943710562842, 5082.110630639623, 5184.7407629618365, 5195.818146364859, 5196.92204616931, 5241.344831896013, 4232.217039847638, 4258.318669012943, 4299.527052024275, 4337.392765012901, 4345.869623911288, 1329.6144118205805, 1330.5742162508097, 1355.0988592586018, 1374.3677908162158, 1396.36465408239, 822.8642274024719, 870.7605408512583, 944.9669261575812, 1013.45780007697, 1025.410389026313, 6091.725872335755, 6118.174046503754, 6227.06594010902, 6303.527235457359, 6312.652804095819, 978.7455261632027, 1030.588423089973, 1039.9636012739518, 1064.0689396777818, 1071.7910007548453, 4337.327714204303, 4369.235383807884, 4373.715708478939, 4374.737515749065, 4403.4495688039, 11234.10127189823, 11459.083273338112, 11523.366214858095, 11561.942190288995, 11570.42147892602, 11253.324800511995, 11353.886461135447, 11420.086393088533, 11426.857314268673, 11481.942590287163, 8597.441166324168, 8727.738167854974, 8750.906136732909, 8758.036615972238, 8766.868496972551, 6108.358622344767, 6207.615806466129, 6208.255009398901, 6244.781432649836, 6310.810675679737, 10550.155987521133, 10577.9471102644, 10665.946670266909, 10682.57269709203, 10704.143668506345, 10329.12202462769, 10352.068313851789, 10476.790464190826, 10544.736381590215, 10630.399299335066, 7423.925760742323, 7627.847443051219, 7642.3504002158215, 7643.197464266172, 7643.503172293783, 8405.95797021011, 8428.831423371621, 8451.492910425393, 8459.238668519863, 9032.36773425854, 7727.536347819148, 7971.44199906001, 8036.919630803617, 8045.11503734577, 8049.87925181111, 7644.617769111411, 7718.575478348745, 7740.806479838049, 7824.256695613907, 8136.511809291462, 6846.520743547904, 6941.861162776817, 6994.860102798018, 7192.784216473514, 7325.047743793273, 5092.719900405513, 5164.380274366949, 5249.238860365302, 5264.394594621514, 5305.708186049805, 5434.728263586726, 5459.542228406837, 5526.088195447867, 5621.8594535136945, 5623.015972204766], "value": 4838.308066283618, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.19406335744577, 364.50791431567404, 365.2184325543338, 370.0415922760051, 372.7539823716348, 5562.304711911016, 5589.357223919245, 5591.273134492515, 5613.578981576377, 5617.595601099725, 5407.621466497347, 5531.9723401382935, 5548.195511650808, 5549.890021995607, 5552.361478429982, 4341.720596686749, 4353.564643535645, 4356.89107772305, 4383.59724888036, 4390.297552391618, 4327.891802704942, 4357.760323182224, 4360.037982907688, 4362.411074504948, 4362.716423432483, 4336.241157797389, 4339.826406943718, 4342.6742994275555, 4348.847790327339, 4382.539833317488, 4239.7668128252935, 4327.285997810358, 4343.913121737563, 4345.456817897762, 4362.47650281965, 3880.06878349197, 3884.941725874114, 3886.3587508061137, 3886.378179491268, 3894.7342113813124, 5381.381141168777, 5397.676139431607, 5419.268398766195, 5428.185772134172, 5428.4300148484235, 4898.673130263132, 4922.621981271563, 4973.726445045521, 4978.751062446863, 4979.825706100305, 5740.512056475204, 5777.959967205901, 5783.277090363705, 5819.214406055171, 5820.505257053155, 4264.402983582301, 4266.210751011073, 4267.829286828523, 4269.893252668677, 4275.46556680415, 5702.4582664647205, 5762.452567006169, 5853.531717462635, 6022.698865056774, 6040.879182416327, 4211.599898009684, 4311.913761724748, 4318.5033721121845, 4320.1359728053885, 4329.134173165379, 4347.804348804311, 4348.0, 4362.0, 4362.956370436318, 4373.037931655031, 4629.305604159403, 4707.0, 4911.607071434277, 4934.432540257844, 4943.28322393251, 5574.637648552913, 5771.153230966134, 5782.335031471351, 5786.826395208151, 5790.218320526759, 1497.7304085264539, 1509.939602415913, 1514.8411465229108, 1515.1742300446283, 1517.8482151784954, 937.5312343828086, 991.8908920018793, 994.7811481474064, 996.2179688944144, 1024.1704219582161, 4917.754112294371, 4942.57988071018, 4945.505449455098, 4967.453580106186, 4978.601711863114, 5200.8959820803375, 5209.661372010807, 5227.60792940531, 5228.555572776357, 5263.921041184385, 4951.579115775199, 4959.677620954626, 4966.1061009018, 5242.580593552507, 5683.943160568341, 3153.936921261562, 3169.4453470642547, 3173.6667649896426, 3177.68223177685, 3186.633537143212, 6027.668478233739, 6058.666773327421, 6081.415398455639, 6148.1392605035335, 6177.972793331235, 5964.0, 6006.909896351558, 6061.030235162441, 6079.969600151971, 6099.329073801879, 6109.236345456818, 6110.625109350361, 6131.0, 6133.815985520441, 6133.815985520441, 5676.83624856895, 5934.9406505934385, 5974.2830860297045, 6001.579889407874, 6044.758209671564, 5856.920793118382, 5901.29184497863, 5922.437368449991, 5941.970290148694, 5963.403659634176, 5861.824145275648, 6006.969965150146, 6011.248593925759, 6131.84670383244, 6183.5671502994355, 4256.063665993476, 4274.422952901443, 4278.101598664315, 4287.228298906227, 4288.292431748727, 5780.381493181916, 5951.404859514014, 5956.255468066492, 5959.463648271676, 5989.011813050972, 5784.004518441131, 5819.738111785065, 5849.034909239927, 5850.853728656818, 5853.970730146492, 5819.0, 5826.038703613856, 5848.766049357978, 5852.970735146297, 5872.588918775645, 5576.470235327637, 5798.246227990334, 5819.301683797971, 5824.504917081926, 5857.159277750373, 5864.648121112747, 5870.853228669317, 5883.823485295448, 5889.0, 5898.64608123514, 5571.275734154534, 5738.225339579103, 5739.139129130664, 5783.826485205451, 5786.855328616818], "value": 4412.370770502474, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [805.2430715127783, 813.6704634622976, 845.2223953962354, 848.4824257203105, 907.4192516789255, 16314.592135196626, 17602.767806253567, 17625.82374176258, 17717.7342339865, 17741.11294435278, 15940.362385504566, 16013.0, 16048.75926861098, 16055.91972040141, 16062.27719752611, 718.985620287594, 734.8162959260159, 850.706506255341, 867.0765634599131, 870.7344260000697, 870.843248215321, 873.724776695339, 874.3224001398935, 875.7329014650529, 876.548577482597, 753.2392283793354, 921.3642586615248, 927.5594092805931, 929.4051806843626, 930.4882314726873, 768.9615519224044, 774.6939958716332, 775.798292443963, 887.32563251929, 905.3707673167152, 671.3823282580038, 673.1719984419192, 673.3905815237218, 673.4948788408693, 673.5318953327439, 16102.0, 16111.838881611151, 16158.434454794144, 16172.75740863888, 16202.918985404998, 15772.447964321309, 15830.920845395814, 15972.201389930573, 16274.75587866183, 16451.67096658072, 14032.789508157386, 14137.151770893779, 14147.787783183261, 14379.496717614833, 14521.564353069425, 4660.464046634646, 4668.579827815479, 4717.669763116583, 4764.8332308369045, 4807.807687692488, 88483.55758221232, 88554.0, 89754.5512272441, 90608.09391906128, 91084.0, 12729.299888506035, 12825.294608796607, 12856.485740570273, 13045.543405980745, 13344.866551334362, 24837.0, 25257.62113568298, 25261.74738252594, 25294.241172764847, 25308.49383012366, 9418.858717119248, 9538.0, 9579.568919398644, 9606.903930960741, 9829.164521015651, 5183.766730497136, 5288.0, 5390.353157621111, 5445.564354851603, 5559.499645031967, 3750.7937063461227, 3884.7863367515056, 3885.86399476017, 3886.2810380079777, 3893.162969961472, 727.3853593713304, 736.1901907901266, 736.9115706115193, 742.5136535569211, 758.7192738686721, 634.9238091429058, 766.6665000724703, 774.6591499740097, 783.9216078392229, 785.3246208260891, 10251.333663311862, 10938.234323597271, 11302.604408845651, 11325.886741132648, 11755.235909666015, 712.1774350625036, 741.0144507804607, 763.5571368606195, 808.1837344282317, 822.4777266435856, 5145.151050076695, 5228.398734145622, 5237.476252374732, 5239.0, 5306.628536002443, 107484.46257768817, 115324.0, 132579.33710331385, 133477.3326133363, 138490.0, 113983.43008284905, 114589.0, 115737.0, 115922.0, 117630.41184794021, 89152.5542372284, 101809.99999999852, 103038.48480757549, 103825.48087259516, 105169.0, 9931.219258607602, 10044.296899217277, 10091.596336146471, 10261.435621040915, 10266.897331026594, 58932.705336474755, 59751.701241493516, 60902.0, 62869.685651571446, 64512.03231951618, 80987.19012810032, 83987.0, 87325.0, 90062.0, 91539.54230228806, 13524.526641567498, 13560.186388816703, 13573.577168854072, 14074.225917574631, 14095.506657266946, 13313.733725325634, 13407.798883016567, 13437.395317210554, 13554.390052447467, 13687.315634218448, 13672.86327136716, 13965.231912244517, 13991.370388332345, 14215.786763198354, 14689.706205876037, 13053.543125990545, 13425.932870335586, 13656.317184140951, 13659.112157709716, 13881.583552493441, 13490.730185396433, 13523.188608683511, 14336.354864030935, 14694.11835289886, 14738.189399583125, 10619.0, 10809.459527023775, 11004.559817607205, 11450.713732156762, 11551.768964620493, 11276.267042642203, 11562.94218528902, 11743.17797754149, 11764.411779410824, 11837.46731397072], "value": 8268.5010923425, "unit": "score"}], "name": "dromaeo_css", "value": 7653.916280352021, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 110.0, 112.0, 112.0, 110.0, 111.0, 111.0, 109.0, 110.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 115.0, 162.0, 122.0, 117.0, 116.0, 115.0, 150.0, 124.0], "value": 128.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 162.0, 161.0, 161.0, 161.0, 161.0, 161.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 74.0, 105.0, 76.0, 76.0, 76.0, 76.0, 102.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 123.0, 82.0, 82.0, 82.0, 100.0, 81.0, 82.0, 103.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 145.0, 147.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 51.0, 50.0, 51.0, 51.0, 50.0, 51.0, 50.0, 51.0], "value": 50.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 59.0, 58.0, 60.0, 57.0, 59.0, 59.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 73.0, 72.0, 75.0, 79.0, 73.0, 73.0, 74.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 131.0, 119.0, 120.0, 125.0, 117.0, 127.0, 121.0, 162.0, 124.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 154.0, 154.0, 157.0, 153.0, 155.0, 155.0, 157.0, 151.0, 151.0], "value": 154.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 67.0, 62.0, 64.0, 63.0, 61.0, 61.0, 61.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1455.0000000000002, "alertThreshold": 2.0}]} 10:08:10 INFO - Return code: 0 10:08:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:08:10 INFO - # TBPL SUCCESS # 10:08:10 INFO - Running post-action listener: _resource_record_post_action 10:08:10 INFO - [mozharness: 2016-10-05 17:08:10.944567Z] Finished run-tests step (success) 10:08:10 INFO - Running post-run listener: _resource_record_post_run 10:08:11 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 2002944; Write bytes: 248795136; Read time: 84; Write time: 230932 10:08:11 INFO - TinderboxPrint: CPU usage
13.0% 10:08:11 INFO - TinderboxPrint: I/O read bytes / time
2,002,944 / 84 10:08:11 INFO - TinderboxPrint: I/O write bytes / time
248,795,136 / 230,932 10:08:11 INFO - TinderboxPrint: CPU idle
8,267.2 (87.0%) 10:08:11 INFO - TinderboxPrint: CPU user
1,184.2 (12.5%) 10:08:11 INFO - TinderboxPrint: Swap in / out
0 / 0 10:08:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 524288; Read time: 0; Write time: 48 10:08:11 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 248270848; Read time: 36; Write time: 230884 10:08:11 INFO - Running post-run listener: _upload_blobber_files 10:08:11 INFO - Blob upload gear active. 10:08:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:08:11 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 10:08:11 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'] 10:08:11 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 10:08:11 INFO - (blobuploader) - INFO - Open directory for files ... 10:08:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:08:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:08:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:15 INFO - (blobuploader) - INFO - Done attempting. 10:08:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:08:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:08:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:16 INFO - (blobuploader) - INFO - Done attempting. 10:08:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:08:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:08:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:16 INFO - (blobuploader) - INFO - Done attempting. 10:08:16 INFO - (blobuploader) - INFO - Iteration through files over. 10:08:16 INFO - Return code: 0 10:08:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:08:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:08:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d24754325c473a4a74df568973ea94e15d4fe7b7b6959bba2d281fb79d1f8ff9d718f0e8b98eda62f7872cad409e31961319c99636a2fc92b3da708401548fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37a54337e1331df5e94f94e22553a60e6d7c838477b0d5a900c9e7afb699fa3a51a25144563f5614f430d8640edea61350ed4431a220d0aaa5d489b22173de72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e046efd64a2cd5283b4ab634f54f504ada644cb396d212cabc368897e066d34e0b4af36a50b2837e5e1c1a51fc83eb47c2ad4c8638a48fd6f882c16296aafea3"} 10:08:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:08:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:08:16 INFO - Contents: 10:08:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d24754325c473a4a74df568973ea94e15d4fe7b7b6959bba2d281fb79d1f8ff9d718f0e8b98eda62f7872cad409e31961319c99636a2fc92b3da708401548fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37a54337e1331df5e94f94e22553a60e6d7c838477b0d5a900c9e7afb699fa3a51a25144563f5614f430d8640edea61350ed4431a220d0aaa5d489b22173de72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e046efd64a2cd5283b4ab634f54f504ada644cb396d212cabc368897e066d34e0b4af36a50b2837e5e1c1a51fc83eb47c2ad4c8638a48fd6f882c16296aafea3"} 10:08:16 INFO - Running post-run listener: copy_logs_to_upload_dir 10:08:16 INFO - Copying logs to upload dir... 10:08:16 INFO - mkdir: /builds/slave/test/build/upload/logs 10:08:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1389.501307 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 9 secs) (at 2016-10-05 10:08:16.700274) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 10:08:16.704195) ========= 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=fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765 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/8d24754325c473a4a74df568973ea94e15d4fe7b7b6959bba2d281fb79d1f8ff9d718f0e8b98eda62f7872cad409e31961319c99636a2fc92b3da708401548fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37a54337e1331df5e94f94e22553a60e6d7c838477b0d5a900c9e7afb699fa3a51a25144563f5614f430d8640edea61350ed4431a220d0aaa5d489b22173de72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e046efd64a2cd5283b4ab634f54f504ada644cb396d212cabc368897e066d34e0b4af36a50b2837e5e1c1a51fc83eb47c2ad4c8638a48fd6f882c16296aafea3"} build_url:https://queue.taskcluster.net/v1/task/eP0uvdQ6SIuVZDp_q8PWZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://queue.taskcluster.net/v1/task/eP0uvdQ6SIuVZDp_q8PWZg/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/8d24754325c473a4a74df568973ea94e15d4fe7b7b6959bba2d281fb79d1f8ff9d718f0e8b98eda62f7872cad409e31961319c99636a2fc92b3da708401548fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37a54337e1331df5e94f94e22553a60e6d7c838477b0d5a900c9e7afb699fa3a51a25144563f5614f430d8640edea61350ed4431a220d0aaa5d489b22173de72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e046efd64a2cd5283b4ab634f54f504ada644cb396d212cabc368897e066d34e0b4af36a50b2837e5e1c1a51fc83eb47c2ad4c8638a48fd6f882c16296aafea3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 10:08:16.730711) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 10:08:16.731090) ========= 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=fa44defc139c4ba8574fe040000001db-1475685904.876580-1827470765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 10:08:16.818856) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 10:08:16.819761) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 10:08:16.820574) ========= ========= Total master_lag: 0.82 =========