builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1475240828.15 results: success (0) buildid: 20160930032420 builduid: 45cdcd58ba9343b9a28b915360ede9f4 revision: 2684459e8b6a5ea18efc14ed7561de39bc73eb15 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 06:07:08.153583) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 06:07:08.154122) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 06:07:08.154452) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 06:07:08.187434) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 06:07:08.187758) ========= 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=1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-30 06:07:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 121M=0s 2016-09-30 06:07:08 (121 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107311 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 06:07:08.308933) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 06:07:08.309258) ========= 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=1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023656 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 06:07:08.360321) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 06:07:08.360712) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2684459e8b6a5ea18efc14ed7561de39bc73eb15 --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 2684459e8b6a5ea18efc14ed7561de39bc73eb15 --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=1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-30 06:07:08,959 truncating revision to first 12 chars 2016-09-30 06:07:08,959 Setting DEBUG logging. 2016-09-30 06:07:08,960 attempt 1/10 2016-09-30 06:07:08,960 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2684459e8b6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 06:07:10,348 unpacking tar archive at: mozilla-aurora-2684459e8b6a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.770188 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 06:07:10.145222) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 06:07:10.145545) ========= script_repo_revision: 2684459e8b6a5ea18efc14ed7561de39bc73eb15 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 06:07:10.145952) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 06:07:10.146232) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 06:07:10.156848) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-09-30 06:07:10.157255) ========= /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=1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:07:10 INFO - MultiFileLogger online at 20160930 06:07:10 in /builds/slave/test 06:07:10 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 06:07:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:07:10 INFO - {'append_to_log': False, 06:07:10 INFO - 'base_work_dir': '/builds/slave/test', 06:07:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:07:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:07:10 INFO - 'branch': 'Mozilla-Aurora', 06:07:10 INFO - 'buildbot_json_path': 'buildprops.json', 06:07:10 INFO - 'config_files': ('talos/linux_config.py',), 06:07:10 INFO - 'default_actions': ('clobber', 06:07:10 INFO - 'read-buildbot-config', 06:07:10 INFO - 'download-and-extract', 06:07:10 INFO - 'populate-webroot', 06:07:10 INFO - 'create-virtualenv', 06:07:10 INFO - 'install', 06:07:10 INFO - 'run-tests'), 06:07:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:07:10 INFO - 'download_minidump_stackwalk': True, 06:07:10 INFO - 'download_symbols': 'ondemand', 06:07:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:07:10 INFO - 'tooltool.py': '/tools/tooltool.py', 06:07:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:07:10 INFO - '/tools/misc-python/virtualenv.py')}, 06:07:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:07:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:07:10 INFO - 'installer_path': 'installer.exe', 06:07:10 INFO - 'log_level': 'info', 06:07:10 INFO - 'log_name': 'talos', 06:07:10 INFO - 'log_to_console': True, 06:07:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:07:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:07:10 INFO - 'opt_config_files': (), 06:07:10 INFO - 'pip_index': False, 06:07:10 INFO - 'sps_profile': False, 06:07:10 INFO - 'sps_profile_interval': 0, 06:07:10 INFO - 'suite': 'dromaeojs', 06:07:10 INFO - 'system_bits': '32', 06:07:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:07:10 INFO - 'title': 'talos-linux64-ix-027', 06:07:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:07:10 INFO - 'use_talos_json': True, 06:07:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:07:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:07:10 INFO - 'work_dir': 'build'} 06:07:10 INFO - [mozharness: 2016-09-30 13:07:10.843277Z] Running clobber step. 06:07:10 INFO - Running pre-action listener: _resource_record_pre_action 06:07:10 INFO - Running main action method: clobber 06:07:10 INFO - rmtree: /builds/slave/test/build 06:07:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:07:11 INFO - Running post-action listener: _resource_record_post_action 06:07:11 INFO - [mozharness: 2016-09-30 13:07:11.305187Z] Finished clobber step (success) 06:07:11 INFO - [mozharness: 2016-09-30 13:07:11.305289Z] Running read-buildbot-config step. 06:07:11 INFO - Running pre-action listener: _resource_record_pre_action 06:07:11 INFO - Running main action method: read_buildbot_config 06:07:11 INFO - Using buildbot properties: 06:07:11 INFO - { 06:07:11 INFO - "project": "", 06:07:11 INFO - "product": "firefox", 06:07:11 INFO - "script_repo_revision": "production", 06:07:11 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 06:07:11 INFO - "repository": "", 06:07:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 06:07:11 INFO - "buildid": "20160930032420", 06:07:11 INFO - "pgo_build": "True", 06:07:11 INFO - "basedir": "/builds/slave/test", 06:07:11 INFO - "buildnumber": 541, 06:07:11 INFO - "slavename": "talos-linux64-ix-027", 06:07:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:07:11 INFO - "platform": "ubuntu64_hw", 06:07:11 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:07:11 INFO - "branch": "mozilla-aurora", 06:07:11 INFO - "repo_path": "releases/mozilla-aurora", 06:07:11 INFO - "revision": "2684459e8b6a5ea18efc14ed7561de39bc73eb15", 06:07:11 INFO - "stage_platform": "linux64-pgo", 06:07:11 INFO - "builduid": "45cdcd58ba9343b9a28b915360ede9f4", 06:07:11 INFO - "slavebuilddir": "test" 06:07:11 INFO - } 06:07:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/SYQTvccCS_aLetAI_qCs_Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 06:07:11 INFO - Running post-action listener: _resource_record_post_action 06:07:11 INFO - [mozharness: 2016-09-30 13:07:11.307750Z] Finished read-buildbot-config step (success) 06:07:11 INFO - [mozharness: 2016-09-30 13:07:11.307841Z] Running download-and-extract step. 06:07:11 INFO - Running pre-action listener: _resource_record_pre_action 06:07:11 INFO - Running main action method: download_and_extract 06:07:11 INFO - mkdir: /builds/slave/test/build/tests 06:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:11 INFO - trying https://queue.taskcluster.net/v1/task/SYQTvccCS_aLetAI_qCs_Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 06:07:11 INFO - Downloading https://queue.taskcluster.net/v1/task/SYQTvccCS_aLetAI_qCs_Q/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 06:07:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SYQTvccCS_aLetAI_qCs_Q/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 06:07:11 INFO - Downloaded 1361 bytes. 06:07:11 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 06:07:11 INFO - Using the following test package requirements: 06:07:11 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 06:07:11 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:07:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:07:11 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:07:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:07:11 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:07:11 INFO - u'jsshell-linux-x86_64.zip'], 06:07:11 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:07:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:07:11 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 06:07:11 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:07:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:07:11 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:07:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:07:11 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:07:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:07:11 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:07:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:07:11 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:07:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SYQTvccCS_aLetAI_qCs_Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 06:07:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SYQTvccCS_aLetAI_qCs_Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:07:11 INFO - Fetch https://queue.taskcluster.net/v1/task/SYQTvccCS_aLetAI_qCs_Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 06:07:12 INFO - Expected file size: 21900507 06:07:17 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 06:07:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SYQTvccCS_aLetAI_qCs_Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 06:07:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SYQTvccCS_aLetAI_qCs_Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:07:17 INFO - Fetch https://queue.taskcluster.net/v1/task/SYQTvccCS_aLetAI_qCs_Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 06:07:17 INFO - Expected file size: 21900507 06:07:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SYQTvccCS_aLetAI_qCs_Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 06:07:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SYQTvccCS_aLetAI_qCs_Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:07:22 INFO - Fetch https://queue.taskcluster.net/v1/task/SYQTvccCS_aLetAI_qCs_Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 06:07:23 INFO - Expected file size: 14414059 06:07: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')]} 06:07:24 INFO - trying https://queue.taskcluster.net/v1/task/SYQTvccCS_aLetAI_qCs_Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 06:07:24 INFO - Downloading https://queue.taskcluster.net/v1/task/SYQTvccCS_aLetAI_qCs_Q/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 06:07:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SYQTvccCS_aLetAI_qCs_Q/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 06:07:25 INFO - Downloaded 63917990 bytes. 06:07:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SYQTvccCS_aLetAI_qCs_Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 06:07:25 INFO - mkdir: /builds/slave/test/properties 06:07:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:07:25 INFO - Writing to file /builds/slave/test/properties/build_url 06:07:25 INFO - Contents: 06:07:25 INFO - build_url:https://queue.taskcluster.net/v1/task/SYQTvccCS_aLetAI_qCs_Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 06:07:26 INFO - Running post-action listener: _resource_record_post_action 06:07:26 INFO - Running post-action listener: set_extra_try_arguments 06:07:26 INFO - [mozharness: 2016-09-30 13:07:26.188827Z] Finished download-and-extract step (success) 06:07:26 INFO - [mozharness: 2016-09-30 13:07:26.189056Z] Running populate-webroot step. 06:07:26 INFO - Running pre-action listener: _resource_record_pre_action 06:07:26 INFO - Running main action method: populate_webroot 06:07:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:07:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:07:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:07:26 INFO - '--tppagecycles', 06:07:26 INFO - '7'], 06:07:26 INFO - 'tests': ['tsvgm']}}, 06:07:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:07:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:07:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:07:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:07:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:26 INFO - 'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:07:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:07:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:26 INFO - 'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['damp', 'tps']}, 06:07:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:26 INFO - 'tests': ['damp', 'tps']}, 06:07:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['dromaeo_dom']}, 06:07:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:07:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['basic_compositor_video']}, 06:07:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:07:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['a11yr', 06:07:26 INFO - 'ts_paint', 06:07:26 INFO - 'tpaint', 06:07:26 INFO - 'sessionrestore', 06:07:26 INFO - 'sessionrestore_no_auto_restore', 06:07:26 INFO - 'tabpaint']}, 06:07:26 INFO - 'other-e10s': {'tests': ['a11yr', 06:07:26 INFO - 'ts_paint', 06:07:26 INFO - 'tpaint', 06:07:26 INFO - 'sessionrestore', 06:07:26 INFO - 'sessionrestore_no_auto_restore', 06:07:26 INFO - 'tabpaint']}, 06:07:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:07:26 INFO - 'ts_paint', 06:07:26 INFO - 'tpaint', 06:07:26 INFO - 'sessionrestore', 06:07:26 INFO - 'sessionrestore_no_auto_restore', 06:07:26 INFO - 'tabpaint']}, 06:07:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:07:26 INFO - 'ts_paint', 06:07:26 INFO - 'tpaint', 06:07:26 INFO - 'sessionrestore', 06:07:26 INFO - 'sessionrestore_no_auto_restore', 06:07:26 INFO - 'tabpaint']}, 06:07:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['a11yr', 06:07:26 INFO - 'ts_paint', 06:07:26 INFO - 'tpaint', 06:07:26 INFO - 'sessionrestore', 06:07:26 INFO - 'sessionrestore_no_auto_restore', 06:07:26 INFO - 'tabpaint']}, 06:07:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['a11yr', 06:07:26 INFO - 'ts_paint', 06:07:26 INFO - 'tpaint', 06:07:26 INFO - 'sessionrestore', 06:07:26 INFO - 'sessionrestore_no_auto_restore', 06:07:26 INFO - 'tabpaint']}, 06:07:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['tsvgx', 06:07:26 INFO - 'tsvgr_opacity', 06:07:26 INFO - 'tart', 06:07:26 INFO - 'tscrollx', 06:07:26 INFO - 'cart']}, 06:07:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:07:26 INFO - 'tsvgr_opacity', 06:07:26 INFO - 'tart', 06:07:26 INFO - 'tscrollx', 06:07:26 INFO - 'cart']}, 06:07:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:26 INFO - 'talos_options': ['--disable-e10s'], 06:07:26 INFO - 'tests': ['tp5o']}, 06:07:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:26 INFO - 'tests': ['tp5o']}, 06:07:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:26 INFO - 'talos_options': ['--disable-e10s', 06:07:26 INFO - '--xperf_path', 06:07:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:07:26 INFO - 'tests': ['tp5n']}, 06:07:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:26 INFO - 'talos_options': ['--xperf_path', 06:07:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:07:26 INFO - 'tests': ['tp5n']}}, 06:07:26 INFO - 'talos.zip': {'path': '', 06:07:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:07:26 INFO - Running post-action listener: _resource_record_post_action 06:07:26 INFO - [mozharness: 2016-09-30 13:07:26.210230Z] Finished populate-webroot step (success) 06:07:26 INFO - [mozharness: 2016-09-30 13:07:26.210318Z] Running create-virtualenv step. 06:07:26 INFO - Running pre-action listener: _resource_record_pre_action 06:07:26 INFO - Running main action method: create_virtualenv 06:07:26 INFO - Creating virtualenv /builds/slave/test/build/venv 06:07:26 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 06:07:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:07:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:07:26 INFO - Using real prefix '/usr' 06:07:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:07:26 INFO - Installing distribute.............................................................................................................................................................................................done. 06:07:28 INFO - Installing pip.................done. 06:07:28 INFO - Return code: 0 06:07:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:07:28 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')]} 06:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:28 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')]} 06:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:28 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 0x7f2c4722df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d75f60>, '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 0x1d76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d771d0>, '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': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', '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 06:07:28 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 06:07:28 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 06:07:28 INFO - Using env: {'DISPLAY': ':0', 06:07:28 INFO - 'HOME': '/home/cltbld', 06:07:28 INFO - 'LANG': 'en_US.UTF-8', 06:07:28 INFO - 'LANGUAGE': 'en_US:en', 06:07:28 INFO - 'LOGNAME': 'cltbld', 06:07:28 INFO - 'MAIL': '/var/mail/cltbld', 06:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:28 INFO - 'MOZ_NO_REMOTE': '1', 06:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:28 INFO - 'NO_EM_RESTART': '1', 06:07:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:28 INFO - 'PWD': '/builds/slave/test', 06:07:28 INFO - 'SHELL': '/bin/bash', 06:07:28 INFO - 'SHLVL': '1', 06:07:28 INFO - 'TERM': 'linux', 06:07:28 INFO - 'TMOUT': '86400', 06:07:28 INFO - 'USER': 'cltbld', 06:07:28 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', 06:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:28 INFO - '_': '/tools/buildbot/bin/python'} 06:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:28 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 06:07:28 INFO - Cleaning up... 06:07:29 INFO - Return code: 0 06:07:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:07:29 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')]} 06:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:29 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')]} 06:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:29 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 0x7f2c4722df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d75f60>, '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 0x1d76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d771d0>, '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': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', '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 06:07:29 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 06:07:29 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 06:07:29 INFO - Using env: {'DISPLAY': ':0', 06:07:29 INFO - 'HOME': '/home/cltbld', 06:07:29 INFO - 'LANG': 'en_US.UTF-8', 06:07:29 INFO - 'LANGUAGE': 'en_US:en', 06:07:29 INFO - 'LOGNAME': 'cltbld', 06:07:29 INFO - 'MAIL': '/var/mail/cltbld', 06:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:29 INFO - 'MOZ_NO_REMOTE': '1', 06:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:29 INFO - 'NO_EM_RESTART': '1', 06:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:29 INFO - 'PWD': '/builds/slave/test', 06:07:29 INFO - 'SHELL': '/bin/bash', 06:07:29 INFO - 'SHLVL': '1', 06:07:29 INFO - 'TERM': 'linux', 06:07:29 INFO - 'TMOUT': '86400', 06:07:29 INFO - 'USER': 'cltbld', 06:07:29 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', 06:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:29 INFO - '_': '/tools/buildbot/bin/python'} 06:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:29 INFO - Downloading/unpacking psutil>=3.1.1 06:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:07:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:07:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:07:31 INFO - Installing collected packages: psutil 06:07:31 INFO - Running setup.py install for psutil 06:07:31 INFO - building 'psutil._psutil_linux' extension 06:07:31 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 06:07:31 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 06:07:31 INFO - building 'psutil._psutil_posix' extension 06:07:31 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 06:07:31 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 06:07:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:07:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:07:31 INFO - Successfully installed psutil 06:07:31 INFO - Cleaning up... 06:07:31 INFO - Return code: 0 06:07:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:07:31 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')]} 06:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:31 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')]} 06:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:31 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 0x7f2c4722df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d75f60>, '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 0x1d76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d771d0>, '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': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', '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 06:07:31 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 06:07:31 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 06:07:31 INFO - Using env: {'DISPLAY': ':0', 06:07:31 INFO - 'HOME': '/home/cltbld', 06:07:31 INFO - 'LANG': 'en_US.UTF-8', 06:07:31 INFO - 'LANGUAGE': 'en_US:en', 06:07:31 INFO - 'LOGNAME': 'cltbld', 06:07:31 INFO - 'MAIL': '/var/mail/cltbld', 06:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:31 INFO - 'MOZ_NO_REMOTE': '1', 06:07:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:31 INFO - 'NO_EM_RESTART': '1', 06:07:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:31 INFO - 'PWD': '/builds/slave/test', 06:07:31 INFO - 'SHELL': '/bin/bash', 06:07:31 INFO - 'SHLVL': '1', 06:07:31 INFO - 'TERM': 'linux', 06:07:31 INFO - 'TMOUT': '86400', 06:07:31 INFO - 'USER': 'cltbld', 06:07:31 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', 06:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:31 INFO - '_': '/tools/buildbot/bin/python'} 06:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:07:31 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 06:07:31 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 06:07:31 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 06:07:31 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 06:07:31 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 06:07:31 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 06:07:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:07:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:07:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:07:33 INFO - Installing collected packages: mozsystemmonitor 06:07:33 INFO - Running setup.py install for mozsystemmonitor 06:07:33 INFO - Successfully installed mozsystemmonitor 06:07:33 INFO - Cleaning up... 06:07:34 INFO - Return code: 0 06:07:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:07:34 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')]} 06:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:34 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')]} 06:07:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:34 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 0x7f2c4722df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d75f60>, '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 0x1d76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d771d0>, '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': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', '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 06:07:34 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 06:07:34 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 06:07:34 INFO - Using env: {'DISPLAY': ':0', 06:07:34 INFO - 'HOME': '/home/cltbld', 06:07:34 INFO - 'LANG': 'en_US.UTF-8', 06:07:34 INFO - 'LANGUAGE': 'en_US:en', 06:07:34 INFO - 'LOGNAME': 'cltbld', 06:07:34 INFO - 'MAIL': '/var/mail/cltbld', 06:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:34 INFO - 'MOZ_NO_REMOTE': '1', 06:07:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:34 INFO - 'NO_EM_RESTART': '1', 06:07:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:34 INFO - 'PWD': '/builds/slave/test', 06:07:34 INFO - 'SHELL': '/bin/bash', 06:07:34 INFO - 'SHLVL': '1', 06:07:34 INFO - 'TERM': 'linux', 06:07:34 INFO - 'TMOUT': '86400', 06:07:34 INFO - 'USER': 'cltbld', 06:07:34 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', 06:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:34 INFO - '_': '/tools/buildbot/bin/python'} 06:07:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:34 INFO - Downloading/unpacking jsonschema==2.5.1 06:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:07:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:07:36 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 06:07:36 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 06:07:36 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 06:07:36 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 06:07:36 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 06:07:36 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 06:07:36 INFO - Downloading functools32-3.2.3-2.tar.gz 06:07:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:07:36 INFO - warning: no files found matching '*.txt' 06:07:36 INFO - no previously-included directories found matching 'build' 06:07:36 INFO - no previously-included directories found matching 'dist' 06:07:36 INFO - no previously-included directories found matching '.git*' 06:07:36 INFO - Installing collected packages: jsonschema, functools32 06:07:36 INFO - Running setup.py install for functools32 06:07:36 INFO - warning: no files found matching '*.txt' 06:07:36 INFO - no previously-included directories found matching 'build' 06:07:36 INFO - no previously-included directories found matching 'dist' 06:07:36 INFO - no previously-included directories found matching '.git*' 06:07:36 INFO - Successfully installed jsonschema functools32 06:07:36 INFO - Cleaning up... 06:07:36 INFO - Return code: 0 06:07:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:07: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')]} 06:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07: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')]} 06:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:36 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 0x7f2c4722df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d75f60>, '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 0x1d76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d771d0>, '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': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', '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 06:07:36 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 06:07:36 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 06:07:36 INFO - Using env: {'DISPLAY': ':0', 06:07:36 INFO - 'HOME': '/home/cltbld', 06:07:36 INFO - 'LANG': 'en_US.UTF-8', 06:07:36 INFO - 'LANGUAGE': 'en_US:en', 06:07:36 INFO - 'LOGNAME': 'cltbld', 06:07:36 INFO - 'MAIL': '/var/mail/cltbld', 06:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:36 INFO - 'MOZ_NO_REMOTE': '1', 06:07:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:36 INFO - 'NO_EM_RESTART': '1', 06:07:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:36 INFO - 'PWD': '/builds/slave/test', 06:07:36 INFO - 'SHELL': '/bin/bash', 06:07:36 INFO - 'SHLVL': '1', 06:07:36 INFO - 'TERM': 'linux', 06:07:36 INFO - 'TMOUT': '86400', 06:07:36 INFO - 'USER': 'cltbld', 06:07:36 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', 06:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:36 INFO - '_': '/tools/buildbot/bin/python'} 06:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:07:36 INFO - Cleaning up... 06:07:36 INFO - Return code: 0 06:07:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:07: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')]} 06:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07: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')]} 06:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:36 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 0x7f2c4722df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d75f60>, '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 0x1d76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d771d0>, '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': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', '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 06:07:36 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 06:07:36 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 06:07:36 INFO - Using env: {'DISPLAY': ':0', 06:07:36 INFO - 'HOME': '/home/cltbld', 06:07:36 INFO - 'LANG': 'en_US.UTF-8', 06:07:36 INFO - 'LANGUAGE': 'en_US:en', 06:07:36 INFO - 'LOGNAME': 'cltbld', 06:07:36 INFO - 'MAIL': '/var/mail/cltbld', 06:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:36 INFO - 'MOZ_NO_REMOTE': '1', 06:07:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:36 INFO - 'NO_EM_RESTART': '1', 06:07:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:36 INFO - 'PWD': '/builds/slave/test', 06:07:36 INFO - 'SHELL': '/bin/bash', 06:07:36 INFO - 'SHLVL': '1', 06:07:36 INFO - 'TERM': 'linux', 06:07:36 INFO - 'TMOUT': '86400', 06:07:36 INFO - 'USER': 'cltbld', 06:07:36 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', 06:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:36 INFO - '_': '/tools/buildbot/bin/python'} 06:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:37 INFO - Downloading/unpacking blobuploader==1.2.4 06:07:37 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 06:07:37 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 06:07:37 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 06:07:37 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 06:07:37 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 06:07:37 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 06:07:38 INFO - Downloading blobuploader-1.2.4.tar.gz 06:07:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:07:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:07:39 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 06:07:39 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 06:07:39 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 06:07:39 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 06:07:39 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 06:07:39 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 06:07:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:07:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:07:39 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 06:07:39 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 06:07:39 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 06:07:39 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 06:07:39 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 06:07:39 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 06:07:39 INFO - Downloading docopt-0.6.1.tar.gz 06:07:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:07:39 INFO - Installing collected packages: blobuploader, requests, docopt 06:07:39 INFO - Running setup.py install for blobuploader 06:07:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:07:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:07:39 INFO - Running setup.py install for requests 06:07:40 INFO - Running setup.py install for docopt 06:07:40 INFO - Successfully installed blobuploader requests docopt 06:07:40 INFO - Cleaning up... 06:07:40 INFO - Return code: 0 06:07:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:40 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 0x7f2c4722df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d75f60>, '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 0x1d76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d771d0>, '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': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', '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 06:07:40 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 06:07:40 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 06:07:40 INFO - Using env: {'DISPLAY': ':0', 06:07:40 INFO - 'HOME': '/home/cltbld', 06:07:40 INFO - 'LANG': 'en_US.UTF-8', 06:07:40 INFO - 'LANGUAGE': 'en_US:en', 06:07:40 INFO - 'LOGNAME': 'cltbld', 06:07:40 INFO - 'MAIL': '/var/mail/cltbld', 06:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:40 INFO - 'MOZ_NO_REMOTE': '1', 06:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:40 INFO - 'NO_EM_RESTART': '1', 06:07:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:40 INFO - 'PWD': '/builds/slave/test', 06:07:40 INFO - 'SHELL': '/bin/bash', 06:07:40 INFO - 'SHLVL': '1', 06:07:40 INFO - 'TERM': 'linux', 06:07:40 INFO - 'TMOUT': '86400', 06:07:40 INFO - 'USER': 'cltbld', 06:07:40 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', 06:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:40 INFO - '_': '/tools/buildbot/bin/python'} 06:07:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:07:40 INFO - Running setup.py (path:/tmp/pip-m7FAYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:07:40 INFO - Running setup.py (path:/tmp/pip-YpPqg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:07:40 INFO - Running setup.py (path:/tmp/pip-iEuZi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:07:40 INFO - Running setup.py (path:/tmp/pip-M4dUGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:07:40 INFO - Running setup.py (path:/tmp/pip-yWgJlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:07:40 INFO - Running setup.py (path:/tmp/pip-hI1LG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:07:40 INFO - Running setup.py (path:/tmp/pip-291saE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:07:41 INFO - Running setup.py (path:/tmp/pip-lFVTiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:07:41 INFO - Running setup.py (path:/tmp/pip-9TK7ED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:07:41 INFO - Running setup.py (path:/tmp/pip-cAX4gX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:07:41 INFO - Running setup.py (path:/tmp/pip-aq9Pxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:07:41 INFO - Running setup.py (path:/tmp/pip-j52WgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:07:41 INFO - Running setup.py (path:/tmp/pip-6xplbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:07:41 INFO - Running setup.py (path:/tmp/pip-fS0wlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:07:41 INFO - Running setup.py (path:/tmp/pip-uG0aRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:07:41 INFO - Running setup.py (path:/tmp/pip-dZMDed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:07:41 INFO - Running setup.py (path:/tmp/pip-KRIMVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:07:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:07:41 INFO - Running setup.py install for manifestparser 06:07:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:07:41 INFO - Running setup.py install for mozcrash 06:07:41 INFO - Running setup.py install for mozdebug 06:07:42 INFO - Running setup.py install for mozdevice 06:07:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:07:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:07:42 INFO - Running setup.py install for mozfile 06:07:42 INFO - Running setup.py install for mozhttpd 06:07:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:07:42 INFO - Running setup.py install for mozinfo 06:07:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:07:42 INFO - Running setup.py install for mozInstall 06:07:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:07:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:07:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:07:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:07:42 INFO - Running setup.py install for mozleak 06:07:42 INFO - Running setup.py install for mozlog 06:07:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:07:42 INFO - Running setup.py install for moznetwork 06:07:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:07:42 INFO - Running setup.py install for mozprocess 06:07:43 INFO - Running setup.py install for mozprofile 06:07:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:07:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:07:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:07:43 INFO - Running setup.py install for mozrunner 06:07:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:07:43 INFO - Running setup.py install for mozscreenshot 06:07:43 INFO - Running setup.py install for moztest 06:07:43 INFO - Running setup.py install for mozversion 06:07:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:07:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:07:43 INFO - Cleaning up... 06:07:43 INFO - Return code: 0 06:07:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:43 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 0x7f2c4722df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d75f60>, '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 0x1d76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d771d0>, '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': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', '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 06:07:43 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 06:07:43 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 06:07:43 INFO - Using env: {'DISPLAY': ':0', 06:07:43 INFO - 'HOME': '/home/cltbld', 06:07:43 INFO - 'LANG': 'en_US.UTF-8', 06:07:43 INFO - 'LANGUAGE': 'en_US:en', 06:07:43 INFO - 'LOGNAME': 'cltbld', 06:07:43 INFO - 'MAIL': '/var/mail/cltbld', 06:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:43 INFO - 'MOZ_NO_REMOTE': '1', 06:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:43 INFO - 'NO_EM_RESTART': '1', 06:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:43 INFO - 'PWD': '/builds/slave/test', 06:07:43 INFO - 'SHELL': '/bin/bash', 06:07:43 INFO - 'SHLVL': '1', 06:07:43 INFO - 'TERM': 'linux', 06:07:43 INFO - 'TMOUT': '86400', 06:07:43 INFO - 'USER': 'cltbld', 06:07:43 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', 06:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:43 INFO - '_': '/tools/buildbot/bin/python'} 06:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:07:43 INFO - Running setup.py (path:/tmp/pip-EZ8FHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:07:43 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)) 06:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:07:43 INFO - Running setup.py (path:/tmp/pip-2C4LzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:07:43 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)) 06:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:07:43 INFO - Running setup.py (path:/tmp/pip-_8UvJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:07:44 INFO - Running setup.py (path:/tmp/pip-_okY5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:07:44 INFO - Running setup.py (path:/tmp/pip-y0_gie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:07:44 INFO - Running setup.py (path:/tmp/pip-8JQRmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:07:44 INFO - Running setup.py (path:/tmp/pip-Z8txRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:07:44 INFO - Running setup.py (path:/tmp/pip-TkM817-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:07:44 INFO - Running setup.py (path:/tmp/pip-lX2Zk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:07:44 INFO - Running setup.py (path:/tmp/pip-9ZoKVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:07:44 INFO - Running setup.py (path:/tmp/pip-C1TLg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:07:44 INFO - Running setup.py (path:/tmp/pip-ltiC7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:07:44 INFO - Running setup.py (path:/tmp/pip-64bY9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:07:44 INFO - Running setup.py (path:/tmp/pip-mvOVwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:07:44 INFO - Running setup.py (path:/tmp/pip-SQl2hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:07:44 INFO - Running setup.py (path:/tmp/pip-e5mGil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:07:44 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)) 06:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:07:44 INFO - Running setup.py (path:/tmp/pip-W8vpZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:07:45 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)) 06:07:45 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)) 06:07:45 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)) 06:07:45 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)) 06:07:45 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)) 06:07:45 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)) 06:07:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:07:45 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 06:07:45 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 06:07:45 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 06:07:45 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 06:07:45 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 06:07:45 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 06:07:46 INFO - Downloading blessings-1.6.tar.gz 06:07:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:07:47 INFO - Installing collected packages: blessings 06:07:47 INFO - Running setup.py install for blessings 06:07:47 INFO - Successfully installed blessings 06:07:47 INFO - Cleaning up... 06:07:47 INFO - Return code: 0 06:07:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:07:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:07:47 INFO - Reading from file tmpfile_stdout 06:07:47 INFO - Current package versions: 06:07:47 INFO - argparse == 1.2.1 06:07:47 INFO - blessings == 1.6 06:07:47 INFO - blobuploader == 1.2.4 06:07:47 INFO - docopt == 0.6.1 06:07:47 INFO - functools32 == 3.2.3-2 06:07:47 INFO - jsonschema == 2.5.1 06:07:47 INFO - manifestparser == 1.1 06:07:47 INFO - mozInstall == 1.12 06:07:47 INFO - mozcrash == 0.17 06:07:47 INFO - mozdebug == 0.1 06:07:47 INFO - mozdevice == 0.48 06:07:47 INFO - mozfile == 1.2 06:07:47 INFO - mozhttpd == 0.7 06:07:47 INFO - mozinfo == 0.9 06:07:47 INFO - mozleak == 0.1 06:07:47 INFO - mozlog == 3.4 06:07:47 INFO - moznetwork == 0.27 06:07:47 INFO - mozprocess == 0.23 06:07:47 INFO - mozprofile == 0.28 06:07:47 INFO - mozrunner == 6.12 06:07:47 INFO - mozscreenshot == 0.1 06:07:47 INFO - mozsystemmonitor == 0.3 06:07:47 INFO - moztest == 0.7 06:07:47 INFO - mozversion == 1.4 06:07:47 INFO - psutil == 3.1.1 06:07:47 INFO - requests == 1.2.3 06:07:47 INFO - wsgiref == 0.1.2 06:07:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:07:47 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')]} 06:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:47 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')]} 06:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:47 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 0x7f2c4722df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d75f60>, '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 0x1d76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d771d0>, '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': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', '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 06:07:47 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 06:07:47 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 06:07:47 INFO - Using env: {'DISPLAY': ':0', 06:07:47 INFO - 'HOME': '/home/cltbld', 06:07:47 INFO - 'LANG': 'en_US.UTF-8', 06:07:47 INFO - 'LANGUAGE': 'en_US:en', 06:07:47 INFO - 'LOGNAME': 'cltbld', 06:07:47 INFO - 'MAIL': '/var/mail/cltbld', 06:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:47 INFO - 'MOZ_NO_REMOTE': '1', 06:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:47 INFO - 'NO_EM_RESTART': '1', 06:07:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:47 INFO - 'PWD': '/builds/slave/test', 06:07:47 INFO - 'SHELL': '/bin/bash', 06:07:47 INFO - 'SHLVL': '1', 06:07:47 INFO - 'TERM': 'linux', 06:07:47 INFO - 'TMOUT': '86400', 06:07:47 INFO - 'USER': 'cltbld', 06:07:47 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', 06:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:47 INFO - '_': '/tools/buildbot/bin/python'} 06:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:47 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)) 06:07:47 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)) 06:07:47 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)) 06:07:47 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)) 06:07:47 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)) 06:07:47 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)) 06:07:47 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)) 06:07:47 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)) 06:07:47 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)) 06:07:47 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)) 06:07:47 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)) 06:07:47 INFO - Cleaning up... 06:07:47 INFO - Return code: 0 06:07:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:07:47 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')]} 06:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:47 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')]} 06:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:47 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 0x7f2c4722df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d75f60>, '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 0x1d76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d771d0>, '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': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', '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 06:07:47 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 06:07:47 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 06:07:47 INFO - Using env: {'DISPLAY': ':0', 06:07:47 INFO - 'HOME': '/home/cltbld', 06:07:47 INFO - 'LANG': 'en_US.UTF-8', 06:07:47 INFO - 'LANGUAGE': 'en_US:en', 06:07:47 INFO - 'LOGNAME': 'cltbld', 06:07:47 INFO - 'MAIL': '/var/mail/cltbld', 06:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:47 INFO - 'MOZ_NO_REMOTE': '1', 06:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:47 INFO - 'NO_EM_RESTART': '1', 06:07:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:47 INFO - 'PWD': '/builds/slave/test', 06:07:47 INFO - 'SHELL': '/bin/bash', 06:07:47 INFO - 'SHLVL': '1', 06:07:47 INFO - 'TERM': 'linux', 06:07:47 INFO - 'TMOUT': '86400', 06:07:47 INFO - 'USER': 'cltbld', 06:07:47 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', 06:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:47 INFO - '_': '/tools/buildbot/bin/python'} 06:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:07:47 INFO - Cleaning up... 06:07:47 INFO - Return code: 0 06:07:47 INFO - Running post-action listener: _resource_record_post_action 06:07:47 INFO - Running post-action listener: _start_resource_monitoring 06:07:47 INFO - Starting resource monitoring. 06:07:47 INFO - [mozharness: 2016-09-30 13:07:47.862894Z] Finished create-virtualenv step (success) 06:07:47 INFO - [mozharness: 2016-09-30 13:07:47.863358Z] Running install step. 06:07:47 INFO - Running pre-action listener: _resource_record_pre_action 06:07:47 INFO - Running main action method: install 06:07:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:07:48 INFO - Reading from file tmpfile_stdout 06:07:48 INFO - Detecting whether we're running mozinstall >=1.0... 06:07:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:07:48 INFO - Reading from file tmpfile_stdout 06:07:48 INFO - Output received: 06:07:48 INFO - Usage: mozinstall [options] installer 06:07:48 INFO - Options: 06:07:48 INFO - -h, --help show this help message and exit 06:07:48 INFO - -d DEST, --destination=DEST 06:07:48 INFO - Directory to install application into. [default: 06:07:48 INFO - "/builds/slave/test"] 06:07:48 INFO - --app=APP Application being installed. [default: firefox] 06:07:48 INFO - mkdir: /builds/slave/test/build/application 06:07:48 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'] 06:07:48 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 06:08:04 INFO - Reading from file tmpfile_stdout 06:08:04 INFO - Output received: 06:08:04 INFO - /builds/slave/test/build/application/firefox/firefox 06:08:04 INFO - Running post-action listener: _resource_record_post_action 06:08:04 INFO - [mozharness: 2016-09-30 13:08:04.140528Z] Finished install step (success) 06:08:04 INFO - [mozharness: 2016-09-30 13:08:04.140775Z] Running run-tests step. 06:08:04 INFO - Running pre-action listener: _resource_record_pre_action 06:08:04 INFO - Running main action method: run_tests 06:08:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:08:04 INFO - Python 2.7.3 06:08:04 INFO - Return code: 0 06:08:04 INFO - grabbing minidump binary from tooltool 06:08:04 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')]} 06:08:04 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 0x1d75f60>, '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 0x1d76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d771d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:08:04 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 06:08:04 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 06:08:04 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 06:08:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:08:04 INFO - Return code: 0 06:08:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:08:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:08:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:08:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:08:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:08:04 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/SYQTvccCS_aLetAI_qCs_Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 06:08:04 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/SYQTvccCS_aLetAI_qCs_Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 06:08:04 INFO - Using env: {'DISPLAY': ':0', 06:08:04 INFO - 'HOME': '/home/cltbld', 06:08:04 INFO - 'LANG': 'en_US.UTF-8', 06:08:04 INFO - 'LANGUAGE': 'en_US:en', 06:08:04 INFO - 'LOGNAME': 'cltbld', 06:08:04 INFO - 'MAIL': '/var/mail/cltbld', 06:08:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:08:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:04 INFO - 'MOZ_NO_REMOTE': '1', 06:08:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:04 INFO - 'NO_EM_RESTART': '1', 06:08:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:04 INFO - 'PWD': '/builds/slave/test', 06:08:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:08:04 INFO - 'SHELL': '/bin/bash', 06:08:04 INFO - 'SHLVL': '1', 06:08:04 INFO - 'TERM': 'linux', 06:08:04 INFO - 'TMOUT': '86400', 06:08:04 INFO - 'USER': 'cltbld', 06:08:04 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030', 06:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:04 INFO - '_': '/tools/buildbot/bin/python'} 06:08:04 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/SYQTvccCS_aLetAI_qCs_Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 06:08:04 INFO - mozversion application_buildid: 20160930032420 06:08:04 INFO - mozversion application_changeset: 2684459e8b6a5ea18efc14ed7561de39bc73eb15 06:08:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:08:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:08:04 INFO - mozversion application_name: Firefox 06:08:04 INFO - mozversion application_remotingname: firefox-dev 06:08:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:08:04 INFO - mozversion application_vendor: Mozilla 06:08:04 INFO - mozversion application_version: 51.0a2 06:08:04 INFO - mozversion platform_buildid: 20160930032420 06:08:04 INFO - mozversion platform_changeset: 2684459e8b6a5ea18efc14ed7561de39bc73eb15 06:08:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:08:04 INFO - mozversion platform_version: 51.0a2 06:08:04 INFO - using testdate: 1475240884 06:08:04 INFO - actual date: 1475240884 06:08:04 INFO - starting webserver on 'localhost:55788' 06:08:04 INFO - SUITE-START | Running 2 tests 06:08:04 INFO - TEST-START | dromaeo_css 06:08:04 INFO - operating with platform_type : linux_ 06:08:04 INFO - Initialising browser for dromaeo_css test... 06:08:04 INFO - TEST-INFO | started process 25283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKfpvXo/profile http://localhost:55788/getInfo.html) 06:08:08 INFO - PROCESS | 25283 | __metrics Screen width/height:1600/1200 06:08:08 INFO - PROCESS | 25283 | colorDepth:24 06:08:08 INFO - PROCESS | 25283 | Browser inner width/height: 1024/697 06:08:08 INFO - PROCESS | 25283 | __metrics 06:08:08 INFO - PROCESS | 25283 | 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" 06:08:08 INFO - PROCESS | 25283 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:08:09 INFO - PROCESS | 25283 | console.error: PushService: 06:08:09 INFO - PROCESS | 25283 | stateChangeProcessEnqueue: Error transitioning state 06:08:09 INFO - PROCESS | 25283 | UnknownError 06:08:09 INFO - TEST-INFO | 25283: exit 0 06:08:09 INFO - Browser initialized. 06:08:09 INFO - Running cycle 1/1 for dromaeo_css test... 06:08:09 INFO - TEST-INFO | started process 25375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKfpvXo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:21 INFO - PROCESS | 25375 | RSS: Main: 144670720 06:08:21 INFO - PROCESS | 25375 | 06:09:12 INFO - PROCESS | 25375 | 1475240952539 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] 06:11:21 INFO - PROCESS | 25375 | Cycle 1(1): loaded http://localhost:55788/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55788/tests/dromaeo/cssquery-ext.html) 06:11:22 INFO - PROCESS | 25375 | RSS: Main: 233070592 06:11:22 INFO - PROCESS | 25375 | 06:14:24 INFO - PROCESS | 25375 | Cycle 1(1): loaded http://localhost:55788/tests/dromaeo/cssquery-ext.html (next: http://localhost:55788/tests/dromaeo/cssquery-jquery.html) 06:14:25 INFO - PROCESS | 25375 | RSS: Main: 234831872 06:14:25 INFO - PROCESS | 25375 | 06:17:27 INFO - PROCESS | 25375 | Cycle 1(1): loaded http://localhost:55788/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55788/tests/dromaeo/cssquery-mootools.html) 06:17:27 INFO - PROCESS | 25375 | RSS: Main: 174542848 06:17:27 INFO - PROCESS | 25375 | 06:20:29 INFO - PROCESS | 25375 | Cycle 1(1): loaded http://localhost:55788/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55788/tests/dromaeo/cssquery-prototype.html) 06:20:30 INFO - PROCESS | 25375 | RSS: Main: 237645824 06:20:30 INFO - PROCESS | 25375 | 06:23:33 INFO - PROCESS | 25375 | Cycle 1(1): loaded http://localhost:55788/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55788/tests/dromaeo/cssquery-yui.html) 06:23:33 INFO - PROCESS | 25375 | RSS: Main: 177844224 06:23:33 INFO - PROCESS | 25375 | 06:26:36 INFO - PROCESS | 25375 | Cycle 1(1): loaded http://localhost:55788/tests/dromaeo/cssquery-yui.html (next: http://localhost:55788/tests/dromaeo/cssquery-dojo.html) 06:26:36 INFO - PROCESS | 25375 | RSS: Main: 262938624 06:26:36 INFO - PROCESS | 25375 | 06:26:36 INFO - PROCESS | 25375 | __start_tp_report 06:26:36 INFO - PROCESS | 25375 | _x_x_mozilla_page_load 06:26:36 INFO - PROCESS | 25375 | _x_x_mozilla_page_load_details 06:26:36 INFO - PROCESS | 25375 | |i|pagename|runs| 06:26:36 INFO - PROCESS | 25375 | |0;dojo.html;3009.9999999999995;3036.544518322252;3045.4213699397114;3060.2808340040074;3082.5222090575953;5264.236685680578;5368.167933970236;5368.785248590061;5386.030514507387;5393.352797664276;5610;5628.465295796903;5662.462066103713;5665.1785491103765;5666.348369937458;5094.184930411126;5125.513076257749;5168.069747445477;5169.483051694838;5219.582433405338;4907.435644900828;4907.5583197512215;5163.948360516403;5203.765830537616;5211.322528071364;4895.755212239392;4920.434150072734;4970.801167953277;4985.451600323961;5036.697798132123;4924.827631032915;4930.926036109461;5007.524285192901;5011.373578302712;5031.622628302892;4785.928211076836;4925.729084900329;4937.1606826839525;4941.851744447672;4979.975100124512;5215.973920130413;5369.838904832861;5410.404855465896;5414.052540805344;5438.265834112383;5856.648601083949;5862.296524417055;5985.551083668743;6013.909791353133;6014.248218972629;5760.452756988079;6032.879342413127;6037.154798328237;6055.455009049163;6057.151998720183;5431.782728690848;5444.646098003617;5495.230667706524;5509.9806535791;5520;6060;6068.969655151696;6070.484008859208;6075.301340345828;6076.75692972285;5848.1227815827115;5851.912221316684;5855.3851845556455;5857.384974577693;5860.560457965585;5585.245991791137;5636.60543761941;5811.2445382100905;5845.240118784616;5872.765089396376;5929.436703513159;5933.910991335133;5942.6731529766275;5972.880542389128;5986.3714309997695;5888.293404791367;5904.675242861598;5943.524518038546;5945.494632956247;5968.134620480093;4397.868063958086;4443.733375997451;4474.440694913136;4587.632989360844;4591.081783643284;4017.9598204017584;4050.9797451012555;4068.6948478864206;4073;4094.713370064067;5576.386597474356;5583.022970980062;5589.301337332833;5589.524890384363;5602.187682785973;5699.145128230715;5779.450952159538;5901.144334071536;5908.704564771744;5913.556483263773;5444.945550544523;5492.011437941129;5507.531859791962;5564.638298510584;5601.719914004365;5075.2387141929;5080.187170052774;5086.237064440364;5087.211482220262;5088.211327244283;5946.821595352233;5994.0409534474275;6046.546509011841;6059.636421814617;6064.727087281083;5797.652140871562;5833.591648584558;5892.5285977122585;5907.616004959664;6007;6105.26630253466;6143.880361275353;6146.754129834757;6151.6924153793025;6151.84620384494;5784.392638772868;5817.854553636193;5861.472467477947;5864.912026319694;5898.879212949526;5632.971835140798;5655.377908430151;5673.262475878109;5681.2330335404195;5954.46409823118;5591.161325801162;5591.6365436246515;5599.552035837205;5605.355384130877;5616.719164041863;5596.972015140062;5605.523530499953;5605.579581531483;5610.85972850682;5615.213870058276;5463.863403414946;5551.389347171727;5553.111502159635;5577.135543990688;5649.265595472562;5754.223179870832;5852.151438041375;5853.678047707247;5856.882862342814;5885.411458854081;5699.8860022800145;5702.116171993348;5705.686187259575;5710.371859095413;5710.828675139753 06:26:36 INFO - PROCESS | 25375 | |1;ext.html;582.6911736779506;606.814921448958;618.2797041446714;625.3590070178064;633.4837107757178;33746.662533374656;37565.248695026086;45008.54991450084;45652.543474565246;45707;47378.526214737845;47732;47772.76113619427;47773;47831.76084119575;9293.07069293072;9452.19656329213;9452.952735236315;9458.196053335474;9461.38500997433;8531.445456045369;8603.56982150893;10889.455527223647;11117.777644447147;11149.275297105662;11280.266782659142;11390.54437822486;11395.373254471;11417.885821141765;11430.485628146711;11127.833082503768;11187.72030699239;11205.719857003558;11211.439428028647;11218.158638102175;10984.176186786022;11029.283096598696;11103.500342484607;11104.056155226735;11105.222634415593;44357.556424435665;44607.10785784299;44724.329135063;44726.10547789026;44731.776341118086;4016.4376987221813;4024.5170579530645;4129.215449064668;4324.567543245682;4530.592246697813;34030.48954265688;34544.654553454646;34744.65255347439;34843.825780871186;36106.277874442625;4277.379779931924;4494.5730155635165;4517;4538.841140560065;4564.315352697089;360669;362611;364193;364475.9999999973;364972;61948.07077893835;62267.68866155731;62290.377096229364;62331.37668623347;62346.376536234966;39739.20521589552;40335.59664403377;40495.7975210128;42880.571194288284;63645.68177159085;17937.103144842706;17943.102844857705;17954.371596994042;18040.458786236435;18063.2774689011;13241.3379331035;13483.123596966361;14594.708105837824;14616.342264598119;14664.340104695315;19532.14216255843;20616.79383206149;20708.48228794262;20752.273670421764;20804.791952080588;7362.286555348929;7605.353544948631;7655.732049378245;7750.3024727773645;7766.5728384939375;1054.8997845204694;1059.7297689089232;1091.4215465803138;1093.2620481175175;1178.6699724077273;34305;34595;34752;34821.30357392838;34866;1153.700037990112;1157.288267715349;1159.7274640459486;1171.2211379432752;1177.1171621284036;17274.740878886576;17936.742418590224;17959.439994816843;18088.457346279632;18135.818641813676;546503;549983;550827;551004;551236;61929.071063934076;62962;62983.68508157522;62991.37008629855;63017.36982630115;1327.336331834083;1385.1688986607955;1416.3201663201514;1472.197652279489;1484.747592909208;31242;35370;35465;35686.464703028956;35779.28441431209;52576.47423525869;52723.209151861985;52820.73589632027;53033.73483132714;53164.73417632887;405137;405984;407305;407357;407481;30252;30883.84558077195;31186.064418067494;31256.843715781277;32704.67295327016;50146.24780628367;50244.748776257344;50657.746711266205;51198.23202651889;51301.23048154206;42279;42375.152496950504;42418.36372454354;42509;43962;42781.78609107059;43158.784206080025;43615.56384436115;44937.550624493335;45138;43245;43758.56241437545;44075.11849763051;44816.32775508435;44817;36291;37656.62343376641;38507.80746096252;38806.41790373203;39454;29253;29597;30279.545806813356;30451.84774076204;30492.390152197277 06:26:36 INFO - PROCESS | 25375 | |2;jquery.html;370.0803503294315;400.95589485156626;402.21166513633267;407.0962463331404;413.5926112778914;14480;16732.916335418322;20718.689219661715;20740.377788666327;21137.894310528463;19582.412527624194;19657.803421965775;19741.703874441893;19992.800071999274;20290.898545507287;5845.181674565564;5848.181254624356;5873.823785286427;5907.645541267538;6035.853187894286;4333.241682705514;5801.854953626172;5886.264216972857;5889.64662120272;5894.941050589504;4528.818847246106;6307.1485349477925;6557.114789503404;6582.835429114262;6693.899591506131;6473.482121430275;6672.699728512204;6678.966605166992;6696.83257918551;6728.596284222962;5902.852428689274;5913.526917846562;5915.822525324247;5916.704164791786;5919.733611987428;23453.179138730062;23736.64395034076;23840.165594204118;23871.045158193825;24110.63834042473;2517.458746369521;2531.708853481855;2537.7716005559587;2769.62610047643;3063.494523403636;15155.772663410058;15215;15225.61935951599;15552.455664051704;15989.680206395808;2038.2458490358515;2057.2799520167973;2062.5874825035053;2092.027371022241;2176.8040876321206;62138.68930655318;83414;84809.57595211985;85542.57228713878;89272.99999999935;10954.671359859058;11010.339379637247;11203.439828008566;11379.487923043484;11380.203385763083;15668.373265069498;15706.214689265491;15727;15731.213439328216;15731.606709832346;8364.832703345899;8651.178138076873;8681.739547813575;8701.825963480822;8884.200421962054;8512.148785121562;8544.31645468361;8553.358498112666;8636.222739953435;8775.210231079105;6530.183727034121;6732.461403087741;6827.556208846409;6897.3447522485285;6927.7228910844005;1822.2528763207022;1830.9725354119698;1967.9828176119306;1982.7125066865513;2017.6973453981727;878.5299864572551;968.7239136845965;999;1000.1498726082917;1082.0423924826428;20162.798372016092;20529.589408211752;20598.58802823965;20723;20793.168273269202;1032.8244198486275;1048.3814549415881;1079.2660990526517;1088.3089238333714;1114.749181434187;10909.890901091047;11763.353015584054;12020.218685785396;12137.271763694207;12144.514219431123;436913;462376;493223;497152;517417;89258.10741892627;89517;90777.54611226902;91517.54241228885;91567.54216228877;1057.5452555401098;1100.1199040767353;1109.0905457524752;1125.0549538387793;1131.932084074958;17640.38258660941;18085.728714069035;18111.275548977894;18259.360922367654;18263.81736182621;44387.778061109486;44568.77715611401;45577.316340254256;45780.542194577625;46038.539614603425;56130.719346403006;57162.14256786068;59652;61794;62839;8975.32685048611;9080.772980675272;9118.316126290421;9139.497327646777;9435.24518038569;10880.836787448354;12169.661337252717;13397;13431.529896453578;13798.17210967345;8170.9943436861;11572.59495917639;11619.709507262387;11696.590619328283;11844.111691622991;5873.148393482836;9882.555285012335;11858.16992810495;12003.079507278793;12092.214006089576;11907.52369905194;11945.940270298594;12272.693182670504;12572.874271257171;12809.359532023174;8582.742517724479;8607.827843443221;8778.166074222938;8788.91211087881;8895.288376929959;11678.182527223013;11770.88229117732;12247.57133500359;12351.19717218378;12690.492380304684 06:26:36 INFO - PROCESS | 25375 | |3;mootools.html;1509.064380084348;1560.329058504843;1699.3287651377707;1792.9910350448247;1805.7291406289064;8571.871421928668;9191.77020574486;9224.354295199339;9229.261659067275;9231.953840230806;7859.960700196505;8029.558374289411;8807.515586642749;8957.059508751585;8979.057198994093;2440.865752383618;2448.5959816630325;2451.203358908353;2464.2484042367073;2466.198485492222;2402.855828650278;2407.3018824540864;2451.595486744694;2452.043702955849;2471.9876400617973;2120.07776617172;2180.9890950545305;2369.739328673853;2446.9265922022278;2449.889754961022;2452.3623857796924;2463.310273123528;2496.5506208882393;2503.0613519930116;2513.924582262535;2435.342457536473;2448.64494648275;2451.019592163131;2455.0793452455327;2457.9262622121364;8498.78753031173;8591.82816343676;8639.913600864036;8656.697015604424;8676.913230867674;5240.371155461369;5383.488568585978;5386.218998245233;5388.73056347185;5412.4587541245955;3431.742619303562;3450.1719587299117;3478.165240342325;3502.2645244498685;3503.5095086687884;1205.5479195301762;1212.5210541836013;1228.2200802490484;1239.2007155384817;1284.7237843863613;12743.299118548475;12772.105952583323;12774.489020439265;12780.360981950773;12791.232526048467;4752.667313288037;4788.281757736368;4851.951480485221;4877.268409738567;4884.902301954012;10749.355038697704;10763.677089687322;10767.246292759432;10772.622958196425;10779.137668986463;5571.275734154534;5580.972095139498;5581.358143813513;5588.3573389060775;5590.496855283044;5021.774020169101;5134.2812006319145;5140.511651393112;5154.329937108152;5221.373435187802;4269.743815371025;4303.526612072669;4337.7397356158735;4389.034412429324;4390.473143222834;1216.1486959128645;1327.4690123950304;1328.5881376773232;1337.9264140472173;1372.6911444925013;852.7740148860557;972.6547075788135;994.9204063674889;997.3168379659957;1014.1987829614669;6133.29467111279;6207.565470417027;6224.688765561704;6333.809985700436;6437.806865794034;969.6412327438893;1005.5223768709805;1005.8088963096989;1029.9433531155707;1037.6368271105052;4150.875473735793;4235.661147108224;4265.7440553566885;4276.3799249109325;4356.477222733229;11045.502952367162;11488.655340339803;11490.310581365145;11496.137789665809;11522.251053681484;11084.833727494093;11203.60787372438;11353.659390218307;11376.431178441046;11410.087193024705;8524.104968978292;8610.65557377698;8617.138286171332;8618;8619.482831030158;6332.493400528039;6345.90481142774;6346.587471814318;6432.485401167802;6460.3862633049785;10610.204234682275;10745;10754.13966882632;10755.032047115797;10767;10494.422806745702;10507.211959103252;10741.624043158452;10855.67432977012;11095.944520277348;8012.599370031592;8107.878381824159;8131.71538996156;8133.389995750461;8134.715284964997;8535.95732021336;8555.144485551395;8725.432846864933;8732.476051436934;8781.824363512822;8026.799330016796;8084.797880053045;8106;8128.227818357246;8315.95842020786;7609.733659321897;7836.059672839296;7860.803479913048;7904.446688731734;8044.155363686963;7014.5440546364325;7126.216116227314;7128;7128.928710712827;7136.3220494052985;5608.4111168326735;5712.34308054579;5731.283589551306;5746.913796293143;5833.125031245348;5514.91727624078;5599.552035837041;5601.859953501195;5656.462636049569;5719.28508936383 06:26:36 INFO - PROCESS | 25375 | |4;prototype.html;346.9444888817788;350.27143541433816;352.52233223981494;356.1843378662859;359.7230132797744;5570.944290557093;5604.5796565257615;5646.435356464352;5664.773409063632;5678.744456499458;5501.367342755584;5515.420880807517;5522.723863806814;5532.972335138319;5536.667799932007;4060.776657283848;4389.629600016004;4403.295472724365;4406.206882761102;4443.577860103301;3845.288621604998;4251.914961700764;4293.098449325646;4296.248156572603;4298.376735373369;4247.575242475743;4270.871873843789;4283.421738065368;4285;4302.827886884521;4179.540250572434;4305.0744090020635;4311.2670845955945;4322.481302243719;4322.654187664979;3727.6086010969;3805.60041195676;3829.7170447899707;3838.1747924196434;3874.3219936511;5378.596605254583;5392.379876314196;5394.352677678665;5410.891782164374;5483.396826349099;4754.690945088592;4976.4277108132665;5005.349304590416;5008.924866127011;5052.7726252318735;5819.7090145492975;5822.214001109881;5834.854128646775;5842.108156462536;5844.795432159896;4221.409002739619;4235.618794308496;4242.215190189825;4270.12462445198;4272.423222864904;5878.265216847894;6067.7572897084065;6173.259208894961;6198.721057552421;6214;4281.678874084456;4291.163223171514;4301.870943871689;4313.317806055641;4320.503142138694;4353.10761293934;4361.280388735887;4361.738295702268;4375.518692943773;4389.846355377546;4919.1883339248625;5007.098722230034;5023.944971555941;5041.495850414929;5043.87390315245;5852.151438041546;5861.238039054895;5909.172715819789;5920.792772253037;5986.371430999682;1463.9853601464063;1464.8535146485267;1466.149633212734;1472.7128209999162;1486.7734119351578;916.3493919317359;957.3729207369184;971.4851128901694;974.6734843827397;975.1223898491414;5045.695069729333;5073.554037099409;5089.872753181126;5094.54149126573;5122.795088196505;5291.973540132351;5333.653312534673;5345.118055520873;5355.027959482447;5360.892782144335;4909.239067944474;5025.331507999108;5065.290859279704;5111.488851114858;5139.614528910347;2802.467531169071;2821.3087793490317;2831.929201769972;2838.929026774347;2861.8998335058172;5438.45615438453;5487.725613719378;5520.564653190119;5525.005499010217;5606.467385598362;5321.946780532223;5399.298091248191;5401.972990135103;5409;5467.699276539749;5920.60865696561;6030.638161710312;6088;6146.877062458815;6217.782377616762;6043.909341359795;6053.939460605337;6058.454739073328;6078.57449978515;6094.7562097517375;5837.001653867114;5927.318358388668;5946.583739138218;5984.162217289496;6021.969890150521;6155;6173.074038894202;6197.504199664107;6232.501399887908;6236.253848922309;4312.805923733376;4322.63257623093;4331.7184383015;4334.41485399467;4343.326784348431;5842.620229685057;6037.396260373927;6048.395160483917;6052.335607707915;6067.817965461043;5913.822585322448;5929.407059294209;5949.167116603766;5979.730912109053;6032;5662.603617746719;5876.236089308362;5891.646501209942;5911;5980.667539659449;5832.416758324133;5846.532277417881;5884.764609415575;5885.735141918538;5892.086726557391;5810.302763668386;5935.376785437467;5945.732442040032;5965.821025369246;6032.426919442646;5786.334571524329;5812.593118481665;5816.680082595498;5820.76716931318;5842.2405087338375 06:26:36 INFO - PROCESS | 25375 | |5;yui.html;718.769993602047;734.6730704836343;788.712120076172;881.4623079921249;902.9638814447422;15522.223888805556;16579.751303730452;17581.648367032652;17731.645367092668;17780.555486112822;15813.920930395332;16039.278232479537;16051.678966420664;16059.197040147976;16427;723.1791916175126;737.0823324960405;853.036069241756;867.0722327109963;874.1608056265976;877.3419935048713;884.5179377239388;886.2865393358344;886.3441053620339;886.4991279926853;931.8695382646401;932.4824722279133;933.77589378549;933.8785957825473;933.9766505837374;761.1361105145672;777.0558771093092;896.5472436419566;927.7958849053231;928.5264515097282;645.2418408370146;646.8415238266608;646.912666789982;647.9222493300787;671.4259308291438;15807.288672009672;15872.365105395771;15895.284712187979;15931.601709957344;15936.920315398465;15148.469803556933;15644;15727.764083538756;15786.921065394714;15904.602384940354;13950.581482555539;14239.928800356036;14296.714065718732;14322.928385358111;14329.283535823168;4489.169503641804;4533.750643714594;4575.542445755431;4651.767411629405;4670.626349892001;86206.56896715476;87586.5620671899;87588.56205718931;87739;87893;11678.24091434054;11780.352080635475;11785.292882427082;11985.28088314704;12028.819567706492;22210.77789222087;22564;22578.54842903133;22580.774192257868;22606.773932260796;8442.409031367746;8447.915520844714;8832.823343533093;8836.425632333878;9102.81794364109;4993.775280112403;5155.664881782672;5176.870578235575;5312.07038768214;5314.946850531523;3459.4810778383444;3573.8391772370305;3584.6953008994005;3590.694790942799;3591.120175557005;589.3163929841363;597.6682940967804;602;609.9878002440015;613.355976224962;552.3923683947705;590.6397097770357;626.8714913442733;634.66127320822;693.6774399904069;9709.368891022203;10185.33795303303;10348.948255258676;10435.582576697;10729.446547539397;616.9136320915076;625.1185827982523;685.8936864785966;710.1123595505618;776.7592046465613;5099.133147364957;5222.086134926372;5236.6857988520815;5253.369595648546;5323.441038690959;115037;115115;115650;117422;120959.39520302518;65432;65933.34066659368;68211;104521.86434406979;107196.46401768098;93838.53080734552;95901.52049239709;99641;101313.49343253237;101375.99999999853;9708.920653008758;9920.511923211576;9940;9978.451185184884;10025.699229023141;55789;56465.71767141138;56999.71500142473;57869.4213057864;57996;77230;82461.17538824535;83951;84994.57502712446;86824;11718.531258749554;12886.806697899727;13466.124701894345;13761.243131627856;13826.30868456553;15973.281202346156;16263;17149.91425042867;17433.389831355842;17459.865108767888;14448.927755361156;14546.4908728194;15363.923180384027;15368.308426121075;15412.075275483507;14584.197869116875;14797.408103675732;14869.405223790927;14985.2507374633;15460.613484662974;14820.851791482379;15230.314635841192;15687.921560392126;16490.75263871019;16500.504984850475;12017.579384721494;12287.69280767988;13296.468141274627;13478.595642130751;13693.315334233448;12631.431585578488;12710.395181343512;12753;12789.93605031969;13087 06:26:36 INFO - PROCESS | 25375 | __end_tp_report 06:26:36 INFO - PROCESS | 25375 | __start_cc_report 06:26:36 INFO - PROCESS | 25375 | _x_x_mozilla_cycle_collect,871 06:26:36 INFO - PROCESS | 25375 | __end_cc_report 06:26:36 INFO - PROCESS | 25375 | __startTimestamp1475241996847__endTimestamp 06:26:36 INFO - PROCESS | 25375 | 06:26:36 INFO - PROCESS | 25375 | ------- Summary: start ------- 06:26:36 INFO - PROCESS | 25375 | Number of tests: 6 06:26:36 INFO - PROCESS | 25375 | 06:26:36 INFO - PROCESS | 25375 | [#0] dojo.html Cycles:165 Average:5454.74 Median:5610.00 stddev:634.96 (11.3%) stddev-sans-first:607.25 06:26:36 INFO - PROCESS | 25375 | Values: 3010.0 3036.5 3045.4 3060.3 3082.5 5264.2 5368.2 5368.8 5386.0 5393.4 5610.0 5628.5 5662.5 5665.2 5666.3 5094.2 5125.5 5168.1 5169.5 5219.6 4907.4 4907.6 5163.9 5203.8 5211.3 4895.8 4920.4 4970.8 4985.5 5036.7 4924.8 4930.9 5007.5 5011.4 5031.6 4785.9 4925.7 4937.2 4941.9 4980.0 5216.0 5369.8 5410.4 5414.1 5438.3 5856.6 5862.3 5985.6 6013.9 6014.2 5760.5 6032.9 6037.2 6055.5 6057.2 5431.8 5444.6 5495.2 5510.0 5520.0 6060.0 6069.0 6070.5 6075.3 6076.8 5848.1 5851.9 5855.4 5857.4 5860.6 5585.2 5636.6 5811.2 5845.2 5872.8 5929.4 5933.9 5942.7 5972.9 5986.4 5888.3 5904.7 5943.5 5945.5 5968.1 4397.9 4443.7 4474.4 4587.6 4591.1 4018.0 4051.0 4068.7 4073.0 4094.7 5576.4 5583.0 5589.3 5589.5 5602.2 5699.1 5779.5 5901.1 5908.7 5913.6 5444.9 5492.0 5507.5 5564.6 5601.7 5075.2 5080.2 5086.2 5087.2 5088.2 5946.8 5994.0 6046.5 6059.6 6064.7 5797.7 5833.6 5892.5 5907.6 6007.0 6105.3 6143.9 6146.8 6151.7 6151.8 5784.4 5817.9 5861.5 5864.9 5898.9 5633.0 5655.4 5673.3 5681.2 5954.5 5591.2 5591.6 5599.6 5605.4 5616.7 5597.0 5605.5 5605.6 5610.9 5615.2 5463.9 5551.4 5553.1 5577.1 5649.3 5754.2 5852.2 5853.7 5856.9 5885.4 5699.9 5702.1 5705.7 5710.4 5710.8 06:26:36 INFO - PROCESS | 25375 | 06:26:36 INFO - PROCESS | 25375 | [#1] ext.html Cycles:180 Average:61289.74 Median:21877.82 stddev:118242.70 (540.5%) stddev-sans-first:118486.55 06:26:36 INFO - PROCESS | 25375 | Values: 582.7 606.8 618.3 625.4 633.5 33746.7 37565.2 45008.5 45652.5 45707.0 47378.5 47732.0 47772.8 47773.0 47831.8 9293.1 9452.2 9453.0 9458.2 9461.4 8531.4 8603.6 10889.5 11117.8 11149.3 11280.3 11390.5 11395.4 11417.9 11430.5 11127.8 11187.7 11205.7 11211.4 11218.2 10984.2 11029.3 11103.5 11104.1 11105.2 44357.6 44607.1 44724.3 44726.1 44731.8 4016.4 4024.5 4129.2 4324.6 4530.6 34030.5 34544.7 34744.7 34843.8 36106.3 4277.4 4494.6 4517.0 4538.8 4564.3 360669.0 362611.0 364193.0 364476.0 364972.0 61948.1 62267.7 62290.4 62331.4 62346.4 39739.2 40335.6 40495.8 42880.6 63645.7 17937.1 17943.1 17954.4 18040.5 18063.3 13241.3 13483.1 14594.7 14616.3 14664.3 19532.1 20616.8 20708.5 20752.3 20804.8 7362.3 7605.4 7655.7 7750.3 7766.6 1054.9 1059.7 1091.4 1093.3 1178.7 34305.0 34595.0 34752.0 34821.3 34866.0 1153.7 1157.3 1159.7 1171.2 1177.1 17274.7 17936.7 17959.4 18088.5 18135.8 546503.0 549983.0 550827.0 551004.0 551236.0 61929.1 62962.0 62983.7 62991.4 63017.4 1327.3 1385.2 1416.3 1472.2 1484.7 31242.0 35370.0 35465.0 35686.5 35779.3 52576.5 52723.2 52820.7 53033.7 53164.7 405137.0 405984.0 407305.0 407357.0 407481.0 30252.0 30883.8 31186.1 31256.8 32704.7 50146.2 50244.7 50657.7 51198.2 51301.2 42279.0 42375.2 42418.4 42509.0 43962.0 42781.8 43158.8 43615.6 44937.6 45138.0 43245.0 43758.6 44075.1 44816.3 44817.0 36291.0 37656.6 38507.8 38806.4 39454.0 29253.0 29597.0 30279.5 30451.8 30492.4 06:26:36 INFO - PROCESS | 25375 | 06:26:36 INFO - PROCESS | 25375 | [#2] jquery.html Cycles:180 Average:29271.84 Median:2534.74 stddev:79497.24 (3136.3%) stddev-sans-first:79690.63 06:26:36 INFO - PROCESS | 25375 | Values: 370.1 401.0 402.2 407.1 413.6 14480.0 16732.9 20718.7 20740.4 21137.9 19582.4 19657.8 19741.7 19992.8 20290.9 5845.2 5848.2 5873.8 5907.6 6035.9 4333.2 5801.9 5886.3 5889.6 5894.9 4528.8 6307.1 6557.1 6582.8 6693.9 6473.5 6672.7 6679.0 6696.8 6728.6 5902.9 5913.5 5915.8 5916.7 5919.7 23453.2 23736.6 23840.2 23871.0 24110.6 2517.5 2531.7 2537.8 2769.6 3063.5 15155.8 15215.0 15225.6 15552.5 15989.7 2038.2 2057.3 2062.6 2092.0 2176.8 62138.7 83414.0 84809.6 85542.6 89273.0 10954.7 11010.3 11203.4 11379.5 11380.2 15668.4 15706.2 15727.0 15731.2 15731.6 8364.8 8651.2 8681.7 8701.8 8884.2 8512.1 8544.3 8553.4 8636.2 8775.2 6530.2 6732.5 6827.6 6897.3 6927.7 1822.3 1831.0 1968.0 1982.7 2017.7 878.5 968.7 999.0 1000.1 1082.0 20162.8 20529.6 20598.6 20723.0 20793.2 1032.8 1048.4 1079.3 1088.3 1114.7 10909.9 11763.4 12020.2 12137.3 12144.5 436913.0 462376.0 493223.0 497152.0 517417.0 89258.1 89517.0 90777.5 91517.5 91567.5 1057.5 1100.1 1109.1 1125.1 1131.9 17640.4 18085.7 18111.3 18259.4 18263.8 44387.8 44568.8 45577.3 45780.5 46038.5 56130.7 57162.1 59652.0 61794.0 62839.0 8975.3 9080.8 9118.3 9139.5 9435.2 10880.8 12169.7 13397.0 13431.5 13798.2 8171.0 11572.6 11619.7 11696.6 11844.1 5873.1 9882.6 11858.2 12003.1 12092.2 11907.5 11945.9 12272.7 12572.9 12809.4 8582.7 8607.8 8778.2 8788.9 8895.3 11678.2 11770.9 12247.6 12351.2 12690.5 06:26:36 INFO - PROCESS | 25375 | 06:26:36 INFO - PROCESS | 25375 | [#3] mootools.html Cycles:180 Average:6047.24 Median:4770.47 stddev:3400.65 (71.3%) stddev-sans-first:3393.08 06:26:36 INFO - PROCESS | 25375 | Values: 1509.1 1560.3 1699.3 1793.0 1805.7 8571.9 9191.8 9224.4 9229.3 9232.0 7860.0 8029.6 8807.5 8957.1 8979.1 2440.9 2448.6 2451.2 2464.2 2466.2 2402.9 2407.3 2451.6 2452.0 2472.0 2120.1 2181.0 2369.7 2446.9 2449.9 2452.4 2463.3 2496.6 2503.1 2513.9 2435.3 2448.6 2451.0 2455.1 2457.9 8498.8 8591.8 8639.9 8656.7 8676.9 5240.4 5383.5 5386.2 5388.7 5412.5 3431.7 3450.2 3478.2 3502.3 3503.5 1205.5 1212.5 1228.2 1239.2 1284.7 12743.3 12772.1 12774.5 12780.4 12791.2 4752.7 4788.3 4852.0 4877.3 4884.9 10749.4 10763.7 10767.2 10772.6 10779.1 5571.3 5581.0 5581.4 5588.4 5590.5 5021.8 5134.3 5140.5 5154.3 5221.4 4269.7 4303.5 4337.7 4389.0 4390.5 1216.1 1327.5 1328.6 1337.9 1372.7 852.8 972.7 994.9 997.3 1014.2 6133.3 6207.6 6224.7 6333.8 6437.8 969.6 1005.5 1005.8 1029.9 1037.6 4150.9 4235.7 4265.7 4276.4 4356.5 11045.5 11488.7 11490.3 11496.1 11522.3 11084.8 11203.6 11353.7 11376.4 11410.1 8524.1 8610.7 8617.1 8618.0 8619.5 6332.5 6345.9 6346.6 6432.5 6460.4 10610.2 10745.0 10754.1 10755.0 10767.0 10494.4 10507.2 10741.6 10855.7 11095.9 8012.6 8107.9 8131.7 8133.4 8134.7 8536.0 8555.1 8725.4 8732.5 8781.8 8026.8 8084.8 8106.0 8128.2 8316.0 7609.7 7836.1 7860.8 7904.4 8044.2 7014.5 7126.2 7128.0 7128.9 7136.3 5608.4 5712.3 5731.3 5746.9 5833.1 5514.9 5599.6 5601.9 5656.5 5719.3 06:26:36 INFO - PROCESS | 25375 | 06:26:36 INFO - PROCESS | 25375 | [#4] prototype.html Cycles:180 Average:4841.49 Median:5405.49 stddev:1432.76 (26.5%) stddev-sans-first:1396.50 06:26:36 INFO - PROCESS | 25375 | Values: 346.9 350.3 352.5 356.2 359.7 5570.9 5604.6 5646.4 5664.8 5678.7 5501.4 5515.4 5522.7 5533.0 5536.7 4060.8 4389.6 4403.3 4406.2 4443.6 3845.3 4251.9 4293.1 4296.2 4298.4 4247.6 4270.9 4283.4 4285.0 4302.8 4179.5 4305.1 4311.3 4322.5 4322.7 3727.6 3805.6 3829.7 3838.2 3874.3 5378.6 5392.4 5394.4 5410.9 5483.4 4754.7 4976.4 5005.3 5008.9 5052.8 5819.7 5822.2 5834.9 5842.1 5844.8 4221.4 4235.6 4242.2 4270.1 4272.4 5878.3 6067.8 6173.3 6198.7 6214.0 4281.7 4291.2 4301.9 4313.3 4320.5 4353.1 4361.3 4361.7 4375.5 4389.8 4919.2 5007.1 5023.9 5041.5 5043.9 5852.2 5861.2 5909.2 5920.8 5986.4 1464.0 1464.9 1466.1 1472.7 1486.8 916.3 957.4 971.5 974.7 975.1 5045.7 5073.6 5089.9 5094.5 5122.8 5292.0 5333.7 5345.1 5355.0 5360.9 4909.2 5025.3 5065.3 5111.5 5139.6 2802.5 2821.3 2831.9 2838.9 2861.9 5438.5 5487.7 5520.6 5525.0 5606.5 5321.9 5399.3 5402.0 5409.0 5467.7 5920.6 6030.6 6088.0 6146.9 6217.8 6043.9 6053.9 6058.5 6078.6 6094.8 5837.0 5927.3 5946.6 5984.2 6022.0 6155.0 6173.1 6197.5 6232.5 6236.3 4312.8 4322.6 4331.7 4334.4 4343.3 5842.6 6037.4 6048.4 6052.3 6067.8 5913.8 5929.4 5949.2 5979.7 6032.0 5662.6 5876.2 5891.6 5911.0 5980.7 5832.4 5846.5 5884.8 5885.7 5892.1 5810.3 5935.4 5945.7 5965.8 6032.4 5786.3 5812.6 5816.7 5820.8 5842.2 06:26:36 INFO - PROCESS | 25375 | 06:26:36 INFO - PROCESS | 25375 | [#5] yui.html Cycles:180 Average:22057.06 Median:4554.65 stddev:31061.16 (682.0%) stddev-sans-first:31106.97 06:26:36 INFO - PROCESS | 25375 | Values: 718.8 734.7 788.7 881.5 903.0 15522.2 16579.8 17581.6 17731.6 17780.6 15813.9 16039.3 16051.7 16059.2 16427.0 723.2 737.1 853.0 867.1 874.2 877.3 884.5 886.3 886.3 886.5 931.9 932.5 933.8 933.9 934.0 761.1 777.1 896.5 927.8 928.5 645.2 646.8 646.9 647.9 671.4 15807.3 15872.4 15895.3 15931.6 15936.9 15148.5 15644.0 15727.8 15786.9 15904.6 13950.6 14239.9 14296.7 14322.9 14329.3 4489.2 4533.8 4575.5 4651.8 4670.6 86206.6 87586.6 87588.6 87739.0 87893.0 11678.2 11780.4 11785.3 11985.3 12028.8 22210.8 22564.0 22578.5 22580.8 22606.8 8442.4 8447.9 8832.8 8836.4 9102.8 4993.8 5155.7 5176.9 5312.1 5314.9 3459.5 3573.8 3584.7 3590.7 3591.1 589.3 597.7 602.0 610.0 613.4 552.4 590.6 626.9 634.7 693.7 9709.4 10185.3 10348.9 10435.6 10729.4 616.9 625.1 685.9 710.1 776.8 5099.1 5222.1 5236.7 5253.4 5323.4 115037.0 115115.0 115650.0 117422.0 120959.4 65432.0 65933.3 68211.0 104521.9 107196.5 93838.5 95901.5 99641.0 101313.5 101376.0 9708.9 9920.5 9940.0 9978.5 10025.7 55789.0 56465.7 56999.7 57869.4 57996.0 77230.0 82461.2 83951.0 84994.6 86824.0 11718.5 12886.8 13466.1 13761.2 13826.3 15973.3 16263.0 17149.9 17433.4 17459.9 14448.9 14546.5 15363.9 15368.3 15412.1 14584.2 14797.4 14869.4 14985.3 15460.6 14820.9 15230.3 15687.9 16490.8 16500.5 12017.6 12287.7 13296.5 13478.6 13693.3 12631.4 12710.4 12753.0 12789.9 13087.0 06:26:36 INFO - PROCESS | 25375 | -------- Summary: end -------- 06:26:36 INFO - PROCESS | 25375 | 06:26:37 INFO - TEST-INFO | 25375: exit 0 06:26:37 INFO - TEST-OK | dromaeo_css | took 1113192ms 06:26:37 INFO - TEST-START | kraken 06:26:37 INFO - operating with platform_type : linux_ 06:26:37 INFO - Initialising browser for kraken test... 06:26:37 INFO - TEST-INFO | started process 25697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprgH4yP/profile http://localhost:55788/getInfo.html) 06:26:41 INFO - PROCESS | 25697 | __metrics Screen width/height:1600/1200 06:26:41 INFO - PROCESS | 25697 | colorDepth:24 06:26:41 INFO - PROCESS | 25697 | Browser inner width/height: 1024/697 06:26:41 INFO - PROCESS | 25697 | __metrics 06:26:41 INFO - PROCESS | 25697 | 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" 06:26:41 INFO - PROCESS | 25697 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:26:42 INFO - PROCESS | 25697 | console.error: PushService: 06:26:42 INFO - PROCESS | 25697 | stateChangeProcessEnqueue: Error transitioning state 06:26:42 INFO - PROCESS | 25697 | UnknownError 06:26:42 INFO - TEST-INFO | 25697: exit 0 06:26:42 INFO - Browser initialized. 06:26:42 INFO - Running cycle 1/1 for kraken test... 06:26:42 INFO - TEST-INFO | started process 25790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprgH4yP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:26:54 INFO - PROCESS | 25790 | RSS: Main: 144715776 06:26:54 INFO - PROCESS | 25790 | 06:26:57 INFO - PROCESS | 25790 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55788/tests/kraken/driver.html?testName=audio-beat-detection) 06:26:57 INFO - PROCESS | 25790 | RSS: Main: 186433536 06:26:57 INFO - PROCESS | 25790 | 06:27:00 INFO - PROCESS | 25790 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55788/tests/kraken/driver.html?testName=audio-dft) 06:27:01 INFO - PROCESS | 25790 | RSS: Main: 175325184 06:27:01 INFO - PROCESS | 25790 | 06:27:03 INFO - PROCESS | 25790 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55788/tests/kraken/driver.html?testName=audio-fft) 06:27:04 INFO - PROCESS | 25790 | RSS: Main: 266170368 06:27:04 INFO - PROCESS | 25790 | 06:27:06 INFO - PROCESS | 25790 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55788/tests/kraken/driver.html?testName=audio-oscillator) 06:27:07 INFO - PROCESS | 25790 | RSS: Main: 172965888 06:27:07 INFO - PROCESS | 25790 | 06:27:09 INFO - PROCESS | 25790 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55788/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:27:09 INFO - PROCESS | 25790 | RSS: Main: 174202880 06:27:09 INFO - PROCESS | 25790 | 06:27:12 INFO - PROCESS | 25790 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55788/tests/kraken/driver.html?testName=imaging-darkroom) 06:27:13 INFO - PROCESS | 25790 | RSS: Main: 210444288 06:27:13 INFO - PROCESS | 25790 | 06:27:16 INFO - PROCESS | 25790 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55788/tests/kraken/driver.html?testName=imaging-desaturate) 06:27:17 INFO - PROCESS | 25790 | RSS: Main: 209543168 06:27:17 INFO - PROCESS | 25790 | 06:27:20 INFO - PROCESS | 25790 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55788/tests/kraken/driver.html?testName=json-parse-financial) 06:27:20 INFO - PROCESS | 25790 | RSS: Main: 209317888 06:27:20 INFO - PROCESS | 25790 | 06:27:22 INFO - PROCESS | 25790 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55788/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:27:22 INFO - PROCESS | 25790 | RSS: Main: 171171840 06:27:22 INFO - PROCESS | 25790 | 06:27:24 INFO - PROCESS | 25790 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55788/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:27:24 INFO - PROCESS | 25790 | RSS: Main: 178274304 06:27:24 INFO - PROCESS | 25790 | 06:27:26 INFO - PROCESS | 25790 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55788/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:27:27 INFO - PROCESS | 25790 | RSS: Main: 183980032 06:27:27 INFO - PROCESS | 25790 | 06:27:30 INFO - PROCESS | 25790 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55788/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:27:30 INFO - PROCESS | 25790 | RSS: Main: 184016896 06:27:30 INFO - PROCESS | 25790 | 06:27:33 INFO - PROCESS | 25790 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55788/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:27:33 INFO - PROCESS | 25790 | RSS: Main: 182837248 06:27:33 INFO - PROCESS | 25790 | 06:27:35 INFO - PROCESS | 25790 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55788/tests/kraken/driver.html?testName=ai-astar) 06:27:35 INFO - PROCESS | 25790 | RSS: Main: 233730048 06:27:35 INFO - PROCESS | 25790 | 06:27:35 INFO - PROCESS | 25790 | __start_tp_report 06:27:35 INFO - PROCESS | 25790 | _x_x_mozilla_page_load 06:27:35 INFO - PROCESS | 25790 | _x_x_mozilla_page_load_details 06:27:35 INFO - PROCESS | 25790 | |i|pagename|runs| 06:27:35 INFO - PROCESS | 25790 | |0;ai-astar;109;112;111;110;109;110;110;111;111;111 06:27:35 INFO - PROCESS | 25790 | |1;audio-beat-detection;143;123;115;149;122;122;120;117;158;118 06:27:35 INFO - PROCESS | 25790 | |2;audio-dft;166;163;163;161;160;161;163;162;161;161 06:27:35 INFO - PROCESS | 25790 | |3;audio-fft;75;74;76;110;76;75;75;78;100;75 06:27:35 INFO - PROCESS | 25790 | |4;audio-oscillator;82;81;117;81;81;81;104;81;80;102 06:27:35 INFO - PROCESS | 25790 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;118;117 06:27:35 INFO - PROCESS | 25790 | |6;imaging-darkroom;148;146;147;147;147;146;147;147;147;146 06:27:35 INFO - PROCESS | 25790 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;96 06:27:35 INFO - PROCESS | 25790 | |8;json-parse-financial;49;48;50;48;50;51;50;50;48;49 06:27:35 INFO - PROCESS | 25790 | |9;json-stringify-tinderbox;58;59;58;59;59;59;58;58;58;58 06:27:35 INFO - PROCESS | 25790 | |10;stanford-crypto-aes;73;73;73;72;72;73;73;78;79;72 06:27:35 INFO - PROCESS | 25790 | |11;stanford-crypto-ccm;129;123;129;121;117;119;118;123;151;119 06:27:35 INFO - PROCESS | 25790 | |12;stanford-crypto-pbkdf2;153;154;154;152;152;152;153;157;152;149 06:27:35 INFO - PROCESS | 25790 | |13;stanford-crypto-sha256-iterative;64;62;64;62;61;65;62;62;62;62 06:27:35 INFO - PROCESS | 25790 | __end_tp_report 06:27:35 INFO - PROCESS | 25790 | __start_cc_report 06:27:35 INFO - PROCESS | 25790 | _x_x_mozilla_cycle_collect,1566 06:27:35 INFO - PROCESS | 25790 | __end_cc_report 06:27:35 INFO - PROCESS | 25790 | __startTimestamp1475242055824__endTimestamp 06:27:35 INFO - PROCESS | 25790 | 06:27:35 INFO - PROCESS | 25790 | ------- Summary: start ------- 06:27:35 INFO - PROCESS | 25790 | Number of tests: 14 06:27:35 INFO - PROCESS | 25790 | 06:27:35 INFO - PROCESS | 25790 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:0.97 (0.9%) stddev-sans-first:0.88 06:27:35 INFO - PROCESS | 25790 | Values: 109.0 112.0 111.0 110.0 109.0 110.0 110.0 111.0 111.0 111.0 06:27:35 INFO - PROCESS | 25790 | 06:27:35 INFO - PROCESS | 25790 | [#1] audio-beat-detection Cycles:10 Average:128.70 Median:122.50 stddev:15.32 (12.5%) stddev-sans-first:15.35 06:27:35 INFO - PROCESS | 25790 | Values: 143.0 123.0 115.0 149.0 122.0 122.0 120.0 117.0 158.0 118.0 06:27:35 INFO - PROCESS | 25790 | 06:27:35 INFO - PROCESS | 25790 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.73 (1.1%) stddev-sans-first:1.12 06:27:35 INFO - PROCESS | 25790 | Values: 166.0 163.0 163.0 161.0 160.0 161.0 163.0 162.0 161.0 161.0 06:27:35 INFO - PROCESS | 25790 | 06:27:35 INFO - PROCESS | 25790 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:12.70 (16.9%) stddev-sans-first:13.26 06:27:35 INFO - PROCESS | 25790 | Values: 75.0 74.0 76.0 110.0 76.0 75.0 75.0 78.0 100.0 75.0 06:27:35 INFO - PROCESS | 25790 | 06:27:35 INFO - PROCESS | 25790 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:81.00 stddev:13.45 (16.6%) stddev-sans-first:14.02 06:27:35 INFO - PROCESS | 25790 | Values: 82.0 81.0 117.0 81.0 81.0 81.0 104.0 81.0 80.0 102.0 06:27:35 INFO - PROCESS | 25790 | 06:27:35 INFO - PROCESS | 25790 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 06:27:35 INFO - PROCESS | 25790 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 118.0 117.0 06:27:35 INFO - PROCESS | 25790 | 06:27:35 INFO - PROCESS | 25790 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 06:27:35 INFO - PROCESS | 25790 | Values: 148.0 146.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 06:27:35 INFO - PROCESS | 25790 | 06:27:35 INFO - PROCESS | 25790 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:27:35 INFO - PROCESS | 25790 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 06:27:35 INFO - PROCESS | 25790 | 06:27:35 INFO - PROCESS | 25790 | [#8] json-parse-financial Cycles:10 Average:49.30 Median:50.00 stddev:1.06 (2.1%) stddev-sans-first:1.12 06:27:35 INFO - PROCESS | 25790 | Values: 49.0 48.0 50.0 48.0 50.0 51.0 50.0 50.0 48.0 49.0 06:27:35 INFO - PROCESS | 25790 | 06:27:35 INFO - PROCESS | 25790 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 06:27:35 INFO - PROCESS | 25790 | Values: 58.0 59.0 58.0 59.0 59.0 59.0 58.0 58.0 58.0 58.0 06:27:35 INFO - PROCESS | 25790 | 06:27:35 INFO - PROCESS | 25790 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:73.00 stddev:2.53 (3.5%) stddev-sans-first:2.67 06:27:35 INFO - PROCESS | 25790 | Values: 73.0 73.0 73.0 72.0 72.0 73.0 73.0 78.0 79.0 72.0 06:27:35 INFO - PROCESS | 25790 | 06:27:35 INFO - PROCESS | 25790 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:123.00 stddev:10.09 (8.2%) stddev-sans-first:10.60 06:27:35 INFO - PROCESS | 25790 | Values: 129.0 123.0 129.0 121.0 117.0 119.0 118.0 123.0 151.0 119.0 06:27:35 INFO - PROCESS | 25790 | 06:27:35 INFO - PROCESS | 25790 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.80 Median:153.00 stddev:2.04 (1.3%) stddev-sans-first:2.17 06:27:35 INFO - PROCESS | 25790 | Values: 153.0 154.0 154.0 152.0 152.0 152.0 153.0 157.0 152.0 149.0 06:27:35 INFO - PROCESS | 25790 | 06:27:35 INFO - PROCESS | 25790 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.00 stddev:1.26 (2.0%) stddev-sans-first:1.24 06:27:35 INFO - PROCESS | 25790 | Values: 64.0 62.0 64.0 62.0 61.0 65.0 62.0 62.0 62.0 62.0 06:27:35 INFO - PROCESS | 25790 | -------- Summary: end -------- 06:27:35 INFO - PROCESS | 25790 | 06:27:36 INFO - TEST-INFO | 25790: exit 0 06:27:36 INFO - TEST-OK | kraken | took 59244ms 06:27:36 INFO - SUITE-END | took 1172s 06:27:36 INFO - Completed test suite (00:19:32) 06:27:36 INFO - javascript benchmark 06:27:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3009.9999999999995, 3036.544518322252, 3045.4213699397114, 3060.2808340040074, 3082.5222090575953, 5264.236685680578, 5368.167933970236, 5368.785248590061, 5386.030514507387, 5393.352797664276, 5610.0, 5628.465295796903, 5662.462066103713, 5665.1785491103765, 5666.348369937458, 5094.184930411126, 5125.513076257749, 5168.069747445477, 5169.483051694838, 5219.582433405338, 4907.435644900828, 4907.5583197512215, 5163.948360516403, 5203.765830537616, 5211.322528071364, 4895.755212239392, 4920.434150072734, 4970.801167953277, 4985.451600323961, 5036.697798132123, 4924.827631032915, 4930.926036109461, 5007.524285192901, 5011.373578302712, 5031.622628302892, 4785.928211076836, 4925.729084900329, 4937.1606826839525, 4941.851744447672, 4979.975100124512, 5215.973920130413, 5369.838904832861, 5410.404855465896, 5414.052540805344, 5438.265834112383, 5856.648601083949, 5862.296524417055, 5985.551083668743, 6013.909791353133, 6014.248218972629, 5760.452756988079, 6032.879342413127, 6037.154798328237, 6055.455009049163, 6057.151998720183, 5431.782728690848, 5444.646098003617, 5495.230667706524, 5509.9806535791, 5520.0, 6060.0, 6068.969655151696, 6070.484008859208, 6075.301340345828, 6076.75692972285, 5848.1227815827115, 5851.912221316684, 5855.3851845556455, 5857.384974577693, 5860.560457965585, 5585.245991791137, 5636.60543761941, 5811.2445382100905, 5845.240118784616, 5872.765089396376, 5929.436703513159, 5933.910991335133, 5942.6731529766275, 5972.880542389128, 5986.3714309997695, 5888.293404791367, 5904.675242861598, 5943.524518038546, 5945.494632956247, 5968.134620480093, 4397.868063958086, 4443.733375997451, 4474.440694913136, 4587.632989360844, 4591.081783643284, 4017.9598204017584, 4050.9797451012555, 4068.6948478864206, 4073.0, 4094.713370064067, 5576.386597474356, 5583.022970980062, 5589.301337332833, 5589.524890384363, 5602.187682785973, 5699.145128230715, 5779.450952159538, 5901.144334071536, 5908.704564771744, 5913.556483263773, 5444.945550544523, 5492.011437941129, 5507.531859791962, 5564.638298510584, 5601.719914004365, 5075.2387141929, 5080.187170052774, 5086.237064440364, 5087.211482220262, 5088.211327244283, 5946.821595352233, 5994.0409534474275, 6046.546509011841, 6059.636421814617, 6064.727087281083, 5797.652140871562, 5833.591648584558, 5892.5285977122585, 5907.616004959664, 6007.0, 6105.26630253466, 6143.880361275353, 6146.754129834757, 6151.6924153793025, 6151.84620384494, 5784.392638772868, 5817.854553636193, 5861.472467477947, 5864.912026319694, 5898.879212949526, 5632.971835140798, 5655.377908430151, 5673.262475878109, 5681.2330335404195, 5954.46409823118, 5591.161325801162, 5591.6365436246515, 5599.552035837205, 5605.355384130877, 5616.719164041863, 5596.972015140062, 5605.523530499953, 5605.579581531483, 5610.85972850682, 5615.213870058276, 5463.863403414946, 5551.389347171727, 5553.111502159635, 5577.135543990688, 5649.265595472562, 5754.223179870832, 5852.151438041375, 5853.678047707247, 5856.882862342814, 5885.411458854081, 5699.8860022800145, 5702.116171993348, 5705.686187259575, 5710.371859095413, 5710.828675139753], "value": 5410.189448233119, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.6911736779506, 606.814921448958, 618.2797041446714, 625.3590070178064, 633.4837107757178, 33746.662533374656, 37565.248695026086, 45008.54991450084, 45652.543474565246, 45707.0, 47378.526214737845, 47732.0, 47772.76113619427, 47773.0, 47831.76084119575, 9293.07069293072, 9452.19656329213, 9452.952735236315, 9458.196053335474, 9461.38500997433, 8531.445456045369, 8603.56982150893, 10889.455527223647, 11117.777644447147, 11149.275297105662, 11280.266782659142, 11390.54437822486, 11395.373254471, 11417.885821141765, 11430.485628146711, 11127.833082503768, 11187.72030699239, 11205.719857003558, 11211.439428028647, 11218.158638102175, 10984.176186786022, 11029.283096598696, 11103.500342484607, 11104.056155226735, 11105.222634415593, 44357.556424435665, 44607.10785784299, 44724.329135063, 44726.10547789026, 44731.776341118086, 4016.4376987221813, 4024.5170579530645, 4129.215449064668, 4324.567543245682, 4530.592246697813, 34030.48954265688, 34544.654553454646, 34744.65255347439, 34843.825780871186, 36106.277874442625, 4277.379779931924, 4494.5730155635165, 4517.0, 4538.841140560065, 4564.315352697089, 360669.0, 362611.0, 364193.0, 364475.9999999973, 364972.0, 61948.07077893835, 62267.68866155731, 62290.377096229364, 62331.37668623347, 62346.376536234966, 39739.20521589552, 40335.59664403377, 40495.7975210128, 42880.571194288284, 63645.68177159085, 17937.103144842706, 17943.102844857705, 17954.371596994042, 18040.458786236435, 18063.2774689011, 13241.3379331035, 13483.123596966361, 14594.708105837824, 14616.342264598119, 14664.340104695315, 19532.14216255843, 20616.79383206149, 20708.48228794262, 20752.273670421764, 20804.791952080588, 7362.286555348929, 7605.353544948631, 7655.732049378245, 7750.3024727773645, 7766.5728384939375, 1054.8997845204694, 1059.7297689089232, 1091.4215465803138, 1093.2620481175175, 1178.6699724077273, 34305.0, 34595.0, 34752.0, 34821.30357392838, 34866.0, 1153.700037990112, 1157.288267715349, 1159.7274640459486, 1171.2211379432752, 1177.1171621284036, 17274.740878886576, 17936.742418590224, 17959.439994816843, 18088.457346279632, 18135.818641813676, 546503.0, 549983.0, 550827.0, 551004.0, 551236.0, 61929.071063934076, 62962.0, 62983.68508157522, 62991.37008629855, 63017.36982630115, 1327.336331834083, 1385.1688986607955, 1416.3201663201514, 1472.197652279489, 1484.747592909208, 31242.0, 35370.0, 35465.0, 35686.464703028956, 35779.28441431209, 52576.47423525869, 52723.209151861985, 52820.73589632027, 53033.73483132714, 53164.73417632887, 405137.0, 405984.0, 407305.0, 407357.0, 407481.0, 30252.0, 30883.84558077195, 31186.064418067494, 31256.843715781277, 32704.67295327016, 50146.24780628367, 50244.748776257344, 50657.746711266205, 51198.23202651889, 51301.23048154206, 42279.0, 42375.152496950504, 42418.36372454354, 42509.0, 43962.0, 42781.78609107059, 43158.784206080025, 43615.56384436115, 44937.550624493335, 45138.0, 43245.0, 43758.56241437545, 44075.11849763051, 44816.32775508435, 44817.0, 36291.0, 37656.62343376641, 38507.80746096252, 38806.41790373203, 39454.0, 29253.0, 29597.0, 30279.545806813356, 30451.84774076204, 30492.390152197277], "value": 21442.961778448982, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.0803503294315, 400.95589485156626, 402.21166513633267, 407.0962463331404, 413.5926112778914, 14480.0, 16732.916335418322, 20718.689219661715, 20740.377788666327, 21137.894310528463, 19582.412527624194, 19657.803421965775, 19741.703874441893, 19992.800071999274, 20290.898545507287, 5845.181674565564, 5848.181254624356, 5873.823785286427, 5907.645541267538, 6035.853187894286, 4333.241682705514, 5801.854953626172, 5886.264216972857, 5889.64662120272, 5894.941050589504, 4528.818847246106, 6307.1485349477925, 6557.114789503404, 6582.835429114262, 6693.899591506131, 6473.482121430275, 6672.699728512204, 6678.966605166992, 6696.83257918551, 6728.596284222962, 5902.852428689274, 5913.526917846562, 5915.822525324247, 5916.704164791786, 5919.733611987428, 23453.179138730062, 23736.64395034076, 23840.165594204118, 23871.045158193825, 24110.63834042473, 2517.458746369521, 2531.708853481855, 2537.7716005559587, 2769.62610047643, 3063.494523403636, 15155.772663410058, 15215.0, 15225.61935951599, 15552.455664051704, 15989.680206395808, 2038.2458490358515, 2057.2799520167973, 2062.5874825035053, 2092.027371022241, 2176.8040876321206, 62138.68930655318, 83414.0, 84809.57595211985, 85542.57228713878, 89272.99999999935, 10954.671359859058, 11010.339379637247, 11203.439828008566, 11379.487923043484, 11380.203385763083, 15668.373265069498, 15706.214689265491, 15727.0, 15731.213439328216, 15731.606709832346, 8364.832703345899, 8651.178138076873, 8681.739547813575, 8701.825963480822, 8884.200421962054, 8512.148785121562, 8544.31645468361, 8553.358498112666, 8636.222739953435, 8775.210231079105, 6530.183727034121, 6732.461403087741, 6827.556208846409, 6897.3447522485285, 6927.7228910844005, 1822.2528763207022, 1830.9725354119698, 1967.9828176119306, 1982.7125066865513, 2017.6973453981727, 878.5299864572551, 968.7239136845965, 999.0, 1000.1498726082917, 1082.0423924826428, 20162.798372016092, 20529.589408211752, 20598.58802823965, 20723.0, 20793.168273269202, 1032.8244198486275, 1048.3814549415881, 1079.2660990526517, 1088.3089238333714, 1114.749181434187, 10909.890901091047, 11763.353015584054, 12020.218685785396, 12137.271763694207, 12144.514219431123, 436913.0, 462376.0, 493223.0, 497152.0, 517417.0, 89258.10741892627, 89517.0, 90777.54611226902, 91517.54241228885, 91567.54216228877, 1057.5452555401098, 1100.1199040767353, 1109.0905457524752, 1125.0549538387793, 1131.932084074958, 17640.38258660941, 18085.728714069035, 18111.275548977894, 18259.360922367654, 18263.81736182621, 44387.778061109486, 44568.77715611401, 45577.316340254256, 45780.542194577625, 46038.539614603425, 56130.719346403006, 57162.14256786068, 59652.0, 61794.0, 62839.0, 8975.32685048611, 9080.772980675272, 9118.316126290421, 9139.497327646777, 9435.24518038569, 10880.836787448354, 12169.661337252717, 13397.0, 13431.529896453578, 13798.17210967345, 8170.9943436861, 11572.59495917639, 11619.709507262387, 11696.590619328283, 11844.111691622991, 5873.148393482836, 9882.555285012335, 11858.16992810495, 12003.079507278793, 12092.214006089576, 11907.52369905194, 11945.940270298594, 12272.693182670504, 12572.874271257171, 12809.359532023174, 8582.742517724479, 8607.827843443221, 8778.166074222938, 8788.91211087881, 8895.288376929959, 11678.182527223013, 11770.88229117732, 12247.57133500359, 12351.19717218378, 12690.492380304684], "value": 9712.089379673138, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1509.064380084348, 1560.329058504843, 1699.3287651377707, 1792.9910350448247, 1805.7291406289064, 8571.871421928668, 9191.77020574486, 9224.354295199339, 9229.261659067275, 9231.953840230806, 7859.960700196505, 8029.558374289411, 8807.515586642749, 8957.059508751585, 8979.057198994093, 2440.865752383618, 2448.5959816630325, 2451.203358908353, 2464.2484042367073, 2466.198485492222, 2402.855828650278, 2407.3018824540864, 2451.595486744694, 2452.043702955849, 2471.9876400617973, 2120.07776617172, 2180.9890950545305, 2369.739328673853, 2446.9265922022278, 2449.889754961022, 2452.3623857796924, 2463.310273123528, 2496.5506208882393, 2503.0613519930116, 2513.924582262535, 2435.342457536473, 2448.64494648275, 2451.019592163131, 2455.0793452455327, 2457.9262622121364, 8498.78753031173, 8591.82816343676, 8639.913600864036, 8656.697015604424, 8676.913230867674, 5240.371155461369, 5383.488568585978, 5386.218998245233, 5388.73056347185, 5412.4587541245955, 3431.742619303562, 3450.1719587299117, 3478.165240342325, 3502.2645244498685, 3503.5095086687884, 1205.5479195301762, 1212.5210541836013, 1228.2200802490484, 1239.2007155384817, 1284.7237843863613, 12743.299118548475, 12772.105952583323, 12774.489020439265, 12780.360981950773, 12791.232526048467, 4752.667313288037, 4788.281757736368, 4851.951480485221, 4877.268409738567, 4884.902301954012, 10749.355038697704, 10763.677089687322, 10767.246292759432, 10772.622958196425, 10779.137668986463, 5571.275734154534, 5580.972095139498, 5581.358143813513, 5588.3573389060775, 5590.496855283044, 5021.774020169101, 5134.2812006319145, 5140.511651393112, 5154.329937108152, 5221.373435187802, 4269.743815371025, 4303.526612072669, 4337.7397356158735, 4389.034412429324, 4390.473143222834, 1216.1486959128645, 1327.4690123950304, 1328.5881376773232, 1337.9264140472173, 1372.6911444925013, 852.7740148860557, 972.6547075788135, 994.9204063674889, 997.3168379659957, 1014.1987829614669, 6133.29467111279, 6207.565470417027, 6224.688765561704, 6333.809985700436, 6437.806865794034, 969.6412327438893, 1005.5223768709805, 1005.8088963096989, 1029.9433531155707, 1037.6368271105052, 4150.875473735793, 4235.661147108224, 4265.7440553566885, 4276.3799249109325, 4356.477222733229, 11045.502952367162, 11488.655340339803, 11490.310581365145, 11496.137789665809, 11522.251053681484, 11084.833727494093, 11203.60787372438, 11353.659390218307, 11376.431178441046, 11410.087193024705, 8524.104968978292, 8610.65557377698, 8617.138286171332, 8618.0, 8619.482831030158, 6332.493400528039, 6345.90481142774, 6346.587471814318, 6432.485401167802, 6460.3862633049785, 10610.204234682275, 10745.0, 10754.13966882632, 10755.032047115797, 10767.0, 10494.422806745702, 10507.211959103252, 10741.624043158452, 10855.67432977012, 11095.944520277348, 8012.599370031592, 8107.878381824159, 8131.71538996156, 8133.389995750461, 8134.715284964997, 8535.95732021336, 8555.144485551395, 8725.432846864933, 8732.476051436934, 8781.824363512822, 8026.799330016796, 8084.797880053045, 8106.0, 8128.227818357246, 8315.95842020786, 7609.733659321897, 7836.059672839296, 7860.803479913048, 7904.446688731734, 8044.155363686963, 7014.5440546364325, 7126.216116227314, 7128.0, 7128.928710712827, 7136.3220494052985, 5608.4111168326735, 5712.34308054579, 5731.283589551306, 5746.913796293143, 5833.125031245348, 5514.91727624078, 5599.552035837041, 5601.859953501195, 5656.462636049569, 5719.28508936383], "value": 4857.154989529506, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.9444888817788, 350.27143541433816, 352.52233223981494, 356.1843378662859, 359.7230132797744, 5570.944290557093, 5604.5796565257615, 5646.435356464352, 5664.773409063632, 5678.744456499458, 5501.367342755584, 5515.420880807517, 5522.723863806814, 5532.972335138319, 5536.667799932007, 4060.776657283848, 4389.629600016004, 4403.295472724365, 4406.206882761102, 4443.577860103301, 3845.288621604998, 4251.914961700764, 4293.098449325646, 4296.248156572603, 4298.376735373369, 4247.575242475743, 4270.871873843789, 4283.421738065368, 4285.0, 4302.827886884521, 4179.540250572434, 4305.0744090020635, 4311.2670845955945, 4322.481302243719, 4322.654187664979, 3727.6086010969, 3805.60041195676, 3829.7170447899707, 3838.1747924196434, 3874.3219936511, 5378.596605254583, 5392.379876314196, 5394.352677678665, 5410.891782164374, 5483.396826349099, 4754.690945088592, 4976.4277108132665, 5005.349304590416, 5008.924866127011, 5052.7726252318735, 5819.7090145492975, 5822.214001109881, 5834.854128646775, 5842.108156462536, 5844.795432159896, 4221.409002739619, 4235.618794308496, 4242.215190189825, 4270.12462445198, 4272.423222864904, 5878.265216847894, 6067.7572897084065, 6173.259208894961, 6198.721057552421, 6214.0, 4281.678874084456, 4291.163223171514, 4301.870943871689, 4313.317806055641, 4320.503142138694, 4353.10761293934, 4361.280388735887, 4361.738295702268, 4375.518692943773, 4389.846355377546, 4919.1883339248625, 5007.098722230034, 5023.944971555941, 5041.495850414929, 5043.87390315245, 5852.151438041546, 5861.238039054895, 5909.172715819789, 5920.792772253037, 5986.371430999682, 1463.9853601464063, 1464.8535146485267, 1466.149633212734, 1472.7128209999162, 1486.7734119351578, 916.3493919317359, 957.3729207369184, 971.4851128901694, 974.6734843827397, 975.1223898491414, 5045.695069729333, 5073.554037099409, 5089.872753181126, 5094.54149126573, 5122.795088196505, 5291.973540132351, 5333.653312534673, 5345.118055520873, 5355.027959482447, 5360.892782144335, 4909.239067944474, 5025.331507999108, 5065.290859279704, 5111.488851114858, 5139.614528910347, 2802.467531169071, 2821.3087793490317, 2831.929201769972, 2838.929026774347, 2861.8998335058172, 5438.45615438453, 5487.725613719378, 5520.564653190119, 5525.005499010217, 5606.467385598362, 5321.946780532223, 5399.298091248191, 5401.972990135103, 5409.0, 5467.699276539749, 5920.60865696561, 6030.638161710312, 6088.0, 6146.877062458815, 6217.782377616762, 6043.909341359795, 6053.939460605337, 6058.454739073328, 6078.57449978515, 6094.7562097517375, 5837.001653867114, 5927.318358388668, 5946.583739138218, 5984.162217289496, 6021.969890150521, 6155.0, 6173.074038894202, 6197.504199664107, 6232.501399887908, 6236.253848922309, 4312.805923733376, 4322.63257623093, 4331.7184383015, 4334.41485399467, 4343.326784348431, 5842.620229685057, 6037.396260373927, 6048.395160483917, 6052.335607707915, 6067.817965461043, 5913.822585322448, 5929.407059294209, 5949.167116603766, 5979.730912109053, 6032.0, 5662.603617746719, 5876.236089308362, 5891.646501209942, 5911.0, 5980.667539659449, 5832.416758324133, 5846.532277417881, 5884.764609415575, 5885.735141918538, 5892.086726557391, 5810.302763668386, 5935.376785437467, 5945.732442040032, 5965.821025369246, 6032.426919442646, 5786.334571524329, 5812.593118481665, 5816.680082595498, 5820.76716931318, 5842.2405087338375], "value": 4385.333080449199, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.769993602047, 734.6730704836343, 788.712120076172, 881.4623079921249, 902.9638814447422, 15522.223888805556, 16579.751303730452, 17581.648367032652, 17731.645367092668, 17780.555486112822, 15813.920930395332, 16039.278232479537, 16051.678966420664, 16059.197040147976, 16427.0, 723.1791916175126, 737.0823324960405, 853.036069241756, 867.0722327109963, 874.1608056265976, 877.3419935048713, 884.5179377239388, 886.2865393358344, 886.3441053620339, 886.4991279926853, 931.8695382646401, 932.4824722279133, 933.77589378549, 933.8785957825473, 933.9766505837374, 761.1361105145672, 777.0558771093092, 896.5472436419566, 927.7958849053231, 928.5264515097282, 645.2418408370146, 646.8415238266608, 646.912666789982, 647.9222493300787, 671.4259308291438, 15807.288672009672, 15872.365105395771, 15895.284712187979, 15931.601709957344, 15936.920315398465, 15148.469803556933, 15644.0, 15727.764083538756, 15786.921065394714, 15904.602384940354, 13950.581482555539, 14239.928800356036, 14296.714065718732, 14322.928385358111, 14329.283535823168, 4489.169503641804, 4533.750643714594, 4575.542445755431, 4651.767411629405, 4670.626349892001, 86206.56896715476, 87586.5620671899, 87588.56205718931, 87739.0, 87893.0, 11678.24091434054, 11780.352080635475, 11785.292882427082, 11985.28088314704, 12028.819567706492, 22210.77789222087, 22564.0, 22578.54842903133, 22580.774192257868, 22606.773932260796, 8442.409031367746, 8447.915520844714, 8832.823343533093, 8836.425632333878, 9102.81794364109, 4993.775280112403, 5155.664881782672, 5176.870578235575, 5312.07038768214, 5314.946850531523, 3459.4810778383444, 3573.8391772370305, 3584.6953008994005, 3590.694790942799, 3591.120175557005, 589.3163929841363, 597.6682940967804, 602.0, 609.9878002440015, 613.355976224962, 552.3923683947705, 590.6397097770357, 626.8714913442733, 634.66127320822, 693.6774399904069, 9709.368891022203, 10185.33795303303, 10348.948255258676, 10435.582576697, 10729.446547539397, 616.9136320915076, 625.1185827982523, 685.8936864785966, 710.1123595505618, 776.7592046465613, 5099.133147364957, 5222.086134926372, 5236.6857988520815, 5253.369595648546, 5323.441038690959, 115037.0, 115115.0, 115650.0, 117422.0, 120959.39520302518, 65432.0, 65933.34066659368, 68211.0, 104521.86434406979, 107196.46401768098, 93838.53080734552, 95901.52049239709, 99641.0, 101313.49343253237, 101375.99999999853, 9708.920653008758, 9920.511923211576, 9940.0, 9978.451185184884, 10025.699229023141, 55789.0, 56465.71767141138, 56999.71500142473, 57869.4213057864, 57996.0, 77230.0, 82461.17538824535, 83951.0, 84994.57502712446, 86824.0, 11718.531258749554, 12886.806697899727, 13466.124701894345, 13761.243131627856, 13826.30868456553, 15973.281202346156, 16263.0, 17149.91425042867, 17433.389831355842, 17459.865108767888, 14448.927755361156, 14546.4908728194, 15363.923180384027, 15368.308426121075, 15412.075275483507, 14584.197869116875, 14797.408103675732, 14869.405223790927, 14985.2507374633, 15460.613484662974, 14820.851791482379, 15230.314635841192, 15687.921560392126, 16490.75263871019, 16500.504984850475, 12017.579384721494, 12287.69280767988, 13296.468141274627, 13478.595642130751, 13693.315334233448, 12631.431585578488, 12710.395181343512, 12753.0, 12789.93605031969, 13087.0], "value": 8047.456214416594, "unit": "score"}], "name": "dromaeo_css", "value": 7602.965152627833, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 111.0, 110.0, 109.0, 110.0, 110.0, 111.0, 111.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 123.0, 115.0, 149.0, 122.0, 122.0, 120.0, 117.0, 158.0, 118.0], "value": 128.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 163.0, 161.0, 160.0, 161.0, 163.0, 162.0, 161.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 110.0, 76.0, 75.0, 75.0, 78.0, 100.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 117.0, 81.0, 81.0, 81.0, 104.0, 81.0, 80.0, 102.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 118.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 50.0, 48.0, 50.0, 51.0, 50.0, 50.0, 48.0, 49.0], "value": 49.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 59.0, 59.0, 59.0, 58.0, 58.0, 58.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 72.0, 72.0, 73.0, 73.0, 78.0, 79.0, 72.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 123.0, 129.0, 121.0, 117.0, 119.0, 118.0, 123.0, 151.0, 119.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 154.0, 154.0, 152.0, 152.0, 152.0, 153.0, 157.0, 152.0, 149.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 64.0, 62.0, 61.0, 65.0, 62.0, 62.0, 62.0, 62.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1452.1999999999998, "alertThreshold": 2.0}]} 06:27:37 INFO - Return code: 0 06:27:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:27:37 INFO - # TBPL SUCCESS # 06:27:37 INFO - Running post-action listener: _resource_record_post_action 06:27:37 INFO - [mozharness: 2016-09-30 13:27:37.140637Z] Finished run-tests step (success) 06:27:37 INFO - Running post-run listener: _resource_record_post_run 06:27:37 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 360116224; Read time: 0; Write time: 238336 06:27:37 INFO - TinderboxPrint: CPU usage
13.0% 06:27:37 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:27:37 INFO - TinderboxPrint: I/O write bytes / time
360,116,224 / 238,336 06:27:37 INFO - TinderboxPrint: CPU idle
8,257.1 (87.0%) 06:27:37 INFO - TinderboxPrint: CPU user
1,189.7 (12.5%) 06:27:37 INFO - TinderboxPrint: Swap in / out
0 / 0 06:27:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107544576; Read time: 0; Write time: 107524 06:27:37 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 240611328; Read time: 0; Write time: 128804 06:27:37 INFO - Running post-run listener: _upload_blobber_files 06:27:37 INFO - Blob upload gear active. 06:27:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:27:37 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 06:27:37 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'] 06:27:37 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 06:27:38 INFO - (blobuploader) - INFO - Open directory for files ... 06:27:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:27:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:27:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:27:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:27:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:27:41 INFO - (blobuploader) - INFO - Done attempting. 06:27:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:27:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:27:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:27:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:27:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:27:42 INFO - (blobuploader) - INFO - Done attempting. 06:27:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:27:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:27:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:27:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:27:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:27:42 INFO - (blobuploader) - INFO - Done attempting. 06:27:42 INFO - (blobuploader) - INFO - Iteration through files over. 06:27:42 INFO - Return code: 0 06:27:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:27:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:27:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37b4f67fabc5f7b2f6302c583fec2ba5f695b4ee77cc4dcd348e5476f3ce53e38f700ae96f790910ee19db715aed98370fc6b086b3dab7c1f98cfec981f2f61b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a13659916255031eafa3316fc08ba1cd6555006696335c2ae35ecdf56c16cc7505be8bbadf9d4b2a0304bb6a862d5a7de85c494f462a200b796ff1c667f31f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f70306882fb5f6b0fc7f0b394c11404432d481a254575289ca7d1357abba60aa975310a3f01603e5e539d7ea51c07398a54b9c401ca627fb557c641dcdd5423"} 06:27:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:27:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:27:42 INFO - Contents: 06:27:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37b4f67fabc5f7b2f6302c583fec2ba5f695b4ee77cc4dcd348e5476f3ce53e38f700ae96f790910ee19db715aed98370fc6b086b3dab7c1f98cfec981f2f61b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a13659916255031eafa3316fc08ba1cd6555006696335c2ae35ecdf56c16cc7505be8bbadf9d4b2a0304bb6a862d5a7de85c494f462a200b796ff1c667f31f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f70306882fb5f6b0fc7f0b394c11404432d481a254575289ca7d1357abba60aa975310a3f01603e5e539d7ea51c07398a54b9c401ca627fb557c641dcdd5423"} 06:27:42 INFO - Running post-run listener: copy_logs_to_upload_dir 06:27:42 INFO - Copying logs to upload dir... 06:27:42 INFO - mkdir: /builds/slave/test/build/upload/logs 06:27:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.140236 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-09-30 06:27:42.312686) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 06:27:42.316100) ========= 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=1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030 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/37b4f67fabc5f7b2f6302c583fec2ba5f695b4ee77cc4dcd348e5476f3ce53e38f700ae96f790910ee19db715aed98370fc6b086b3dab7c1f98cfec981f2f61b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a13659916255031eafa3316fc08ba1cd6555006696335c2ae35ecdf56c16cc7505be8bbadf9d4b2a0304bb6a862d5a7de85c494f462a200b796ff1c667f31f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f70306882fb5f6b0fc7f0b394c11404432d481a254575289ca7d1357abba60aa975310a3f01603e5e539d7ea51c07398a54b9c401ca627fb557c641dcdd5423"} build_url:https://queue.taskcluster.net/v1/task/SYQTvccCS_aLetAI_qCs_Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011683 build_url: 'https://queue.taskcluster.net/v1/task/SYQTvccCS_aLetAI_qCs_Q/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/37b4f67fabc5f7b2f6302c583fec2ba5f695b4ee77cc4dcd348e5476f3ce53e38f700ae96f790910ee19db715aed98370fc6b086b3dab7c1f98cfec981f2f61b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a13659916255031eafa3316fc08ba1cd6555006696335c2ae35ecdf56c16cc7505be8bbadf9d4b2a0304bb6a862d5a7de85c494f462a200b796ff1c667f31f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f70306882fb5f6b0fc7f0b394c11404432d481a254575289ca7d1357abba60aa975310a3f01603e5e539d7ea51c07398a54b9c401ca627fb557c641dcdd5423"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 06:27:42.341074) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 06:27:42.341375) ========= 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=1f5564757af27664ca02d71f000001b0-1475237802.843839-1180815030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 06:27:42.426317) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 06:27:42.426600) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 06:27:42.426888) ========= ========= Total master_lag: 0.16 =========