builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1474645209.89 results: success (0) buildid: 20160923055359 builduid: 581dab9710d3440db91f95dc7eeb90a1 revision: 4dd6247f67104db93b1a495aacb2cf5410a62af1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 08:40:09.886296) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 08:40:09.886739) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 08:40:09.887063) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 08:40:09.904797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 08:40:09.905283) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-23 08:40:10-- 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% 40.8M=0s 2016-09-23 08:40:10 (40.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127122 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 08:40:10.049141) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 08:40:10.049467) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016017 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 08:40:10.100154) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 08:40:10.100777) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4dd6247f67104db93b1a495aacb2cf5410a62af1 --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 4dd6247f67104db93b1a495aacb2cf5410a62af1 --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=e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-23 08:40:10,436 truncating revision to first 12 chars 2016-09-23 08:40:10,436 Setting DEBUG logging. 2016-09-23 08:40:10,436 attempt 1/10 2016-09-23 08:40:10,436 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4dd6247f6710?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 08:40:10,909 unpacking tar archive at: mozilla-aurora-4dd6247f6710/testing/mozharness/ program finished with exit code 0 elapsedTime=1.414995 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 08:40:11.534476) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 08:40:11.535224) ========= script_repo_revision: 4dd6247f67104db93b1a495aacb2cf5410a62af1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 08:40:11.536214) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 08:40:11.536996) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 08:40:11.548652) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-09-23 08:40:11.549014) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:40:11 INFO - MultiFileLogger online at 20160923 08:40:11 in /builds/slave/test 08:40:11 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 08:40:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:40:11 INFO - {'append_to_log': False, 08:40:11 INFO - 'base_work_dir': '/builds/slave/test', 08:40:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:40:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:40:11 INFO - 'branch': 'Mozilla-Aurora', 08:40:11 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:11 INFO - 'config_files': ('talos/linux_config.py',), 08:40:11 INFO - 'default_actions': ('clobber', 08:40:11 INFO - 'read-buildbot-config', 08:40:11 INFO - 'download-and-extract', 08:40:11 INFO - 'populate-webroot', 08:40:11 INFO - 'create-virtualenv', 08:40:11 INFO - 'install', 08:40:11 INFO - 'run-tests'), 08:40:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:11 INFO - 'download_minidump_stackwalk': True, 08:40:11 INFO - 'download_symbols': 'ondemand', 08:40:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:40:11 INFO - 'tooltool.py': '/tools/tooltool.py', 08:40:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:40:11 INFO - '/tools/misc-python/virtualenv.py')}, 08:40:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:11 INFO - 'installer_path': 'installer.exe', 08:40:11 INFO - 'log_level': 'info', 08:40:11 INFO - 'log_name': 'talos', 08:40:11 INFO - 'log_to_console': True, 08:40:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:40:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:40:11 INFO - 'opt_config_files': (), 08:40:11 INFO - 'pip_index': False, 08:40:11 INFO - 'sps_profile': False, 08:40:11 INFO - 'sps_profile_interval': 0, 08:40:11 INFO - 'suite': 'dromaeojs', 08:40:11 INFO - 'system_bits': '32', 08:40:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:11 INFO - 'title': 'talos-linux64-ix-067', 08:40:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:11 INFO - 'use_talos_json': True, 08:40:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:40:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:11 INFO - 'work_dir': 'build'} 08:40:11 INFO - [mozharness: 2016-09-23 15:40:11.977567Z] Running clobber step. 08:40:11 INFO - Running pre-action listener: _resource_record_pre_action 08:40:11 INFO - Running main action method: clobber 08:40:11 INFO - rmtree: /builds/slave/test/build 08:40:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:40:12 INFO - Running post-action listener: _resource_record_post_action 08:40:12 INFO - [mozharness: 2016-09-23 15:40:12.949647Z] Finished clobber step (success) 08:40:12 INFO - [mozharness: 2016-09-23 15:40:12.949746Z] Running read-buildbot-config step. 08:40:12 INFO - Running pre-action listener: _resource_record_pre_action 08:40:12 INFO - Running main action method: read_buildbot_config 08:40:12 INFO - Using buildbot properties: 08:40:12 INFO - { 08:40:12 INFO - "project": "", 08:40:12 INFO - "product": "firefox", 08:40:12 INFO - "script_repo_revision": "production", 08:40:12 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:40:12 INFO - "repository": "", 08:40:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:40:12 INFO - "buildid": "20160923055359", 08:40:12 INFO - "pgo_build": "True", 08:40:12 INFO - "basedir": "/builds/slave/test", 08:40:12 INFO - "buildnumber": 784, 08:40:12 INFO - "slavename": "talos-linux64-ix-067", 08:40:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:40:12 INFO - "platform": "ubuntu64_hw", 08:40:12 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:40:12 INFO - "branch": "mozilla-aurora", 08:40:12 INFO - "repo_path": "releases/mozilla-aurora", 08:40:12 INFO - "revision": "4dd6247f67104db93b1a495aacb2cf5410a62af1", 08:40:12 INFO - "stage_platform": "linux64-pgo", 08:40:12 INFO - "builduid": "581dab9710d3440db91f95dc7eeb90a1", 08:40:12 INFO - "slavebuilddir": "test" 08:40:12 INFO - } 08:40:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/FQbQ_FvgQ0quA9v3qn7h_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 08:40:12 INFO - Running post-action listener: _resource_record_post_action 08:40:12 INFO - [mozharness: 2016-09-23 15:40:12.952261Z] Finished read-buildbot-config step (success) 08:40:12 INFO - [mozharness: 2016-09-23 15:40:12.952351Z] Running download-and-extract step. 08:40:12 INFO - Running pre-action listener: _resource_record_pre_action 08:40:12 INFO - Running main action method: download_and_extract 08:40:12 INFO - mkdir: /builds/slave/test/build/tests 08:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:12 INFO - trying https://queue.taskcluster.net/v1/task/FQbQ_FvgQ0quA9v3qn7h_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 08:40:12 INFO - Downloading https://queue.taskcluster.net/v1/task/FQbQ_FvgQ0quA9v3qn7h_w/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 08:40:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FQbQ_FvgQ0quA9v3qn7h_w/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 08:40:13 INFO - Downloaded 1361 bytes. 08:40:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 08:40:13 INFO - Using the following test package requirements: 08:40:13 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 08:40:13 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:40:13 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:40:13 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:40:13 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:40:13 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:40:13 INFO - u'jsshell-linux-x86_64.zip'], 08:40:13 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:40:13 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:40:13 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 08:40:13 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:40:13 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:40:13 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:40:13 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:40:13 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:40:13 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:40:13 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:40:13 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:40:13 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:40:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FQbQ_FvgQ0quA9v3qn7h_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 08:40:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FQbQ_FvgQ0quA9v3qn7h_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:40:13 INFO - Fetch https://queue.taskcluster.net/v1/task/FQbQ_FvgQ0quA9v3qn7h_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:40:14 INFO - Expected file size: 21893922 08:40:18 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 08:40:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FQbQ_FvgQ0quA9v3qn7h_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 08:40:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FQbQ_FvgQ0quA9v3qn7h_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:40:18 INFO - Fetch https://queue.taskcluster.net/v1/task/FQbQ_FvgQ0quA9v3qn7h_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:40:18 INFO - Expected file size: 21893922 08:40:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FQbQ_FvgQ0quA9v3qn7h_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 08:40:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FQbQ_FvgQ0quA9v3qn7h_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:40:23 INFO - Fetch https://queue.taskcluster.net/v1/task/FQbQ_FvgQ0quA9v3qn7h_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:40:24 INFO - Expected file size: 14414059 08:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:25 INFO - trying https://queue.taskcluster.net/v1/task/FQbQ_FvgQ0quA9v3qn7h_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 08:40:25 INFO - Downloading https://queue.taskcluster.net/v1/task/FQbQ_FvgQ0quA9v3qn7h_w/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 08:40:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FQbQ_FvgQ0quA9v3qn7h_w/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 08:40:27 INFO - Downloaded 63968310 bytes. 08:40:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FQbQ_FvgQ0quA9v3qn7h_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 08:40:27 INFO - mkdir: /builds/slave/test/properties 08:40:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:40:27 INFO - Writing to file /builds/slave/test/properties/build_url 08:40:27 INFO - Contents: 08:40:27 INFO - build_url:https://queue.taskcluster.net/v1/task/FQbQ_FvgQ0quA9v3qn7h_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 08:40:28 INFO - Running post-action listener: _resource_record_post_action 08:40:28 INFO - Running post-action listener: set_extra_try_arguments 08:40:28 INFO - [mozharness: 2016-09-23 15:40:28.328460Z] Finished download-and-extract step (success) 08:40:28 INFO - [mozharness: 2016-09-23 15:40:28.328687Z] Running populate-webroot step. 08:40:28 INFO - Running pre-action listener: _resource_record_pre_action 08:40:28 INFO - Running main action method: populate_webroot 08:40:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:40:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:40:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:40:28 INFO - '--tppagecycles', 08:40:28 INFO - '7'], 08:40:28 INFO - 'tests': ['tsvgm']}}, 08:40:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:40:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:40:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:40:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:40:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:28 INFO - 'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:28 INFO - 'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['damp', 'tps']}, 08:40:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:28 INFO - 'tests': ['damp', 'tps']}, 08:40:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['dromaeo_dom']}, 08:40:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['basic_compositor_video']}, 08:40:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:40:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['a11yr', 08:40:28 INFO - 'ts_paint', 08:40:28 INFO - 'tpaint', 08:40:28 INFO - 'sessionrestore', 08:40:28 INFO - 'sessionrestore_no_auto_restore', 08:40:28 INFO - 'tabpaint']}, 08:40:28 INFO - 'other-e10s': {'tests': ['a11yr', 08:40:28 INFO - 'ts_paint', 08:40:28 INFO - 'tpaint', 08:40:28 INFO - 'sessionrestore', 08:40:28 INFO - 'sessionrestore_no_auto_restore', 08:40:28 INFO - 'tabpaint']}, 08:40:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:40:28 INFO - 'ts_paint', 08:40:28 INFO - 'tpaint', 08:40:28 INFO - 'sessionrestore', 08:40:28 INFO - 'sessionrestore_no_auto_restore', 08:40:28 INFO - 'tabpaint']}, 08:40:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:40:28 INFO - 'ts_paint', 08:40:28 INFO - 'tpaint', 08:40:28 INFO - 'sessionrestore', 08:40:28 INFO - 'sessionrestore_no_auto_restore', 08:40:28 INFO - 'tabpaint']}, 08:40:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['a11yr', 08:40:28 INFO - 'ts_paint', 08:40:28 INFO - 'tpaint', 08:40:28 INFO - 'sessionrestore', 08:40:28 INFO - 'sessionrestore_no_auto_restore', 08:40:28 INFO - 'tabpaint']}, 08:40:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['a11yr', 08:40:28 INFO - 'ts_paint', 08:40:28 INFO - 'tpaint', 08:40:28 INFO - 'sessionrestore', 08:40:28 INFO - 'sessionrestore_no_auto_restore', 08:40:28 INFO - 'tabpaint']}, 08:40:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['tsvgx', 08:40:28 INFO - 'tsvgr_opacity', 08:40:28 INFO - 'tart', 08:40:28 INFO - 'tscrollx', 08:40:28 INFO - 'cart']}, 08:40:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:40:28 INFO - 'tsvgr_opacity', 08:40:28 INFO - 'tart', 08:40:28 INFO - 'tscrollx', 08:40:28 INFO - 'cart']}, 08:40:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:28 INFO - 'talos_options': ['--disable-e10s'], 08:40:28 INFO - 'tests': ['tp5o']}, 08:40:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:28 INFO - 'tests': ['tp5o']}, 08:40:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:28 INFO - 'talos_options': ['--disable-e10s', 08:40:28 INFO - '--xperf_path', 08:40:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:28 INFO - 'tests': ['tp5n']}, 08:40:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:28 INFO - 'talos_options': ['--xperf_path', 08:40:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:28 INFO - 'tests': ['tp5n']}}, 08:40:28 INFO - 'talos.zip': {'path': '', 08:40:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:40:28 INFO - Running post-action listener: _resource_record_post_action 08:40:28 INFO - [mozharness: 2016-09-23 15:40:28.350631Z] Finished populate-webroot step (success) 08:40:28 INFO - [mozharness: 2016-09-23 15:40:28.350730Z] Running create-virtualenv step. 08:40:28 INFO - Running pre-action listener: _resource_record_pre_action 08:40:28 INFO - Running main action method: create_virtualenv 08:40:28 INFO - Creating virtualenv /builds/slave/test/build/venv 08:40:28 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 08:40:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:40:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:28 INFO - Using real prefix '/usr' 08:40:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:40:28 INFO - Installing distribute.............................................................................................................................................................................................done. 08:40:30 INFO - Installing pip.................done. 08:40:30 INFO - Return code: 0 08:40:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:30 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 0x7fbfd7518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25acca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a9f60>, '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 0x25aad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', '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 08:40:30 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 08:40:30 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 08:40:30 INFO - Using env: {'DISPLAY': ':0', 08:40:30 INFO - 'HOME': '/home/cltbld', 08:40:30 INFO - 'LANG': 'en_US.UTF-8', 08:40:30 INFO - 'LANGUAGE': 'en_US:en', 08:40:30 INFO - 'LOGNAME': 'cltbld', 08:40:30 INFO - 'MAIL': '/var/mail/cltbld', 08:40:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:30 INFO - 'MOZ_NO_REMOTE': '1', 08:40:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:30 INFO - 'NO_EM_RESTART': '1', 08:40:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:30 INFO - 'PWD': '/builds/slave/test', 08:40:30 INFO - 'SHELL': '/bin/bash', 08:40:30 INFO - 'SHLVL': '1', 08:40:30 INFO - 'TERM': 'linux', 08:40:30 INFO - 'TMOUT': '86400', 08:40:30 INFO - 'USER': 'cltbld', 08:40:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', 08:40:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:30 INFO - '_': '/tools/buildbot/bin/python'} 08:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:31 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 08:40:31 INFO - Cleaning up... 08:40:31 INFO - Return code: 0 08:40:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbfd7518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25acca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a9f60>, '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 0x25aad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', '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 08:40:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:40:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:40:31 INFO - Using env: {'DISPLAY': ':0', 08:40:31 INFO - 'HOME': '/home/cltbld', 08:40:31 INFO - 'LANG': 'en_US.UTF-8', 08:40:31 INFO - 'LANGUAGE': 'en_US:en', 08:40:31 INFO - 'LOGNAME': 'cltbld', 08:40:31 INFO - 'MAIL': '/var/mail/cltbld', 08:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:31 INFO - 'MOZ_NO_REMOTE': '1', 08:40:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:31 INFO - 'NO_EM_RESTART': '1', 08:40:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:31 INFO - 'PWD': '/builds/slave/test', 08:40:31 INFO - 'SHELL': '/bin/bash', 08:40:31 INFO - 'SHLVL': '1', 08:40:31 INFO - 'TERM': 'linux', 08:40:31 INFO - 'TMOUT': '86400', 08:40:31 INFO - 'USER': 'cltbld', 08:40:31 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', 08:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:31 INFO - '_': '/tools/buildbot/bin/python'} 08:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:31 INFO - Downloading/unpacking psutil>=3.1.1 08:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:40:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:33 INFO - Installing collected packages: psutil 08:40:33 INFO - Running setup.py install for psutil 08:40:33 INFO - building 'psutil._psutil_linux' extension 08:40:33 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 08:40:33 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 08:40:33 INFO - building 'psutil._psutil_posix' extension 08:40:33 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 08:40:33 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 08:40:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:33 INFO - Successfully installed psutil 08:40:33 INFO - Cleaning up... 08:40:33 INFO - Return code: 0 08:40:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:33 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 0x7fbfd7518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25acca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a9f60>, '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 0x25aad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', '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 08:40:33 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 08:40:33 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 08:40:33 INFO - Using env: {'DISPLAY': ':0', 08:40:33 INFO - 'HOME': '/home/cltbld', 08:40:33 INFO - 'LANG': 'en_US.UTF-8', 08:40:33 INFO - 'LANGUAGE': 'en_US:en', 08:40:33 INFO - 'LOGNAME': 'cltbld', 08:40:33 INFO - 'MAIL': '/var/mail/cltbld', 08:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:33 INFO - 'MOZ_NO_REMOTE': '1', 08:40:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:33 INFO - 'NO_EM_RESTART': '1', 08:40:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:33 INFO - 'PWD': '/builds/slave/test', 08:40:33 INFO - 'SHELL': '/bin/bash', 08:40:33 INFO - 'SHLVL': '1', 08:40:33 INFO - 'TERM': 'linux', 08:40:33 INFO - 'TMOUT': '86400', 08:40:33 INFO - 'USER': 'cltbld', 08:40:33 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', 08:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:33 INFO - '_': '/tools/buildbot/bin/python'} 08:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:40:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:40:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:40:36 INFO - Installing collected packages: mozsystemmonitor 08:40:36 INFO - Running setup.py install for mozsystemmonitor 08:40:36 INFO - Successfully installed mozsystemmonitor 08:40:36 INFO - Cleaning up... 08:40:36 INFO - Return code: 0 08:40:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbfd7518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25acca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a9f60>, '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 0x25aad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', '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 08:40:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:40:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:40:36 INFO - Using env: {'DISPLAY': ':0', 08:40:36 INFO - 'HOME': '/home/cltbld', 08:40:36 INFO - 'LANG': 'en_US.UTF-8', 08:40:36 INFO - 'LANGUAGE': 'en_US:en', 08:40:36 INFO - 'LOGNAME': 'cltbld', 08:40:36 INFO - 'MAIL': '/var/mail/cltbld', 08:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:36 INFO - 'MOZ_NO_REMOTE': '1', 08:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:36 INFO - 'NO_EM_RESTART': '1', 08:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:36 INFO - 'PWD': '/builds/slave/test', 08:40:36 INFO - 'SHELL': '/bin/bash', 08:40:36 INFO - 'SHLVL': '1', 08:40:36 INFO - 'TERM': 'linux', 08:40:36 INFO - 'TMOUT': '86400', 08:40:36 INFO - 'USER': 'cltbld', 08:40:36 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', 08:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:36 INFO - '_': '/tools/buildbot/bin/python'} 08:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:36 INFO - Downloading/unpacking jsonschema==2.5.1 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:40:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:40:38 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 08:40:38 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 08:40:38 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 08:40:38 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 08:40:38 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 08:40:38 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 08:40:38 INFO - Downloading functools32-3.2.3-2.tar.gz 08:40:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:40:38 INFO - warning: no files found matching '*.txt' 08:40:38 INFO - no previously-included directories found matching 'build' 08:40:38 INFO - no previously-included directories found matching 'dist' 08:40:38 INFO - no previously-included directories found matching '.git*' 08:40:38 INFO - Installing collected packages: jsonschema, functools32 08:40:38 INFO - Running setup.py install for functools32 08:40:38 INFO - warning: no files found matching '*.txt' 08:40:38 INFO - no previously-included directories found matching 'build' 08:40:38 INFO - no previously-included directories found matching 'dist' 08:40:38 INFO - no previously-included directories found matching '.git*' 08:40:38 INFO - Successfully installed jsonschema functools32 08:40:38 INFO - Cleaning up... 08:40:38 INFO - Return code: 0 08:40:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:40:38 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')]} 08:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:38 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')]} 08:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:38 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 0x7fbfd7518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25acca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a9f60>, '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 0x25aad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', '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 08:40:38 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 08:40:38 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 08:40:38 INFO - Using env: {'DISPLAY': ':0', 08:40:38 INFO - 'HOME': '/home/cltbld', 08:40:38 INFO - 'LANG': 'en_US.UTF-8', 08:40:38 INFO - 'LANGUAGE': 'en_US:en', 08:40:38 INFO - 'LOGNAME': 'cltbld', 08:40:38 INFO - 'MAIL': '/var/mail/cltbld', 08:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:38 INFO - 'MOZ_NO_REMOTE': '1', 08:40:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:38 INFO - 'NO_EM_RESTART': '1', 08:40:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:38 INFO - 'PWD': '/builds/slave/test', 08:40:38 INFO - 'SHELL': '/bin/bash', 08:40:38 INFO - 'SHLVL': '1', 08:40:38 INFO - 'TERM': 'linux', 08:40:38 INFO - 'TMOUT': '86400', 08:40:38 INFO - 'USER': 'cltbld', 08:40:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', 08:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:38 INFO - '_': '/tools/buildbot/bin/python'} 08:40:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:40:38 INFO - Cleaning up... 08:40:38 INFO - Return code: 0 08:40:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:40:38 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')]} 08:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:38 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')]} 08:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:38 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 0x7fbfd7518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25acca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a9f60>, '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 0x25aad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', '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 08:40:38 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 08:40:38 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 08:40:38 INFO - Using env: {'DISPLAY': ':0', 08:40:38 INFO - 'HOME': '/home/cltbld', 08:40:38 INFO - 'LANG': 'en_US.UTF-8', 08:40:38 INFO - 'LANGUAGE': 'en_US:en', 08:40:38 INFO - 'LOGNAME': 'cltbld', 08:40:38 INFO - 'MAIL': '/var/mail/cltbld', 08:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:38 INFO - 'MOZ_NO_REMOTE': '1', 08:40:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:38 INFO - 'NO_EM_RESTART': '1', 08:40:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:38 INFO - 'PWD': '/builds/slave/test', 08:40:38 INFO - 'SHELL': '/bin/bash', 08:40:38 INFO - 'SHLVL': '1', 08:40:38 INFO - 'TERM': 'linux', 08:40:38 INFO - 'TMOUT': '86400', 08:40:38 INFO - 'USER': 'cltbld', 08:40:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', 08:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:38 INFO - '_': '/tools/buildbot/bin/python'} 08:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:39 INFO - Downloading/unpacking blobuploader==1.2.4 08:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:41 INFO - Downloading blobuploader-1.2.4.tar.gz 08:40:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:40:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:40:41 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 08:40:41 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 08:40:41 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 08:40:41 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 08:40:41 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 08:40:41 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 08:40:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:40:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:40:41 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 08:40:41 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 08:40:41 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 08:40:41 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 08:40:41 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 08:40:41 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 08:40:41 INFO - Downloading docopt-0.6.1.tar.gz 08:40:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:40:41 INFO - Installing collected packages: blobuploader, requests, docopt 08:40:41 INFO - Running setup.py install for blobuploader 08:40:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:40:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:40:41 INFO - Running setup.py install for requests 08:40:42 INFO - Running setup.py install for docopt 08:40:42 INFO - Successfully installed blobuploader requests docopt 08:40:42 INFO - Cleaning up... 08:40:42 INFO - Return code: 0 08:40:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:42 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')]} 08:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:42 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')]} 08:40:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:42 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 0x7fbfd7518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25acca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a9f60>, '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 0x25aad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', '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 08:40:42 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 08:40:42 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 08:40:42 INFO - Using env: {'DISPLAY': ':0', 08:40:42 INFO - 'HOME': '/home/cltbld', 08:40:42 INFO - 'LANG': 'en_US.UTF-8', 08:40:42 INFO - 'LANGUAGE': 'en_US:en', 08:40:42 INFO - 'LOGNAME': 'cltbld', 08:40:42 INFO - 'MAIL': '/var/mail/cltbld', 08:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:42 INFO - 'MOZ_NO_REMOTE': '1', 08:40:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:42 INFO - 'NO_EM_RESTART': '1', 08:40:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:42 INFO - 'PWD': '/builds/slave/test', 08:40:42 INFO - 'SHELL': '/bin/bash', 08:40:42 INFO - 'SHLVL': '1', 08:40:42 INFO - 'TERM': 'linux', 08:40:42 INFO - 'TMOUT': '86400', 08:40:42 INFO - 'USER': 'cltbld', 08:40:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', 08:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:42 INFO - '_': '/tools/buildbot/bin/python'} 08:40:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:42 INFO - Running setup.py (path:/tmp/pip-iwFpvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:42 INFO - Running setup.py (path:/tmp/pip-Y_WNJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:42 INFO - Running setup.py (path:/tmp/pip-L3qK8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:42 INFO - Running setup.py (path:/tmp/pip-wBTXn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:42 INFO - Running setup.py (path:/tmp/pip-_FyW5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:43 INFO - Running setup.py (path:/tmp/pip-JZZBgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:43 INFO - Running setup.py (path:/tmp/pip-JLHmXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:43 INFO - Running setup.py (path:/tmp/pip-GKe8ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:43 INFO - Running setup.py (path:/tmp/pip-_EZ50N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:43 INFO - Running setup.py (path:/tmp/pip-uqdcNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:43 INFO - Running setup.py (path:/tmp/pip-HxstnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:43 INFO - Running setup.py (path:/tmp/pip-0aVAI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:43 INFO - Running setup.py (path:/tmp/pip-8yXPAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:43 INFO - Running setup.py (path:/tmp/pip-ijo8RK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:43 INFO - Running setup.py (path:/tmp/pip-9_mYDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:43 INFO - Running setup.py (path:/tmp/pip-UTd8Jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:43 INFO - Running setup.py (path:/tmp/pip-S1lK6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:40:43 INFO - Running setup.py install for manifestparser 08:40:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:40:44 INFO - Running setup.py install for mozcrash 08:40:44 INFO - Running setup.py install for mozdebug 08:40:44 INFO - Running setup.py install for mozdevice 08:40:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:40:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:40:44 INFO - Running setup.py install for mozfile 08:40:44 INFO - Running setup.py install for mozhttpd 08:40:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:40:44 INFO - Running setup.py install for mozinfo 08:40:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:40:44 INFO - Running setup.py install for mozInstall 08:40:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:40:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:40:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:40:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:40:44 INFO - Running setup.py install for mozleak 08:40:44 INFO - Running setup.py install for mozlog 08:40:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:40:44 INFO - Running setup.py install for moznetwork 08:40:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:40:45 INFO - Running setup.py install for mozprocess 08:40:45 INFO - Running setup.py install for mozprofile 08:40:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:40:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:40:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:40:45 INFO - Running setup.py install for mozrunner 08:40:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:40:45 INFO - Running setup.py install for mozscreenshot 08:40:45 INFO - Running setup.py install for moztest 08:40:45 INFO - Running setup.py install for mozversion 08:40:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:40:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:40:45 INFO - Cleaning up... 08:40:45 INFO - Return code: 0 08:40:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:45 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 0x7fbfd7518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25acca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a9f60>, '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 0x25aad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', '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 08:40:45 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 08:40:45 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 08:40:45 INFO - Using env: {'DISPLAY': ':0', 08:40:45 INFO - 'HOME': '/home/cltbld', 08:40:45 INFO - 'LANG': 'en_US.UTF-8', 08:40:45 INFO - 'LANGUAGE': 'en_US:en', 08:40:45 INFO - 'LOGNAME': 'cltbld', 08:40:45 INFO - 'MAIL': '/var/mail/cltbld', 08:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:45 INFO - 'MOZ_NO_REMOTE': '1', 08:40:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:45 INFO - 'NO_EM_RESTART': '1', 08:40:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:45 INFO - 'PWD': '/builds/slave/test', 08:40:45 INFO - 'SHELL': '/bin/bash', 08:40:45 INFO - 'SHLVL': '1', 08:40:45 INFO - 'TERM': 'linux', 08:40:45 INFO - 'TMOUT': '86400', 08:40:45 INFO - 'USER': 'cltbld', 08:40:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', 08:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:45 INFO - '_': '/tools/buildbot/bin/python'} 08:40:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:45 INFO - Running setup.py (path:/tmp/pip-fAXwAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:46 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)) 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:46 INFO - Running setup.py (path:/tmp/pip-FnjOS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:46 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)) 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:46 INFO - Running setup.py (path:/tmp/pip-gwRXBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:46 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)) 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:46 INFO - Running setup.py (path:/tmp/pip-3UDj7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:46 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)) 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:46 INFO - Running setup.py (path:/tmp/pip-Si6JD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:46 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)) 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:46 INFO - Running setup.py (path:/tmp/pip-_c7Zsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:46 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)) 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:46 INFO - Running setup.py (path:/tmp/pip-dLL0Kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:46 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)) 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:46 INFO - Running setup.py (path:/tmp/pip-LHYkB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:46 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)) 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:46 INFO - Running setup.py (path:/tmp/pip-Wy4o96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:46 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)) 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:46 INFO - Running setup.py (path:/tmp/pip-OEVrV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:46 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)) 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:46 INFO - Running setup.py (path:/tmp/pip-5k7uR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:46 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)) 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:46 INFO - Running setup.py (path:/tmp/pip-hqyee2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:46 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)) 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:46 INFO - Running setup.py (path:/tmp/pip-9PvxU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:46 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)) 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:46 INFO - Running setup.py (path:/tmp/pip-z9Z2KD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:46 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)) 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:46 INFO - Running setup.py (path:/tmp/pip-ao5hjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:47 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)) 08:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:47 INFO - Running setup.py (path:/tmp/pip-R2kyAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:47 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)) 08:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:47 INFO - Running setup.py (path:/tmp/pip-vL1VGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:47 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)) 08:40:47 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)) 08:40:47 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)) 08:40:47 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)) 08:40:47 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)) 08:40:47 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)) 08:40:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:40:47 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 08:40:47 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 08:40:47 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 08:40:47 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 08:40:47 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 08:40:47 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 08:40:49 INFO - Downloading blessings-1.6.tar.gz 08:40:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:40:49 INFO - Installing collected packages: blessings 08:40:49 INFO - Running setup.py install for blessings 08:40:49 INFO - Successfully installed blessings 08:40:49 INFO - Cleaning up... 08:40:49 INFO - Return code: 0 08:40:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:40:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:49 INFO - Reading from file tmpfile_stdout 08:40:49 INFO - Current package versions: 08:40:49 INFO - argparse == 1.2.1 08:40:49 INFO - blessings == 1.6 08:40:49 INFO - blobuploader == 1.2.4 08:40:49 INFO - docopt == 0.6.1 08:40:49 INFO - functools32 == 3.2.3-2 08:40:49 INFO - jsonschema == 2.5.1 08:40:49 INFO - manifestparser == 1.1 08:40:49 INFO - mozInstall == 1.12 08:40:49 INFO - mozcrash == 0.17 08:40:49 INFO - mozdebug == 0.1 08:40:49 INFO - mozdevice == 0.48 08:40:49 INFO - mozfile == 1.2 08:40:49 INFO - mozhttpd == 0.7 08:40:49 INFO - mozinfo == 0.9 08:40:49 INFO - mozleak == 0.1 08:40:49 INFO - mozlog == 3.4 08:40:49 INFO - moznetwork == 0.27 08:40:49 INFO - mozprocess == 0.23 08:40:49 INFO - mozprofile == 0.28 08:40:49 INFO - mozrunner == 6.12 08:40:49 INFO - mozscreenshot == 0.1 08:40:49 INFO - mozsystemmonitor == 0.3 08:40:49 INFO - moztest == 0.7 08:40:49 INFO - mozversion == 1.4 08:40:49 INFO - psutil == 3.1.1 08:40:49 INFO - requests == 1.2.3 08:40:49 INFO - wsgiref == 0.1.2 08:40:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:49 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')]} 08:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:49 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')]} 08:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:49 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 0x7fbfd7518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25acca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a9f60>, '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 0x25aad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', '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 08:40:49 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 08:40:49 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 08:40:49 INFO - Using env: {'DISPLAY': ':0', 08:40:49 INFO - 'HOME': '/home/cltbld', 08:40:49 INFO - 'LANG': 'en_US.UTF-8', 08:40:49 INFO - 'LANGUAGE': 'en_US:en', 08:40:49 INFO - 'LOGNAME': 'cltbld', 08:40:49 INFO - 'MAIL': '/var/mail/cltbld', 08:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:49 INFO - 'MOZ_NO_REMOTE': '1', 08:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:49 INFO - 'NO_EM_RESTART': '1', 08:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:49 INFO - 'PWD': '/builds/slave/test', 08:40:49 INFO - 'SHELL': '/bin/bash', 08:40:49 INFO - 'SHLVL': '1', 08:40:49 INFO - 'TERM': 'linux', 08:40:49 INFO - 'TMOUT': '86400', 08:40:49 INFO - 'USER': 'cltbld', 08:40:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', 08:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:49 INFO - '_': '/tools/buildbot/bin/python'} 08:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:49 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)) 08:40:49 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)) 08:40:49 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)) 08:40:49 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)) 08:40:49 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)) 08:40:49 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)) 08:40:49 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)) 08:40:49 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)) 08:40:49 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)) 08:40:49 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)) 08:40:49 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)) 08:40:49 INFO - Cleaning up... 08:40:49 INFO - Return code: 0 08:40:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:40:49 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')]} 08:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:49 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')]} 08:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:49 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 0x7fbfd7518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25acca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a9f60>, '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 0x25aad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', '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 08:40:49 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 08:40:49 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 08:40:49 INFO - Using env: {'DISPLAY': ':0', 08:40:49 INFO - 'HOME': '/home/cltbld', 08:40:49 INFO - 'LANG': 'en_US.UTF-8', 08:40:49 INFO - 'LANGUAGE': 'en_US:en', 08:40:49 INFO - 'LOGNAME': 'cltbld', 08:40:49 INFO - 'MAIL': '/var/mail/cltbld', 08:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:49 INFO - 'MOZ_NO_REMOTE': '1', 08:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:49 INFO - 'NO_EM_RESTART': '1', 08:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:49 INFO - 'PWD': '/builds/slave/test', 08:40:49 INFO - 'SHELL': '/bin/bash', 08:40:49 INFO - 'SHLVL': '1', 08:40:49 INFO - 'TERM': 'linux', 08:40:49 INFO - 'TMOUT': '86400', 08:40:49 INFO - 'USER': 'cltbld', 08:40:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', 08:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:49 INFO - '_': '/tools/buildbot/bin/python'} 08:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:40:49 INFO - Cleaning up... 08:40:49 INFO - Return code: 0 08:40:49 INFO - Running post-action listener: _resource_record_post_action 08:40:49 INFO - Running post-action listener: _start_resource_monitoring 08:40:50 INFO - Starting resource monitoring. 08:40:50 INFO - [mozharness: 2016-09-23 15:40:50.017517Z] Finished create-virtualenv step (success) 08:40:50 INFO - [mozharness: 2016-09-23 15:40:50.017975Z] Running install step. 08:40:50 INFO - Running pre-action listener: _resource_record_pre_action 08:40:50 INFO - Running main action method: install 08:40:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:50 INFO - Reading from file tmpfile_stdout 08:40:50 INFO - Detecting whether we're running mozinstall >=1.0... 08:40:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:40:50 INFO - Reading from file tmpfile_stdout 08:40:50 INFO - Output received: 08:40:50 INFO - Usage: mozinstall [options] installer 08:40:50 INFO - Options: 08:40:50 INFO - -h, --help show this help message and exit 08:40:50 INFO - -d DEST, --destination=DEST 08:40:50 INFO - Directory to install application into. [default: 08:40:50 INFO - "/builds/slave/test"] 08:40:50 INFO - --app=APP Application being installed. [default: firefox] 08:40:50 INFO - mkdir: /builds/slave/test/build/application 08:40:50 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'] 08:40:50 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 08:41:06 INFO - Reading from file tmpfile_stdout 08:41:06 INFO - Output received: 08:41:06 INFO - /builds/slave/test/build/application/firefox/firefox 08:41:06 INFO - Running post-action listener: _resource_record_post_action 08:41:06 INFO - [mozharness: 2016-09-23 15:41:06.263640Z] Finished install step (success) 08:41:06 INFO - [mozharness: 2016-09-23 15:41:06.263885Z] Running run-tests step. 08:41:06 INFO - Running pre-action listener: _resource_record_pre_action 08:41:06 INFO - Running main action method: run_tests 08:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:06 INFO - Python 2.7.3 08:41:06 INFO - Return code: 0 08:41:06 INFO - grabbing minidump binary from tooltool 08:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:06 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 0x25a9f60>, '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 0x25aad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:06 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 08:41:06 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 08:41:06 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 08:41:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:06 INFO - Return code: 0 08:41:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:41:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:41:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:06 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/FQbQ_FvgQ0quA9v3qn7h_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 08:41:06 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/FQbQ_FvgQ0quA9v3qn7h_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 08:41:06 INFO - Using env: {'DISPLAY': ':0', 08:41:06 INFO - 'HOME': '/home/cltbld', 08:41:06 INFO - 'LANG': 'en_US.UTF-8', 08:41:06 INFO - 'LANGUAGE': 'en_US:en', 08:41:06 INFO - 'LOGNAME': 'cltbld', 08:41:06 INFO - 'MAIL': '/var/mail/cltbld', 08:41:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:06 INFO - 'MOZ_NO_REMOTE': '1', 08:41:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:06 INFO - 'NO_EM_RESTART': '1', 08:41:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:06 INFO - 'PWD': '/builds/slave/test', 08:41:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:06 INFO - 'SHELL': '/bin/bash', 08:41:06 INFO - 'SHLVL': '1', 08:41:06 INFO - 'TERM': 'linux', 08:41:06 INFO - 'TMOUT': '86400', 08:41:06 INFO - 'USER': 'cltbld', 08:41:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050', 08:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:06 INFO - '_': '/tools/buildbot/bin/python'} 08:41:06 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/FQbQ_FvgQ0quA9v3qn7h_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 08:41:06 INFO - mozversion application_buildid: 20160923055359 08:41:06 INFO - mozversion application_changeset: 4dd6247f67104db93b1a495aacb2cf5410a62af1 08:41:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:41:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:06 INFO - mozversion application_name: Firefox 08:41:06 INFO - mozversion application_remotingname: firefox-dev 08:41:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:41:06 INFO - mozversion application_vendor: Mozilla 08:41:06 INFO - mozversion application_version: 51.0a2 08:41:06 INFO - mozversion platform_buildid: 20160923055359 08:41:06 INFO - mozversion platform_changeset: 4dd6247f67104db93b1a495aacb2cf5410a62af1 08:41:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:41:06 INFO - mozversion platform_version: 51.0a2 08:41:06 INFO - using testdate: 1474645266 08:41:06 INFO - actual date: 1474645266 08:41:06 INFO - starting webserver on 'localhost:37587' 08:41:06 INFO - SUITE-START | Running 2 tests 08:41:06 INFO - TEST-START | dromaeo_css 08:41:06 INFO - operating with platform_type : linux_ 08:41:06 INFO - Initialising browser for dromaeo_css test... 08:41:06 INFO - TEST-INFO | started process 31384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnCl9Sk/profile http://localhost:37587/getInfo.html) 08:41:10 INFO - PROCESS | 31384 | __metrics Screen width/height:1600/1200 08:41:10 INFO - PROCESS | 31384 | colorDepth:24 08:41:10 INFO - PROCESS | 31384 | Browser inner width/height: 1024/697 08:41:10 INFO - PROCESS | 31384 | __metrics 08:41:10 INFO - PROCESS | 31384 | 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" 08:41:10 INFO - PROCESS | 31384 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:41:11 INFO - PROCESS | 31384 | console.error: PushService: 08:41:11 INFO - PROCESS | 31384 | stateChangeProcessEnqueue: Error transitioning state 08:41:11 INFO - PROCESS | 31384 | UnknownError 08:41:11 INFO - TEST-INFO | 31384: exit 0 08:41:11 INFO - Browser initialized. 08:41:11 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:11 INFO - TEST-INFO | started process 31478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnCl9Sk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:23 INFO - PROCESS | 31478 | RSS: Main: 144576512 08:41:23 INFO - PROCESS | 31478 | 08:42:14 INFO - PROCESS | 31478 | 1474645334691 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] 08:44:23 INFO - PROCESS | 31478 | Cycle 1(1): loaded http://localhost:37587/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37587/tests/dromaeo/cssquery-ext.html) 08:44:24 INFO - PROCESS | 31478 | RSS: Main: 245583872 08:44:24 INFO - PROCESS | 31478 | 08:47:27 INFO - PROCESS | 31478 | Cycle 1(1): loaded http://localhost:37587/tests/dromaeo/cssquery-ext.html (next: http://localhost:37587/tests/dromaeo/cssquery-jquery.html) 08:47:27 INFO - PROCESS | 31478 | RSS: Main: 229351424 08:47:27 INFO - PROCESS | 31478 | 08:50:29 INFO - PROCESS | 31478 | Cycle 1(1): loaded http://localhost:37587/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37587/tests/dromaeo/cssquery-mootools.html) 08:50:30 INFO - PROCESS | 31478 | RSS: Main: 205979648 08:50:30 INFO - PROCESS | 31478 | 08:53:32 INFO - PROCESS | 31478 | Cycle 1(1): loaded http://localhost:37587/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37587/tests/dromaeo/cssquery-prototype.html) 08:53:32 INFO - PROCESS | 31478 | RSS: Main: 224960512 08:53:32 INFO - PROCESS | 31478 | 08:56:35 INFO - PROCESS | 31478 | Cycle 1(1): loaded http://localhost:37587/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37587/tests/dromaeo/cssquery-yui.html) 08:56:36 INFO - PROCESS | 31478 | RSS: Main: 174764032 08:56:36 INFO - PROCESS | 31478 | 08:59:38 INFO - PROCESS | 31478 | Cycle 1(1): loaded http://localhost:37587/tests/dromaeo/cssquery-yui.html (next: http://localhost:37587/tests/dromaeo/cssquery-dojo.html) 08:59:39 INFO - PROCESS | 31478 | RSS: Main: 259723264 08:59:39 INFO - PROCESS | 31478 | 08:59:39 INFO - PROCESS | 31478 | __start_tp_report 08:59:39 INFO - PROCESS | 31478 | _x_x_mozilla_page_load 08:59:39 INFO - PROCESS | 31478 | _x_x_mozilla_page_load_details 08:59:39 INFO - PROCESS | 31478 | |i|pagename|runs| 08:59:39 INFO - PROCESS | 31478 | |0;dojo.html;3022.5768392425066;3054.037978036919;3067.3405217878153;3076.3078307380856;3104.8913288034923;5390.51485366317;5470.917936230955;5476.479734425223;5517.972410137953;5518.337799464065;5559.277293951781;5567;5582.27430434044;5589.105743081108;5599.216109744639;4997.30037794709;5014.197728363462;5050.823221187259;5096.261042148886;5127.48725127488;4941.579965702902;4959.553640172384;5067.797288108472;5120.871978200556;5124.461931497176;4971.776270067856;4984.277279794428;5016.27264046713;5021.874453138665;5039.420466646327;5059.747012649371;5068.087744206042;5144.536991670768;5150.665206761549;5173;4743.501932297094;4986.177280748672;5004.599632029429;5084.110280700899;5098.4136824265315;5273.683578985273;5362.946370536322;5375.489328513824;5427.4301198374;5515.917261241085;5735.168400581934;5735.283089613798;5894.734736936848;5898.1152827076285;5898.941010589882;5636.379998200195;5921.023031199847;5924.407559244084;5926.348101708809;5938.2280303560265;5314.787408503656;5451.209574611659;5488.533474654699;5504.6421982571;5553.16702494629;6024.457798798129;6057.575969682168;6060.151578778975;6060.818175454743;6069.15031895535;5648.435156484319;5813.389594092644;5814.738336774771;5824.446677565625;5824.475797178275;5753.741081651336;5789.478946894799;5790.971045144747;5817.272840894888;5900.144479050599;5830.2420685310635;5836.328822185418;5838.854028649318;5849.356570777211;5908.940910590925;5863.530917526673;5918.763249469973;5920.555958303058;5927.288725352985;5947.970260148758;4406.471223453206;4434.312681534368;4499.10017996402;4507.143642707875;4549.363089167519;4034.2738307104414;4039.5758445363404;4043.555208927016;4045.130296986103;4067.8576249831112;5674.631148975386;5689.544836413077;5694.686792226385;5699.646818882787;5742;5680.289963754531;5724.542036637059;5819.679917604488;5849.766009359578;6009.549283803644;5610.18652295423;5618.494335509824;5619.129034999582;5629.549636029108;5651.2935883014625;5134.383873935077;5135.589152867761;5140.56305214061;5145.794168233228;5164.509371609691;5806.912896306474;5849.853753656193;5995.100734889627;6078.908816367758;6081.543884208702;5863.530917526673;5869;5892.705364731832;5900.203472531153;5954.940450595612;6071.514278857592;6104.26748790148;6104.786332478342;6113.29697084841;6115.082737589397;5657.830265092054;5677.063284558167;5807.303123625192;5830.271216097988;5832.096025116114;5826.067829147316;5908.734106965283;5910.852228694317;5948.40515948419;6009.759609615741;5771.624844385102;5826.271716035496;5835.503982161564;5840.094785308284;5840.94159058421;5574.832755017356;5809.419058094326;5842.123681447647;5844.736986835517;5850.473457388855;5544.916826247691;5671.716414179357;5683.9715801420725;5692.402297758676;5810.82567522975;5802.1586869902785;5848.970755146197;5850.5904586678525;5850.94149058504;5852.824415267549;5485.862853428696;5519.641223320471;5717.656940583578;5726.141078838207;5727.455891690282 08:59:39 INFO - PROCESS | 31478 | |1;ext.html;583.6848102024907;606.9393060693928;627.7677259414017;628.4187126907609;647.1683886206224;35305.82347088264;47187.29219061717;48913.51086489134;48928.75535622326;49060.50939490604;48860;49123.263151052764;49201.50798492014;49263.50736492634;49359.75320123394;8493.108223636522;9334.813303733921;9488.335816492814;9491.620335186619;9497.240220782356;8457.70398036069;11186.272892261977;11430.542778288858;11433.656990290305;11790.528378864836;11540.307581545092;11580.82628760565;11607.593734219305;11619.535218591247;11629.302241865473;11353.489092990836;11364.090872730161;11431.714207144805;11437.656870293904;11451;11299.717507062389;11365.204435689506;11400.94299528497;11402.885971140347;11416.257943233662;45592.77203613994;45882.77058614719;46001;46020.53979460196;46053.769731151464;3891.902702432462;3950.7036972227197;3991.261616600938;4035.1122752994293;4153.460050193486;33459.49810752841;33756;34012.82993585041;34121.2395949048;34294.828525857214;4683.929741053887;4708.552687494683;4709.505501922283;4719.622430205575;4772.308015337791;387950;388635;389231;391444.99999999715;392681;66144;66401.66799165973;66441.6677916617;66501;66542;41093.38359924604;41733.1653366937;42021.36967945483;44752.10495790066;71040.64479677672;20021;20214.090365933567;20258.797412025986;20275.493112672302;20295.898520507304;13377.933110334581;13767.036307458582;15243.618909527351;15574.143422111893;15800.20998950048;20150.596988060155;20852.791472085388;21357;21526.354209373745;21603.459913501974;7372.741954031583;7409.370203532652;7508.3993280537425;7620.1998790127345;7658.578778167254;1010.9241806864515;1116.9609063682894;1122.4275619434147;1126.4536699700639;1150.327058670687;35045.47431788525;35611.28777424437;35666.82166589202;35854.46218306728;35939.82030089885;1149.436775979764;1155.1105648650491;1176.858776946772;1218.792805223114;1256.7989121740477;16901.32394704198;19010.80989190118;20151.798482015285;20246.898765506077;20382.286619968527;397901;403216;403777;586499;589471;68125.65937170382;69133;69133.3086669137;69151.65424172847;69301.30698693049;1377.9448822047207;1417.6739349949364;1486.138039936834;1504.653929596199;1529.3194528434963;33714.662853371156;35259.82370088133;36727.632723672425;37215.62784372122;37328.44007339838;60828.69585652043;62206.68896655488;62483;62552.68723656353;62562.374376257474;542981;557001;561039;562951;563400;45354;49066.75466622644;49437;49447.50552494429;49512.50487495079;53713.731431342596;54131;54307.18539221994;54578;54689.72655136699;44778.55221447744;45231.54768452273;46188.53811461977;46944.06111877812;47363;46620;47442;47559.52440475689;47787;48050.519494804605;45090;45657.08685826199;45811.3128303069;46336.53663463322;46347.76826115983;38686.22627547377;40573;41087.794561027;41351.37972930469;41928;30272.243193920327;30624.693753062184;30824.537631935986;31023.84488077545;31106.844465777525 08:59:39 INFO - PROCESS | 31478 | |2;jquery.html;394.7710328009751;412.85756414037166;425.7232798680858;426.8676710219832;438.32716779743083;14830.332635031422;16678;20644.690329645047;20818.271360502386;22385.216517421894;17115.486535403958;17567.03381314027;18595.907020464914;21241.256556020544;21364.4658883528;5754.568407369454;5830.271216097988;5884;5914.763409463616;5951.940480595182;5885.823425297248;5992.700364981755;5993.250843644544;5995.460408563228;5996.580239383245;4283;4558.772061396933;4604.769761511928;6566.63883486408;6707.564008339466;5494.587905907073;6656.500762442788;6682.699278532454;6684.933150668504;6696.497762667795;5583.972080139614;5689.715514224272;5694.402087780765;5702.45826646468;5707.229524014247;15286.541403757905;15392.769108463383;15485.070895746292;15505.302261398152;15650.686986260325;2646.6691663542056;2711.850848203348;2720.1159623122367;2922.7515661168613;2933.5306350983956;11230.3261804292;11449.31304121747;11455.198136130473;12853.67865803353;13107.606771796765;1927.267638297452;1939.8254157125925;1998.280618977167;2002.4493264352275;2043.6423625865564;53100;76608;83291.5835420819;84284;90846;11849;11890.702732431586;11911.10666700001;11992.76014479723;12087.879121208676;17188.742168867477;17200.569985750455;17218.139093045298;17227.138643067796;17270.568235794206;9033.63865445388;9242.844644419447;9388.155066044088;9429.858552121723;9516.19112375442;8208.876866847002;8305.667773289;8308.086110527836;8486.490810551386;8497.532635705096;5123.795048198031;5158.845234642967;5174.404943431554;5205.505476979681;5237.371515418175;2055.691646253044;2080.417483104733;2113.4293740689927;2117.163720330461;2158.4388059104745;928.2017464980112;1002.9949850250702;1031.582209205273;1048.1981284317503;1060.48036462133;20361.287354942506;20885.16459341609;20935.47661308449;21107.366778996653;21132;1039.3763741755038;1043.7703705184847;1077.353587847301;1129.6949823547595;1131.9207655464038;11042;11658.242214256046;11717.00405465528;11836.467358968866;12028.398580070962;487208;492039;495522;536989;539297;98345;99736;100430;101559.98440015654;103040;1068.1188019883627;1068.2201992545486;1107.0977153619774;1118.1557923767502;1119.7480566872389;18653.44039678812;19010.23959041623;19091.713624295924;19206.61586768229;19255.903720481307;40903;41296.1740765189;43350;43628;44285;56752.43247567637;57469;59157.70421148039;66110.66944665246;66428.33571664222;9140.131687489678;9350.251979841732;9559.23526117895;9712.5143742814;9751.756206094904;8085.83828323442;10516.57933682644;14418.855811441752;14636.926815365856;14724.55826325212;12303.507859685513;12601.87398126007;12730.809037864625;12893.355332233163;13194.868051319363;10034.598616055568;11891;12165.33090680021;12304.138710290194;12651.93674031624;12294.385280736105;12357.567485137977;12371.257724536557;12832.294223817406;12843.807342890052;7649.847003060019;7962.402819788424;9113.726588202364;9209.585568649292;9496.097870702271;11907.345096019802;12167.087468440079;12260.509579616715;12291.508339666314;12703.36483175819 08:59:39 INFO - PROCESS | 31478 | |3;mootools.html;1415.3560130140786;1514.3942423030787;1560.3446552447972;1688.1812321024302;1844.0687452836307;7737.342325902298;8602.397832151752;8754.080821513744;8762.737117886465;9182.724518264462;8953.865692014626;9034.367594268404;9034.72895813125;9037.593308301126;9049.728508144766;2460.07747094839;2496.400863792686;2496.6255061740794;2504.499100179962;2504.74952504749;2367.6685264062958;2488.701355837302;2496.3509487533283;2496.5755821510297;2498.375406148463;2421.8910149043336;2442.157455677788;2485.2171565956755;2485.3289611804894;2487.4900645367657;2363.8108951283943;2385.9880700596473;2387.5463661904355;2387.7970372518357;2391.1630929174826;2299.298713892262;2350.7414184439867;2362.5393048355577;2366.25462979161;2366.7869891709656;7877.251661092187;8084.717034903809;8918;8966.058563850767;8983.146601072887;5140.1004824155625;5287.973560132214;5292.894142117175;5342.332208473941;5368.060589396879;3447.8103704296254;3475.5134281200653;3489.8604055837736;3505.439129739255;3518.138056176253;1155.4338374196668;1156.8033434316187;1182.4265231362783;1201.4113084588575;1229.9016078713682;12281;12293.446794894162;12300.323482208474;12315.384230788515;12348.814767778491;4511.300748384006;4590.28850528162;4746.620270378361;4750.7387093709485;4760.166970780099;10473.790524189473;10491.580336786596;10518.789624207473;10537.894621053845;10540.420276884844;5413.756380962866;5438;5444.373897001817;5445.700486473282;5449.5640348772795;4858.975705121523;4941.950580494221;5030.924536131961;5031.949680503221;5031.974840125849;4005.579414161471;4026.295398305285;4091.8772436826944;4097.590240975938;4128.195001974586;1239.2007155384727;1256.2023115321836;1261.482792055253;1270.6823294176456;1282.9807552886714;1011.544804837826;1013.5236438873718;1034.0796690945065;1040.15747244732;1040.9063184313447;6182.1345011698395;6209.316975132731;6212.751489940442;6247.656378899113;6333.524985626096;455.90426010537493;469.5867636479944;471.58759515251353;473.96682232244103;478.9233722604367;4088.0597462583773;4112.485939257593;4216.683748718859;4298.075913678574;4315.697901146952;9878.802423951482;10285.74285642865;10392.636257731094;10500.317479363817;10753;9791.510424478747;10180.23648226386;10872.61945831892;10899.891001089887;10908;7569.091708994956;7738.61306934651;7893.13175550689;8209.753707388787;8214.466059705981;6201.751929922933;6292.685365731603;6468.191476065492;6479.902801458076;6562.146920900253;10112.393256404639;10139.08748212635;10153.39079655223;10174.898251017396;10208.234382421497;9722;10057.597696092074;10276.537555810157;10403.687889363331;10429.791404171723;7457.515261507984;7568.205338439605;7583.355414789805;7585.6965721370525;7587.165411804586;8593.140685931357;8607.956960215159;8696.043435222247;8696.739097827076;8710.956445217987;7663;7835.960820195863;7859.292663660298;7941.126476087741;7981.640826162953;7769.106552746506;7776.222377762178;7803.258690424401;7924.366050716044;7970.844227587083;7282.817929551804;7311.195768465358;7324.08448943882;7395.001674773836;7415.443841711785;5259.55293800016;5302.2659383588425;5372.946270537244;5414.377346605191;5496.917546236889;5286.603504737083;5310.654807437504;5314.840554783363;5384.488473595002;5475.151351540518 08:59:39 INFO - PROCESS | 31478 | |4;prototype.html;347.3001901169143;355.8203107430747;360.13208168314367;363.4058314655537;365.18199233716484;5481.534069604083;5622.578306627004;5628.662280263182;5638.097904335307;5641.5204707599905;5548.58385621078;5557;5575.721213939307;5595.720213989294;5595.972020139904;3922.568517463091;4168.520620128678;4389.868303950887;4398.73607583546;4465.46414430268;4290.270653988814;4369.519352871182;4369.803358848843;4378.759168245745;4380.802863871133;4343.67422443318;4346.5436129206455;4347.978260108695;4349.521552629224;4364.432623758923;4135.875923722293;4368.378972616437;4376;4383.934240986404;4393.406890069831;3701.38927077032;3900.64894159527;3914.7846868422225;3928.998105483112;3936.862209822671;5407.242985981966;5426.5116139547235;5436.673799572039;5437.619366644337;5458.754356053987;4809.591184749301;5006.3241462402475;5037.748112594392;5039.3196918415915;5047.848564543069;5727.627704199255;5752.36723960364;5760.74076666551;5784.248047753807;5786.379813652185;4216.388623649554;4235.449391579075;4239.321708526621;4240.215560121387;4257.063446041897;5636.2954630671165;5820.82537523875;5960.1357803118735;6060.575759696823;6104.877902441971;4275.786210689453;4296.183725092223;4304.956950430518;4310.224159651293;4311.892202694958;4355.2813785725;4401.679496151141;4402.25161722508;4414.448193975753;4420.182266280748;4879;4903.828366007173;4928.950710492921;5027.145385284437;5043.52086551777;5775.335836378787;5779.104238842986;5807.245058142415;5813.1979086483325;5826.941730582725;1473.9705205895823;1484.717903598313;1487.8129150149264;1498.887583431247;1504.4809540708438;949.6846867088993;983.3608154699502;984.5871174864093;986.9013098690217;999.3554157568473;4929.658412254223;4935.925961110586;4948.925766113512;4996.925046124311;5016.974915125401;5158.426679862678;5192.532672059533;5206.947930520722;5225.764840582183;5236.973815130977;4979.925301120486;5002.89994200114;5042.520960508746;5289.68261904287;5735.569832262597;3153.3220357623222;3187.5974571188603;3188.2826364068364;3195.6578237139993;3196.5684632574303;6034.069097888633;6178.258608966863;6188.721507532172;6190.535709821781;6222.439980401786;6095.4818840398175;6107.175531303306;6124.77504499102;6131.63210207389;6134.171886795226;6136.417040381246;6137.3735959970645;6146.78486252979;6149.754009839557;6156.322804491502;5817.447342502455;5965.791197308074;5997.970010149921;6006;6009.639421634716;5922.785828904978;5927.436893495111;5932.644041357532;5933.376995415592;5939.792107276225;5838.241028666416;5911.6403227257115;6043.667598282137;6112.3802192419935;6157.722902469489;4319.092990472036;4341.479022517318;4343.543927887653;4352.564743525622;4391.726399344155;5820.126980952891;5909.497692696169;6075.36208698098;6086.7260973255425;6090.984962443619;5806.9419305806405;5808.593398462067;5836.920169768437;5855.3559108498885;5890.087036509348;5847.970760146172;5854.619449735754;5864.970675146597;5882.647041177543;5929.347771745019;5622.662640241599;5740.167675687086;5749.8212866361455;5751.798687045934;5785.206585958366;5834.833033393424;5849.473547380756;5882.882342353215;5919.83925867064;5952.910706339322;5485.561155107662;5759.193712880284;5760.1935728998815;5775.27809023872;5798.536117110537 08:59:39 INFO - PROCESS | 31478 | |5;yui.html;815.7144999250263;816.6937398475571;822.3585603229479;831.1688311688312;919.8160367926414;17293.56766080847;18102.818971810277;18148.81851181488;18180.90909545452;18217.36239231627;16113.919430402831;16239.269232884519;16261.18694065295;16262.105584192865;16276.83723162768;717.4977515738991;733.2667332667332;858.0732808566733;879.560219890055;883.1301168349171;888.9288856891433;892.2237653241689;894.1773568317132;896.3053633434108;896.4397251717677;758.9620518974057;941.2187884056251;945.5461378538306;945.9763505912373;946.0586716217339;779.9181085985975;896.4755617963499;916.5646317998963;925.3938670171049;927.3554879358849;685.1572565744112;686.080651926416;687.3229868579446;689.2659317826499;690.1786873620426;14707.19110448925;14762.188079655614;14783.556493305217;14871.107733536022;14899.329530171168;15255.61860953474;15256.618584535365;15276;15303.464378746801;15530.378784848706;13866.168029918137;14085.859141408557;14134.575962721136;14142.787858182135;14341.928290358586;4582.656300777455;4634.165850146972;4670.439547254351;4715.693479923828;4731.077439899221;88032.11967880304;89719.55140224322;93158;93555.53222233846;95549.52225238898;12708.745825083446;12823.35883205836;12984.480620775252;13043.543475978295;13068.673283167807;24546.754532454805;24657.63013554798;24705.629415558782;24737.5052498949;24914.750852491605;9237;9494.762630934281;9548.18840398574;9642.807143857224;9734.221262299;5228.947710522846;5385.467722131805;5459.945400546023;5461.2354270402175;5513.917291240635;3604.4232922732235;3718.1076541629814;3726.2174943261675;3726.9627303726616;3731.6268373162466;565.4373897971544;571.4571157400403;610.0665981049002;616.0205273614885;668.9933100668931;625.2153547298112;675.4967549175896;756.9327248579476;761.2007392238238;810.3768003539791;10249.59001639941;10909.127269818395;10958.397288149228;11027.724306892393;11188.944055279671;772.3577235772314;780.2704471319335;808.551254053994;817.6320655704957;828.200786241268;5074.974625126851;5108.61685373591;5112.488751124932;5133.563647090039;5190.480951904779;75146;128137.3593132047;129435;130754.34622827015;136376.31811840876;109864.45067774769;111292.44353778179;113247;114294.42852785683;118283;69502;95398;95812;96342.9999999986;102618.48690756499;9831.508424578886;9861;9868;9916.851247231441;10156.085952264331;58379.4162058374;60003.39996599978;60202.39797601968;60359.09461357995;61800.69099654473;66791.3320866785;70923.64538177276;71104.64447677729;78259.2174078252;80727.19272807431;13204.60386188416;14492.275386230856;14620.488282910048;14625.122492650475;14925.402983880524;13573.86426135726;13659;13660.86339136596;14581.781273281122;16592.91703541523;14880.330385132911;15192.924035379752;15579.688406232039;15607.21963901823;15865.365385384917;12057;14961.40154393812;15515;15593.532194034196;16014.519564413085;14466.20435876037;14658.853411466176;14668.926655366655;15176.772348414563;16398.918005409898;11900.285982841056;12315.676662630993;12340.691482712646;12912.677183070498;13061.412236449572;13263.204207747565;13339.66650833737;13354.599362019155;13535.390907409386;13653 08:59:39 INFO - PROCESS | 31478 | __end_tp_report 08:59:39 INFO - PROCESS | 31478 | __start_cc_report 08:59:39 INFO - PROCESS | 31478 | _x_x_mozilla_cycle_collect,854 08:59:39 INFO - PROCESS | 31478 | __end_cc_report 08:59:39 INFO - PROCESS | 31478 | __startTimestamp1474646379057__endTimestamp 08:59:39 INFO - PROCESS | 31478 | 08:59:39 INFO - PROCESS | 31478 | ------- Summary: start ------- 08:59:39 INFO - PROCESS | 31478 | Number of tests: 6 08:59:39 INFO - PROCESS | 31478 | 08:59:39 INFO - PROCESS | 31478 | [#0] dojo.html Cycles:165 Average:5470.32 Median:5689.54 stddev:627.69 (11.0%) stddev-sans-first:599.52 08:59:39 INFO - PROCESS | 31478 | Values: 3022.6 3054.0 3067.3 3076.3 3104.9 5390.5 5470.9 5476.5 5518.0 5518.3 5559.3 5567.0 5582.3 5589.1 5599.2 4997.3 5014.2 5050.8 5096.3 5127.5 4941.6 4959.6 5067.8 5120.9 5124.5 4971.8 4984.3 5016.3 5021.9 5039.4 5059.7 5068.1 5144.5 5150.7 5173.0 4743.5 4986.2 5004.6 5084.1 5098.4 5273.7 5362.9 5375.5 5427.4 5515.9 5735.2 5735.3 5894.7 5898.1 5898.9 5636.4 5921.0 5924.4 5926.3 5938.2 5314.8 5451.2 5488.5 5504.6 5553.2 6024.5 6057.6 6060.2 6060.8 6069.2 5648.4 5813.4 5814.7 5824.4 5824.5 5753.7 5789.5 5791.0 5817.3 5900.1 5830.2 5836.3 5838.9 5849.4 5908.9 5863.5 5918.8 5920.6 5927.3 5948.0 4406.5 4434.3 4499.1 4507.1 4549.4 4034.3 4039.6 4043.6 4045.1 4067.9 5674.6 5689.5 5694.7 5699.6 5742.0 5680.3 5724.5 5819.7 5849.8 6009.5 5610.2 5618.5 5619.1 5629.5 5651.3 5134.4 5135.6 5140.6 5145.8 5164.5 5806.9 5849.9 5995.1 6078.9 6081.5 5863.5 5869.0 5892.7 5900.2 5954.9 6071.5 6104.3 6104.8 6113.3 6115.1 5657.8 5677.1 5807.3 5830.3 5832.1 5826.1 5908.7 5910.9 5948.4 6009.8 5771.6 5826.3 5835.5 5840.1 5840.9 5574.8 5809.4 5842.1 5844.7 5850.5 5544.9 5671.7 5684.0 5692.4 5810.8 5802.2 5849.0 5850.6 5850.9 5852.8 5485.9 5519.6 5717.7 5726.1 5727.5 08:59:39 INFO - PROCESS | 31478 | 08:59:39 INFO - PROCESS | 31478 | [#1] ext.html Cycles:180 Average:66114.50 Median:41222.38 stddev:127618.00 (309.6%) stddev-sans-first:127881.16 08:59:39 INFO - PROCESS | 31478 | Values: 583.7 606.9 627.8 628.4 647.2 35305.8 47187.3 48913.5 48928.8 49060.5 48860.0 49123.3 49201.5 49263.5 49359.8 8493.1 9334.8 9488.3 9491.6 9497.2 8457.7 11186.3 11430.5 11433.7 11790.5 11540.3 11580.8 11607.6 11619.5 11629.3 11353.5 11364.1 11431.7 11437.7 11451.0 11299.7 11365.2 11400.9 11402.9 11416.3 45592.8 45882.8 46001.0 46020.5 46053.8 3891.9 3950.7 3991.3 4035.1 4153.5 33459.5 33756.0 34012.8 34121.2 34294.8 4683.9 4708.6 4709.5 4719.6 4772.3 387950.0 388635.0 389231.0 391445.0 392681.0 66144.0 66401.7 66441.7 66501.0 66542.0 41093.4 41733.2 42021.4 44752.1 71040.6 20021.0 20214.1 20258.8 20275.5 20295.9 13377.9 13767.0 15243.6 15574.1 15800.2 20150.6 20852.8 21357.0 21526.4 21603.5 7372.7 7409.4 7508.4 7620.2 7658.6 1010.9 1117.0 1122.4 1126.5 1150.3 35045.5 35611.3 35666.8 35854.5 35939.8 1149.4 1155.1 1176.9 1218.8 1256.8 16901.3 19010.8 20151.8 20246.9 20382.3 397901.0 403216.0 403777.0 586499.0 589471.0 68125.7 69133.0 69133.3 69151.7 69301.3 1377.9 1417.7 1486.1 1504.7 1529.3 33714.7 35259.8 36727.6 37215.6 37328.4 60828.7 62206.7 62483.0 62552.7 62562.4 542981.0 557001.0 561039.0 562951.0 563400.0 45354.0 49066.8 49437.0 49447.5 49512.5 53713.7 54131.0 54307.2 54578.0 54689.7 44778.6 45231.5 46188.5 46944.1 47363.0 46620.0 47442.0 47559.5 47787.0 48050.5 45090.0 45657.1 45811.3 46336.5 46347.8 38686.2 40573.0 41087.8 41351.4 41928.0 30272.2 30624.7 30824.5 31023.8 31106.8 08:59:39 INFO - PROCESS | 31478 | 08:59:39 INFO - PROCESS | 31478 | [#2] jquery.html Cycles:180 Average:30041.64 Median:11624.58 stddev:84245.07 (724.7%) stddev-sans-first:84451.99 08:59:39 INFO - PROCESS | 31478 | Values: 394.8 412.9 425.7 426.9 438.3 14830.3 16678.0 20644.7 20818.3 22385.2 17115.5 17567.0 18595.9 21241.3 21364.5 5754.6 5830.3 5884.0 5914.8 5951.9 5885.8 5992.7 5993.3 5995.5 5996.6 4283.0 4558.8 4604.8 6566.6 6707.6 5494.6 6656.5 6682.7 6684.9 6696.5 5584.0 5689.7 5694.4 5702.5 5707.2 15286.5 15392.8 15485.1 15505.3 15650.7 2646.7 2711.9 2720.1 2922.8 2933.5 11230.3 11449.3 11455.2 12853.7 13107.6 1927.3 1939.8 1998.3 2002.4 2043.6 53100.0 76608.0 83291.6 84284.0 90846.0 11849.0 11890.7 11911.1 11992.8 12087.9 17188.7 17200.6 17218.1 17227.1 17270.6 9033.6 9242.8 9388.2 9429.9 9516.2 8208.9 8305.7 8308.1 8486.5 8497.5 5123.8 5158.8 5174.4 5205.5 5237.4 2055.7 2080.4 2113.4 2117.2 2158.4 928.2 1003.0 1031.6 1048.2 1060.5 20361.3 20885.2 20935.5 21107.4 21132.0 1039.4 1043.8 1077.4 1129.7 1131.9 11042.0 11658.2 11717.0 11836.5 12028.4 487208.0 492039.0 495522.0 536989.0 539297.0 98345.0 99736.0 100430.0 101560.0 103040.0 1068.1 1068.2 1107.1 1118.2 1119.7 18653.4 19010.2 19091.7 19206.6 19255.9 40903.0 41296.2 43350.0 43628.0 44285.0 56752.4 57469.0 59157.7 66110.7 66428.3 9140.1 9350.3 9559.2 9712.5 9751.8 8085.8 10516.6 14418.9 14636.9 14724.6 12303.5 12601.9 12730.8 12893.4 13194.9 10034.6 11891.0 12165.3 12304.1 12651.9 12294.4 12357.6 12371.3 12832.3 12843.8 7649.8 7962.4 9113.7 9209.6 9496.1 11907.3 12167.1 12260.5 12291.5 12703.4 08:59:39 INFO - PROCESS | 31478 | 08:59:39 INFO - PROCESS | 31478 | [#3] mootools.html Cycles:180 Average:5851.29 Median:470.59 stddev:3261.89 (693.2%) stddev-sans-first:3254.00 08:59:39 INFO - PROCESS | 31478 | Values: 1415.4 1514.4 1560.3 1688.2 1844.1 7737.3 8602.4 8754.1 8762.7 9182.7 8953.9 9034.4 9034.7 9037.6 9049.7 2460.1 2496.4 2496.6 2504.5 2504.7 2367.7 2488.7 2496.4 2496.6 2498.4 2421.9 2442.2 2485.2 2485.3 2487.5 2363.8 2386.0 2387.5 2387.8 2391.2 2299.3 2350.7 2362.5 2366.3 2366.8 7877.3 8084.7 8918.0 8966.1 8983.1 5140.1 5288.0 5292.9 5342.3 5368.1 3447.8 3475.5 3489.9 3505.4 3518.1 1155.4 1156.8 1182.4 1201.4 1229.9 12281.0 12293.4 12300.3 12315.4 12348.8 4511.3 4590.3 4746.6 4750.7 4760.2 10473.8 10491.6 10518.8 10537.9 10540.4 5413.8 5438.0 5444.4 5445.7 5449.6 4859.0 4942.0 5030.9 5031.9 5032.0 4005.6 4026.3 4091.9 4097.6 4128.2 1239.2 1256.2 1261.5 1270.7 1283.0 1011.5 1013.5 1034.1 1040.2 1040.9 6182.1 6209.3 6212.8 6247.7 6333.5 455.9 469.6 471.6 474.0 478.9 4088.1 4112.5 4216.7 4298.1 4315.7 9878.8 10285.7 10392.6 10500.3 10753.0 9791.5 10180.2 10872.6 10899.9 10908.0 7569.1 7738.6 7893.1 8209.8 8214.5 6201.8 6292.7 6468.2 6479.9 6562.1 10112.4 10139.1 10153.4 10174.9 10208.2 9722.0 10057.6 10276.5 10403.7 10429.8 7457.5 7568.2 7583.4 7585.7 7587.2 8593.1 8608.0 8696.0 8696.7 8711.0 7663.0 7836.0 7859.3 7941.1 7981.6 7769.1 7776.2 7803.3 7924.4 7970.8 7282.8 7311.2 7324.1 7395.0 7415.4 5259.6 5302.3 5372.9 5414.4 5496.9 5286.6 5310.7 5314.8 5384.5 5475.2 08:59:39 INFO - PROCESS | 31478 | 08:59:39 INFO - PROCESS | 31478 | [#4] prototype.html Cycles:180 Average:4868.74 Median:5517.07 stddev:1417.53 (25.7%) stddev-sans-first:1380.29 08:59:39 INFO - PROCESS | 31478 | Values: 347.3 355.8 360.1 363.4 365.2 5481.5 5622.6 5628.7 5638.1 5641.5 5548.6 5557.0 5575.7 5595.7 5596.0 3922.6 4168.5 4389.9 4398.7 4465.5 4290.3 4369.5 4369.8 4378.8 4380.8 4343.7 4346.5 4348.0 4349.5 4364.4 4135.9 4368.4 4376.0 4383.9 4393.4 3701.4 3900.6 3914.8 3929.0 3936.9 5407.2 5426.5 5436.7 5437.6 5458.8 4809.6 5006.3 5037.7 5039.3 5047.8 5727.6 5752.4 5760.7 5784.2 5786.4 4216.4 4235.4 4239.3 4240.2 4257.1 5636.3 5820.8 5960.1 6060.6 6104.9 4275.8 4296.2 4305.0 4310.2 4311.9 4355.3 4401.7 4402.3 4414.4 4420.2 4879.0 4903.8 4929.0 5027.1 5043.5 5775.3 5779.1 5807.2 5813.2 5826.9 1474.0 1484.7 1487.8 1498.9 1504.5 949.7 983.4 984.6 986.9 999.4 4929.7 4935.9 4948.9 4996.9 5017.0 5158.4 5192.5 5206.9 5225.8 5237.0 4979.9 5002.9 5042.5 5289.7 5735.6 3153.3 3187.6 3188.3 3195.7 3196.6 6034.1 6178.3 6188.7 6190.5 6222.4 6095.5 6107.2 6124.8 6131.6 6134.2 6136.4 6137.4 6146.8 6149.8 6156.3 5817.4 5965.8 5998.0 6006.0 6009.6 5922.8 5927.4 5932.6 5933.4 5939.8 5838.2 5911.6 6043.7 6112.4 6157.7 4319.1 4341.5 4343.5 4352.6 4391.7 5820.1 5909.5 6075.4 6086.7 6091.0 5806.9 5808.6 5836.9 5855.4 5890.1 5848.0 5854.6 5865.0 5882.6 5929.3 5622.7 5740.2 5749.8 5751.8 5785.2 5834.8 5849.5 5882.9 5919.8 5952.9 5485.6 5759.2 5760.2 5775.3 5798.5 08:59:39 INFO - PROCESS | 31478 | 08:59:39 INFO - PROCESS | 31478 | [#5] yui.html Cycles:180 Average:22876.63 Median:4157.14 stddev:32966.31 (793.0%) stddev-sans-first:33017.17 08:59:39 INFO - PROCESS | 31478 | Values: 815.7 816.7 822.4 831.2 919.8 17293.6 18102.8 18148.8 18180.9 18217.4 16113.9 16239.3 16261.2 16262.1 16276.8 717.5 733.3 858.1 879.6 883.1 888.9 892.2 894.2 896.3 896.4 759.0 941.2 945.5 946.0 946.1 779.9 896.5 916.6 925.4 927.4 685.2 686.1 687.3 689.3 690.2 14707.2 14762.2 14783.6 14871.1 14899.3 15255.6 15256.6 15276.0 15303.5 15530.4 13866.2 14085.9 14134.6 14142.8 14341.9 4582.7 4634.2 4670.4 4715.7 4731.1 88032.1 89719.6 93158.0 93555.5 95549.5 12708.7 12823.4 12984.5 13043.5 13068.7 24546.8 24657.6 24705.6 24737.5 24914.8 9237.0 9494.8 9548.2 9642.8 9734.2 5228.9 5385.5 5459.9 5461.2 5513.9 3604.4 3718.1 3726.2 3727.0 3731.6 565.4 571.5 610.1 616.0 669.0 625.2 675.5 756.9 761.2 810.4 10249.6 10909.1 10958.4 11027.7 11188.9 772.4 780.3 808.6 817.6 828.2 5075.0 5108.6 5112.5 5133.6 5190.5 75146.0 128137.4 129435.0 130754.3 136376.3 109864.5 111292.4 113247.0 114294.4 118283.0 69502.0 95398.0 95812.0 96343.0 102618.5 9831.5 9861.0 9868.0 9916.9 10156.1 58379.4 60003.4 60202.4 60359.1 61800.7 66791.3 70923.6 71104.6 78259.2 80727.2 13204.6 14492.3 14620.5 14625.1 14925.4 13573.9 13659.0 13660.9 14581.8 16592.9 14880.3 15192.9 15579.7 15607.2 15865.4 12057.0 14961.4 15515.0 15593.5 16014.5 14466.2 14658.9 14668.9 15176.8 16398.9 11900.3 12315.7 12340.7 12912.7 13061.4 13263.2 13339.7 13354.6 13535.4 13653.0 08:59:39 INFO - PROCESS | 31478 | -------- Summary: end -------- 08:59:39 INFO - PROCESS | 31478 | 08:59:39 INFO - TEST-INFO | 31478: exit 0 08:59:39 INFO - TEST-OK | dromaeo_css | took 1113265ms 08:59:39 INFO - TEST-START | kraken 08:59:39 INFO - operating with platform_type : linux_ 08:59:39 INFO - Initialising browser for kraken test... 08:59:39 INFO - TEST-INFO | started process 31798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH_byYk/profile http://localhost:37587/getInfo.html) 08:59:43 INFO - PROCESS | 31798 | __metrics Screen width/height:1600/1200 08:59:43 INFO - PROCESS | 31798 | colorDepth:24 08:59:43 INFO - PROCESS | 31798 | Browser inner width/height: 1024/697 08:59:43 INFO - PROCESS | 31798 | __metrics 08:59:44 INFO - PROCESS | 31798 | 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" 08:59:44 INFO - PROCESS | 31798 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:59:44 INFO - PROCESS | 31798 | console.error: PushService: 08:59:44 INFO - PROCESS | 31798 | stateChangeProcessEnqueue: Error transitioning state 08:59:44 INFO - PROCESS | 31798 | UnknownError 08:59:45 INFO - TEST-INFO | 31798: exit 0 08:59:45 INFO - Browser initialized. 08:59:45 INFO - Running cycle 1/1 for kraken test... 08:59:45 INFO - TEST-INFO | started process 31889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH_byYk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:59:56 INFO - PROCESS | 31889 | RSS: Main: 144179200 08:59:56 INFO - PROCESS | 31889 | 08:59:59 INFO - PROCESS | 31889 | Cycle 1(1): loaded http://localhost:37587/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37587/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:00 INFO - PROCESS | 31889 | RSS: Main: 185593856 09:00:00 INFO - PROCESS | 31889 | 09:00:02 INFO - PROCESS | 31889 | Cycle 1(1): loaded http://localhost:37587/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37587/tests/kraken/driver.html?testName=audio-dft) 09:00:03 INFO - PROCESS | 31889 | RSS: Main: 176447488 09:00:03 INFO - PROCESS | 31889 | 09:00:06 INFO - PROCESS | 31889 | Cycle 1(1): loaded http://localhost:37587/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37587/tests/kraken/driver.html?testName=audio-fft) 09:00:06 INFO - PROCESS | 31889 | RSS: Main: 266825728 09:00:06 INFO - PROCESS | 31889 | 09:00:08 INFO - PROCESS | 31889 | Cycle 1(1): loaded http://localhost:37587/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37587/tests/kraken/driver.html?testName=audio-oscillator) 09:00:09 INFO - PROCESS | 31889 | RSS: Main: 173010944 09:00:09 INFO - PROCESS | 31889 | 09:00:11 INFO - PROCESS | 31889 | Cycle 1(1): loaded http://localhost:37587/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37587/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:00:12 INFO - PROCESS | 31889 | RSS: Main: 174292992 09:00:12 INFO - PROCESS | 31889 | 09:00:15 INFO - PROCESS | 31889 | Cycle 1(1): loaded http://localhost:37587/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37587/tests/kraken/driver.html?testName=imaging-darkroom) 09:00:15 INFO - PROCESS | 31889 | RSS: Main: 210202624 09:00:15 INFO - PROCESS | 31889 | 09:00:19 INFO - PROCESS | 31889 | Cycle 1(1): loaded http://localhost:37587/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37587/tests/kraken/driver.html?testName=imaging-desaturate) 09:00:19 INFO - PROCESS | 31889 | RSS: Main: 209821696 09:00:19 INFO - PROCESS | 31889 | 09:00:22 INFO - PROCESS | 31889 | Cycle 1(1): loaded http://localhost:37587/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37587/tests/kraken/driver.html?testName=json-parse-financial) 09:00:22 INFO - PROCESS | 31889 | RSS: Main: 209293312 09:00:22 INFO - PROCESS | 31889 | 09:00:24 INFO - PROCESS | 31889 | Cycle 1(1): loaded http://localhost:37587/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37587/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:00:25 INFO - PROCESS | 31889 | RSS: Main: 170901504 09:00:25 INFO - PROCESS | 31889 | 09:00:26 INFO - PROCESS | 31889 | Cycle 1(1): loaded http://localhost:37587/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37587/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:00:27 INFO - PROCESS | 31889 | RSS: Main: 178823168 09:00:27 INFO - PROCESS | 31889 | 09:00:29 INFO - PROCESS | 31889 | Cycle 1(1): loaded http://localhost:37587/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37587/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:00:29 INFO - PROCESS | 31889 | RSS: Main: 183205888 09:00:29 INFO - PROCESS | 31889 | 09:00:32 INFO - PROCESS | 31889 | Cycle 1(1): loaded http://localhost:37587/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37587/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:00:33 INFO - PROCESS | 31889 | RSS: Main: 185049088 09:00:33 INFO - PROCESS | 31889 | 09:00:35 INFO - PROCESS | 31889 | Cycle 1(1): loaded http://localhost:37587/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37587/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:00:36 INFO - PROCESS | 31889 | RSS: Main: 182931456 09:00:36 INFO - PROCESS | 31889 | 09:00:37 INFO - PROCESS | 31889 | Cycle 1(1): loaded http://localhost:37587/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37587/tests/kraken/driver.html?testName=ai-astar) 09:00:38 INFO - PROCESS | 31889 | RSS: Main: 234180608 09:00:38 INFO - PROCESS | 31889 | 09:00:38 INFO - PROCESS | 31889 | __start_tp_report 09:00:38 INFO - PROCESS | 31889 | _x_x_mozilla_page_load 09:00:38 INFO - PROCESS | 31889 | _x_x_mozilla_page_load_details 09:00:38 INFO - PROCESS | 31889 | |i|pagename|runs| 09:00:38 INFO - PROCESS | 31889 | |0;ai-astar;109;113;114;112;113;112;114;113;112;112 09:00:38 INFO - PROCESS | 31889 | |1;audio-beat-detection;146;123;117;156;123;122;117;125;146;118 09:00:38 INFO - PROCESS | 31889 | |2;audio-dft;161;163;162;161;162;161;162;161;161;163 09:00:38 INFO - PROCESS | 31889 | |3;audio-fft;75;75;75;114;76;76;76;75;99;74 09:00:38 INFO - PROCESS | 31889 | |4;audio-oscillator;82;82;124;82;82;83;108;82;82;106 09:00:38 INFO - PROCESS | 31889 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 09:00:38 INFO - PROCESS | 31889 | |6;imaging-darkroom;145;146;146;146;145;146;145;146;145;146 09:00:38 INFO - PROCESS | 31889 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;95 09:00:38 INFO - PROCESS | 31889 | |8;json-parse-financial;51;49;51;49;49;50;50;50;50;50 09:00:38 INFO - PROCESS | 31889 | |9;json-stringify-tinderbox;59;59;58;59;59;58;58;59;59;59 09:00:38 INFO - PROCESS | 31889 | |10;stanford-crypto-aes;77;78;73;72;73;80;74;74;74;81 09:00:38 INFO - PROCESS | 31889 | |11;stanford-crypto-ccm;121;136;120;120;122;119;125;125;162;140 09:00:38 INFO - PROCESS | 31889 | |12;stanford-crypto-pbkdf2;156;155;154;155;152;154;155;156;155;154 09:00:38 INFO - PROCESS | 31889 | |13;stanford-crypto-sha256-iterative;65;62;62;63;62;63;62;61;62;61 09:00:38 INFO - PROCESS | 31889 | __end_tp_report 09:00:38 INFO - PROCESS | 31889 | __start_cc_report 09:00:38 INFO - PROCESS | 31889 | _x_x_mozilla_cycle_collect,1638 09:00:38 INFO - PROCESS | 31889 | __end_cc_report 09:00:38 INFO - PROCESS | 31889 | __startTimestamp1474646438244__endTimestamp 09:00:38 INFO - PROCESS | 31889 | 09:00:38 INFO - PROCESS | 31889 | ------- Summary: start ------- 09:00:38 INFO - PROCESS | 31889 | Number of tests: 14 09:00:38 INFO - PROCESS | 31889 | 09:00:38 INFO - PROCESS | 31889 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:1.43 (1.3%) stddev-sans-first:0.83 09:00:38 INFO - PROCESS | 31889 | Values: 109.0 113.0 114.0 112.0 113.0 112.0 114.0 113.0 112.0 112.0 09:00:38 INFO - PROCESS | 31889 | 09:00:38 INFO - PROCESS | 31889 | [#1] audio-beat-detection Cycles:10 Average:129.30 Median:124.00 stddev:14.35 (11.6%) stddev-sans-first:13.88 09:00:38 INFO - PROCESS | 31889 | Values: 146.0 123.0 117.0 156.0 123.0 122.0 117.0 125.0 146.0 118.0 09:00:38 INFO - PROCESS | 31889 | 09:00:38 INFO - PROCESS | 31889 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 09:00:38 INFO - PROCESS | 31889 | Values: 161.0 163.0 162.0 161.0 162.0 161.0 162.0 161.0 161.0 163.0 09:00:38 INFO - PROCESS | 31889 | 09:00:38 INFO - PROCESS | 31889 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.50 stddev:13.66 (18.1%) stddev-sans-first:14.28 09:00:38 INFO - PROCESS | 31889 | Values: 75.0 75.0 75.0 114.0 76.0 76.0 76.0 75.0 99.0 74.0 09:00:38 INFO - PROCESS | 31889 | 09:00:38 INFO - PROCESS | 31889 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:82.00 stddev:15.46 (18.9%) stddev-sans-first:16.03 09:00:38 INFO - PROCESS | 31889 | Values: 82.0 82.0 124.0 82.0 82.0 83.0 108.0 82.0 82.0 106.0 09:00:38 INFO - PROCESS | 31889 | 09:00:38 INFO - PROCESS | 31889 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:00:38 INFO - PROCESS | 31889 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 09:00:38 INFO - PROCESS | 31889 | 09:00:38 INFO - PROCESS | 31889 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:00:38 INFO - PROCESS | 31889 | Values: 145.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 146.0 09:00:38 INFO - PROCESS | 31889 | 09:00:38 INFO - PROCESS | 31889 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:00:38 INFO - PROCESS | 31889 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 09:00:38 INFO - PROCESS | 31889 | 09:00:38 INFO - PROCESS | 31889 | [#8] json-parse-financial Cycles:10 Average:49.90 Median:50.00 stddev:0.74 (1.5%) stddev-sans-first:0.67 09:00:38 INFO - PROCESS | 31889 | Values: 51.0 49.0 51.0 49.0 49.0 50.0 50.0 50.0 50.0 50.0 09:00:38 INFO - PROCESS | 31889 | 09:00:38 INFO - PROCESS | 31889 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 09:00:38 INFO - PROCESS | 31889 | Values: 59.0 59.0 58.0 59.0 59.0 58.0 58.0 59.0 59.0 59.0 09:00:38 INFO - PROCESS | 31889 | 09:00:38 INFO - PROCESS | 31889 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:75.50 stddev:3.17 (4.2%) stddev-sans-first:3.32 09:00:38 INFO - PROCESS | 31889 | Values: 77.0 78.0 73.0 72.0 73.0 80.0 74.0 74.0 74.0 81.0 09:00:38 INFO - PROCESS | 31889 | 09:00:38 INFO - PROCESS | 31889 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:125.00 stddev:13.61 (10.9%) stddev-sans-first:14.12 09:00:38 INFO - PROCESS | 31889 | Values: 121.0 136.0 120.0 120.0 122.0 119.0 125.0 125.0 162.0 140.0 09:00:38 INFO - PROCESS | 31889 | 09:00:38 INFO - PROCESS | 31889 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.60 Median:155.00 stddev:1.17 (0.8%) stddev-sans-first:1.13 09:00:38 INFO - PROCESS | 31889 | Values: 156.0 155.0 154.0 155.0 152.0 154.0 155.0 156.0 155.0 154.0 09:00:38 INFO - PROCESS | 31889 | 09:00:38 INFO - PROCESS | 31889 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:1.16 (1.9%) stddev-sans-first:0.71 09:00:38 INFO - PROCESS | 31889 | Values: 65.0 62.0 62.0 63.0 62.0 63.0 62.0 61.0 62.0 61.0 09:00:38 INFO - PROCESS | 31889 | -------- Summary: end -------- 09:00:38 INFO - PROCESS | 31889 | 09:00:39 INFO - TEST-INFO | 31889: exit 0 09:00:39 INFO - TEST-OK | kraken | took 59362ms 09:00:39 INFO - SUITE-END | took 1172s 09:00:39 INFO - Completed test suite (00:19:32) 09:00:39 INFO - javascript benchmark 09:00:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3022.5768392425066, 3054.037978036919, 3067.3405217878153, 3076.3078307380856, 3104.8913288034923, 5390.51485366317, 5470.917936230955, 5476.479734425223, 5517.972410137953, 5518.337799464065, 5559.277293951781, 5567.0, 5582.27430434044, 5589.105743081108, 5599.216109744639, 4997.30037794709, 5014.197728363462, 5050.823221187259, 5096.261042148886, 5127.48725127488, 4941.579965702902, 4959.553640172384, 5067.797288108472, 5120.871978200556, 5124.461931497176, 4971.776270067856, 4984.277279794428, 5016.27264046713, 5021.874453138665, 5039.420466646327, 5059.747012649371, 5068.087744206042, 5144.536991670768, 5150.665206761549, 5173.0, 4743.501932297094, 4986.177280748672, 5004.599632029429, 5084.110280700899, 5098.4136824265315, 5273.683578985273, 5362.946370536322, 5375.489328513824, 5427.4301198374, 5515.917261241085, 5735.168400581934, 5735.283089613798, 5894.734736936848, 5898.1152827076285, 5898.941010589882, 5636.379998200195, 5921.023031199847, 5924.407559244084, 5926.348101708809, 5938.2280303560265, 5314.787408503656, 5451.209574611659, 5488.533474654699, 5504.6421982571, 5553.16702494629, 6024.457798798129, 6057.575969682168, 6060.151578778975, 6060.818175454743, 6069.15031895535, 5648.435156484319, 5813.389594092644, 5814.738336774771, 5824.446677565625, 5824.475797178275, 5753.741081651336, 5789.478946894799, 5790.971045144747, 5817.272840894888, 5900.144479050599, 5830.2420685310635, 5836.328822185418, 5838.854028649318, 5849.356570777211, 5908.940910590925, 5863.530917526673, 5918.763249469973, 5920.555958303058, 5927.288725352985, 5947.970260148758, 4406.471223453206, 4434.312681534368, 4499.10017996402, 4507.143642707875, 4549.363089167519, 4034.2738307104414, 4039.5758445363404, 4043.555208927016, 4045.130296986103, 4067.8576249831112, 5674.631148975386, 5689.544836413077, 5694.686792226385, 5699.646818882787, 5742.0, 5680.289963754531, 5724.542036637059, 5819.679917604488, 5849.766009359578, 6009.549283803644, 5610.18652295423, 5618.494335509824, 5619.129034999582, 5629.549636029108, 5651.2935883014625, 5134.383873935077, 5135.589152867761, 5140.56305214061, 5145.794168233228, 5164.509371609691, 5806.912896306474, 5849.853753656193, 5995.100734889627, 6078.908816367758, 6081.543884208702, 5863.530917526673, 5869.0, 5892.705364731832, 5900.203472531153, 5954.940450595612, 6071.514278857592, 6104.26748790148, 6104.786332478342, 6113.29697084841, 6115.082737589397, 5657.830265092054, 5677.063284558167, 5807.303123625192, 5830.271216097988, 5832.096025116114, 5826.067829147316, 5908.734106965283, 5910.852228694317, 5948.40515948419, 6009.759609615741, 5771.624844385102, 5826.271716035496, 5835.503982161564, 5840.094785308284, 5840.94159058421, 5574.832755017356, 5809.419058094326, 5842.123681447647, 5844.736986835517, 5850.473457388855, 5544.916826247691, 5671.716414179357, 5683.9715801420725, 5692.402297758676, 5810.82567522975, 5802.1586869902785, 5848.970755146197, 5850.5904586678525, 5850.94149058504, 5852.824415267549, 5485.862853428696, 5519.641223320471, 5717.656940583578, 5726.141078838207, 5727.455891690282], "value": 5426.653667412856, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.6848102024907, 606.9393060693928, 627.7677259414017, 628.4187126907609, 647.1683886206224, 35305.82347088264, 47187.29219061717, 48913.51086489134, 48928.75535622326, 49060.50939490604, 48860.0, 49123.263151052764, 49201.50798492014, 49263.50736492634, 49359.75320123394, 8493.108223636522, 9334.813303733921, 9488.335816492814, 9491.620335186619, 9497.240220782356, 8457.70398036069, 11186.272892261977, 11430.542778288858, 11433.656990290305, 11790.528378864836, 11540.307581545092, 11580.82628760565, 11607.593734219305, 11619.535218591247, 11629.302241865473, 11353.489092990836, 11364.090872730161, 11431.714207144805, 11437.656870293904, 11451.0, 11299.717507062389, 11365.204435689506, 11400.94299528497, 11402.885971140347, 11416.257943233662, 45592.77203613994, 45882.77058614719, 46001.0, 46020.53979460196, 46053.769731151464, 3891.902702432462, 3950.7036972227197, 3991.261616600938, 4035.1122752994293, 4153.460050193486, 33459.49810752841, 33756.0, 34012.82993585041, 34121.2395949048, 34294.828525857214, 4683.929741053887, 4708.552687494683, 4709.505501922283, 4719.622430205575, 4772.308015337791, 387950.0, 388635.0, 389231.0, 391444.99999999715, 392681.0, 66144.0, 66401.66799165973, 66441.6677916617, 66501.0, 66542.0, 41093.38359924604, 41733.1653366937, 42021.36967945483, 44752.10495790066, 71040.64479677672, 20021.0, 20214.090365933567, 20258.797412025986, 20275.493112672302, 20295.898520507304, 13377.933110334581, 13767.036307458582, 15243.618909527351, 15574.143422111893, 15800.20998950048, 20150.596988060155, 20852.791472085388, 21357.0, 21526.354209373745, 21603.459913501974, 7372.741954031583, 7409.370203532652, 7508.3993280537425, 7620.1998790127345, 7658.578778167254, 1010.9241806864515, 1116.9609063682894, 1122.4275619434147, 1126.4536699700639, 1150.327058670687, 35045.47431788525, 35611.28777424437, 35666.82166589202, 35854.46218306728, 35939.82030089885, 1149.436775979764, 1155.1105648650491, 1176.858776946772, 1218.792805223114, 1256.7989121740477, 16901.32394704198, 19010.80989190118, 20151.798482015285, 20246.898765506077, 20382.286619968527, 397901.0, 403216.0, 403777.0, 586499.0, 589471.0, 68125.65937170382, 69133.0, 69133.3086669137, 69151.65424172847, 69301.30698693049, 1377.9448822047207, 1417.6739349949364, 1486.138039936834, 1504.653929596199, 1529.3194528434963, 33714.662853371156, 35259.82370088133, 36727.632723672425, 37215.62784372122, 37328.44007339838, 60828.69585652043, 62206.68896655488, 62483.0, 62552.68723656353, 62562.374376257474, 542981.0, 557001.0, 561039.0, 562951.0, 563400.0, 45354.0, 49066.75466622644, 49437.0, 49447.50552494429, 49512.50487495079, 53713.731431342596, 54131.0, 54307.18539221994, 54578.0, 54689.72655136699, 44778.55221447744, 45231.54768452273, 46188.53811461977, 46944.06111877812, 47363.0, 46620.0, 47442.0, 47559.52440475689, 47787.0, 48050.519494804605, 45090.0, 45657.08685826199, 45811.3128303069, 46336.53663463322, 46347.76826115983, 38686.22627547377, 40573.0, 41087.794561027, 41351.37972930469, 41928.0, 30272.243193920327, 30624.693753062184, 30824.537631935986, 31023.84488077545, 31106.844465777525], "value": 22707.610853089333, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.7710328009751, 412.85756414037166, 425.7232798680858, 426.8676710219832, 438.32716779743083, 14830.332635031422, 16678.0, 20644.690329645047, 20818.271360502386, 22385.216517421894, 17115.486535403958, 17567.03381314027, 18595.907020464914, 21241.256556020544, 21364.4658883528, 5754.568407369454, 5830.271216097988, 5884.0, 5914.763409463616, 5951.940480595182, 5885.823425297248, 5992.700364981755, 5993.250843644544, 5995.460408563228, 5996.580239383245, 4283.0, 4558.772061396933, 4604.769761511928, 6566.63883486408, 6707.564008339466, 5494.587905907073, 6656.500762442788, 6682.699278532454, 6684.933150668504, 6696.497762667795, 5583.972080139614, 5689.715514224272, 5694.402087780765, 5702.45826646468, 5707.229524014247, 15286.541403757905, 15392.769108463383, 15485.070895746292, 15505.302261398152, 15650.686986260325, 2646.6691663542056, 2711.850848203348, 2720.1159623122367, 2922.7515661168613, 2933.5306350983956, 11230.3261804292, 11449.31304121747, 11455.198136130473, 12853.67865803353, 13107.606771796765, 1927.267638297452, 1939.8254157125925, 1998.280618977167, 2002.4493264352275, 2043.6423625865564, 53100.0, 76608.0, 83291.5835420819, 84284.0, 90846.0, 11849.0, 11890.702732431586, 11911.10666700001, 11992.76014479723, 12087.879121208676, 17188.742168867477, 17200.569985750455, 17218.139093045298, 17227.138643067796, 17270.568235794206, 9033.63865445388, 9242.844644419447, 9388.155066044088, 9429.858552121723, 9516.19112375442, 8208.876866847002, 8305.667773289, 8308.086110527836, 8486.490810551386, 8497.532635705096, 5123.795048198031, 5158.845234642967, 5174.404943431554, 5205.505476979681, 5237.371515418175, 2055.691646253044, 2080.417483104733, 2113.4293740689927, 2117.163720330461, 2158.4388059104745, 928.2017464980112, 1002.9949850250702, 1031.582209205273, 1048.1981284317503, 1060.48036462133, 20361.287354942506, 20885.16459341609, 20935.47661308449, 21107.366778996653, 21132.0, 1039.3763741755038, 1043.7703705184847, 1077.353587847301, 1129.6949823547595, 1131.9207655464038, 11042.0, 11658.242214256046, 11717.00405465528, 11836.467358968866, 12028.398580070962, 487208.0, 492039.0, 495522.0, 536989.0, 539297.0, 98345.0, 99736.0, 100430.0, 101559.98440015654, 103040.0, 1068.1188019883627, 1068.2201992545486, 1107.0977153619774, 1118.1557923767502, 1119.7480566872389, 18653.44039678812, 19010.23959041623, 19091.713624295924, 19206.61586768229, 19255.903720481307, 40903.0, 41296.1740765189, 43350.0, 43628.0, 44285.0, 56752.43247567637, 57469.0, 59157.70421148039, 66110.66944665246, 66428.33571664222, 9140.131687489678, 9350.251979841732, 9559.23526117895, 9712.5143742814, 9751.756206094904, 8085.83828323442, 10516.57933682644, 14418.855811441752, 14636.926815365856, 14724.55826325212, 12303.507859685513, 12601.87398126007, 12730.809037864625, 12893.355332233163, 13194.868051319363, 10034.598616055568, 11891.0, 12165.33090680021, 12304.138710290194, 12651.93674031624, 12294.385280736105, 12357.567485137977, 12371.257724536557, 12832.294223817406, 12843.807342890052, 7649.847003060019, 7962.402819788424, 9113.726588202364, 9209.585568649292, 9496.097870702271, 11907.345096019802, 12167.087468440079, 12260.509579616715, 12291.508339666314, 12703.36483175819], "value": 9636.049707434004, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.3560130140786, 1514.3942423030787, 1560.3446552447972, 1688.1812321024302, 1844.0687452836307, 7737.342325902298, 8602.397832151752, 8754.080821513744, 8762.737117886465, 9182.724518264462, 8953.865692014626, 9034.367594268404, 9034.72895813125, 9037.593308301126, 9049.728508144766, 2460.07747094839, 2496.400863792686, 2496.6255061740794, 2504.499100179962, 2504.74952504749, 2367.6685264062958, 2488.701355837302, 2496.3509487533283, 2496.5755821510297, 2498.375406148463, 2421.8910149043336, 2442.157455677788, 2485.2171565956755, 2485.3289611804894, 2487.4900645367657, 2363.8108951283943, 2385.9880700596473, 2387.5463661904355, 2387.7970372518357, 2391.1630929174826, 2299.298713892262, 2350.7414184439867, 2362.5393048355577, 2366.25462979161, 2366.7869891709656, 7877.251661092187, 8084.717034903809, 8918.0, 8966.058563850767, 8983.146601072887, 5140.1004824155625, 5287.973560132214, 5292.894142117175, 5342.332208473941, 5368.060589396879, 3447.8103704296254, 3475.5134281200653, 3489.8604055837736, 3505.439129739255, 3518.138056176253, 1155.4338374196668, 1156.8033434316187, 1182.4265231362783, 1201.4113084588575, 1229.9016078713682, 12281.0, 12293.446794894162, 12300.323482208474, 12315.384230788515, 12348.814767778491, 4511.300748384006, 4590.28850528162, 4746.620270378361, 4750.7387093709485, 4760.166970780099, 10473.790524189473, 10491.580336786596, 10518.789624207473, 10537.894621053845, 10540.420276884844, 5413.756380962866, 5438.0, 5444.373897001817, 5445.700486473282, 5449.5640348772795, 4858.975705121523, 4941.950580494221, 5030.924536131961, 5031.949680503221, 5031.974840125849, 4005.579414161471, 4026.295398305285, 4091.8772436826944, 4097.590240975938, 4128.195001974586, 1239.2007155384727, 1256.2023115321836, 1261.482792055253, 1270.6823294176456, 1282.9807552886714, 1011.544804837826, 1013.5236438873718, 1034.0796690945065, 1040.15747244732, 1040.9063184313447, 6182.1345011698395, 6209.316975132731, 6212.751489940442, 6247.656378899113, 6333.524985626096, 455.90426010537493, 469.5867636479944, 471.58759515251353, 473.96682232244103, 478.9233722604367, 4088.0597462583773, 4112.485939257593, 4216.683748718859, 4298.075913678574, 4315.697901146952, 9878.802423951482, 10285.74285642865, 10392.636257731094, 10500.317479363817, 10753.0, 9791.510424478747, 10180.23648226386, 10872.61945831892, 10899.891001089887, 10908.0, 7569.091708994956, 7738.61306934651, 7893.13175550689, 8209.753707388787, 8214.466059705981, 6201.751929922933, 6292.685365731603, 6468.191476065492, 6479.902801458076, 6562.146920900253, 10112.393256404639, 10139.08748212635, 10153.39079655223, 10174.898251017396, 10208.234382421497, 9722.0, 10057.597696092074, 10276.537555810157, 10403.687889363331, 10429.791404171723, 7457.515261507984, 7568.205338439605, 7583.355414789805, 7585.6965721370525, 7587.165411804586, 8593.140685931357, 8607.956960215159, 8696.043435222247, 8696.739097827076, 8710.956445217987, 7663.0, 7835.960820195863, 7859.292663660298, 7941.126476087741, 7981.640826162953, 7769.106552746506, 7776.222377762178, 7803.258690424401, 7924.366050716044, 7970.844227587083, 7282.817929551804, 7311.195768465358, 7324.08448943882, 7395.001674773836, 7415.443841711785, 5259.55293800016, 5302.2659383588425, 5372.946270537244, 5414.377346605191, 5496.917546236889, 5286.603504737083, 5310.654807437504, 5314.840554783363, 5384.488473595002, 5475.151351540518], "value": 4645.779652964707, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.3001901169143, 355.8203107430747, 360.13208168314367, 363.4058314655537, 365.18199233716484, 5481.534069604083, 5622.578306627004, 5628.662280263182, 5638.097904335307, 5641.5204707599905, 5548.58385621078, 5557.0, 5575.721213939307, 5595.720213989294, 5595.972020139904, 3922.568517463091, 4168.520620128678, 4389.868303950887, 4398.73607583546, 4465.46414430268, 4290.270653988814, 4369.519352871182, 4369.803358848843, 4378.759168245745, 4380.802863871133, 4343.67422443318, 4346.5436129206455, 4347.978260108695, 4349.521552629224, 4364.432623758923, 4135.875923722293, 4368.378972616437, 4376.0, 4383.934240986404, 4393.406890069831, 3701.38927077032, 3900.64894159527, 3914.7846868422225, 3928.998105483112, 3936.862209822671, 5407.242985981966, 5426.5116139547235, 5436.673799572039, 5437.619366644337, 5458.754356053987, 4809.591184749301, 5006.3241462402475, 5037.748112594392, 5039.3196918415915, 5047.848564543069, 5727.627704199255, 5752.36723960364, 5760.74076666551, 5784.248047753807, 5786.379813652185, 4216.388623649554, 4235.449391579075, 4239.321708526621, 4240.215560121387, 4257.063446041897, 5636.2954630671165, 5820.82537523875, 5960.1357803118735, 6060.575759696823, 6104.877902441971, 4275.786210689453, 4296.183725092223, 4304.956950430518, 4310.224159651293, 4311.892202694958, 4355.2813785725, 4401.679496151141, 4402.25161722508, 4414.448193975753, 4420.182266280748, 4879.0, 4903.828366007173, 4928.950710492921, 5027.145385284437, 5043.52086551777, 5775.335836378787, 5779.104238842986, 5807.245058142415, 5813.1979086483325, 5826.941730582725, 1473.9705205895823, 1484.717903598313, 1487.8129150149264, 1498.887583431247, 1504.4809540708438, 949.6846867088993, 983.3608154699502, 984.5871174864093, 986.9013098690217, 999.3554157568473, 4929.658412254223, 4935.925961110586, 4948.925766113512, 4996.925046124311, 5016.974915125401, 5158.426679862678, 5192.532672059533, 5206.947930520722, 5225.764840582183, 5236.973815130977, 4979.925301120486, 5002.89994200114, 5042.520960508746, 5289.68261904287, 5735.569832262597, 3153.3220357623222, 3187.5974571188603, 3188.2826364068364, 3195.6578237139993, 3196.5684632574303, 6034.069097888633, 6178.258608966863, 6188.721507532172, 6190.535709821781, 6222.439980401786, 6095.4818840398175, 6107.175531303306, 6124.77504499102, 6131.63210207389, 6134.171886795226, 6136.417040381246, 6137.3735959970645, 6146.78486252979, 6149.754009839557, 6156.322804491502, 5817.447342502455, 5965.791197308074, 5997.970010149921, 6006.0, 6009.639421634716, 5922.785828904978, 5927.436893495111, 5932.644041357532, 5933.376995415592, 5939.792107276225, 5838.241028666416, 5911.6403227257115, 6043.667598282137, 6112.3802192419935, 6157.722902469489, 4319.092990472036, 4341.479022517318, 4343.543927887653, 4352.564743525622, 4391.726399344155, 5820.126980952891, 5909.497692696169, 6075.36208698098, 6086.7260973255425, 6090.984962443619, 5806.9419305806405, 5808.593398462067, 5836.920169768437, 5855.3559108498885, 5890.087036509348, 5847.970760146172, 5854.619449735754, 5864.970675146597, 5882.647041177543, 5929.347771745019, 5622.662640241599, 5740.167675687086, 5749.8212866361455, 5751.798687045934, 5785.206585958366, 5834.833033393424, 5849.473547380756, 5882.882342353215, 5919.83925867064, 5952.910706339322, 5485.561155107662, 5759.193712880284, 5760.1935728998815, 5775.27809023872, 5798.536117110537], "value": 4420.765257919794, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.7144999250263, 816.6937398475571, 822.3585603229479, 831.1688311688312, 919.8160367926414, 17293.56766080847, 18102.818971810277, 18148.81851181488, 18180.90909545452, 18217.36239231627, 16113.919430402831, 16239.269232884519, 16261.18694065295, 16262.105584192865, 16276.83723162768, 717.4977515738991, 733.2667332667332, 858.0732808566733, 879.560219890055, 883.1301168349171, 888.9288856891433, 892.2237653241689, 894.1773568317132, 896.3053633434108, 896.4397251717677, 758.9620518974057, 941.2187884056251, 945.5461378538306, 945.9763505912373, 946.0586716217339, 779.9181085985975, 896.4755617963499, 916.5646317998963, 925.3938670171049, 927.3554879358849, 685.1572565744112, 686.080651926416, 687.3229868579446, 689.2659317826499, 690.1786873620426, 14707.19110448925, 14762.188079655614, 14783.556493305217, 14871.107733536022, 14899.329530171168, 15255.61860953474, 15256.618584535365, 15276.0, 15303.464378746801, 15530.378784848706, 13866.168029918137, 14085.859141408557, 14134.575962721136, 14142.787858182135, 14341.928290358586, 4582.656300777455, 4634.165850146972, 4670.439547254351, 4715.693479923828, 4731.077439899221, 88032.11967880304, 89719.55140224322, 93158.0, 93555.53222233846, 95549.52225238898, 12708.745825083446, 12823.35883205836, 12984.480620775252, 13043.543475978295, 13068.673283167807, 24546.754532454805, 24657.63013554798, 24705.629415558782, 24737.5052498949, 24914.750852491605, 9237.0, 9494.762630934281, 9548.18840398574, 9642.807143857224, 9734.221262299, 5228.947710522846, 5385.467722131805, 5459.945400546023, 5461.2354270402175, 5513.917291240635, 3604.4232922732235, 3718.1076541629814, 3726.2174943261675, 3726.9627303726616, 3731.6268373162466, 565.4373897971544, 571.4571157400403, 610.0665981049002, 616.0205273614885, 668.9933100668931, 625.2153547298112, 675.4967549175896, 756.9327248579476, 761.2007392238238, 810.3768003539791, 10249.59001639941, 10909.127269818395, 10958.397288149228, 11027.724306892393, 11188.944055279671, 772.3577235772314, 780.2704471319335, 808.551254053994, 817.6320655704957, 828.200786241268, 5074.974625126851, 5108.61685373591, 5112.488751124932, 5133.563647090039, 5190.480951904779, 75146.0, 128137.3593132047, 129435.0, 130754.34622827015, 136376.31811840876, 109864.45067774769, 111292.44353778179, 113247.0, 114294.42852785683, 118283.0, 69502.0, 95398.0, 95812.0, 96342.9999999986, 102618.48690756499, 9831.508424578886, 9861.0, 9868.0, 9916.851247231441, 10156.085952264331, 58379.4162058374, 60003.39996599978, 60202.39797601968, 60359.09461357995, 61800.69099654473, 66791.3320866785, 70923.64538177276, 71104.64447677729, 78259.2174078252, 80727.19272807431, 13204.60386188416, 14492.275386230856, 14620.488282910048, 14625.122492650475, 14925.402983880524, 13573.86426135726, 13659.0, 13660.86339136596, 14581.781273281122, 16592.91703541523, 14880.330385132911, 15192.924035379752, 15579.688406232039, 15607.21963901823, 15865.365385384917, 12057.0, 14961.40154393812, 15515.0, 15593.532194034196, 16014.519564413085, 14466.20435876037, 14658.853411466176, 14668.926655366655, 15176.772348414563, 16398.918005409898, 11900.285982841056, 12315.676662630993, 12340.691482712646, 12912.677183070498, 13061.412236449572, 13263.204207747565, 13339.66650833737, 13354.599362019155, 13535.390907409386, 13653.0], "value": 8272.947208190086, "unit": "score"}], "name": "dromaeo_css", "value": 7658.514049956472, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 114.0, 112.0, 113.0, 112.0, 114.0, 113.0, 112.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 123.0, 117.0, 156.0, 123.0, 122.0, 117.0, 125.0, 146.0, 118.0], "value": 129.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 163.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 114.0, 76.0, 76.0, 76.0, 75.0, 99.0, 74.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 124.0, 82.0, 82.0, 83.0, 108.0, 82.0, 82.0, 106.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 51.0, 49.0, 49.0, 50.0, 50.0, 50.0, 50.0, 50.0], "value": 49.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 59.0, 59.0, 58.0, 58.0, 59.0, 59.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 73.0, 72.0, 73.0, 80.0, 74.0, 74.0, 74.0, 81.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 136.0, 120.0, 120.0, 122.0, 119.0, 125.0, 125.0, 162.0, 140.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 154.0, 155.0, 152.0, 154.0, 155.0, 156.0, 155.0, 154.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 62.0, 63.0, 62.0, 63.0, 62.0, 61.0, 62.0, 61.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1463.8999999999996, "alertThreshold": 2.0}]} 09:00:39 INFO - Return code: 0 09:00:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:00:39 INFO - # TBPL SUCCESS # 09:00:39 INFO - Running post-action listener: _resource_record_post_action 09:00:39 INFO - [mozharness: 2016-09-23 16:00:39.566442Z] Finished run-tests step (success) 09:00:39 INFO - Running post-run listener: _resource_record_post_run 09:00:39 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 2129920; Write bytes: 376008704; Read time: 312; Write time: 215056 09:00:39 INFO - TinderboxPrint: CPU usage
13.0% 09:00:39 INFO - TinderboxPrint: I/O read bytes / time
2,129,920 / 312 09:00:39 INFO - TinderboxPrint: I/O write bytes / time
376,008,704 / 215,056 09:00:39 INFO - TinderboxPrint: CPU idle
8,258.7 (87.0%) 09:00:39 INFO - TinderboxPrint: CPU user
1,187.1 (12.5%) 09:00:39 INFO - TinderboxPrint: Swap in / out
0 / 0 09:00:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108171264; Read time: 0; Write time: 86552 09:00:39 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 251039744; Read time: 16; Write time: 123684 09:00:40 INFO - Running post-run listener: _upload_blobber_files 09:00:40 INFO - Blob upload gear active. 09:00:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:00:40 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 09:00:40 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'] 09:00:40 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 09:00:40 INFO - (blobuploader) - INFO - Open directory for files ... 09:00:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:00:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:00:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:45 INFO - (blobuploader) - INFO - Done attempting. 09:00:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:00:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:00:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:46 INFO - (blobuploader) - INFO - Done attempting. 09:00:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:00:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:00:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:46 INFO - (blobuploader) - INFO - Done attempting. 09:00:46 INFO - (blobuploader) - INFO - Iteration through files over. 09:00:46 INFO - Return code: 0 09:00:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:00:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:00:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b7df19bb1d497ce98d7663bc92927909c5a720e304062b65e73e31fdb330624170288e19889a44bae68909356e02169ebc354be14f06866cd22fd7052c364a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0a1d08bbba7caad23ce4ba521699aa862663dbc7967d669eb8823613e481ed129c7708e3177ad8cc2694d53548d98bce214c9092efca0fd6356860c0ec3fe8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef9adb7140554cd0142770777e5b21bd8457baa9fec6e9fe0c494f1be3400793edab672cf5a7aaea8528e9905a05bff31b85ddfe43a95b55b10c34f0727b23fe"} 09:00:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:00:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:00:46 INFO - Contents: 09:00:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b7df19bb1d497ce98d7663bc92927909c5a720e304062b65e73e31fdb330624170288e19889a44bae68909356e02169ebc354be14f06866cd22fd7052c364a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0a1d08bbba7caad23ce4ba521699aa862663dbc7967d669eb8823613e481ed129c7708e3177ad8cc2694d53548d98bce214c9092efca0fd6356860c0ec3fe8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef9adb7140554cd0142770777e5b21bd8457baa9fec6e9fe0c494f1be3400793edab672cf5a7aaea8528e9905a05bff31b85ddfe43a95b55b10c34f0727b23fe"} 09:00:46 INFO - Running post-run listener: copy_logs_to_upload_dir 09:00:46 INFO - Copying logs to upload dir... 09:00:46 INFO - mkdir: /builds/slave/test/build/upload/logs 09:00:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.078701 ========= master_lag: 16.99 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-09-23 09:01:03.614426) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 09:01:03.617999) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050 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/9b7df19bb1d497ce98d7663bc92927909c5a720e304062b65e73e31fdb330624170288e19889a44bae68909356e02169ebc354be14f06866cd22fd7052c364a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0a1d08bbba7caad23ce4ba521699aa862663dbc7967d669eb8823613e481ed129c7708e3177ad8cc2694d53548d98bce214c9092efca0fd6356860c0ec3fe8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef9adb7140554cd0142770777e5b21bd8457baa9fec6e9fe0c494f1be3400793edab672cf5a7aaea8528e9905a05bff31b85ddfe43a95b55b10c34f0727b23fe"} build_url:https://queue.taskcluster.net/v1/task/FQbQ_FvgQ0quA9v3qn7h_w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009082 build_url: 'https://queue.taskcluster.net/v1/task/FQbQ_FvgQ0quA9v3qn7h_w/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/9b7df19bb1d497ce98d7663bc92927909c5a720e304062b65e73e31fdb330624170288e19889a44bae68909356e02169ebc354be14f06866cd22fd7052c364a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0a1d08bbba7caad23ce4ba521699aa862663dbc7967d669eb8823613e481ed129c7708e3177ad8cc2694d53548d98bce214c9092efca0fd6356860c0ec3fe8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef9adb7140554cd0142770777e5b21bd8457baa9fec6e9fe0c494f1be3400793edab672cf5a7aaea8528e9905a05bff31b85ddfe43a95b55b10c34f0727b23fe"}' ========= master_lag: 0.53 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 09:01:04.160197) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:01:04.160535) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1474645125.693116-1284106050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.21 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:01:04.375087) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 09:01:04.375518) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 09:01:04.376477) ========= ========= Total master_lag: 17.80 =========