builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1475467189.28 results: success (0) buildid: 20161002181155 builduid: 9f219ab184494e608eb83f8dd331ac21 revision: 92fb8d0b256ae2660b921108101a4fc0fde1e809 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-02 20:59:49.281363) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-02 20:59:49.281822) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-02 20:59:49.282097) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-02 20:59:49.309933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-02 20:59:49.310229) ========= 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=ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-02 20:59:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.1M=0s 2016-10-02 20:59:49 (70.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191886 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-02 20:59:49.515498) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-02 20:59:49.515957) ========= 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=ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017354 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-02 20:59:49.565657) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-02 20:59:49.566004) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 92fb8d0b256ae2660b921108101a4fc0fde1e809 --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 92fb8d0b256ae2660b921108101a4fc0fde1e809 --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=ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-02 20:59:49,838 truncating revision to first 12 chars 2016-10-02 20:59:49,838 Setting DEBUG logging. 2016-10-02 20:59:49,838 attempt 1/10 2016-10-02 20:59:49,838 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/92fb8d0b256a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-02 20:59:50,141 unpacking tar archive at: mozilla-aurora-92fb8d0b256a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679639 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-02 20:59:50.259591) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-02 20:59:50.259908) ========= script_repo_revision: 92fb8d0b256ae2660b921108101a4fc0fde1e809 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-02 20:59:50.260306) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-02 20:59:50.260573) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-02 20:59:50.271279) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-02 20:59:50.271697) ========= /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=ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:59:50 INFO - MultiFileLogger online at 20161002 20:59:50 in /builds/slave/test 20:59:50 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 20:59:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:59:50 INFO - {'append_to_log': False, 20:59:50 INFO - 'base_work_dir': '/builds/slave/test', 20:59:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:59:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:59:50 INFO - 'branch': 'Mozilla-Aurora', 20:59:50 INFO - 'buildbot_json_path': 'buildprops.json', 20:59:50 INFO - 'config_files': ('talos/linux_config.py',), 20:59:50 INFO - 'default_actions': ('clobber', 20:59:50 INFO - 'read-buildbot-config', 20:59:50 INFO - 'download-and-extract', 20:59:50 INFO - 'populate-webroot', 20:59:50 INFO - 'create-virtualenv', 20:59:50 INFO - 'install', 20:59:50 INFO - 'run-tests'), 20:59:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:59:50 INFO - 'download_minidump_stackwalk': True, 20:59:50 INFO - 'download_symbols': 'ondemand', 20:59:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:59:50 INFO - 'tooltool.py': '/tools/tooltool.py', 20:59:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:59:50 INFO - '/tools/misc-python/virtualenv.py')}, 20:59:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:59:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:59:50 INFO - 'installer_path': 'installer.exe', 20:59:50 INFO - 'log_level': 'info', 20:59:50 INFO - 'log_name': 'talos', 20:59:50 INFO - 'log_to_console': True, 20:59:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:59:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:59:50 INFO - 'opt_config_files': (), 20:59:50 INFO - 'pip_index': False, 20:59:50 INFO - 'sps_profile': False, 20:59:50 INFO - 'sps_profile_interval': 0, 20:59:50 INFO - 'suite': 'dromaeojs', 20:59:50 INFO - 'system_bits': '32', 20:59:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:59:50 INFO - 'title': 'talos-linux64-ix-035', 20:59:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:59:50 INFO - 'use_talos_json': True, 20:59:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:59:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:59:50 INFO - 'work_dir': 'build'} 20:59:50 INFO - [mozharness: 2016-10-03 03:59:50.645537Z] Running clobber step. 20:59:50 INFO - Running pre-action listener: _resource_record_pre_action 20:59:50 INFO - Running main action method: clobber 20:59:50 INFO - rmtree: /builds/slave/test/build 20:59:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:59:51 INFO - Running post-action listener: _resource_record_post_action 20:59:51 INFO - [mozharness: 2016-10-03 03:59:51.630672Z] Finished clobber step (success) 20:59:51 INFO - [mozharness: 2016-10-03 03:59:51.630774Z] Running read-buildbot-config step. 20:59:51 INFO - Running pre-action listener: _resource_record_pre_action 20:59:51 INFO - Running main action method: read_buildbot_config 20:59:51 INFO - Using buildbot properties: 20:59:51 INFO - { 20:59:51 INFO - "project": "", 20:59:51 INFO - "product": "firefox", 20:59:51 INFO - "script_repo_revision": "production", 20:59:51 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 20:59:51 INFO - "repository": "", 20:59:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 20:59:51 INFO - "buildid": "20161002181155", 20:59:51 INFO - "pgo_build": "True", 20:59:51 INFO - "basedir": "/builds/slave/test", 20:59:51 INFO - "buildnumber": 800, 20:59:51 INFO - "slavename": "talos-linux64-ix-035", 20:59:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:59:51 INFO - "platform": "ubuntu64_hw", 20:59:51 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 20:59:51 INFO - "branch": "mozilla-aurora", 20:59:51 INFO - "repo_path": "releases/mozilla-aurora", 20:59:51 INFO - "revision": "92fb8d0b256ae2660b921108101a4fc0fde1e809", 20:59:51 INFO - "stage_platform": "linux64-pgo", 20:59:51 INFO - "builduid": "9f219ab184494e608eb83f8dd331ac21", 20:59:51 INFO - "slavebuilddir": "test" 20:59:51 INFO - } 20:59:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/GERA3i5zQFeFwQUkW3Mgpw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 20:59:51 INFO - Running post-action listener: _resource_record_post_action 20:59:51 INFO - [mozharness: 2016-10-03 03:59:51.633537Z] Finished read-buildbot-config step (success) 20:59:51 INFO - [mozharness: 2016-10-03 03:59:51.633626Z] Running download-and-extract step. 20:59:51 INFO - Running pre-action listener: _resource_record_pre_action 20:59:51 INFO - Running main action method: download_and_extract 20:59:51 INFO - mkdir: /builds/slave/test/build/tests 20:59:51 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')]} 20:59:51 INFO - trying https://queue.taskcluster.net/v1/task/GERA3i5zQFeFwQUkW3Mgpw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 20:59:51 INFO - Downloading https://queue.taskcluster.net/v1/task/GERA3i5zQFeFwQUkW3Mgpw/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 20:59:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GERA3i5zQFeFwQUkW3Mgpw/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 20:59:52 INFO - Downloaded 1361 bytes. 20:59:52 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 20:59:52 INFO - Using the following test package requirements: 20:59:52 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 20:59:52 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 20:59:52 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 20:59:52 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 20:59:52 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 20:59:52 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 20:59:52 INFO - u'jsshell-linux-x86_64.zip'], 20:59:52 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 20:59:52 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 20:59:52 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 20:59:52 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 20:59:52 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 20:59:52 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 20:59:52 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 20:59:52 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 20:59:52 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 20:59:52 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 20:59:52 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 20:59:52 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:59:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GERA3i5zQFeFwQUkW3Mgpw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 20:59:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GERA3i5zQFeFwQUkW3Mgpw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:59:52 INFO - Fetch https://queue.taskcluster.net/v1/task/GERA3i5zQFeFwQUkW3Mgpw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 20:59:52 INFO - Expected file size: 21900555 20:59:57 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 20:59:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GERA3i5zQFeFwQUkW3Mgpw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 20:59:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GERA3i5zQFeFwQUkW3Mgpw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:59:57 INFO - Fetch https://queue.taskcluster.net/v1/task/GERA3i5zQFeFwQUkW3Mgpw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 20:59:57 INFO - Expected file size: 21900555 21:00:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GERA3i5zQFeFwQUkW3Mgpw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 21:00:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GERA3i5zQFeFwQUkW3Mgpw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:00:02 INFO - Fetch https://queue.taskcluster.net/v1/task/GERA3i5zQFeFwQUkW3Mgpw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 21:00:02 INFO - Expected file size: 14414059 21:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:03 INFO - trying https://queue.taskcluster.net/v1/task/GERA3i5zQFeFwQUkW3Mgpw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 21:00:03 INFO - Downloading https://queue.taskcluster.net/v1/task/GERA3i5zQFeFwQUkW3Mgpw/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 21:00:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GERA3i5zQFeFwQUkW3Mgpw/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 21:00:04 INFO - Downloaded 63910404 bytes. 21:00:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GERA3i5zQFeFwQUkW3Mgpw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 21:00:04 INFO - mkdir: /builds/slave/test/properties 21:00:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:00:04 INFO - Writing to file /builds/slave/test/properties/build_url 21:00:04 INFO - Contents: 21:00:04 INFO - build_url:https://queue.taskcluster.net/v1/task/GERA3i5zQFeFwQUkW3Mgpw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 21:00:05 INFO - Running post-action listener: _resource_record_post_action 21:00:05 INFO - Running post-action listener: set_extra_try_arguments 21:00:05 INFO - [mozharness: 2016-10-03 04:00:05.213446Z] Finished download-and-extract step (success) 21:00:05 INFO - [mozharness: 2016-10-03 04:00:05.213674Z] Running populate-webroot step. 21:00:05 INFO - Running pre-action listener: _resource_record_pre_action 21:00:05 INFO - Running main action method: populate_webroot 21:00:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:00:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:00:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:00:05 INFO - '--tppagecycles', 21:00:05 INFO - '7'], 21:00:05 INFO - 'tests': ['tsvgm']}}, 21:00:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:00:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:00:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:00:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:00:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:00:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:00:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:05 INFO - 'talos_options': ['--disable-e10s'], 21:00:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:00:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:00:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:05 INFO - 'talos_options': ['--disable-e10s'], 21:00:05 INFO - 'tests': ['damp', 'tps']}, 21:00:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:05 INFO - 'tests': ['damp', 'tps']}, 21:00:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:00:05 INFO - 'tests': ['dromaeo_dom']}, 21:00:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:00:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:00:05 INFO - 'tests': ['basic_compositor_video']}, 21:00:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:00:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:00:05 INFO - 'tests': ['a11yr', 21:00:05 INFO - 'ts_paint', 21:00:05 INFO - 'tpaint', 21:00:05 INFO - 'sessionrestore', 21:00:05 INFO - 'sessionrestore_no_auto_restore', 21:00:05 INFO - 'tabpaint']}, 21:00:05 INFO - 'other-e10s': {'tests': ['a11yr', 21:00:05 INFO - 'ts_paint', 21:00:05 INFO - 'tpaint', 21:00:05 INFO - 'sessionrestore', 21:00:05 INFO - 'sessionrestore_no_auto_restore', 21:00:05 INFO - 'tabpaint']}, 21:00:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:00:05 INFO - 'ts_paint', 21:00:05 INFO - 'tpaint', 21:00:05 INFO - 'sessionrestore', 21:00:05 INFO - 'sessionrestore_no_auto_restore', 21:00:05 INFO - 'tabpaint']}, 21:00:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:00:05 INFO - 'ts_paint', 21:00:05 INFO - 'tpaint', 21:00:05 INFO - 'sessionrestore', 21:00:05 INFO - 'sessionrestore_no_auto_restore', 21:00:05 INFO - 'tabpaint']}, 21:00:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:00:05 INFO - 'tests': ['a11yr', 21:00:05 INFO - 'ts_paint', 21:00:05 INFO - 'tpaint', 21:00:05 INFO - 'sessionrestore', 21:00:05 INFO - 'sessionrestore_no_auto_restore', 21:00:05 INFO - 'tabpaint']}, 21:00:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:00:05 INFO - 'tests': ['a11yr', 21:00:05 INFO - 'ts_paint', 21:00:05 INFO - 'tpaint', 21:00:05 INFO - 'sessionrestore', 21:00:05 INFO - 'sessionrestore_no_auto_restore', 21:00:05 INFO - 'tabpaint']}, 21:00:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:00:05 INFO - 'tests': ['tsvgx', 21:00:05 INFO - 'tsvgr_opacity', 21:00:05 INFO - 'tart', 21:00:05 INFO - 'tscrollx', 21:00:05 INFO - 'cart']}, 21:00:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:00:05 INFO - 'tsvgr_opacity', 21:00:05 INFO - 'tart', 21:00:05 INFO - 'tscrollx', 21:00:05 INFO - 'cart']}, 21:00:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:05 INFO - 'talos_options': ['--disable-e10s'], 21:00:05 INFO - 'tests': ['tp5o']}, 21:00:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:05 INFO - 'tests': ['tp5o']}, 21:00:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:05 INFO - 'talos_options': ['--disable-e10s', 21:00:05 INFO - '--xperf_path', 21:00:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:00:05 INFO - 'tests': ['tp5n']}, 21:00:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:05 INFO - 'talos_options': ['--xperf_path', 21:00:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:00:05 INFO - 'tests': ['tp5n']}}, 21:00:05 INFO - 'talos.zip': {'path': '', 21:00:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:00:05 INFO - Running post-action listener: _resource_record_post_action 21:00:05 INFO - [mozharness: 2016-10-03 04:00:05.232187Z] Finished populate-webroot step (success) 21:00:05 INFO - [mozharness: 2016-10-03 04:00:05.232275Z] Running create-virtualenv step. 21:00:05 INFO - Running pre-action listener: _resource_record_pre_action 21:00:05 INFO - Running main action method: create_virtualenv 21:00:05 INFO - Creating virtualenv /builds/slave/test/build/venv 21:00:05 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 21:00:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:00:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:00:05 INFO - Using real prefix '/usr' 21:00:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:00:05 INFO - Installing distribute.............................................................................................................................................................................................done. 21:00:07 INFO - Installing pip.................done. 21:00:07 INFO - Return code: 0 21:00:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:00:07 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')]} 21:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:07 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')]} 21:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:07 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 0x7ff733950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', '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 21:00:07 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 21:00:07 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 21:00:07 INFO - Using env: {'DISPLAY': ':0', 21:00:07 INFO - 'HOME': '/home/cltbld', 21:00:07 INFO - 'LANG': 'en_US.UTF-8', 21:00:07 INFO - 'LANGUAGE': 'en_US:en', 21:00:07 INFO - 'LOGNAME': 'cltbld', 21:00:07 INFO - 'MAIL': '/var/mail/cltbld', 21:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:07 INFO - 'MOZ_NO_REMOTE': '1', 21:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:07 INFO - 'NO_EM_RESTART': '1', 21:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:07 INFO - 'PWD': '/builds/slave/test', 21:00:07 INFO - 'SHELL': '/bin/bash', 21:00:07 INFO - 'SHLVL': '1', 21:00:07 INFO - 'TERM': 'linux', 21:00:07 INFO - 'TMOUT': '86400', 21:00:07 INFO - 'USER': 'cltbld', 21:00:07 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', 21:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:07 INFO - '_': '/tools/buildbot/bin/python'} 21:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:08 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 21:00:08 INFO - Cleaning up... 21:00:08 INFO - Return code: 0 21:00:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff733950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', '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 21:00:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:00:08 INFO - Using env: {'DISPLAY': ':0', 21:00:08 INFO - 'HOME': '/home/cltbld', 21:00:08 INFO - 'LANG': 'en_US.UTF-8', 21:00:08 INFO - 'LANGUAGE': 'en_US:en', 21:00:08 INFO - 'LOGNAME': 'cltbld', 21:00:08 INFO - 'MAIL': '/var/mail/cltbld', 21:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:08 INFO - 'MOZ_NO_REMOTE': '1', 21:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:08 INFO - 'NO_EM_RESTART': '1', 21:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:08 INFO - 'PWD': '/builds/slave/test', 21:00:08 INFO - 'SHELL': '/bin/bash', 21:00:08 INFO - 'SHLVL': '1', 21:00:08 INFO - 'TERM': 'linux', 21:00:08 INFO - 'TMOUT': '86400', 21:00:08 INFO - 'USER': 'cltbld', 21:00:08 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', 21:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:08 INFO - '_': '/tools/buildbot/bin/python'} 21:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:08 INFO - Downloading/unpacking psutil>=3.1.1 21:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:00:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:00:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:00:10 INFO - Installing collected packages: psutil 21:00:10 INFO - Running setup.py install for psutil 21:00:10 INFO - building 'psutil._psutil_linux' extension 21:00:10 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 21:00:10 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 21:00:10 INFO - building 'psutil._psutil_posix' extension 21:00:10 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 21:00:10 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 21:00:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:00:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:00:10 INFO - Successfully installed psutil 21:00:10 INFO - Cleaning up... 21:00:10 INFO - Return code: 0 21:00:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:00:10 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')]} 21:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:10 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')]} 21:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:10 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 0x7ff733950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', '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 21:00:10 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 21:00:10 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 21:00:10 INFO - Using env: {'DISPLAY': ':0', 21:00:10 INFO - 'HOME': '/home/cltbld', 21:00:10 INFO - 'LANG': 'en_US.UTF-8', 21:00:10 INFO - 'LANGUAGE': 'en_US:en', 21:00:10 INFO - 'LOGNAME': 'cltbld', 21:00:10 INFO - 'MAIL': '/var/mail/cltbld', 21:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:10 INFO - 'MOZ_NO_REMOTE': '1', 21:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:10 INFO - 'NO_EM_RESTART': '1', 21:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:10 INFO - 'PWD': '/builds/slave/test', 21:00:10 INFO - 'SHELL': '/bin/bash', 21:00:10 INFO - 'SHLVL': '1', 21:00:10 INFO - 'TERM': 'linux', 21:00:10 INFO - 'TMOUT': '86400', 21:00:10 INFO - 'USER': 'cltbld', 21:00:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', 21:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:10 INFO - '_': '/tools/buildbot/bin/python'} 21:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:00:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:00:12 INFO - Installing collected packages: mozsystemmonitor 21:00:12 INFO - Running setup.py install for mozsystemmonitor 21:00:13 INFO - Successfully installed mozsystemmonitor 21:00:13 INFO - Cleaning up... 21:00:13 INFO - Return code: 0 21:00:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:13 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 0x7ff733950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', '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 21:00:13 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 21:00:13 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 21:00:13 INFO - Using env: {'DISPLAY': ':0', 21:00:13 INFO - 'HOME': '/home/cltbld', 21:00:13 INFO - 'LANG': 'en_US.UTF-8', 21:00:13 INFO - 'LANGUAGE': 'en_US:en', 21:00:13 INFO - 'LOGNAME': 'cltbld', 21:00:13 INFO - 'MAIL': '/var/mail/cltbld', 21:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:13 INFO - 'MOZ_NO_REMOTE': '1', 21:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:13 INFO - 'NO_EM_RESTART': '1', 21:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:13 INFO - 'PWD': '/builds/slave/test', 21:00:13 INFO - 'SHELL': '/bin/bash', 21:00:13 INFO - 'SHLVL': '1', 21:00:13 INFO - 'TERM': 'linux', 21:00:13 INFO - 'TMOUT': '86400', 21:00:13 INFO - 'USER': 'cltbld', 21:00:13 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', 21:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:13 INFO - '_': '/tools/buildbot/bin/python'} 21:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:13 INFO - Downloading/unpacking jsonschema==2.5.1 21:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:00:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:00:15 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 21:00:15 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 21:00:15 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 21:00:15 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 21:00:15 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 21:00:15 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 21:00:15 INFO - Downloading functools32-3.2.3-2.tar.gz 21:00:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:00:15 INFO - warning: no files found matching '*.txt' 21:00:15 INFO - no previously-included directories found matching 'build' 21:00:15 INFO - no previously-included directories found matching 'dist' 21:00:15 INFO - no previously-included directories found matching '.git*' 21:00:15 INFO - Installing collected packages: jsonschema, functools32 21:00:15 INFO - Running setup.py install for functools32 21:00:15 INFO - warning: no files found matching '*.txt' 21:00:15 INFO - no previously-included directories found matching 'build' 21:00:15 INFO - no previously-included directories found matching 'dist' 21:00:15 INFO - no previously-included directories found matching '.git*' 21:00:15 INFO - Successfully installed jsonschema functools32 21:00:15 INFO - Cleaning up... 21:00:15 INFO - Return code: 0 21:00:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:15 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 0x7ff733950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', '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 21:00:15 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 21:00:15 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 21:00:15 INFO - Using env: {'DISPLAY': ':0', 21:00:15 INFO - 'HOME': '/home/cltbld', 21:00:15 INFO - 'LANG': 'en_US.UTF-8', 21:00:15 INFO - 'LANGUAGE': 'en_US:en', 21:00:15 INFO - 'LOGNAME': 'cltbld', 21:00:15 INFO - 'MAIL': '/var/mail/cltbld', 21:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:15 INFO - 'MOZ_NO_REMOTE': '1', 21:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:15 INFO - 'NO_EM_RESTART': '1', 21:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:15 INFO - 'PWD': '/builds/slave/test', 21:00:15 INFO - 'SHELL': '/bin/bash', 21:00:15 INFO - 'SHLVL': '1', 21:00:15 INFO - 'TERM': 'linux', 21:00:15 INFO - 'TMOUT': '86400', 21:00:15 INFO - 'USER': 'cltbld', 21:00:15 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', 21:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:15 INFO - '_': '/tools/buildbot/bin/python'} 21:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:00:15 INFO - Cleaning up... 21:00:15 INFO - Return code: 0 21:00:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:15 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 0x7ff733950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', '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 21:00:15 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 21:00:15 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 21:00:15 INFO - Using env: {'DISPLAY': ':0', 21:00:15 INFO - 'HOME': '/home/cltbld', 21:00:15 INFO - 'LANG': 'en_US.UTF-8', 21:00:15 INFO - 'LANGUAGE': 'en_US:en', 21:00:15 INFO - 'LOGNAME': 'cltbld', 21:00:15 INFO - 'MAIL': '/var/mail/cltbld', 21:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:15 INFO - 'MOZ_NO_REMOTE': '1', 21:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:15 INFO - 'NO_EM_RESTART': '1', 21:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:15 INFO - 'PWD': '/builds/slave/test', 21:00:15 INFO - 'SHELL': '/bin/bash', 21:00:15 INFO - 'SHLVL': '1', 21:00:15 INFO - 'TERM': 'linux', 21:00:15 INFO - 'TMOUT': '86400', 21:00:15 INFO - 'USER': 'cltbld', 21:00:15 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', 21:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:15 INFO - '_': '/tools/buildbot/bin/python'} 21:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:16 INFO - Downloading/unpacking blobuploader==1.2.4 21:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:18 INFO - Downloading blobuploader-1.2.4.tar.gz 21:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:00:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:00:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:18 INFO - Downloading docopt-0.6.1.tar.gz 21:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:00:18 INFO - Installing collected packages: blobuploader, requests, docopt 21:00:18 INFO - Running setup.py install for blobuploader 21:00:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:00:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:00:18 INFO - Running setup.py install for requests 21:00:19 INFO - Running setup.py install for docopt 21:00:19 INFO - Successfully installed blobuploader requests docopt 21:00:19 INFO - Cleaning up... 21:00:19 INFO - Return code: 0 21:00:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:19 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 0x7ff733950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', '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 21:00:19 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 21:00:19 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 21:00:19 INFO - Using env: {'DISPLAY': ':0', 21:00:19 INFO - 'HOME': '/home/cltbld', 21:00:19 INFO - 'LANG': 'en_US.UTF-8', 21:00:19 INFO - 'LANGUAGE': 'en_US:en', 21:00:19 INFO - 'LOGNAME': 'cltbld', 21:00:19 INFO - 'MAIL': '/var/mail/cltbld', 21:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:19 INFO - 'MOZ_NO_REMOTE': '1', 21:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:19 INFO - 'NO_EM_RESTART': '1', 21:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:19 INFO - 'PWD': '/builds/slave/test', 21:00:19 INFO - 'SHELL': '/bin/bash', 21:00:19 INFO - 'SHLVL': '1', 21:00:19 INFO - 'TERM': 'linux', 21:00:19 INFO - 'TMOUT': '86400', 21:00:19 INFO - 'USER': 'cltbld', 21:00:19 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', 21:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:19 INFO - '_': '/tools/buildbot/bin/python'} 21:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:00:19 INFO - Running setup.py (path:/tmp/pip-IjhoVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:00:19 INFO - Running setup.py (path:/tmp/pip-__eTNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:00:19 INFO - Running setup.py (path:/tmp/pip-skc6Pa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:00:19 INFO - Running setup.py (path:/tmp/pip-Y1WuKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:00:19 INFO - Running setup.py (path:/tmp/pip-FcfZHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:00:20 INFO - Running setup.py (path:/tmp/pip-uf652g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:00:20 INFO - Running setup.py (path:/tmp/pip-xxX_j2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:00:20 INFO - Running setup.py (path:/tmp/pip-0eAKcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:00:20 INFO - Running setup.py (path:/tmp/pip-IuLunE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:00:20 INFO - Running setup.py (path:/tmp/pip-C2lNHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:00:20 INFO - Running setup.py (path:/tmp/pip-TH1aet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:00:20 INFO - Running setup.py (path:/tmp/pip-g8Itxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:00:20 INFO - Running setup.py (path:/tmp/pip-FExr9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:00:20 INFO - Running setup.py (path:/tmp/pip-7mQ_b7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:00:20 INFO - Running setup.py (path:/tmp/pip-5KGgAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:00:20 INFO - Running setup.py (path:/tmp/pip-mLTZ0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:00:20 INFO - Running setup.py (path:/tmp/pip-HJE6U9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:00:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:00:20 INFO - Running setup.py install for manifestparser 21:00:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:00:20 INFO - Running setup.py install for mozcrash 21:00:21 INFO - Running setup.py install for mozdebug 21:00:21 INFO - Running setup.py install for mozdevice 21:00:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:00:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:00:21 INFO - Running setup.py install for mozfile 21:00:21 INFO - Running setup.py install for mozhttpd 21:00:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:00:21 INFO - Running setup.py install for mozinfo 21:00:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:00:21 INFO - Running setup.py install for mozInstall 21:00:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:00:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:00:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:00:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:00:21 INFO - Running setup.py install for mozleak 21:00:21 INFO - Running setup.py install for mozlog 21:00:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:00:21 INFO - Running setup.py install for moznetwork 21:00:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:00:21 INFO - Running setup.py install for mozprocess 21:00:22 INFO - Running setup.py install for mozprofile 21:00:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:00:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:00:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:00:22 INFO - Running setup.py install for mozrunner 21:00:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:00:22 INFO - Running setup.py install for mozscreenshot 21:00:22 INFO - Running setup.py install for moztest 21:00:22 INFO - Running setup.py install for mozversion 21:00:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:00:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:00:22 INFO - Cleaning up... 21:00:22 INFO - Return code: 0 21:00:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:00:22 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')]} 21:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:22 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')]} 21:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:22 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 0x7ff733950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', '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 21:00:22 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 21:00:22 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 21:00:22 INFO - Using env: {'DISPLAY': ':0', 21:00:22 INFO - 'HOME': '/home/cltbld', 21:00:22 INFO - 'LANG': 'en_US.UTF-8', 21:00:22 INFO - 'LANGUAGE': 'en_US:en', 21:00:22 INFO - 'LOGNAME': 'cltbld', 21:00:22 INFO - 'MAIL': '/var/mail/cltbld', 21:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:22 INFO - 'MOZ_NO_REMOTE': '1', 21:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:22 INFO - 'NO_EM_RESTART': '1', 21:00:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:22 INFO - 'PWD': '/builds/slave/test', 21:00:22 INFO - 'SHELL': '/bin/bash', 21:00:22 INFO - 'SHLVL': '1', 21:00:22 INFO - 'TERM': 'linux', 21:00:22 INFO - 'TMOUT': '86400', 21:00:22 INFO - 'USER': 'cltbld', 21:00:22 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', 21:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:22 INFO - '_': '/tools/buildbot/bin/python'} 21:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:00:22 INFO - Running setup.py (path:/tmp/pip-IdCcll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:00:22 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)) 21:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:00:22 INFO - Running setup.py (path:/tmp/pip-IhJl16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:00:23 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)) 21:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:00:23 INFO - Running setup.py (path:/tmp/pip-AKFkkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:00:23 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)) 21:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:00:23 INFO - Running setup.py (path:/tmp/pip-UF8q2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:00:23 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)) 21:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:00:23 INFO - Running setup.py (path:/tmp/pip-o8OXpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:00:23 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)) 21:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:00:23 INFO - Running setup.py (path:/tmp/pip-izfW5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:00:23 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)) 21:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:00:23 INFO - Running setup.py (path:/tmp/pip-eO_Rl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:00:23 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)) 21:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:00:23 INFO - Running setup.py (path:/tmp/pip-m7PCJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:00:23 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)) 21:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:00:23 INFO - Running setup.py (path:/tmp/pip-JVOygd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:00:23 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)) 21:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:00:23 INFO - Running setup.py (path:/tmp/pip-ilIPbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:00:23 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)) 21:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:00:23 INFO - Running setup.py (path:/tmp/pip-wWr4bq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:00:23 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)) 21:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:00:23 INFO - Running setup.py (path:/tmp/pip-59EMbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:00:23 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)) 21:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:00:23 INFO - Running setup.py (path:/tmp/pip-gZhqxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:00:23 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)) 21:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:00:23 INFO - Running setup.py (path:/tmp/pip-Q0Ev5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:00:23 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)) 21:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:00:23 INFO - Running setup.py (path:/tmp/pip-ooNh4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:00:23 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)) 21:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:00:23 INFO - Running setup.py (path:/tmp/pip-rqGkzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:00:24 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)) 21:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:00:24 INFO - Running setup.py (path:/tmp/pip-jup6f7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:00:24 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)) 21:00:24 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)) 21:00:24 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)) 21:00:24 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)) 21:00:24 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)) 21:00:24 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)) 21:00:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:00:26 INFO - Downloading blessings-1.6.tar.gz 21:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:00:26 INFO - Installing collected packages: blessings 21:00:26 INFO - Running setup.py install for blessings 21:00:26 INFO - Successfully installed blessings 21:00:26 INFO - Cleaning up... 21:00:26 INFO - Return code: 0 21:00:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:00:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:00:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:00:26 INFO - Reading from file tmpfile_stdout 21:00:26 INFO - Current package versions: 21:00:26 INFO - argparse == 1.2.1 21:00:26 INFO - blessings == 1.6 21:00:26 INFO - blobuploader == 1.2.4 21:00:26 INFO - docopt == 0.6.1 21:00:26 INFO - functools32 == 3.2.3-2 21:00:26 INFO - jsonschema == 2.5.1 21:00:26 INFO - manifestparser == 1.1 21:00:26 INFO - mozInstall == 1.12 21:00:26 INFO - mozcrash == 0.17 21:00:26 INFO - mozdebug == 0.1 21:00:26 INFO - mozdevice == 0.48 21:00:26 INFO - mozfile == 1.2 21:00:26 INFO - mozhttpd == 0.7 21:00:26 INFO - mozinfo == 0.9 21:00:26 INFO - mozleak == 0.1 21:00:26 INFO - mozlog == 3.4 21:00:26 INFO - moznetwork == 0.27 21:00:26 INFO - mozprocess == 0.23 21:00:26 INFO - mozprofile == 0.28 21:00:26 INFO - mozrunner == 6.12 21:00:26 INFO - mozscreenshot == 0.1 21:00:26 INFO - mozsystemmonitor == 0.3 21:00:26 INFO - moztest == 0.7 21:00:26 INFO - mozversion == 1.4 21:00:26 INFO - psutil == 3.1.1 21:00:26 INFO - requests == 1.2.3 21:00:26 INFO - wsgiref == 0.1.2 21:00:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:26 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 0x7ff733950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', '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 21:00:26 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 21:00:26 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 21:00:26 INFO - Using env: {'DISPLAY': ':0', 21:00:26 INFO - 'HOME': '/home/cltbld', 21:00:26 INFO - 'LANG': 'en_US.UTF-8', 21:00:26 INFO - 'LANGUAGE': 'en_US:en', 21:00:26 INFO - 'LOGNAME': 'cltbld', 21:00:26 INFO - 'MAIL': '/var/mail/cltbld', 21:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:26 INFO - 'MOZ_NO_REMOTE': '1', 21:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:26 INFO - 'NO_EM_RESTART': '1', 21:00:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:26 INFO - 'PWD': '/builds/slave/test', 21:00:26 INFO - 'SHELL': '/bin/bash', 21:00:26 INFO - 'SHLVL': '1', 21:00:26 INFO - 'TERM': 'linux', 21:00:26 INFO - 'TMOUT': '86400', 21:00:26 INFO - 'USER': 'cltbld', 21:00:26 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', 21:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:26 INFO - '_': '/tools/buildbot/bin/python'} 21:00:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:26 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)) 21:00:26 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)) 21:00:26 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)) 21:00:26 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)) 21:00:26 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)) 21:00:26 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)) 21:00:26 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)) 21:00:26 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)) 21:00:26 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)) 21:00:26 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)) 21:00:26 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)) 21:00:26 INFO - Cleaning up... 21:00:26 INFO - Return code: 0 21:00:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:00:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff733950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', '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 21:00:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:00:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:00:26 INFO - Using env: {'DISPLAY': ':0', 21:00:26 INFO - 'HOME': '/home/cltbld', 21:00:26 INFO - 'LANG': 'en_US.UTF-8', 21:00:26 INFO - 'LANGUAGE': 'en_US:en', 21:00:26 INFO - 'LOGNAME': 'cltbld', 21:00:26 INFO - 'MAIL': '/var/mail/cltbld', 21:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:26 INFO - 'MOZ_NO_REMOTE': '1', 21:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:26 INFO - 'NO_EM_RESTART': '1', 21:00:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:26 INFO - 'PWD': '/builds/slave/test', 21:00:26 INFO - 'SHELL': '/bin/bash', 21:00:26 INFO - 'SHLVL': '1', 21:00:26 INFO - 'TERM': 'linux', 21:00:26 INFO - 'TMOUT': '86400', 21:00:26 INFO - 'USER': 'cltbld', 21:00:26 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', 21:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:26 INFO - '_': '/tools/buildbot/bin/python'} 21:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:00:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:00:27 INFO - Cleaning up... 21:00:27 INFO - Return code: 0 21:00:27 INFO - Running post-action listener: _resource_record_post_action 21:00:27 INFO - Running post-action listener: _start_resource_monitoring 21:00:27 INFO - Starting resource monitoring. 21:00:27 INFO - [mozharness: 2016-10-03 04:00:27.206972Z] Finished create-virtualenv step (success) 21:00:27 INFO - [mozharness: 2016-10-03 04:00:27.207481Z] Running install step. 21:00:27 INFO - Running pre-action listener: _resource_record_pre_action 21:00:27 INFO - Running main action method: install 21:00:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:00:27 INFO - Reading from file tmpfile_stdout 21:00:27 INFO - Detecting whether we're running mozinstall >=1.0... 21:00:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:00:27 INFO - Reading from file tmpfile_stdout 21:00:27 INFO - Output received: 21:00:27 INFO - Usage: mozinstall [options] installer 21:00:27 INFO - Options: 21:00:27 INFO - -h, --help show this help message and exit 21:00:27 INFO - -d DEST, --destination=DEST 21:00:27 INFO - Directory to install application into. [default: 21:00:27 INFO - "/builds/slave/test"] 21:00:27 INFO - --app=APP Application being installed. [default: firefox] 21:00:27 INFO - mkdir: /builds/slave/test/build/application 21:00:27 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'] 21:00:27 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 21:00:43 INFO - Reading from file tmpfile_stdout 21:00:43 INFO - Output received: 21:00:43 INFO - /builds/slave/test/build/application/firefox/firefox 21:00:43 INFO - Running post-action listener: _resource_record_post_action 21:00:43 INFO - [mozharness: 2016-10-03 04:00:43.446159Z] Finished install step (success) 21:00:43 INFO - [mozharness: 2016-10-03 04:00:43.446405Z] Running run-tests step. 21:00:43 INFO - Running pre-action listener: _resource_record_pre_action 21:00:43 INFO - Running main action method: run_tests 21:00:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:00:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:00:43 INFO - Python 2.7.3 21:00:43 INFO - Return code: 0 21:00:43 INFO - grabbing minidump binary from tooltool 21:00: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')]} 21:00:43 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 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:00:43 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 21:00:43 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 21:00:43 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 21:00:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:00:43 INFO - Return code: 0 21:00:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:00:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:00:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:00:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:00:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:00:43 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/GERA3i5zQFeFwQUkW3Mgpw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 21:00:43 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/GERA3i5zQFeFwQUkW3Mgpw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 21:00:43 INFO - Using env: {'DISPLAY': ':0', 21:00:43 INFO - 'HOME': '/home/cltbld', 21:00:43 INFO - 'LANG': 'en_US.UTF-8', 21:00:43 INFO - 'LANGUAGE': 'en_US:en', 21:00:43 INFO - 'LOGNAME': 'cltbld', 21:00:43 INFO - 'MAIL': '/var/mail/cltbld', 21:00:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:00:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:00:43 INFO - 'MOZ_NO_REMOTE': '1', 21:00:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:00:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:00:43 INFO - 'NO_EM_RESTART': '1', 21:00:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:00:43 INFO - 'PWD': '/builds/slave/test', 21:00:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:00:43 INFO - 'SHELL': '/bin/bash', 21:00:43 INFO - 'SHLVL': '1', 21:00:43 INFO - 'TERM': 'linux', 21:00:43 INFO - 'TMOUT': '86400', 21:00:43 INFO - 'USER': 'cltbld', 21:00:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381', 21:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:00:43 INFO - '_': '/tools/buildbot/bin/python'} 21:00:43 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/GERA3i5zQFeFwQUkW3Mgpw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 21:00:43 INFO - mozversion application_buildid: 20161002181155 21:00:43 INFO - mozversion application_changeset: 92fb8d0b256ae2660b921108101a4fc0fde1e809 21:00:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:00:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:00:43 INFO - mozversion application_name: Firefox 21:00:43 INFO - mozversion application_remotingname: firefox-dev 21:00:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:00:43 INFO - mozversion application_vendor: Mozilla 21:00:43 INFO - mozversion application_version: 51.0a2 21:00:43 INFO - mozversion platform_buildid: 20161002181155 21:00:43 INFO - mozversion platform_changeset: 92fb8d0b256ae2660b921108101a4fc0fde1e809 21:00:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:00:43 INFO - mozversion platform_version: 51.0a2 21:00:43 INFO - using testdate: 1475467243 21:00:43 INFO - actual date: 1475467243 21:00:43 INFO - starting webserver on 'localhost:58224' 21:00:43 INFO - SUITE-START | Running 2 tests 21:00:43 INFO - TEST-START | dromaeo_css 21:00:43 INFO - operating with platform_type : linux_ 21:00:43 INFO - Initialising browser for dromaeo_css test... 21:00:43 INFO - TEST-INFO | started process 11719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5_Fdyq/profile http://localhost:58224/getInfo.html) 21:00:47 INFO - PROCESS | 11719 | __metrics Screen width/height:1600/1200 21:00:47 INFO - PROCESS | 11719 | colorDepth:24 21:00:47 INFO - PROCESS | 11719 | Browser inner width/height: 1024/697 21:00:47 INFO - PROCESS | 11719 | __metrics 21:00:48 INFO - PROCESS | 11719 | 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" 21:00:48 INFO - PROCESS | 11719 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:00:48 INFO - PROCESS | 11719 | console.error: PushService: 21:00:48 INFO - PROCESS | 11719 | stateChangeProcessEnqueue: Error transitioning state 21:00:48 INFO - PROCESS | 11719 | UnknownError 21:00:49 INFO - TEST-INFO | 11719: exit 0 21:00:49 INFO - Browser initialized. 21:00:49 INFO - Running cycle 1/1 for dromaeo_css test... 21:00:49 INFO - TEST-INFO | started process 11809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5_Fdyq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:01:01 INFO - PROCESS | 11809 | RSS: Main: 144465920 21:01:01 INFO - PROCESS | 11809 | 21:01:52 INFO - PROCESS | 11809 | 1475467312354 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] 21:04:01 INFO - PROCESS | 11809 | Cycle 1(1): loaded http://localhost:58224/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58224/tests/dromaeo/cssquery-ext.html) 21:04:02 INFO - PROCESS | 11809 | RSS: Main: 234708992 21:04:02 INFO - PROCESS | 11809 | 21:07:04 INFO - PROCESS | 11809 | Cycle 1(1): loaded http://localhost:58224/tests/dromaeo/cssquery-ext.html (next: http://localhost:58224/tests/dromaeo/cssquery-jquery.html) 21:07:05 INFO - PROCESS | 11809 | RSS: Main: 234962944 21:07:05 INFO - PROCESS | 11809 | 21:10:07 INFO - PROCESS | 11809 | Cycle 1(1): loaded http://localhost:58224/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58224/tests/dromaeo/cssquery-mootools.html) 21:10:07 INFO - PROCESS | 11809 | RSS: Main: 186433536 21:10:07 INFO - PROCESS | 11809 | 21:13:09 INFO - PROCESS | 11809 | Cycle 1(1): loaded http://localhost:58224/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58224/tests/dromaeo/cssquery-prototype.html) 21:13:10 INFO - PROCESS | 11809 | RSS: Main: 203104256 21:13:10 INFO - PROCESS | 11809 | 21:16:13 INFO - PROCESS | 11809 | Cycle 1(1): loaded http://localhost:58224/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58224/tests/dromaeo/cssquery-yui.html) 21:16:13 INFO - PROCESS | 11809 | RSS: Main: 176726016 21:16:13 INFO - PROCESS | 11809 | 21:19:16 INFO - PROCESS | 11809 | Cycle 1(1): loaded http://localhost:58224/tests/dromaeo/cssquery-yui.html (next: http://localhost:58224/tests/dromaeo/cssquery-dojo.html) 21:19:16 INFO - PROCESS | 11809 | RSS: Main: 267100160 21:19:16 INFO - PROCESS | 11809 | 21:19:16 INFO - PROCESS | 11809 | __start_tp_report 21:19:16 INFO - PROCESS | 11809 | _x_x_mozilla_page_load 21:19:16 INFO - PROCESS | 11809 | _x_x_mozilla_page_load_details 21:19:16 INFO - PROCESS | 11809 | |i|pagename|runs| 21:19:16 INFO - PROCESS | 11809 | |0;dojo.html;3108.9689103108967;3133.592632957715;3156.558081868539;3171.286460546376;3200.1359632899116;5530.446955304467;5595.832125036245;5610.747516361764;5612.719364031797;5620.606557540974;5535.972320138404;5560.36055853577;5562.137868630369;5583.58123140764;5597.692126933017;4993.475685053062;5009.924851127236;5044.445111037783;5084.872878178038;5120.206368012964;4955.677880937727;5054.772535235905;5109.386873575176;5112.795488180487;5115.872103197431;4938.580220681247;5038.84883453497;5059.392872855263;5079.492050794909;5082.110630639641;5087.949120508803;5118.104331741967;5118.692878427306;5178.6116041297055;5204.453532379083;5025.824096156617;5106.64253502255;5158.819441319573;5173.767180476888;5200.765965531522;5336.06618841705;5360.839174824761;5480.150576660624;5545.057340252127;5548.944510554883;5950.523958083386;5967.761289548413;5971.134185543072;5975.9701201494145;5981.282246130492;6001.879962400728;6016.127661489103;6026.9095963560585;6027.035674292092;6029.427204415618;5384.057789886754;5439.401665816757;5524.06090964533;5598.776048958078;5616.550675945915;6081.27024757032;6105.053716673922;6106.969465152646;6109.75560977556;6135.601185922901;5835.591508594358;5837.387074357216;5839.941600583939;5841.182234487175;5844.503217226498;5774.191613174159;5782.681952492653;5871.031279838779;5913.881722365529;5919.526437885045;5960.940390596125;5962.642241465526;5962.701864906738;5983.820485385445;5996.1005849122985;5956.404359564096;5957.553183511254;5968.791092311835;5984.371640977634;5996.1005849122985;4455.420795296591;4499.167653984024;4639.37368455261;4641.512641172696;4653.837115700934;4057.087155390014;4087.509498860156;4095.959040409558;4121.464209652726;4176.644985176234;5755.712214389264;5759.481646651738;5762.366139724627;5762.88474230513;5764.481196692318;5701.059325211294;6053.878922421527;6086.056661217518;6098.390160983866;6099.146119543268;5460.808871689472;5660.037793575019;5709.9714501427225;5737.340205876294;5794.246747922743;5212.9739351303;5239.633225674166;5250.291210686585;5253.264542963988;5268.157094864803;6252.937470625327;6275.96862015687;6292.937070629235;6311.779087731908;6340.524460665376;5792.362840087671;5860.472557469848;5869.911951320648;5913.231279933581;5917.023691090922;6204.906926396198;6240.906386404298;6250.0937364082865;6259.624422534663;6270.15352927349;5878.1333439604605;5886.793962211302;5888.440598143169;5893.675847828411;5906.055031194988;5715.914261286167;5724.141378793214;5913.319968203539;5936.851578710567;5957.523398128226;5900.557458190567;5906.645601263938;5915.70421478933;5924.229850119629;5952.494038006645;5882.117682347682;5893.44012318829;5894.086416605433;5894.292684877671;5912.70436478183;5514.834554963358;5525.806596769094;5575.498205161555;5779.479846813807;5781.046127388934;5720.799772007959;5765.91351129725;5802.071668533014;5820;5827.9417205829095;5682.971585142213;5683.516901063291;5684.914726279192;5689.630174038674;5692.6299790513485 21:19:16 INFO - PROCESS | 11809 | |1;ext.html;573.2261447046487;589.7788329376484;621.2079598511897;621.8538643418799;625.0904933322014;34085.65914340856;37164;44051.33922991154;44822.327665084966;44835.32747008789;47191.292130618065;47659.28511072328;47703.761481192545;47731.761341193334;47806.76096619521;8386.203310685476;9237.076292370743;9338.906610933871;9373.203277721403;9399.81200375992;8423.789405264855;8697.52163631;8704.390692651517;10773.245872788908;11142.49858756354;11284.435778211098;11298.265612735187;11358.31850088993;11365.431728413587;11373.715657108556;11142.610008649699;11242.66272011841;11243.269187502869;11250.437478126101;11251.381174035425;10963.397013164273;11033.668989930315;11036.834447483294;11046.668599942015;11047.889521104848;44467;44629.553704462865;44743.32885006727;44800.77599611981;44815;3606.549181352331;3748.5126933498746;3779.4897688811934;3818.0264032671766;4104.548499665035;32632.347353052806;32689.346213075605;32722.509162362585;32863.835680821685;32910.34179316424;4630.861074167747;4722.173619616553;4733.644976626732;4764.285357196413;4775.21209000518;393196.0340198309;400607;402792;403004;410655;63951.360486394544;64233.357666423675;64274.67862660657;64326.35673643203;64417.35582644207;38942.80528597339;39694.603053969666;39987.40018899661;42361;42732.359014614805;17527.91236043837;17677;17693.823061769475;17699.115044247737;17699.38052168168;13432.865671343357;13502.459901604023;13508.459661613622;13513.391897364641;13529.66175845592;18189.363372281907;18521.722174167397;19511;19802.900985495267;19938.70091948622;7368.815779605446;7481.8877716834295;7510.737124200627;7687.115981662068;7736.922630773733;955.7849483866214;982.6855406269925;1048.6696690542456;1053.5522402978856;1080.2006515178712;32618;33249.66750332466;33256.501152482735;33312.1671958203;33353.83323083369;1136.8010598145293;1141.9771604568027;1146.1432479383286;1156.843826083468;1166.2477701882237;14394.424223030961;16484.752728709078;17382.724908063443;18625.81374186268;18785.436436906915;552342;553696;555617;557575;558134;58755.706221469474;58804.117938230964;59195.704021479614;59514.80970380568;59541;1298.5455090718174;1335.626024713082;1349.8650134986424;1393.087527669358;1411.3155119766905;25063.624045639695;30194.396112078073;30204.09387718372;32934.34131317408;33038.83480582582;56674.149887752545;57588.42411575998;57651;57651.42348576461;57826.421735783784;519263;524270;524448;524701;524845;30042.24894377658;30456.543151852296;48164.27753583629;48280.62161759651;51984.220236697234;47980.760096199294;52359.73820130875;52584;52723.736381317845;52787;42870.35694464523;44413.77793111014;44577;44936.32595511135;45505.77247113743;44472.555274446844;45287.32069019033;45806.54193458023;46019.539804601525;46496.07007859892;44080.559194407644;47045.294320585905;48686.5131348682;48811.26783098185;48850.75574622104;37738.811305943294;40262.597374025885;40569.59430405658;40905;41294.793526033376;29372.706272936997;29403.558946616246;30032.84983575068;30121.548176777804;30395.84802076064 21:19:16 INFO - PROCESS | 11809 | |2;jquery.html;392.14903659059837;408.83033541080454;420.7034041001095;426.0796679172987;431.6546762589927;14416.423343066277;16373.263203155857;20003.399898003066;20086.196552137935;20796.272130475398;17809.198586063627;18040.63918721625;18116.547086322847;18194.72707909379;18531;4759.238521836507;5740.196372507852;5903.409659034105;5935.673537955411;5943.3462319144855;4340.197063543254;4554.476235232957;5827.737751801179;5923.200367950315;6197.349278325756;6560.475161987053;6587.80236592903;6595.835104122388;6596.571222870498;6599.505037122211;6310.274318453367;6437.4528165105785;6458.095866578683;6474.805755827333;6479.22249330081;5553.250311208016;5716.485516303511;5722.685252311121;5725.198472213893;5763.366029736768;20275.594488110302;20347.491312717153;20364.490887727778;24317.87841060801;25116.623250651253;2417.5648383291;2598.7141414444395;2614.6993095793846;2746.8489233092173;2872.8563571821323;11415.143864210135;11477.540898364055;12455.065870059781;15137.318820652987;15264.771028434583;1982.4944639117077;1996.3012945469115;2005.7492813398326;2019.0813180003063;2089.4751992694273;80681.59659201725;81658;81724;85453;87931;11794.410279485992;11863.288202707865;12064.09519286057;12073.396330183632;12267.57063502773;17118.058506782247;17125.57186070358;17131.143442827808;17132.828671713374;17141.314347425963;8524.65901363951;8551.664850708228;8587.441816281922;8675.392722509363;8803.823923521493;7965.681372745141;7999.720009799629;8036.758897233092;8110.270075693216;8169.591520423955;5094.465081166498;5166.45752196014;5171.7672704728375;5202.115640341151;5290.6296559241255;1826.1782198010949;1906.075553356621;2033.5627840014172;2136.626090434168;2187.0704950396334;1011.3577878047346;1019.8572199892021;1020.1940467031111;1058.7459009837737;1087.7117563845586;19057;19401.32095376655;19476.123574439185;19839.900800495907;20434.795652043587;1030.896910308963;1034.3380236648552;1041.317936751429;1041.3595638682157;1074.6561100447939;10760.784784304271;11085.279456835442;11223.551057957753;11336.546538138547;11441.485133169028;499125;503454;503694;505999;518337;90116.09883901208;91144.08855911488;91649;91863.54068229749;92130.53934730284;499.69768290183913;519.7687029272013;528.6326003427581;1066.9946650266854;1099.5217080569978;11167.218294719292;11702.2978621283;11805.291682499077;11973.940130299292;12358.876411236131;39878.40182397325;41150;41706.95732606709;42131.368029480196;43111.35332970071;57809.71095144498;58541.70729146327;58659;58877;58918.116228257466;8717.134636372706;8832.38173327861;8911.331650126136;9038.864417033881;9310.627574897198;12476.5009399623;13873.306334683024;13974.161550307013;14076.507322243673;14150.080244784056;12567.748645026866;12617.68455788576;12767.680807979503;12825.294608796607;12881.8067728986;12183.634490965285;12218.694532636755;12392.938035309766;12464.626061218178;12611.810822837848;12247.877521224673;12415.31715755606;12472.87527124717;12482.063845211464;12779.105462617528;9000;9096.545172741204;9352.719418417459;9597.136257736558;9619.18236949867;11808.586699465477;11927;11958.043356531283;12061.396930153282;12551.87448125507 21:19:16 INFO - PROCESS | 11809 | |3;mootools.html;1516.1812621184565;1567.396552327354;1696.4740930311605;1780.2611916054839;1820.644974230025;9063.365564410495;9822.508874556279;9845.310828242025;9849.359791613559;9850.113489785917;8390.62242199101;8597.226249637532;9075.273978081754;9346.205572526327;9660.323777335572;2362.70466191726;2396.95206095878;2403.0868270057354;2403.267003563912;2405.9759402405925;2460.963085553718;2486.552420564298;2532.4048848520583;2534.214393538;2536.492701459706;2206.3160420269687;2277.7836105569945;2280.612295909691;2461.4092617771694;2545;2539.733328000561;2553.4254792671686;2555.080171138389;2556.8593727345174;2559.5648739714293;2506.5989441689426;2519.48350588129;2565.9101931432497;2568.345072006626;2573.4981678572685;9485.715428537154;9670.613175473043;9675.854862177073;9683.225341972626;9712;5648.54811615074;5816.912746308809;5817.331006934172;5831.241938547962;5835.766569337221;3669.5779985301765;3679.2089700714473;3723.8882833514767;3807.257584770971;3807.2956503047026;1113.6325012745774;1130.9038731707815;1131.4399372310759;1147.9540818367254;1158.846947287446;13390.196588204739;13401.53094641683;13447.125936814173;13505.594832155051;13580.728385432236;5027.622928280393;5069.974650126799;5120.1039818031695;5219.634625576173;5222.294990176353;11326.207165498336;11328.2070255083;11345.035671967975;11377.032952199155;11391.031762300132;5699.772009119672;5705.144228365695;5705.2012718219485;5711.7144142792695;5714.457126572969;5085.974570127126;5237.188235823453;5251.737413129328;5260.263563101169;5304.416514183436;4192.622663960197;4248.808803603845;4261.680373971964;4282.164977829293;4341.196878577473;1391.5964370332692;1432.6131944375168;1441.7116576684496;1450.833154187282;1456.9927150364392;1017.6234793126442;1042.4891803016467;1046.1160319529986;1062.5218651606808;1063.3938654966748;6505.804825855232;6598.406143447113;6657.933420665731;6673.499487538454;6774.898376524356;1025.205465764024;1061.1404762142688;1087.9673609791719;1117.2402766118955;1124.6176300058019;4496.303073023687;4499.505054444008;4508.616767574727;4528.841490547881;4561.201789686792;11297.26567773092;11670.533178672758;11749;11755.471003804849;12080.87919120815;11896.881031189578;11917.404129793476;12016.038716902627;12023;12029.578964736193;8707.172818582225;8938.955305223562;8988.59551320192;8998.59506322217;9004.324675649352;6582.341765823379;6670.966645166744;6758.391744742997;6788.25329213796;6802.761903333359;10975.835362469728;11211.60759373418;11214.327140371604;11226.831597526207;11257.943710281395;10851.348919064565;11063.336199828036;11157.27477713946;11239.325640461599;11369.147313951653;8365;8547.91452085496;8558.78603034929;8637.784055398666;8706.085860984505;9442.905570944202;9520.190783783455;9535.809283814424;9548.092931171528;9571.521423928914;7878.212178782076;8011.919880801117;8064.677412903653;8094.109647938604;8305.044919834054;8147.633356498854;8176.305014073632;8197.672093116209;8303.335733141213;8337.958310208653;7423.146338171179;7626.313631773167;7685.423593230642;7761.340286075747;7825.686972521035;5314.813981510629;5332.9466705334;5349.4650534946195;5357.383900851452;5551.08407112838;5406.189071639285;5443.591730620298;5637.718114094361;5695.544356451557;5708.400617935057 21:19:16 INFO - PROCESS | 11809 | |4;prototype.html;325.14649046253584;340.2242886219419;349.6870301080533;352.86767462201664;365.4682437054085;5289.603279754019;5293.6294459387855;5423.674579525222;5493.807716729915;5521.751521181546;5375.569954403648;5445.891082178354;5459.781608735646;5490.149026900826;5499.642523235987;4325.589069038437;4332.956670433295;4337.826486940518;4346.239408103585;4355.912881742363;4134.8139333729905;4251.829926802924;4322.092360604277;4323.286657701476;4342.305231162999;4162.980069882883;4247.745135291877;4258.957410425903;4260.403543503897;4272;4232.174725928445;4233.682473814476;4246.851360202378;4253.851115210984;4255.5957184067465;3761.868334608303;3808.1050953026015;3810.637989391031;3821.5796262411113;3841.481400010991;5298.576113910878;5314.183482754146;5320.973395133038;5353.946460535384;5374.763804324988;4909.612367466437;4910.607151427877;4918.8278410255825;4921;4923.606111511071;5436.2661040759385;5619.887602247933;5680.289963754531;5695.5443564514735;5696.344920334173;4156.293430116887;4162.895927601804;4165.166966606691;4181.59916427997;4203.642690371322;5967.4629283364275;5977.133315669247;5981.58128930975;5992.700364981777;6004.3395226525045;4018.618231268025;4225.408442818008;4323.6757243206885;4340.525900236835;4346.826126954949;4227.133437645275;4243.7029407941145;4246.851360202378;4249.213895429355;4254.106637606075;4607.8848028798875;4639.350490931272;4711.8350857719815;4815.614750819926;4840.443349014838;5738.254026976467;5747.741351639186;5748.31020277561;5748.798792042258;5749.8275051748515;1442.4879167895456;1455.2796365798786;1464.326409851459;1471.9705605887823;1472.6451664468714;937.929655275857;952.7570469530225;953.8187744328555;954.8138113067885;964.5466630683568;4974.90050198994;4989.925151122736;5015.974920125449;5057.721825299644;5095.363079615048;5217.713025783542;5231.875146843447;5238.568737476959;5249.475052494797;5265.736713164327;4715.386999690087;4982.676126051795;4996.425411077773;5010.924836127461;5029.798808047711;2775.514285000117;2778.791225816776;2786.1889771648184;2790.9023184188864;2804.971950280512;5168.870778230575;5393.7303134843105;5439.755211015514;5448.575383954102;5530.198121272393;5308.840734777963;5309.5752339812725;5320.521153096162;5323.813666521731;5334.706076387113;5266.9714913924645;5348.331458567679;5444.210589464506;5448.891022179613;5451.509364157245;4816.518348165296;5141.709306044209;5256;5261.57907367402;5280.7359632019015;5041.495850415075;5085.3134826797905;5092.6435149539175;5107.208382700687;5127.435982042047;5337.144627624358;5371.502251453093;5399.974004939049;5428.565714742732;5445.972770136124;3835.6356146166067;3851.6533511984057;3858.7491813033184;3889.2610404023144;4185.660588611737;5651.276360709859;5799.159121927212;5836.328822185503;5902.4097590240635;5903.586748927534;5761.942380576141;5775.971120144541;5778.508826749773;5782.913256301243;5783.768649253982;5655.095184770417;5741.598088133791;5772.884542309046;5778.561755755319;5787.334456537384;5681.147827825859;5686.744096515584;5691.516221121085;5698.116791897262;5722.141678748221;5773.921388300292;5802.013657678121;5834.883302333845;5836.153757705194;5844.649321040752;5495.752691128829;5636.830895073154;5683.2666036859155;5692.0608099663095;5733.885322293614 21:19:16 INFO - PROCESS | 11809 | |5;yui.html;829.8962629671291;858.8325276571071;865.7532603208086;880.2825697056899;897.2104547997761;16278.674426511478;16975.83024169758;17118.65762684747;17163.399281025166;17315.047672378016;16119.27463264153;16248.51254462365;16262.918685406587;16275;16285.51143465695;721.383217349168;742.7660287009602;744.7430636430423;748.5209465941801;857.6012154348227;878.9692360767374;885.5882014863088;886.3706768194589;886.6231851463135;886.7517095213351;919.7056941778634;934.6822080492631;934.8831396075491;935.0929598289648;935.4247138010143;926.3006430145231;926.7822061815468;927.4249965021729;928.0719280719314;928.1090153452693;553.8255449533384;571.911353740171;650.905618685288;684.3703792510852;684.5721424109931;15723.528294151194;15794.684106317924;16510.257038433298;16584.336626534925;16589.83410165895;15424.228788560527;15426.614334641612;15645.608859778482;15829.683406331924;16288.51134465956;14352.06711563745;14577.344019519041;14601.196934168616;14627.70744585113;14972.1016738996;4858.271259311096;4873.926891096601;4879.414470263556;5113.258577506278;5134.152864777345;86984.56507717485;87001.56499217464;87797.56101219518;90712.09287907169;90807.09192908119;12704.3012634306;12893.097483176087;13157.473701052042;13181.143225690299;13435.664108397174;24387.634185487233;24476.388090297885;24476.75523244745;24479;24485.755142448346;8862.778430539289;9008.234300084436;9023.684171053981;9335.859962100574;9376.390534615228;4706.411698537683;4773.641976851681;4905.460399356068;5061.924071138936;5132.101882170605;3691.53855768029;3758.098056466483;3815.8664446744233;3817.255635151119;3818.4463252828186;625.9593126446857;626.5488848029503;633.556510442692;633.8161933039366;642.0305338938236;610.8503416662946;698.3679769808332;711.6797441151502;728.6283995162505;731.3235257386896;9667.903320966841;9758.316917815826;9970.133259245318;10020.34867733595;10084.34451760648;633.654658211276;673.599208470959;730.5580124024995;731.8938753880658;741.1995045351008;4629.236176030984;4758.881027974328;4960.826371076995;4978.477259887732;5018.698878067327;128301.3584932088;128981;129592.3520382392;130989;133700;67096.32903670998;99262;106201.41131443533;106949;110912.4454377723;81931.5903420491;91627;93873.86668528544;95181;95630.52184739032;9213.585388657393;9306.488143152192;9348.298877584344;9401.153896149379;9461.810763784824;56609.433905660415;56661.43338566727;58881.70559147177;58890.705546471996;59313.703431482565;80304.59847700724;80316.59841700754;82928.58535707524;83795.16204837874;86297.13702862892;11677.416129193676;11743.88256117428;12008;12767.93616031951;13163.934180329037;14066.156030638194;14728.705425891636;14790.926045369704;15884.68230635404;16887.408940687015;14852.405903763729;15279.312430940412;16064.919675401548;16595.751063734297;16617.41839035628;13826.101303415246;13869.930650346683;14158.646033849236;14879.181645009628;15098.169600671628;14734.484293049692;15128.167950762814;15537.76693349578;16209.108499032194;16251.674966500368;12020.63938081859;12131.332776697367;12586;12942.547010854574;13226.867731322563;10437.739056523647;11603.941980290045;11893.881061189624;12373.690657733629;12770.23378597287 21:19:16 INFO - PROCESS | 11809 | __end_tp_report 21:19:16 INFO - PROCESS | 11809 | __start_cc_report 21:19:16 INFO - PROCESS | 11809 | _x_x_mozilla_cycle_collect,783 21:19:16 INFO - PROCESS | 11809 | __end_cc_report 21:19:16 INFO - PROCESS | 11809 | __startTimestamp1475468356581__endTimestamp 21:19:16 INFO - PROCESS | 11809 | 21:19:16 INFO - PROCESS | 11809 | ------- Summary: start ------- 21:19:16 INFO - PROCESS | 11809 | Number of tests: 6 21:19:16 INFO - PROCESS | 11809 | 21:19:16 INFO - PROCESS | 11809 | [#0] dojo.html Cycles:165 Average:5542.42 Median:5759.48 stddev:635.84 (11.0%) stddev-sans-first:608.46 21:19:16 INFO - PROCESS | 11809 | Values: 3109.0 3133.6 3156.6 3171.3 3200.1 5530.4 5595.8 5610.7 5612.7 5620.6 5536.0 5560.4 5562.1 5583.6 5597.7 4993.5 5009.9 5044.4 5084.9 5120.2 4955.7 5054.8 5109.4 5112.8 5115.9 4938.6 5038.8 5059.4 5079.5 5082.1 5087.9 5118.1 5118.7 5178.6 5204.5 5025.8 5106.6 5158.8 5173.8 5200.8 5336.1 5360.8 5480.2 5545.1 5548.9 5950.5 5967.8 5971.1 5976.0 5981.3 6001.9 6016.1 6026.9 6027.0 6029.4 5384.1 5439.4 5524.1 5598.8 5616.6 6081.3 6105.1 6107.0 6109.8 6135.6 5835.6 5837.4 5839.9 5841.2 5844.5 5774.2 5782.7 5871.0 5913.9 5919.5 5960.9 5962.6 5962.7 5983.8 5996.1 5956.4 5957.6 5968.8 5984.4 5996.1 4455.4 4499.2 4639.4 4641.5 4653.8 4057.1 4087.5 4096.0 4121.5 4176.6 5755.7 5759.5 5762.4 5762.9 5764.5 5701.1 6053.9 6086.1 6098.4 6099.1 5460.8 5660.0 5710.0 5737.3 5794.2 5213.0 5239.6 5250.3 5253.3 5268.2 6252.9 6276.0 6292.9 6311.8 6340.5 5792.4 5860.5 5869.9 5913.2 5917.0 6204.9 6240.9 6250.1 6259.6 6270.2 5878.1 5886.8 5888.4 5893.7 5906.1 5715.9 5724.1 5913.3 5936.9 5957.5 5900.6 5906.6 5915.7 5924.2 5952.5 5882.1 5893.4 5894.1 5894.3 5912.7 5514.8 5525.8 5575.5 5779.5 5781.0 5720.8 5765.9 5802.1 5820.0 5827.9 5683.0 5683.5 5684.9 5689.6 5692.6 21:19:16 INFO - PROCESS | 11809 | 21:19:16 INFO - PROCESS | 11809 | [#1] ext.html Cycles:180 Average:65922.97 Median:225974.90 stddev:132091.75 (58.5%) stddev-sans-first:132371.17 21:19:16 INFO - PROCESS | 11809 | Values: 573.2 589.8 621.2 621.9 625.1 34085.7 37164.0 44051.3 44822.3 44835.3 47191.3 47659.3 47703.8 47731.8 47806.8 8386.2 9237.1 9338.9 9373.2 9399.8 8423.8 8697.5 8704.4 10773.2 11142.5 11284.4 11298.3 11358.3 11365.4 11373.7 11142.6 11242.7 11243.3 11250.4 11251.4 10963.4 11033.7 11036.8 11046.7 11047.9 44467.0 44629.6 44743.3 44800.8 44815.0 3606.5 3748.5 3779.5 3818.0 4104.5 32632.3 32689.3 32722.5 32863.8 32910.3 4630.9 4722.2 4733.6 4764.3 4775.2 393196.0 400607.0 402792.0 403004.0 410655.0 63951.4 64233.4 64274.7 64326.4 64417.4 38942.8 39694.6 39987.4 42361.0 42732.4 17527.9 17677.0 17693.8 17699.1 17699.4 13432.9 13502.5 13508.5 13513.4 13529.7 18189.4 18521.7 19511.0 19802.9 19938.7 7368.8 7481.9 7510.7 7687.1 7736.9 955.8 982.7 1048.7 1053.6 1080.2 32618.0 33249.7 33256.5 33312.2 33353.8 1136.8 1142.0 1146.1 1156.8 1166.2 14394.4 16484.8 17382.7 18625.8 18785.4 552342.0 553696.0 555617.0 557575.0 558134.0 58755.7 58804.1 59195.7 59514.8 59541.0 1298.5 1335.6 1349.9 1393.1 1411.3 25063.6 30194.4 30204.1 32934.3 33038.8 56674.1 57588.4 57651.0 57651.4 57826.4 519263.0 524270.0 524448.0 524701.0 524845.0 30042.2 30456.5 48164.3 48280.6 51984.2 47980.8 52359.7 52584.0 52723.7 52787.0 42870.4 44413.8 44577.0 44936.3 45505.8 44472.6 45287.3 45806.5 46019.5 46496.1 44080.6 47045.3 48686.5 48811.3 48850.8 37738.8 40262.6 40569.6 40905.0 41294.8 29372.7 29403.6 30032.8 30121.5 30395.8 21:19:16 INFO - PROCESS | 11809 | 21:19:16 INFO - PROCESS | 11809 | [#2] jquery.html Cycles:180 Average:29661.25 Median:13367.72 stddev:83362.05 (623.6%) stddev-sans-first:83566.94 21:19:16 INFO - PROCESS | 11809 | Values: 392.1 408.8 420.7 426.1 431.7 14416.4 16373.3 20003.4 20086.2 20796.3 17809.2 18040.6 18116.5 18194.7 18531.0 4759.2 5740.2 5903.4 5935.7 5943.3 4340.2 4554.5 5827.7 5923.2 6197.3 6560.5 6587.8 6595.8 6596.6 6599.5 6310.3 6437.5 6458.1 6474.8 6479.2 5553.3 5716.5 5722.7 5725.2 5763.4 20275.6 20347.5 20364.5 24317.9 25116.6 2417.6 2598.7 2614.7 2746.8 2872.9 11415.1 11477.5 12455.1 15137.3 15264.8 1982.5 1996.3 2005.7 2019.1 2089.5 80681.6 81658.0 81724.0 85453.0 87931.0 11794.4 11863.3 12064.1 12073.4 12267.6 17118.1 17125.6 17131.1 17132.8 17141.3 8524.7 8551.7 8587.4 8675.4 8803.8 7965.7 7999.7 8036.8 8110.3 8169.6 5094.5 5166.5 5171.8 5202.1 5290.6 1826.2 1906.1 2033.6 2136.6 2187.1 1011.4 1019.9 1020.2 1058.7 1087.7 19057.0 19401.3 19476.1 19839.9 20434.8 1030.9 1034.3 1041.3 1041.4 1074.7 10760.8 11085.3 11223.6 11336.5 11441.5 499125.0 503454.0 503694.0 505999.0 518337.0 90116.1 91144.1 91649.0 91863.5 92130.5 499.7 519.8 528.6 1067.0 1099.5 11167.2 11702.3 11805.3 11973.9 12358.9 39878.4 41150.0 41707.0 42131.4 43111.4 57809.7 58541.7 58659.0 58877.0 58918.1 8717.1 8832.4 8911.3 9038.9 9310.6 12476.5 13873.3 13974.2 14076.5 14150.1 12567.7 12617.7 12767.7 12825.3 12881.8 12183.6 12218.7 12392.9 12464.6 12611.8 12247.9 12415.3 12472.9 12482.1 12779.1 9000.0 9096.5 9352.7 9597.1 9619.2 11808.6 11927.0 11958.0 12061.4 12551.9 21:19:16 INFO - PROCESS | 11809 | 21:19:16 INFO - PROCESS | 11809 | [#3] mootools.html Cycles:180 Average:6321.75 Median:4497.90 stddev:3607.15 (80.2%) stddev-sans-first:3599.19 21:19:16 INFO - PROCESS | 11809 | Values: 1516.2 1567.4 1696.5 1780.3 1820.6 9063.4 9822.5 9845.3 9849.4 9850.1 8390.6 8597.2 9075.3 9346.2 9660.3 2362.7 2397.0 2403.1 2403.3 2406.0 2461.0 2486.6 2532.4 2534.2 2536.5 2206.3 2277.8 2280.6 2461.4 2545.0 2539.7 2553.4 2555.1 2556.9 2559.6 2506.6 2519.5 2565.9 2568.3 2573.5 9485.7 9670.6 9675.9 9683.2 9712.0 5648.5 5816.9 5817.3 5831.2 5835.8 3669.6 3679.2 3723.9 3807.3 3807.3 1113.6 1130.9 1131.4 1148.0 1158.8 13390.2 13401.5 13447.1 13505.6 13580.7 5027.6 5070.0 5120.1 5219.6 5222.3 11326.2 11328.2 11345.0 11377.0 11391.0 5699.8 5705.1 5705.2 5711.7 5714.5 5086.0 5237.2 5251.7 5260.3 5304.4 4192.6 4248.8 4261.7 4282.2 4341.2 1391.6 1432.6 1441.7 1450.8 1457.0 1017.6 1042.5 1046.1 1062.5 1063.4 6505.8 6598.4 6657.9 6673.5 6774.9 1025.2 1061.1 1088.0 1117.2 1124.6 4496.3 4499.5 4508.6 4528.8 4561.2 11297.3 11670.5 11749.0 11755.5 12080.9 11896.9 11917.4 12016.0 12023.0 12029.6 8707.2 8939.0 8988.6 8998.6 9004.3 6582.3 6671.0 6758.4 6788.3 6802.8 10975.8 11211.6 11214.3 11226.8 11257.9 10851.3 11063.3 11157.3 11239.3 11369.1 8365.0 8547.9 8558.8 8637.8 8706.1 9442.9 9520.2 9535.8 9548.1 9571.5 7878.2 8011.9 8064.7 8094.1 8305.0 8147.6 8176.3 8197.7 8303.3 8338.0 7423.1 7626.3 7685.4 7761.3 7825.7 5314.8 5332.9 5349.5 5357.4 5551.1 5406.2 5443.6 5637.7 5695.5 5708.4 21:19:16 INFO - PROCESS | 11809 | 21:19:16 INFO - PROCESS | 11809 | [#4] prototype.html Cycles:180 Average:4658.42 Median:5244.02 stddev:1341.88 (25.6%) stddev-sans-first:1305.64 21:19:16 INFO - PROCESS | 11809 | Values: 325.1 340.2 349.7 352.9 365.5 5289.6 5293.6 5423.7 5493.8 5521.8 5375.6 5445.9 5459.8 5490.1 5499.6 4325.6 4333.0 4337.8 4346.2 4355.9 4134.8 4251.8 4322.1 4323.3 4342.3 4163.0 4247.7 4259.0 4260.4 4272.0 4232.2 4233.7 4246.9 4253.9 4255.6 3761.9 3808.1 3810.6 3821.6 3841.5 5298.6 5314.2 5321.0 5353.9 5374.8 4909.6 4910.6 4918.8 4921.0 4923.6 5436.3 5619.9 5680.3 5695.5 5696.3 4156.3 4162.9 4165.2 4181.6 4203.6 5967.5 5977.1 5981.6 5992.7 6004.3 4018.6 4225.4 4323.7 4340.5 4346.8 4227.1 4243.7 4246.9 4249.2 4254.1 4607.9 4639.4 4711.8 4815.6 4840.4 5738.3 5747.7 5748.3 5748.8 5749.8 1442.5 1455.3 1464.3 1472.0 1472.6 937.9 952.8 953.8 954.8 964.5 4974.9 4989.9 5016.0 5057.7 5095.4 5217.7 5231.9 5238.6 5249.5 5265.7 4715.4 4982.7 4996.4 5010.9 5029.8 2775.5 2778.8 2786.2 2790.9 2805.0 5168.9 5393.7 5439.8 5448.6 5530.2 5308.8 5309.6 5320.5 5323.8 5334.7 5267.0 5348.3 5444.2 5448.9 5451.5 4816.5 5141.7 5256.0 5261.6 5280.7 5041.5 5085.3 5092.6 5107.2 5127.4 5337.1 5371.5 5400.0 5428.6 5446.0 3835.6 3851.7 3858.7 3889.3 4185.7 5651.3 5799.2 5836.3 5902.4 5903.6 5761.9 5776.0 5778.5 5782.9 5783.8 5655.1 5741.6 5772.9 5778.6 5787.3 5681.1 5686.7 5691.5 5698.1 5722.1 5773.9 5802.0 5834.9 5836.2 5844.6 5495.8 5636.8 5683.3 5692.1 5733.9 21:19:16 INFO - PROCESS | 11809 | 21:19:16 INFO - PROCESS | 11809 | [#5] yui.html Cycles:180 Average:22737.22 Median:4876.67 stddev:32816.44 (672.9%) stddev-sans-first:32867.28 21:19:16 INFO - PROCESS | 11809 | Values: 829.9 858.8 865.8 880.3 897.2 16278.7 16975.8 17118.7 17163.4 17315.0 16119.3 16248.5 16262.9 16275.0 16285.5 721.4 742.8 744.7 748.5 857.6 879.0 885.6 886.4 886.6 886.8 919.7 934.7 934.9 935.1 935.4 926.3 926.8 927.4 928.1 928.1 553.8 571.9 650.9 684.4 684.6 15723.5 15794.7 16510.3 16584.3 16589.8 15424.2 15426.6 15645.6 15829.7 16288.5 14352.1 14577.3 14601.2 14627.7 14972.1 4858.3 4873.9 4879.4 5113.3 5134.2 86984.6 87001.6 87797.6 90712.1 90807.1 12704.3 12893.1 13157.5 13181.1 13435.7 24387.6 24476.4 24476.8 24479.0 24485.8 8862.8 9008.2 9023.7 9335.9 9376.4 4706.4 4773.6 4905.5 5061.9 5132.1 3691.5 3758.1 3815.9 3817.3 3818.4 626.0 626.5 633.6 633.8 642.0 610.9 698.4 711.7 728.6 731.3 9667.9 9758.3 9970.1 10020.3 10084.3 633.7 673.6 730.6 731.9 741.2 4629.2 4758.9 4960.8 4978.5 5018.7 128301.4 128981.0 129592.4 130989.0 133700.0 67096.3 99262.0 106201.4 106949.0 110912.4 81931.6 91627.0 93873.9 95181.0 95630.5 9213.6 9306.5 9348.3 9401.2 9461.8 56609.4 56661.4 58881.7 58890.7 59313.7 80304.6 80316.6 82928.6 83795.2 86297.1 11677.4 11743.9 12008.0 12767.9 13163.9 14066.2 14728.7 14790.9 15884.7 16887.4 14852.4 15279.3 16064.9 16595.8 16617.4 13826.1 13869.9 14158.6 14879.2 15098.2 14734.5 15128.2 15537.8 16209.1 16251.7 12020.6 12131.3 12586.0 12942.5 13226.9 10437.7 11603.9 11893.9 12373.7 12770.2 21:19:16 INFO - PROCESS | 11809 | -------- Summary: end -------- 21:19:16 INFO - PROCESS | 11809 | 21:19:17 INFO - TEST-INFO | 11809: exit 0 21:19:17 INFO - TEST-OK | dromaeo_css | took 1113575ms 21:19:17 INFO - TEST-START | kraken 21:19:17 INFO - operating with platform_type : linux_ 21:19:17 INFO - Initialising browser for kraken test... 21:19:17 INFO - TEST-INFO | started process 12133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx7Wkh9/profile http://localhost:58224/getInfo.html) 21:19:21 INFO - PROCESS | 12133 | __metrics Screen width/height:1600/1200 21:19:21 INFO - PROCESS | 12133 | colorDepth:24 21:19:21 INFO - PROCESS | 12133 | Browser inner width/height: 1024/697 21:19:21 INFO - PROCESS | 12133 | __metrics 21:19:21 INFO - PROCESS | 12133 | 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" 21:19:21 INFO - PROCESS | 12133 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:19:22 INFO - PROCESS | 12133 | console.error: PushService: 21:19:22 INFO - PROCESS | 12133 | stateChangeProcessEnqueue: Error transitioning state 21:19:22 INFO - PROCESS | 12133 | UnknownError 21:19:22 INFO - TEST-INFO | 12133: exit 0 21:19:22 INFO - Browser initialized. 21:19:22 INFO - Running cycle 1/1 for kraken test... 21:19:22 INFO - TEST-INFO | started process 12223 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx7Wkh9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:19:34 INFO - PROCESS | 12223 | RSS: Main: 143728640 21:19:34 INFO - PROCESS | 12223 | 21:19:37 INFO - PROCESS | 12223 | Cycle 1(1): loaded http://localhost:58224/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58224/tests/kraken/driver.html?testName=audio-beat-detection) 21:19:38 INFO - PROCESS | 12223 | RSS: Main: 185589760 21:19:38 INFO - PROCESS | 12223 | 21:19:40 INFO - PROCESS | 12223 | Cycle 1(1): loaded http://localhost:58224/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58224/tests/kraken/driver.html?testName=audio-dft) 21:19:41 INFO - PROCESS | 12223 | RSS: Main: 174764032 21:19:41 INFO - PROCESS | 12223 | 21:19:43 INFO - PROCESS | 12223 | Cycle 1(1): loaded http://localhost:58224/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58224/tests/kraken/driver.html?testName=audio-fft) 21:19:44 INFO - PROCESS | 12223 | RSS: Main: 265785344 21:19:44 INFO - PROCESS | 12223 | 21:19:46 INFO - PROCESS | 12223 | Cycle 1(1): loaded http://localhost:58224/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58224/tests/kraken/driver.html?testName=audio-oscillator) 21:19:47 INFO - PROCESS | 12223 | RSS: Main: 172355584 21:19:47 INFO - PROCESS | 12223 | 21:19:49 INFO - PROCESS | 12223 | Cycle 1(1): loaded http://localhost:58224/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58224/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:19:49 INFO - PROCESS | 12223 | RSS: Main: 173477888 21:19:49 INFO - PROCESS | 12223 | 21:19:52 INFO - PROCESS | 12223 | Cycle 1(1): loaded http://localhost:58224/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58224/tests/kraken/driver.html?testName=imaging-darkroom) 21:19:53 INFO - PROCESS | 12223 | RSS: Main: 210329600 21:19:53 INFO - PROCESS | 12223 | 21:19:56 INFO - PROCESS | 12223 | Cycle 1(1): loaded http://localhost:58224/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58224/tests/kraken/driver.html?testName=imaging-desaturate) 21:19:57 INFO - PROCESS | 12223 | RSS: Main: 209133568 21:19:57 INFO - PROCESS | 12223 | 21:20:00 INFO - PROCESS | 12223 | Cycle 1(1): loaded http://localhost:58224/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58224/tests/kraken/driver.html?testName=json-parse-financial) 21:20:00 INFO - PROCESS | 12223 | RSS: Main: 208789504 21:20:00 INFO - PROCESS | 12223 | 21:20:02 INFO - PROCESS | 12223 | Cycle 1(1): loaded http://localhost:58224/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58224/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:20:02 INFO - PROCESS | 12223 | RSS: Main: 171368448 21:20:02 INFO - PROCESS | 12223 | 21:20:04 INFO - PROCESS | 12223 | Cycle 1(1): loaded http://localhost:58224/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58224/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:20:05 INFO - PROCESS | 12223 | RSS: Main: 179433472 21:20:05 INFO - PROCESS | 12223 | 21:20:07 INFO - PROCESS | 12223 | Cycle 1(1): loaded http://localhost:58224/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58224/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:20:07 INFO - PROCESS | 12223 | RSS: Main: 182980608 21:20:07 INFO - PROCESS | 12223 | 21:20:10 INFO - PROCESS | 12223 | Cycle 1(1): loaded http://localhost:58224/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58224/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:20:10 INFO - PROCESS | 12223 | RSS: Main: 183578624 21:20:10 INFO - PROCESS | 12223 | 21:20:13 INFO - PROCESS | 12223 | Cycle 1(1): loaded http://localhost:58224/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58224/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:20:14 INFO - PROCESS | 12223 | RSS: Main: 181530624 21:20:14 INFO - PROCESS | 12223 | 21:20:15 INFO - PROCESS | 12223 | Cycle 1(1): loaded http://localhost:58224/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58224/tests/kraken/driver.html?testName=ai-astar) 21:20:16 INFO - PROCESS | 12223 | RSS: Main: 233795584 21:20:16 INFO - PROCESS | 12223 | 21:20:16 INFO - PROCESS | 12223 | __start_tp_report 21:20:16 INFO - PROCESS | 12223 | _x_x_mozilla_page_load 21:20:16 INFO - PROCESS | 12223 | _x_x_mozilla_page_load_details 21:20:16 INFO - PROCESS | 12223 | |i|pagename|runs| 21:20:16 INFO - PROCESS | 12223 | |0;ai-astar;110;112;110;110;111;110;111;111;109;110 21:20:16 INFO - PROCESS | 12223 | |1;audio-beat-detection;149;119;116;160;117;121;117;130;154;119 21:20:16 INFO - PROCESS | 12223 | |2;audio-dft;160;161;162;160;161;161;162;161;161;160 21:20:16 INFO - PROCESS | 12223 | |3;audio-fft;74;75;74;111;75;76;75;76;105;76 21:20:16 INFO - PROCESS | 12223 | |4;audio-oscillator;80;81;128;82;82;81;102;81;82;111 21:20:16 INFO - PROCESS | 12223 | |5;imaging-gaussian-blur;116;116;117;117;116;117;117;117;117;116 21:20:16 INFO - PROCESS | 12223 | |6;imaging-darkroom;145;146;145;146;146;145;145;146;145;145 21:20:16 INFO - PROCESS | 12223 | |7;imaging-desaturate;94;94;95;95;95;95;95;95;96;95 21:20:16 INFO - PROCESS | 12223 | |8;json-parse-financial;51;48;51;49;49;48;50;49;48;48 21:20:16 INFO - PROCESS | 12223 | |9;json-stringify-tinderbox;59;60;58;68;58;59;62;59;58;58 21:20:16 INFO - PROCESS | 12223 | |10;stanford-crypto-aes;73;87;73;74;73;73;74;81;73;79 21:20:16 INFO - PROCESS | 12223 | |11;stanford-crypto-ccm;127;122;118;127;134;117;125;120;155;125 21:20:16 INFO - PROCESS | 12223 | |12;stanford-crypto-pbkdf2;150;155;161;153;149;151;148;148;153;151 21:20:16 INFO - PROCESS | 12223 | |13;stanford-crypto-sha256-iterative;63;62;62;62;62;64;61;63;63;60 21:20:16 INFO - PROCESS | 12223 | __end_tp_report 21:20:16 INFO - PROCESS | 12223 | __start_cc_report 21:20:16 INFO - PROCESS | 12223 | _x_x_mozilla_cycle_collect,1631 21:20:16 INFO - PROCESS | 12223 | __end_cc_report 21:20:16 INFO - PROCESS | 12223 | __startTimestamp1475468416046__endTimestamp 21:20:16 INFO - PROCESS | 12223 | 21:20:16 INFO - PROCESS | 12223 | ------- Summary: start ------- 21:20:16 INFO - PROCESS | 12223 | Number of tests: 14 21:20:16 INFO - PROCESS | 12223 | 21:20:16 INFO - PROCESS | 12223 | [#0] ai-astar Cycles:10 Average:110.40 Median:110.50 stddev:0.84 (0.8%) stddev-sans-first:0.88 21:20:16 INFO - PROCESS | 12223 | Values: 110.0 112.0 110.0 110.0 111.0 110.0 111.0 111.0 109.0 110.0 21:20:16 INFO - PROCESS | 12223 | 21:20:16 INFO - PROCESS | 12223 | [#1] audio-beat-detection Cycles:10 Average:130.20 Median:125.50 stddev:17.30 (13.8%) stddev-sans-first:16.96 21:20:16 INFO - PROCESS | 12223 | Values: 149.0 119.0 116.0 160.0 117.0 121.0 117.0 130.0 154.0 119.0 21:20:16 INFO - PROCESS | 12223 | 21:20:16 INFO - PROCESS | 12223 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 21:20:16 INFO - PROCESS | 12223 | Values: 160.0 161.0 162.0 160.0 161.0 161.0 162.0 161.0 161.0 160.0 21:20:16 INFO - PROCESS | 12223 | 21:20:16 INFO - PROCESS | 12223 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.00 stddev:13.95 (18.6%) stddev-sans-first:14.52 21:20:16 INFO - PROCESS | 12223 | Values: 74.0 75.0 74.0 111.0 75.0 76.0 75.0 76.0 105.0 76.0 21:20:16 INFO - PROCESS | 12223 | 21:20:16 INFO - PROCESS | 12223 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:81.00 stddev:16.85 (20.8%) stddev-sans-first:17.39 21:20:16 INFO - PROCESS | 12223 | Values: 80.0 81.0 128.0 82.0 82.0 81.0 102.0 81.0 82.0 111.0 21:20:16 INFO - PROCESS | 12223 | 21:20:16 INFO - PROCESS | 12223 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 21:20:16 INFO - PROCESS | 12223 | Values: 116.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 21:20:16 INFO - PROCESS | 12223 | 21:20:16 INFO - PROCESS | 12223 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 21:20:16 INFO - PROCESS | 12223 | Values: 145.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 21:20:16 INFO - PROCESS | 12223 | 21:20:16 INFO - PROCESS | 12223 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 21:20:16 INFO - PROCESS | 12223 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 21:20:16 INFO - PROCESS | 12223 | 21:20:16 INFO - PROCESS | 12223 | [#8] json-parse-financial Cycles:10 Average:49.10 Median:49.00 stddev:1.20 (2.4%) stddev-sans-first:1.05 21:20:16 INFO - PROCESS | 12223 | Values: 51.0 48.0 51.0 49.0 49.0 48.0 50.0 49.0 48.0 48.0 21:20:16 INFO - PROCESS | 12223 | 21:20:16 INFO - PROCESS | 12223 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:59.00 stddev:3.11 (5.3%) stddev-sans-first:3.28 21:20:16 INFO - PROCESS | 12223 | Values: 59.0 60.0 58.0 68.0 58.0 59.0 62.0 59.0 58.0 58.0 21:20:16 INFO - PROCESS | 12223 | 21:20:16 INFO - PROCESS | 12223 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:74.00 stddev:4.81 (6.5%) stddev-sans-first:4.97 21:20:16 INFO - PROCESS | 12223 | Values: 73.0 87.0 73.0 74.0 73.0 73.0 74.0 81.0 73.0 79.0 21:20:16 INFO - PROCESS | 12223 | 21:20:16 INFO - PROCESS | 12223 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:126.00 stddev:11.04 (8.8%) stddev-sans-first:11.70 21:20:16 INFO - PROCESS | 12223 | Values: 127.0 122.0 118.0 127.0 134.0 117.0 125.0 120.0 155.0 125.0 21:20:16 INFO - PROCESS | 12223 | 21:20:16 INFO - PROCESS | 12223 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.90 Median:152.00 stddev:3.93 (2.6%) stddev-sans-first:4.11 21:20:16 INFO - PROCESS | 12223 | Values: 150.0 155.0 161.0 153.0 149.0 151.0 148.0 148.0 153.0 151.0 21:20:16 INFO - PROCESS | 12223 | 21:20:16 INFO - PROCESS | 12223 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.50 stddev:1.14 (1.8%) stddev-sans-first:1.17 21:20:16 INFO - PROCESS | 12223 | Values: 63.0 62.0 62.0 62.0 62.0 64.0 61.0 63.0 63.0 60.0 21:20:16 INFO - PROCESS | 12223 | -------- Summary: end -------- 21:20:16 INFO - PROCESS | 12223 | 21:20:17 INFO - TEST-INFO | 12223: exit 0 21:20:17 INFO - TEST-OK | kraken | took 59840ms 21:20:17 INFO - SUITE-END | took 1173s 21:20:17 INFO - Completed test suite (00:19:33) 21:20:17 INFO - javascript benchmark 21:20:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3108.9689103108967, 3133.592632957715, 3156.558081868539, 3171.286460546376, 3200.1359632899116, 5530.446955304467, 5595.832125036245, 5610.747516361764, 5612.719364031797, 5620.606557540974, 5535.972320138404, 5560.36055853577, 5562.137868630369, 5583.58123140764, 5597.692126933017, 4993.475685053062, 5009.924851127236, 5044.445111037783, 5084.872878178038, 5120.206368012964, 4955.677880937727, 5054.772535235905, 5109.386873575176, 5112.795488180487, 5115.872103197431, 4938.580220681247, 5038.84883453497, 5059.392872855263, 5079.492050794909, 5082.110630639641, 5087.949120508803, 5118.104331741967, 5118.692878427306, 5178.6116041297055, 5204.453532379083, 5025.824096156617, 5106.64253502255, 5158.819441319573, 5173.767180476888, 5200.765965531522, 5336.06618841705, 5360.839174824761, 5480.150576660624, 5545.057340252127, 5548.944510554883, 5950.523958083386, 5967.761289548413, 5971.134185543072, 5975.9701201494145, 5981.282246130492, 6001.879962400728, 6016.127661489103, 6026.9095963560585, 6027.035674292092, 6029.427204415618, 5384.057789886754, 5439.401665816757, 5524.06090964533, 5598.776048958078, 5616.550675945915, 6081.27024757032, 6105.053716673922, 6106.969465152646, 6109.75560977556, 6135.601185922901, 5835.591508594358, 5837.387074357216, 5839.941600583939, 5841.182234487175, 5844.503217226498, 5774.191613174159, 5782.681952492653, 5871.031279838779, 5913.881722365529, 5919.526437885045, 5960.940390596125, 5962.642241465526, 5962.701864906738, 5983.820485385445, 5996.1005849122985, 5956.404359564096, 5957.553183511254, 5968.791092311835, 5984.371640977634, 5996.1005849122985, 4455.420795296591, 4499.167653984024, 4639.37368455261, 4641.512641172696, 4653.837115700934, 4057.087155390014, 4087.509498860156, 4095.959040409558, 4121.464209652726, 4176.644985176234, 5755.712214389264, 5759.481646651738, 5762.366139724627, 5762.88474230513, 5764.481196692318, 5701.059325211294, 6053.878922421527, 6086.056661217518, 6098.390160983866, 6099.146119543268, 5460.808871689472, 5660.037793575019, 5709.9714501427225, 5737.340205876294, 5794.246747922743, 5212.9739351303, 5239.633225674166, 5250.291210686585, 5253.264542963988, 5268.157094864803, 6252.937470625327, 6275.96862015687, 6292.937070629235, 6311.779087731908, 6340.524460665376, 5792.362840087671, 5860.472557469848, 5869.911951320648, 5913.231279933581, 5917.023691090922, 6204.906926396198, 6240.906386404298, 6250.0937364082865, 6259.624422534663, 6270.15352927349, 5878.1333439604605, 5886.793962211302, 5888.440598143169, 5893.675847828411, 5906.055031194988, 5715.914261286167, 5724.141378793214, 5913.319968203539, 5936.851578710567, 5957.523398128226, 5900.557458190567, 5906.645601263938, 5915.70421478933, 5924.229850119629, 5952.494038006645, 5882.117682347682, 5893.44012318829, 5894.086416605433, 5894.292684877671, 5912.70436478183, 5514.834554963358, 5525.806596769094, 5575.498205161555, 5779.479846813807, 5781.046127388934, 5720.799772007959, 5765.91351129725, 5802.071668533014, 5820.0, 5827.9417205829095, 5682.971585142213, 5683.516901063291, 5684.914726279192, 5689.630174038674, 5692.6299790513485], "value": 5498.741787636418, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.2261447046487, 589.7788329376484, 621.2079598511897, 621.8538643418799, 625.0904933322014, 34085.65914340856, 37164.0, 44051.33922991154, 44822.327665084966, 44835.32747008789, 47191.292130618065, 47659.28511072328, 47703.761481192545, 47731.761341193334, 47806.76096619521, 8386.203310685476, 9237.076292370743, 9338.906610933871, 9373.203277721403, 9399.81200375992, 8423.789405264855, 8697.52163631, 8704.390692651517, 10773.245872788908, 11142.49858756354, 11284.435778211098, 11298.265612735187, 11358.31850088993, 11365.431728413587, 11373.715657108556, 11142.610008649699, 11242.66272011841, 11243.269187502869, 11250.437478126101, 11251.381174035425, 10963.397013164273, 11033.668989930315, 11036.834447483294, 11046.668599942015, 11047.889521104848, 44467.0, 44629.553704462865, 44743.32885006727, 44800.77599611981, 44815.0, 3606.549181352331, 3748.5126933498746, 3779.4897688811934, 3818.0264032671766, 4104.548499665035, 32632.347353052806, 32689.346213075605, 32722.509162362585, 32863.835680821685, 32910.34179316424, 4630.861074167747, 4722.173619616553, 4733.644976626732, 4764.285357196413, 4775.21209000518, 393196.0340198309, 400607.0, 402792.0, 403004.0, 410655.0, 63951.360486394544, 64233.357666423675, 64274.67862660657, 64326.35673643203, 64417.35582644207, 38942.80528597339, 39694.603053969666, 39987.40018899661, 42361.0, 42732.359014614805, 17527.91236043837, 17677.0, 17693.823061769475, 17699.115044247737, 17699.38052168168, 13432.865671343357, 13502.459901604023, 13508.459661613622, 13513.391897364641, 13529.66175845592, 18189.363372281907, 18521.722174167397, 19511.0, 19802.900985495267, 19938.70091948622, 7368.815779605446, 7481.8877716834295, 7510.737124200627, 7687.115981662068, 7736.922630773733, 955.7849483866214, 982.6855406269925, 1048.6696690542456, 1053.5522402978856, 1080.2006515178712, 32618.0, 33249.66750332466, 33256.501152482735, 33312.1671958203, 33353.83323083369, 1136.8010598145293, 1141.9771604568027, 1146.1432479383286, 1156.843826083468, 1166.2477701882237, 14394.424223030961, 16484.752728709078, 17382.724908063443, 18625.81374186268, 18785.436436906915, 552342.0, 553696.0, 555617.0, 557575.0, 558134.0, 58755.706221469474, 58804.117938230964, 59195.704021479614, 59514.80970380568, 59541.0, 1298.5455090718174, 1335.626024713082, 1349.8650134986424, 1393.087527669358, 1411.3155119766905, 25063.624045639695, 30194.396112078073, 30204.09387718372, 32934.34131317408, 33038.83480582582, 56674.149887752545, 57588.42411575998, 57651.0, 57651.42348576461, 57826.421735783784, 519263.0, 524270.0, 524448.0, 524701.0, 524845.0, 30042.24894377658, 30456.543151852296, 48164.27753583629, 48280.62161759651, 51984.220236697234, 47980.760096199294, 52359.73820130875, 52584.0, 52723.736381317845, 52787.0, 42870.35694464523, 44413.77793111014, 44577.0, 44936.32595511135, 45505.77247113743, 44472.555274446844, 45287.32069019033, 45806.54193458023, 46019.539804601525, 46496.07007859892, 44080.559194407644, 47045.294320585905, 48686.5131348682, 48811.26783098185, 48850.75574622104, 37738.811305943294, 40262.597374025885, 40569.59430405658, 40905.0, 41294.793526033376, 29372.706272936997, 29403.558946616246, 30032.84983575068, 30121.548176777804, 30395.84802076064], "value": 21512.533963129146, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.14903659059837, 408.83033541080454, 420.7034041001095, 426.0796679172987, 431.6546762589927, 14416.423343066277, 16373.263203155857, 20003.399898003066, 20086.196552137935, 20796.272130475398, 17809.198586063627, 18040.63918721625, 18116.547086322847, 18194.72707909379, 18531.0, 4759.238521836507, 5740.196372507852, 5903.409659034105, 5935.673537955411, 5943.3462319144855, 4340.197063543254, 4554.476235232957, 5827.737751801179, 5923.200367950315, 6197.349278325756, 6560.475161987053, 6587.80236592903, 6595.835104122388, 6596.571222870498, 6599.505037122211, 6310.274318453367, 6437.4528165105785, 6458.095866578683, 6474.805755827333, 6479.22249330081, 5553.250311208016, 5716.485516303511, 5722.685252311121, 5725.198472213893, 5763.366029736768, 20275.594488110302, 20347.491312717153, 20364.490887727778, 24317.87841060801, 25116.623250651253, 2417.5648383291, 2598.7141414444395, 2614.6993095793846, 2746.8489233092173, 2872.8563571821323, 11415.143864210135, 11477.540898364055, 12455.065870059781, 15137.318820652987, 15264.771028434583, 1982.4944639117077, 1996.3012945469115, 2005.7492813398326, 2019.0813180003063, 2089.4751992694273, 80681.59659201725, 81658.0, 81724.0, 85453.0, 87931.0, 11794.410279485992, 11863.288202707865, 12064.09519286057, 12073.396330183632, 12267.57063502773, 17118.058506782247, 17125.57186070358, 17131.143442827808, 17132.828671713374, 17141.314347425963, 8524.65901363951, 8551.664850708228, 8587.441816281922, 8675.392722509363, 8803.823923521493, 7965.681372745141, 7999.720009799629, 8036.758897233092, 8110.270075693216, 8169.591520423955, 5094.465081166498, 5166.45752196014, 5171.7672704728375, 5202.115640341151, 5290.6296559241255, 1826.1782198010949, 1906.075553356621, 2033.5627840014172, 2136.626090434168, 2187.0704950396334, 1011.3577878047346, 1019.8572199892021, 1020.1940467031111, 1058.7459009837737, 1087.7117563845586, 19057.0, 19401.32095376655, 19476.123574439185, 19839.900800495907, 20434.795652043587, 1030.896910308963, 1034.3380236648552, 1041.317936751429, 1041.3595638682157, 1074.6561100447939, 10760.784784304271, 11085.279456835442, 11223.551057957753, 11336.546538138547, 11441.485133169028, 499125.0, 503454.0, 503694.0, 505999.0, 518337.0, 90116.09883901208, 91144.08855911488, 91649.0, 91863.54068229749, 92130.53934730284, 499.69768290183913, 519.7687029272013, 528.6326003427581, 1066.9946650266854, 1099.5217080569978, 11167.218294719292, 11702.2978621283, 11805.291682499077, 11973.940130299292, 12358.876411236131, 39878.40182397325, 41150.0, 41706.95732606709, 42131.368029480196, 43111.35332970071, 57809.71095144498, 58541.70729146327, 58659.0, 58877.0, 58918.116228257466, 8717.134636372706, 8832.38173327861, 8911.331650126136, 9038.864417033881, 9310.627574897198, 12476.5009399623, 13873.306334683024, 13974.161550307013, 14076.507322243673, 14150.080244784056, 12567.748645026866, 12617.68455788576, 12767.680807979503, 12825.294608796607, 12881.8067728986, 12183.634490965285, 12218.694532636755, 12392.938035309766, 12464.626061218178, 12611.810822837848, 12247.877521224673, 12415.31715755606, 12472.87527124717, 12482.063845211464, 12779.105462617528, 9000.0, 9096.545172741204, 9352.719418417459, 9597.136257736558, 9619.18236949867, 11808.586699465477, 11927.0, 11958.043356531283, 12061.396930153282, 12551.87448125507], "value": 9442.21518082611, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1516.1812621184565, 1567.396552327354, 1696.4740930311605, 1780.2611916054839, 1820.644974230025, 9063.365564410495, 9822.508874556279, 9845.310828242025, 9849.359791613559, 9850.113489785917, 8390.62242199101, 8597.226249637532, 9075.273978081754, 9346.205572526327, 9660.323777335572, 2362.70466191726, 2396.95206095878, 2403.0868270057354, 2403.267003563912, 2405.9759402405925, 2460.963085553718, 2486.552420564298, 2532.4048848520583, 2534.214393538, 2536.492701459706, 2206.3160420269687, 2277.7836105569945, 2280.612295909691, 2461.4092617771694, 2545.0, 2539.733328000561, 2553.4254792671686, 2555.080171138389, 2556.8593727345174, 2559.5648739714293, 2506.5989441689426, 2519.48350588129, 2565.9101931432497, 2568.345072006626, 2573.4981678572685, 9485.715428537154, 9670.613175473043, 9675.854862177073, 9683.225341972626, 9712.0, 5648.54811615074, 5816.912746308809, 5817.331006934172, 5831.241938547962, 5835.766569337221, 3669.5779985301765, 3679.2089700714473, 3723.8882833514767, 3807.257584770971, 3807.2956503047026, 1113.6325012745774, 1130.9038731707815, 1131.4399372310759, 1147.9540818367254, 1158.846947287446, 13390.196588204739, 13401.53094641683, 13447.125936814173, 13505.594832155051, 13580.728385432236, 5027.622928280393, 5069.974650126799, 5120.1039818031695, 5219.634625576173, 5222.294990176353, 11326.207165498336, 11328.2070255083, 11345.035671967975, 11377.032952199155, 11391.031762300132, 5699.772009119672, 5705.144228365695, 5705.2012718219485, 5711.7144142792695, 5714.457126572969, 5085.974570127126, 5237.188235823453, 5251.737413129328, 5260.263563101169, 5304.416514183436, 4192.622663960197, 4248.808803603845, 4261.680373971964, 4282.164977829293, 4341.196878577473, 1391.5964370332692, 1432.6131944375168, 1441.7116576684496, 1450.833154187282, 1456.9927150364392, 1017.6234793126442, 1042.4891803016467, 1046.1160319529986, 1062.5218651606808, 1063.3938654966748, 6505.804825855232, 6598.406143447113, 6657.933420665731, 6673.499487538454, 6774.898376524356, 1025.205465764024, 1061.1404762142688, 1087.9673609791719, 1117.2402766118955, 1124.6176300058019, 4496.303073023687, 4499.505054444008, 4508.616767574727, 4528.841490547881, 4561.201789686792, 11297.26567773092, 11670.533178672758, 11749.0, 11755.471003804849, 12080.87919120815, 11896.881031189578, 11917.404129793476, 12016.038716902627, 12023.0, 12029.578964736193, 8707.172818582225, 8938.955305223562, 8988.59551320192, 8998.59506322217, 9004.324675649352, 6582.341765823379, 6670.966645166744, 6758.391744742997, 6788.25329213796, 6802.761903333359, 10975.835362469728, 11211.60759373418, 11214.327140371604, 11226.831597526207, 11257.943710281395, 10851.348919064565, 11063.336199828036, 11157.27477713946, 11239.325640461599, 11369.147313951653, 8365.0, 8547.91452085496, 8558.78603034929, 8637.784055398666, 8706.085860984505, 9442.905570944202, 9520.190783783455, 9535.809283814424, 9548.092931171528, 9571.521423928914, 7878.212178782076, 8011.919880801117, 8064.677412903653, 8094.109647938604, 8305.044919834054, 8147.633356498854, 8176.305014073632, 8197.672093116209, 8303.335733141213, 8337.958310208653, 7423.146338171179, 7626.313631773167, 7685.423593230642, 7761.340286075747, 7825.686972521035, 5314.813981510629, 5332.9466705334, 5349.4650534946195, 5357.383900851452, 5551.08407112838, 5406.189071639285, 5443.591730620298, 5637.718114094361, 5695.544356451557, 5708.400617935057], "value": 5046.994361828932, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.14649046253584, 340.2242886219419, 349.6870301080533, 352.86767462201664, 365.4682437054085, 5289.603279754019, 5293.6294459387855, 5423.674579525222, 5493.807716729915, 5521.751521181546, 5375.569954403648, 5445.891082178354, 5459.781608735646, 5490.149026900826, 5499.642523235987, 4325.589069038437, 4332.956670433295, 4337.826486940518, 4346.239408103585, 4355.912881742363, 4134.8139333729905, 4251.829926802924, 4322.092360604277, 4323.286657701476, 4342.305231162999, 4162.980069882883, 4247.745135291877, 4258.957410425903, 4260.403543503897, 4272.0, 4232.174725928445, 4233.682473814476, 4246.851360202378, 4253.851115210984, 4255.5957184067465, 3761.868334608303, 3808.1050953026015, 3810.637989391031, 3821.5796262411113, 3841.481400010991, 5298.576113910878, 5314.183482754146, 5320.973395133038, 5353.946460535384, 5374.763804324988, 4909.612367466437, 4910.607151427877, 4918.8278410255825, 4921.0, 4923.606111511071, 5436.2661040759385, 5619.887602247933, 5680.289963754531, 5695.5443564514735, 5696.344920334173, 4156.293430116887, 4162.895927601804, 4165.166966606691, 4181.59916427997, 4203.642690371322, 5967.4629283364275, 5977.133315669247, 5981.58128930975, 5992.700364981777, 6004.3395226525045, 4018.618231268025, 4225.408442818008, 4323.6757243206885, 4340.525900236835, 4346.826126954949, 4227.133437645275, 4243.7029407941145, 4246.851360202378, 4249.213895429355, 4254.106637606075, 4607.8848028798875, 4639.350490931272, 4711.8350857719815, 4815.614750819926, 4840.443349014838, 5738.254026976467, 5747.741351639186, 5748.31020277561, 5748.798792042258, 5749.8275051748515, 1442.4879167895456, 1455.2796365798786, 1464.326409851459, 1471.9705605887823, 1472.6451664468714, 937.929655275857, 952.7570469530225, 953.8187744328555, 954.8138113067885, 964.5466630683568, 4974.90050198994, 4989.925151122736, 5015.974920125449, 5057.721825299644, 5095.363079615048, 5217.713025783542, 5231.875146843447, 5238.568737476959, 5249.475052494797, 5265.736713164327, 4715.386999690087, 4982.676126051795, 4996.425411077773, 5010.924836127461, 5029.798808047711, 2775.514285000117, 2778.791225816776, 2786.1889771648184, 2790.9023184188864, 2804.971950280512, 5168.870778230575, 5393.7303134843105, 5439.755211015514, 5448.575383954102, 5530.198121272393, 5308.840734777963, 5309.5752339812725, 5320.521153096162, 5323.813666521731, 5334.706076387113, 5266.9714913924645, 5348.331458567679, 5444.210589464506, 5448.891022179613, 5451.509364157245, 4816.518348165296, 5141.709306044209, 5256.0, 5261.57907367402, 5280.7359632019015, 5041.495850415075, 5085.3134826797905, 5092.6435149539175, 5107.208382700687, 5127.435982042047, 5337.144627624358, 5371.502251453093, 5399.974004939049, 5428.565714742732, 5445.972770136124, 3835.6356146166067, 3851.6533511984057, 3858.7491813033184, 3889.2610404023144, 4185.660588611737, 5651.276360709859, 5799.159121927212, 5836.328822185503, 5902.4097590240635, 5903.586748927534, 5761.942380576141, 5775.971120144541, 5778.508826749773, 5782.913256301243, 5783.768649253982, 5655.095184770417, 5741.598088133791, 5772.884542309046, 5778.561755755319, 5787.334456537384, 5681.147827825859, 5686.744096515584, 5691.516221121085, 5698.116791897262, 5722.141678748221, 5773.921388300292, 5802.013657678121, 5834.883302333845, 5836.153757705194, 5844.649321040752, 5495.752691128829, 5636.830895073154, 5683.2666036859155, 5692.0608099663095, 5733.885322293614], "value": 4235.290904016497, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [829.8962629671291, 858.8325276571071, 865.7532603208086, 880.2825697056899, 897.2104547997761, 16278.674426511478, 16975.83024169758, 17118.65762684747, 17163.399281025166, 17315.047672378016, 16119.27463264153, 16248.51254462365, 16262.918685406587, 16275.0, 16285.51143465695, 721.383217349168, 742.7660287009602, 744.7430636430423, 748.5209465941801, 857.6012154348227, 878.9692360767374, 885.5882014863088, 886.3706768194589, 886.6231851463135, 886.7517095213351, 919.7056941778634, 934.6822080492631, 934.8831396075491, 935.0929598289648, 935.4247138010143, 926.3006430145231, 926.7822061815468, 927.4249965021729, 928.0719280719314, 928.1090153452693, 553.8255449533384, 571.911353740171, 650.905618685288, 684.3703792510852, 684.5721424109931, 15723.528294151194, 15794.684106317924, 16510.257038433298, 16584.336626534925, 16589.83410165895, 15424.228788560527, 15426.614334641612, 15645.608859778482, 15829.683406331924, 16288.51134465956, 14352.06711563745, 14577.344019519041, 14601.196934168616, 14627.70744585113, 14972.1016738996, 4858.271259311096, 4873.926891096601, 4879.414470263556, 5113.258577506278, 5134.152864777345, 86984.56507717485, 87001.56499217464, 87797.56101219518, 90712.09287907169, 90807.09192908119, 12704.3012634306, 12893.097483176087, 13157.473701052042, 13181.143225690299, 13435.664108397174, 24387.634185487233, 24476.388090297885, 24476.75523244745, 24479.0, 24485.755142448346, 8862.778430539289, 9008.234300084436, 9023.684171053981, 9335.859962100574, 9376.390534615228, 4706.411698537683, 4773.641976851681, 4905.460399356068, 5061.924071138936, 5132.101882170605, 3691.53855768029, 3758.098056466483, 3815.8664446744233, 3817.255635151119, 3818.4463252828186, 625.9593126446857, 626.5488848029503, 633.556510442692, 633.8161933039366, 642.0305338938236, 610.8503416662946, 698.3679769808332, 711.6797441151502, 728.6283995162505, 731.3235257386896, 9667.903320966841, 9758.316917815826, 9970.133259245318, 10020.34867733595, 10084.34451760648, 633.654658211276, 673.599208470959, 730.5580124024995, 731.8938753880658, 741.1995045351008, 4629.236176030984, 4758.881027974328, 4960.826371076995, 4978.477259887732, 5018.698878067327, 128301.3584932088, 128981.0, 129592.3520382392, 130989.0, 133700.0, 67096.32903670998, 99262.0, 106201.41131443533, 106949.0, 110912.4454377723, 81931.5903420491, 91627.0, 93873.86668528544, 95181.0, 95630.52184739032, 9213.585388657393, 9306.488143152192, 9348.298877584344, 9401.153896149379, 9461.810763784824, 56609.433905660415, 56661.43338566727, 58881.70559147177, 58890.705546471996, 59313.703431482565, 80304.59847700724, 80316.59841700754, 82928.58535707524, 83795.16204837874, 86297.13702862892, 11677.416129193676, 11743.88256117428, 12008.0, 12767.93616031951, 13163.934180329037, 14066.156030638194, 14728.705425891636, 14790.926045369704, 15884.68230635404, 16887.408940687015, 14852.405903763729, 15279.312430940412, 16064.919675401548, 16595.751063734297, 16617.41839035628, 13826.101303415246, 13869.930650346683, 14158.646033849236, 14879.181645009628, 15098.169600671628, 14734.484293049692, 15128.167950762814, 15537.76693349578, 16209.108499032194, 16251.674966500368, 12020.63938081859, 12131.332776697367, 12586.0, 12942.547010854574, 13226.867731322563, 10437.739056523647, 11603.941980290045, 11893.881061189624, 12373.690657733629, 12770.23378597287], "value": 8142.495359824687, "unit": "score"}], "name": "dromaeo_css", "value": 7611.28264527623, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 110.0, 110.0, 111.0, 110.0, 111.0, 111.0, 109.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 119.0, 116.0, 160.0, 117.0, 121.0, 117.0, 130.0, 154.0, 119.0], "value": 130.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 160.0, 161.0, 161.0, 162.0, 161.0, 161.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 111.0, 75.0, 76.0, 75.0, 76.0, 105.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 128.0, 82.0, 82.0, 81.0, 102.0, 81.0, 82.0, 111.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 48.0, 51.0, 49.0, 49.0, 48.0, 50.0, 49.0, 48.0, 48.0], "value": 49.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 58.0, 68.0, 58.0, 59.0, 62.0, 59.0, 58.0, 58.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 87.0, 73.0, 74.0, 73.0, 73.0, 74.0, 81.0, 73.0, 79.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 122.0, 118.0, 127.0, 134.0, 117.0, 125.0, 120.0, 155.0, 125.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 155.0, 161.0, 153.0, 149.0, 151.0, 148.0, 148.0, 153.0, 151.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 62.0, 64.0, 61.0, 63.0, 63.0, 60.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1457.2000000000003, "alertThreshold": 2.0}]} 21:20:17 INFO - Return code: 0 21:20:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:20:17 INFO - # TBPL SUCCESS # 21:20:17 INFO - Running post-action listener: _resource_record_post_action 21:20:17 INFO - [mozharness: 2016-10-03 04:20:17.379382Z] Finished run-tests step (success) 21:20:17 INFO - Running post-run listener: _resource_record_post_run 21:20:17 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 2002944; Write bytes: 375017472; Read time: 288; Write time: 260552 21:20:17 INFO - TinderboxPrint: CPU usage
13.0% 21:20:17 INFO - TinderboxPrint: I/O read bytes / time
2,002,944 / 288 21:20:17 INFO - TinderboxPrint: I/O write bytes / time
375,017,472 / 260,552 21:20:17 INFO - TinderboxPrint: CPU idle
8,262.8 (87.0%) 21:20:17 INFO - TinderboxPrint: CPU user
1,190.3 (12.5%) 21:20:17 INFO - TinderboxPrint: Swap in / out
0 / 0 21:20:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124633088; Read time: 0; Write time: 82332 21:20:17 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 250384384; Read time: 236; Write time: 178220 21:20:18 INFO - Running post-run listener: _upload_blobber_files 21:20:18 INFO - Blob upload gear active. 21:20:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:20:18 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 21:20:18 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'] 21:20:18 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 21:20:18 INFO - (blobuploader) - INFO - Open directory for files ... 21:20:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:20:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:20:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:20:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:20:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:20:19 INFO - (blobuploader) - INFO - Done attempting. 21:20:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:20:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:20:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:20:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:20:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:20:23 INFO - (blobuploader) - INFO - Done attempting. 21:20:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:20:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:20:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:20:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:20:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:20:23 INFO - (blobuploader) - INFO - Done attempting. 21:20:23 INFO - (blobuploader) - INFO - Iteration through files over. 21:20:23 INFO - Return code: 0 21:20:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:20:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:20:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da0cf3921915804b82eaa67d0e525fc89d85110db185237bac583c87574657afc1d3f52c39725b0ca75c359efce8cadd65657c14e56a5c54a4975ed7b273a492", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f07e478aa0629571f524d5ae0bf6ed5d29bbcf384ef32a96b8a278838e65269a27430d54c15948496b26c180ff7e792022264418ebc230e73130dfdf60d248d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/890b1eaf27538b9b9a9c467b6cdde839ddfe8cbd40daab9d3eff9d7409ffbd706c385a7172cd8776e3b28eb82229be5d3f8c8de5cb5a3652a8ee98e4d6a858d0"} 21:20:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:20:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:20:23 INFO - Contents: 21:20:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da0cf3921915804b82eaa67d0e525fc89d85110db185237bac583c87574657afc1d3f52c39725b0ca75c359efce8cadd65657c14e56a5c54a4975ed7b273a492", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f07e478aa0629571f524d5ae0bf6ed5d29bbcf384ef32a96b8a278838e65269a27430d54c15948496b26c180ff7e792022264418ebc230e73130dfdf60d248d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/890b1eaf27538b9b9a9c467b6cdde839ddfe8cbd40daab9d3eff9d7409ffbd706c385a7172cd8776e3b28eb82229be5d3f8c8de5cb5a3652a8ee98e4d6a858d0"} 21:20:23 INFO - Running post-run listener: copy_logs_to_upload_dir 21:20:23 INFO - Copying logs to upload dir... 21:20:23 INFO - mkdir: /builds/slave/test/build/upload/logs 21:20:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.365358 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-02 21:20:23.748072) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-02 21:20:23.753077) ========= 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=ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381 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/da0cf3921915804b82eaa67d0e525fc89d85110db185237bac583c87574657afc1d3f52c39725b0ca75c359efce8cadd65657c14e56a5c54a4975ed7b273a492", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f07e478aa0629571f524d5ae0bf6ed5d29bbcf384ef32a96b8a278838e65269a27430d54c15948496b26c180ff7e792022264418ebc230e73130dfdf60d248d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/890b1eaf27538b9b9a9c467b6cdde839ddfe8cbd40daab9d3eff9d7409ffbd706c385a7172cd8776e3b28eb82229be5d3f8c8de5cb5a3652a8ee98e4d6a858d0"} build_url:https://queue.taskcluster.net/v1/task/GERA3i5zQFeFwQUkW3Mgpw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011521 build_url: 'https://queue.taskcluster.net/v1/task/GERA3i5zQFeFwQUkW3Mgpw/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/da0cf3921915804b82eaa67d0e525fc89d85110db185237bac583c87574657afc1d3f52c39725b0ca75c359efce8cadd65657c14e56a5c54a4975ed7b273a492", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f07e478aa0629571f524d5ae0bf6ed5d29bbcf384ef32a96b8a278838e65269a27430d54c15948496b26c180ff7e792022264418ebc230e73130dfdf60d248d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/890b1eaf27538b9b9a9c467b6cdde839ddfe8cbd40daab9d3eff9d7409ffbd706c385a7172cd8776e3b28eb82229be5d3f8c8de5cb5a3652a8ee98e4d6a858d0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-02 21:20:23.781216) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-02 21:20:23.781540) ========= 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=ed14279e38b05397cf4aa391000001a4-1475464163.764455-239946381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-02 21:20:23.831458) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-02 21:20:23.831780) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-02 21:20:23.832090) ========= ========= Total master_lag: 0.23 =========