builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1476461535.19 results: success (0) buildid: 20161014061436 builduid: baf2b81f98404634b2274022b5380ebd revision: f061dfbab3ed719d9d1dc8f1e9cff51efd6d03a8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 09:12:15.194663) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 09:12:15.195288) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 09:12:15.195614) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 09:12:15.212306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:12:15.212609) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 09:12:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-10-14 09:12:15 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.077597 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:12:15.305168) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:12:15.305481) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020026 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:12:15.355477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:12:15.355849) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f061dfbab3ed719d9d1dc8f1e9cff51efd6d03a8 --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 f061dfbab3ed719d9d1dc8f1e9cff51efd6d03a8 --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=9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 09:12:15,625 truncating revision to first 12 chars 2016-10-14 09:12:15,625 Setting DEBUG logging. 2016-10-14 09:12:15,625 attempt 1/10 2016-10-14 09:12:15,625 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f061dfbab3ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 09:12:15,933 unpacking tar archive at: mozilla-aurora-f061dfbab3ed/testing/mozharness/ program finished with exit code 0 elapsedTime=0.717528 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:12:16.089942) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 09:12:16.090281) ========= script_repo_revision: f061dfbab3ed719d9d1dc8f1e9cff51efd6d03a8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 09:12:16.090754) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 09:12:16.091082) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 09:12:16.102477) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-14 09:12:16.102956) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:12:16 INFO - MultiFileLogger online at 20161014 09:12:16 in /builds/slave/test 09:12:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:12:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:12:16 INFO - {'append_to_log': False, 09:12:16 INFO - 'base_work_dir': '/builds/slave/test', 09:12:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:12:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:12:16 INFO - 'branch': 'Mozilla-Aurora', 09:12:16 INFO - 'buildbot_json_path': 'buildprops.json', 09:12:16 INFO - 'config_files': ('talos/linux_config.py',), 09:12:16 INFO - 'default_actions': ('clobber', 09:12:16 INFO - 'read-buildbot-config', 09:12:16 INFO - 'download-and-extract', 09:12:16 INFO - 'populate-webroot', 09:12:16 INFO - 'create-virtualenv', 09:12:16 INFO - 'install', 09:12:16 INFO - 'run-tests'), 09:12:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:12:16 INFO - 'download_minidump_stackwalk': True, 09:12:16 INFO - 'download_symbols': 'ondemand', 09:12:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:12:16 INFO - 'tooltool.py': '/tools/tooltool.py', 09:12:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:12:16 INFO - '/tools/misc-python/virtualenv.py')}, 09:12:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:12:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:12:16 INFO - 'installer_path': 'installer.exe', 09:12:16 INFO - 'log_level': 'info', 09:12:16 INFO - 'log_name': 'talos', 09:12:16 INFO - 'log_to_console': True, 09:12:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:12:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:12:16 INFO - 'opt_config_files': (), 09:12:16 INFO - 'pip_index': False, 09:12:16 INFO - 'sps_profile': False, 09:12:16 INFO - 'sps_profile_interval': 0, 09:12:16 INFO - 'suite': 'dromaeojs', 09:12:16 INFO - 'system_bits': '32', 09:12:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:12:16 INFO - 'title': 'talos-linux64-ix-013', 09:12:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:12:16 INFO - 'use_talos_json': True, 09:12:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:12:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:12:16 INFO - 'work_dir': 'build'} 09:12:16 INFO - [mozharness: 2016-10-14 16:12:16.463633Z] Running clobber step. 09:12:16 INFO - Running pre-action listener: _resource_record_pre_action 09:12:16 INFO - Running main action method: clobber 09:12:16 INFO - rmtree: /builds/slave/test/build 09:12:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:12:16 INFO - Running post-action listener: _resource_record_post_action 09:12:16 INFO - [mozharness: 2016-10-14 16:12:16.922754Z] Finished clobber step (success) 09:12:16 INFO - [mozharness: 2016-10-14 16:12:16.922855Z] Running read-buildbot-config step. 09:12:16 INFO - Running pre-action listener: _resource_record_pre_action 09:12:16 INFO - Running main action method: read_buildbot_config 09:12:16 INFO - Using buildbot properties: 09:12:16 INFO - { 09:12:16 INFO - "project": "", 09:12:16 INFO - "product": "firefox", 09:12:16 INFO - "script_repo_revision": "production", 09:12:16 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:12:16 INFO - "repository": "", 09:12:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:12:16 INFO - "buildid": "20161014061436", 09:12:16 INFO - "pgo_build": "True", 09:12:16 INFO - "basedir": "/builds/slave/test", 09:12:16 INFO - "buildnumber": 574, 09:12:16 INFO - "slavename": "talos-linux64-ix-013", 09:12:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:12:16 INFO - "platform": "ubuntu64_hw", 09:12:16 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:12:16 INFO - "branch": "mozilla-aurora", 09:12:16 INFO - "repo_path": "releases/mozilla-aurora", 09:12:16 INFO - "revision": "f061dfbab3ed719d9d1dc8f1e9cff51efd6d03a8", 09:12:16 INFO - "stage_platform": "linux64-pgo", 09:12:16 INFO - "builduid": "baf2b81f98404634b2274022b5380ebd", 09:12:16 INFO - "slavebuilddir": "test" 09:12:16 INFO - } 09:12:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 09:12:16 INFO - Running post-action listener: _resource_record_post_action 09:12:16 INFO - [mozharness: 2016-10-14 16:12:16.925278Z] Finished read-buildbot-config step (success) 09:12:16 INFO - [mozharness: 2016-10-14 16:12:16.925367Z] Running download-and-extract step. 09:12:16 INFO - Running pre-action listener: _resource_record_pre_action 09:12:16 INFO - Running main action method: download_and_extract 09:12:16 INFO - mkdir: /builds/slave/test/build/tests 09:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:16 INFO - trying https://queue.taskcluster.net/v1/task/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 09:12:16 INFO - Downloading https://queue.taskcluster.net/v1/task/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 09:12:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:12:17 INFO - Downloaded 1361 bytes. 09:12:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 09:12:17 INFO - Using the following test package requirements: 09:12:17 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 09:12:17 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:12:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:12:17 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:12:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:12:17 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:12:17 INFO - u'jsshell-linux-x86_64.zip'], 09:12:17 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:12:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:12:17 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 09:12:17 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:12:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:12:17 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:12:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:12:17 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:12:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:12:17 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:12:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:12:17 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:12:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 09:12:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:12:17 INFO - Fetch https://queue.taskcluster.net/v1/task/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:12:18 INFO - Expected file size: 21907546 09:12:22 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:12:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 09:12:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:12:22 INFO - Fetch https://queue.taskcluster.net/v1/task/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:12:23 INFO - Expected file size: 21907546 09:12:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 09:12:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:12:27 INFO - Fetch https://queue.taskcluster.net/v1/task/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:12:28 INFO - Expected file size: 14414059 09:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:28 INFO - trying https://queue.taskcluster.net/v1/task/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 09:12:28 INFO - Downloading https://queue.taskcluster.net/v1/task/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 09:12:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:12:30 INFO - Downloaded 63992516 bytes. 09:12:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 09:12:30 INFO - mkdir: /builds/slave/test/properties 09:12:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:12:30 INFO - Writing to file /builds/slave/test/properties/build_url 09:12:30 INFO - Contents: 09:12:30 INFO - build_url:https://queue.taskcluster.net/v1/task/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 09:12:30 INFO - Running post-action listener: _resource_record_post_action 09:12:30 INFO - Running post-action listener: set_extra_try_arguments 09:12:30 INFO - [mozharness: 2016-10-14 16:12:30.620217Z] Finished download-and-extract step (success) 09:12:30 INFO - [mozharness: 2016-10-14 16:12:30.620520Z] Running populate-webroot step. 09:12:30 INFO - Running pre-action listener: _resource_record_pre_action 09:12:30 INFO - Running main action method: populate_webroot 09:12:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:12:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:12:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:12:30 INFO - '--tppagecycles', 09:12:30 INFO - '7'], 09:12:30 INFO - 'tests': ['tsvgm']}}, 09:12:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:12:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:12:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:12:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:12:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:12:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:12:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:30 INFO - 'talos_options': ['--disable-e10s'], 09:12:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:12:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:12:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:30 INFO - 'talos_options': ['--disable-e10s'], 09:12:30 INFO - 'tests': ['damp', 'tps']}, 09:12:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:30 INFO - 'tests': ['damp', 'tps']}, 09:12:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:12:30 INFO - 'tests': ['dromaeo_dom']}, 09:12:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:12:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:12:30 INFO - 'tests': ['basic_compositor_video']}, 09:12:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:12:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:12:30 INFO - 'tests': ['a11yr', 09:12:30 INFO - 'ts_paint', 09:12:30 INFO - 'tpaint', 09:12:30 INFO - 'sessionrestore', 09:12:30 INFO - 'sessionrestore_no_auto_restore', 09:12:30 INFO - 'tabpaint']}, 09:12:30 INFO - 'other-e10s': {'tests': ['a11yr', 09:12:30 INFO - 'ts_paint', 09:12:30 INFO - 'tpaint', 09:12:30 INFO - 'sessionrestore', 09:12:30 INFO - 'sessionrestore_no_auto_restore', 09:12:30 INFO - 'tabpaint']}, 09:12:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:12:30 INFO - 'ts_paint', 09:12:30 INFO - 'tpaint', 09:12:30 INFO - 'sessionrestore', 09:12:30 INFO - 'sessionrestore_no_auto_restore', 09:12:30 INFO - 'tabpaint']}, 09:12:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:12:30 INFO - 'ts_paint', 09:12:30 INFO - 'tpaint', 09:12:30 INFO - 'sessionrestore', 09:12:30 INFO - 'sessionrestore_no_auto_restore', 09:12:30 INFO - 'tabpaint']}, 09:12:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:12:30 INFO - 'tests': ['a11yr', 09:12:30 INFO - 'ts_paint', 09:12:30 INFO - 'tpaint', 09:12:30 INFO - 'sessionrestore', 09:12:30 INFO - 'sessionrestore_no_auto_restore', 09:12:30 INFO - 'tabpaint']}, 09:12:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:12:30 INFO - 'tests': ['a11yr', 09:12:30 INFO - 'ts_paint', 09:12:30 INFO - 'tpaint', 09:12:30 INFO - 'sessionrestore', 09:12:30 INFO - 'sessionrestore_no_auto_restore', 09:12:30 INFO - 'tabpaint']}, 09:12:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:12:30 INFO - 'tests': ['tsvgx', 09:12:30 INFO - 'tsvgr_opacity', 09:12:30 INFO - 'tart', 09:12:30 INFO - 'tscrollx', 09:12:30 INFO - 'cart']}, 09:12:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:12:30 INFO - 'tsvgr_opacity', 09:12:30 INFO - 'tart', 09:12:30 INFO - 'tscrollx', 09:12:30 INFO - 'cart']}, 09:12:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:30 INFO - 'talos_options': ['--disable-e10s'], 09:12:30 INFO - 'tests': ['tp5o']}, 09:12:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:30 INFO - 'tests': ['tp5o']}, 09:12:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:30 INFO - 'talos_options': ['--disable-e10s', 09:12:30 INFO - '--xperf_path', 09:12:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:12:30 INFO - 'tests': ['tp5n']}, 09:12:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:30 INFO - 'talos_options': ['--xperf_path', 09:12:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:12:30 INFO - 'tests': ['tp5n']}}, 09:12:30 INFO - 'talos.zip': {'path': '', 09:12:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:12:30 INFO - Running post-action listener: _resource_record_post_action 09:12:30 INFO - [mozharness: 2016-10-14 16:12:30.643517Z] Finished populate-webroot step (success) 09:12:30 INFO - [mozharness: 2016-10-14 16:12:30.643609Z] Running create-virtualenv step. 09:12:30 INFO - Running pre-action listener: _resource_record_pre_action 09:12:30 INFO - Running main action method: create_virtualenv 09:12:30 INFO - Creating virtualenv /builds/slave/test/build/venv 09:12:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:12:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:12:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:12:30 INFO - Using real prefix '/usr' 09:12:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:12:31 INFO - Installing distribute.............................................................................................................................................................................................done. 09:12:33 INFO - Installing pip.................done. 09:12:33 INFO - Return code: 0 09:12:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:12: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')]} 09:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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')]} 09:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7636943f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab3f60>, '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 0x1ab4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab51d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12: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', 'pip>=1.5'] in /builds/slave/test/build 09:12: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 pip>=1.5 09:12:33 INFO - Using env: {'DISPLAY': ':0', 09:12:33 INFO - 'HOME': '/home/cltbld', 09:12:33 INFO - 'LANG': 'en_US.UTF-8', 09:12:33 INFO - 'LANGUAGE': 'en_US:en', 09:12:33 INFO - 'LOGNAME': 'cltbld', 09:12:33 INFO - 'MAIL': '/var/mail/cltbld', 09:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:33 INFO - 'MOZ_NO_REMOTE': '1', 09:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:33 INFO - 'NO_EM_RESTART': '1', 09:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:33 INFO - 'PWD': '/builds/slave/test', 09:12:33 INFO - 'SHELL': '/bin/bash', 09:12:33 INFO - 'SHLVL': '1', 09:12:33 INFO - 'TERM': 'linux', 09:12:33 INFO - 'TMOUT': '86400', 09:12:33 INFO - 'USER': 'cltbld', 09:12:33 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 09:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:33 INFO - '_': '/tools/buildbot/bin/python'} 09:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:12:33 INFO - Cleaning up... 09:12:33 INFO - Return code: 0 09:12:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:12: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')]} 09:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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')]} 09:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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', '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 0x7f7636943f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab3f60>, '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 0x1ab4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab51d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12: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', 'psutil>=3.1.1'] in /builds/slave/test/build 09:12: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 psutil>=3.1.1 09:12:33 INFO - Using env: {'DISPLAY': ':0', 09:12:33 INFO - 'HOME': '/home/cltbld', 09:12:33 INFO - 'LANG': 'en_US.UTF-8', 09:12:33 INFO - 'LANGUAGE': 'en_US:en', 09:12:33 INFO - 'LOGNAME': 'cltbld', 09:12:33 INFO - 'MAIL': '/var/mail/cltbld', 09:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:33 INFO - 'MOZ_NO_REMOTE': '1', 09:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:33 INFO - 'NO_EM_RESTART': '1', 09:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:33 INFO - 'PWD': '/builds/slave/test', 09:12:33 INFO - 'SHELL': '/bin/bash', 09:12:33 INFO - 'SHLVL': '1', 09:12:33 INFO - 'TERM': 'linux', 09:12:33 INFO - 'TMOUT': '86400', 09:12:33 INFO - 'USER': 'cltbld', 09:12:33 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 09:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:33 INFO - '_': '/tools/buildbot/bin/python'} 09:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:33 INFO - Downloading/unpacking psutil>=3.1.1 09:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:12:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:12:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:12:35 INFO - Installing collected packages: psutil 09:12:35 INFO - Running setup.py install for psutil 09:12:35 INFO - building 'psutil._psutil_linux' extension 09:12:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:12:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:12:35 INFO - building 'psutil._psutil_posix' extension 09:12:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:12:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:12:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:12:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:12:36 INFO - Successfully installed psutil 09:12:36 INFO - Cleaning up... 09:12:36 INFO - Return code: 0 09:12:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7636943f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab3f60>, '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 0x1ab4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab51d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:12: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 mozsystemmonitor==0.3 09:12:36 INFO - Using env: {'DISPLAY': ':0', 09:12:36 INFO - 'HOME': '/home/cltbld', 09:12:36 INFO - 'LANG': 'en_US.UTF-8', 09:12:36 INFO - 'LANGUAGE': 'en_US:en', 09:12:36 INFO - 'LOGNAME': 'cltbld', 09:12:36 INFO - 'MAIL': '/var/mail/cltbld', 09:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:36 INFO - 'MOZ_NO_REMOTE': '1', 09:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:36 INFO - 'NO_EM_RESTART': '1', 09:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:36 INFO - 'PWD': '/builds/slave/test', 09:12:36 INFO - 'SHELL': '/bin/bash', 09:12:36 INFO - 'SHLVL': '1', 09:12:36 INFO - 'TERM': 'linux', 09:12:36 INFO - 'TMOUT': '86400', 09:12:36 INFO - 'USER': 'cltbld', 09:12:36 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 09:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:36 INFO - '_': '/tools/buildbot/bin/python'} 09:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:12: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 09:12: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 09:12: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 09:12: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 09:12: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 09:12: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 09:12:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:12:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:12:38 INFO - Installing collected packages: mozsystemmonitor 09:12:38 INFO - Running setup.py install for mozsystemmonitor 09:12:38 INFO - Successfully installed mozsystemmonitor 09:12:38 INFO - Cleaning up... 09:12:38 INFO - Return code: 0 09:12:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:12: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')]} 09:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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')]} 09:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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', '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 0x7f7636943f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab3f60>, '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 0x1ab4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab51d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:12: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 jsonschema==2.5.1 09:12:38 INFO - Using env: {'DISPLAY': ':0', 09:12:38 INFO - 'HOME': '/home/cltbld', 09:12:38 INFO - 'LANG': 'en_US.UTF-8', 09:12:38 INFO - 'LANGUAGE': 'en_US:en', 09:12:38 INFO - 'LOGNAME': 'cltbld', 09:12:38 INFO - 'MAIL': '/var/mail/cltbld', 09:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:38 INFO - 'MOZ_NO_REMOTE': '1', 09:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:38 INFO - 'NO_EM_RESTART': '1', 09:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:38 INFO - 'PWD': '/builds/slave/test', 09:12:38 INFO - 'SHELL': '/bin/bash', 09:12:38 INFO - 'SHLVL': '1', 09:12:38 INFO - 'TERM': 'linux', 09:12:38 INFO - 'TMOUT': '86400', 09:12:38 INFO - 'USER': 'cltbld', 09:12:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 09:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:38 INFO - '_': '/tools/buildbot/bin/python'} 09:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:38 INFO - Downloading/unpacking jsonschema==2.5.1 09:12: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 09:12: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 09:12: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 09:12: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 09:12: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 09:12: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 09:12:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:12:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:40 INFO - Downloading functools32-3.2.3-2.tar.gz 09:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:12:40 INFO - warning: no files found matching '*.txt' 09:12:40 INFO - no previously-included directories found matching 'build' 09:12:40 INFO - no previously-included directories found matching 'dist' 09:12:40 INFO - no previously-included directories found matching '.git*' 09:12:40 INFO - Installing collected packages: jsonschema, functools32 09:12:40 INFO - Running setup.py install for functools32 09:12:41 INFO - warning: no files found matching '*.txt' 09:12:41 INFO - no previously-included directories found matching 'build' 09:12:41 INFO - no previously-included directories found matching 'dist' 09:12:41 INFO - no previously-included directories found matching '.git*' 09:12:41 INFO - Successfully installed jsonschema functools32 09:12:41 INFO - Cleaning up... 09:12:41 INFO - Return code: 0 09:12:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:41 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 0x7f7636943f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab3f60>, '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 0x1ab4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab51d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:12:41 INFO - Using env: {'DISPLAY': ':0', 09:12:41 INFO - 'HOME': '/home/cltbld', 09:12:41 INFO - 'LANG': 'en_US.UTF-8', 09:12:41 INFO - 'LANGUAGE': 'en_US:en', 09:12:41 INFO - 'LOGNAME': 'cltbld', 09:12:41 INFO - 'MAIL': '/var/mail/cltbld', 09:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:41 INFO - 'MOZ_NO_REMOTE': '1', 09:12:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:41 INFO - 'NO_EM_RESTART': '1', 09:12:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:41 INFO - 'PWD': '/builds/slave/test', 09:12:41 INFO - 'SHELL': '/bin/bash', 09:12:41 INFO - 'SHLVL': '1', 09:12:41 INFO - 'TERM': 'linux', 09:12:41 INFO - 'TMOUT': '86400', 09:12:41 INFO - 'USER': 'cltbld', 09:12:41 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 09:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:41 INFO - '_': '/tools/buildbot/bin/python'} 09:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:12:41 INFO - Cleaning up... 09:12:41 INFO - Return code: 0 09:12:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:41 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 0x7f7636943f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab3f60>, '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 0x1ab4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab51d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:12:41 INFO - Using env: {'DISPLAY': ':0', 09:12:41 INFO - 'HOME': '/home/cltbld', 09:12:41 INFO - 'LANG': 'en_US.UTF-8', 09:12:41 INFO - 'LANGUAGE': 'en_US:en', 09:12:41 INFO - 'LOGNAME': 'cltbld', 09:12:41 INFO - 'MAIL': '/var/mail/cltbld', 09:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:41 INFO - 'MOZ_NO_REMOTE': '1', 09:12:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:41 INFO - 'NO_EM_RESTART': '1', 09:12:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:41 INFO - 'PWD': '/builds/slave/test', 09:12:41 INFO - 'SHELL': '/bin/bash', 09:12:41 INFO - 'SHLVL': '1', 09:12:41 INFO - 'TERM': 'linux', 09:12:41 INFO - 'TMOUT': '86400', 09:12:41 INFO - 'USER': 'cltbld', 09:12:41 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 09:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:41 INFO - '_': '/tools/buildbot/bin/python'} 09:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:41 INFO - Downloading/unpacking blobuploader==1.2.4 09:12: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 09:12: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 09:12: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 09:12: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 09:12: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 09:12: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 09:12:43 INFO - Downloading blobuploader-1.2.4.tar.gz 09:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:12:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:12:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:44 INFO - Downloading docopt-0.6.1.tar.gz 09:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:12:44 INFO - Installing collected packages: blobuploader, requests, docopt 09:12:44 INFO - Running setup.py install for blobuploader 09:12:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:12:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:12:44 INFO - Running setup.py install for requests 09:12:44 INFO - Running setup.py install for docopt 09:12:44 INFO - Successfully installed blobuploader requests docopt 09:12:44 INFO - Cleaning up... 09:12:44 INFO - Return code: 0 09:12:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:44 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 0x7f7636943f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab3f60>, '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 0x1ab4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab51d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:12:44 INFO - Using env: {'DISPLAY': ':0', 09:12:44 INFO - 'HOME': '/home/cltbld', 09:12:44 INFO - 'LANG': 'en_US.UTF-8', 09:12:44 INFO - 'LANGUAGE': 'en_US:en', 09:12:44 INFO - 'LOGNAME': 'cltbld', 09:12:44 INFO - 'MAIL': '/var/mail/cltbld', 09:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:44 INFO - 'MOZ_NO_REMOTE': '1', 09:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:44 INFO - 'NO_EM_RESTART': '1', 09:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:44 INFO - 'PWD': '/builds/slave/test', 09:12:44 INFO - 'SHELL': '/bin/bash', 09:12:44 INFO - 'SHLVL': '1', 09:12:44 INFO - 'TERM': 'linux', 09:12:44 INFO - 'TMOUT': '86400', 09:12:44 INFO - 'USER': 'cltbld', 09:12:44 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 09:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:44 INFO - '_': '/tools/buildbot/bin/python'} 09:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:12:45 INFO - Running setup.py (path:/tmp/pip-XrVFAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:12:45 INFO - Running setup.py (path:/tmp/pip-0NGLzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:12:45 INFO - Running setup.py (path:/tmp/pip-qKS548-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:12:45 INFO - Running setup.py (path:/tmp/pip-jv3q6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:12:45 INFO - Running setup.py (path:/tmp/pip-E1OS9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:12:45 INFO - Running setup.py (path:/tmp/pip-rI0mvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:12:45 INFO - Running setup.py (path:/tmp/pip-hR4aaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:12:45 INFO - Running setup.py (path:/tmp/pip-SPBABc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:12:45 INFO - Running setup.py (path:/tmp/pip-GySoSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:12:45 INFO - Running setup.py (path:/tmp/pip-9hyBx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:12:45 INFO - Running setup.py (path:/tmp/pip-rYlvnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:12:45 INFO - Running setup.py (path:/tmp/pip-Lk3oGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:12:45 INFO - Running setup.py (path:/tmp/pip-vTB0Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:12:46 INFO - Running setup.py (path:/tmp/pip-1tIPxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:46 INFO - Running setup.py (path:/tmp/pip-mVblR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:12:46 INFO - Running setup.py (path:/tmp/pip-2hTXuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:12:46 INFO - Running setup.py (path:/tmp/pip-37e7mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:12:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:12:46 INFO - Running setup.py install for manifestparser 09:12:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:12:46 INFO - Running setup.py install for mozcrash 09:12:46 INFO - Running setup.py install for mozdebug 09:12:46 INFO - Running setup.py install for mozdevice 09:12:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:12:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:12:46 INFO - Running setup.py install for mozfile 09:12:46 INFO - Running setup.py install for mozhttpd 09:12:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:12:46 INFO - Running setup.py install for mozinfo 09:12:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:12:47 INFO - Running setup.py install for mozInstall 09:12:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:12:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:12:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:12:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:12:47 INFO - Running setup.py install for mozleak 09:12:47 INFO - Running setup.py install for mozlog 09:12:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:12:47 INFO - Running setup.py install for moznetwork 09:12:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:12:47 INFO - Running setup.py install for mozprocess 09:12:47 INFO - Running setup.py install for mozprofile 09:12:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:12:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:12:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:12:47 INFO - Running setup.py install for mozrunner 09:12:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:12:47 INFO - Running setup.py install for mozscreenshot 09:12:47 INFO - Running setup.py install for moztest 09:12:47 INFO - Running setup.py install for mozversion 09:12:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:12:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:12:48 INFO - Cleaning up... 09:12:48 INFO - Return code: 0 09:12:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:48 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 0x7f7636943f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab3f60>, '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 0x1ab4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab51d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:12:48 INFO - Using env: {'DISPLAY': ':0', 09:12:48 INFO - 'HOME': '/home/cltbld', 09:12:48 INFO - 'LANG': 'en_US.UTF-8', 09:12:48 INFO - 'LANGUAGE': 'en_US:en', 09:12:48 INFO - 'LOGNAME': 'cltbld', 09:12:48 INFO - 'MAIL': '/var/mail/cltbld', 09:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:48 INFO - 'MOZ_NO_REMOTE': '1', 09:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:48 INFO - 'NO_EM_RESTART': '1', 09:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:48 INFO - 'PWD': '/builds/slave/test', 09:12:48 INFO - 'SHELL': '/bin/bash', 09:12:48 INFO - 'SHLVL': '1', 09:12:48 INFO - 'TERM': 'linux', 09:12:48 INFO - 'TMOUT': '86400', 09:12:48 INFO - 'USER': 'cltbld', 09:12:48 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 09:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:48 INFO - '_': '/tools/buildbot/bin/python'} 09:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:12:48 INFO - Running setup.py (path:/tmp/pip-PaYE7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:12:48 INFO - Running setup.py (path:/tmp/pip-EmZGn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:12:48 INFO - Running setup.py (path:/tmp/pip-qdASPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:12:48 INFO - Running setup.py (path:/tmp/pip-44Dhay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:12:48 INFO - Running setup.py (path:/tmp/pip-op0lML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:12:48 INFO - Running setup.py (path:/tmp/pip-TiepSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:12:48 INFO - Running setup.py (path:/tmp/pip-2k3Bsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:12:48 INFO - Running setup.py (path:/tmp/pip-vW0thq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:12:48 INFO - Running setup.py (path:/tmp/pip-yK4h9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:12:48 INFO - Running setup.py (path:/tmp/pip-dxQBuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:12:49 INFO - Running setup.py (path:/tmp/pip-rOkDfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:12:49 INFO - Running setup.py (path:/tmp/pip-lxANM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:12:49 INFO - Running setup.py (path:/tmp/pip-RfDpwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:12:49 INFO - Running setup.py (path:/tmp/pip-bQlR4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:49 INFO - Running setup.py (path:/tmp/pip-FqgM4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:12:49 INFO - Running setup.py (path:/tmp/pip-jVEeMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:12:49 INFO - Running setup.py (path:/tmp/pip-Ir3u9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:12:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:51 INFO - Downloading blessings-1.6.tar.gz 09:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:12:51 INFO - Installing collected packages: blessings 09:12:51 INFO - Running setup.py install for blessings 09:12:51 INFO - Successfully installed blessings 09:12:51 INFO - Cleaning up... 09:12:51 INFO - Return code: 0 09:12:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:12:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:12:51 INFO - Reading from file tmpfile_stdout 09:12:51 INFO - Current package versions: 09:12:51 INFO - argparse == 1.2.1 09:12:51 INFO - blessings == 1.6 09:12:51 INFO - blobuploader == 1.2.4 09:12:51 INFO - docopt == 0.6.1 09:12:51 INFO - functools32 == 3.2.3-2 09:12:51 INFO - jsonschema == 2.5.1 09:12:51 INFO - manifestparser == 1.1 09:12:51 INFO - mozInstall == 1.12 09:12:51 INFO - mozcrash == 0.17 09:12:51 INFO - mozdebug == 0.1 09:12:51 INFO - mozdevice == 0.48 09:12:51 INFO - mozfile == 1.2 09:12:51 INFO - mozhttpd == 0.7 09:12:51 INFO - mozinfo == 0.9 09:12:51 INFO - mozleak == 0.1 09:12:51 INFO - mozlog == 3.4 09:12:51 INFO - moznetwork == 0.27 09:12:51 INFO - mozprocess == 0.23 09:12:51 INFO - mozprofile == 0.28 09:12:51 INFO - mozrunner == 6.12 09:12:51 INFO - mozscreenshot == 0.1 09:12:51 INFO - mozsystemmonitor == 0.3 09:12:51 INFO - moztest == 0.7 09:12:51 INFO - mozversion == 1.4 09:12:51 INFO - psutil == 3.1.1 09:12:51 INFO - requests == 1.2.3 09:12:51 INFO - wsgiref == 0.1.2 09:12:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:51 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 0x7f7636943f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab3f60>, '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 0x1ab4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab51d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:12:51 INFO - Using env: {'DISPLAY': ':0', 09:12:51 INFO - 'HOME': '/home/cltbld', 09:12:51 INFO - 'LANG': 'en_US.UTF-8', 09:12:51 INFO - 'LANGUAGE': 'en_US:en', 09:12:51 INFO - 'LOGNAME': 'cltbld', 09:12:51 INFO - 'MAIL': '/var/mail/cltbld', 09:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:51 INFO - 'MOZ_NO_REMOTE': '1', 09:12:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:51 INFO - 'NO_EM_RESTART': '1', 09:12:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:51 INFO - 'PWD': '/builds/slave/test', 09:12:51 INFO - 'SHELL': '/bin/bash', 09:12:51 INFO - 'SHLVL': '1', 09:12:51 INFO - 'TERM': 'linux', 09:12:51 INFO - 'TMOUT': '86400', 09:12:51 INFO - 'USER': 'cltbld', 09:12:51 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 09:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:51 INFO - '_': '/tools/buildbot/bin/python'} 09:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:12:52 INFO - Cleaning up... 09:12:52 INFO - Return code: 0 09:12:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:52 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 0x7f7636943f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab3f60>, '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 0x1ab4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab51d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:12:52 INFO - Using env: {'DISPLAY': ':0', 09:12:52 INFO - 'HOME': '/home/cltbld', 09:12:52 INFO - 'LANG': 'en_US.UTF-8', 09:12:52 INFO - 'LANGUAGE': 'en_US:en', 09:12:52 INFO - 'LOGNAME': 'cltbld', 09:12:52 INFO - 'MAIL': '/var/mail/cltbld', 09:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:52 INFO - 'MOZ_NO_REMOTE': '1', 09:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:52 INFO - 'NO_EM_RESTART': '1', 09:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:52 INFO - 'PWD': '/builds/slave/test', 09:12:52 INFO - 'SHELL': '/bin/bash', 09:12:52 INFO - 'SHLVL': '1', 09:12:52 INFO - 'TERM': 'linux', 09:12:52 INFO - 'TMOUT': '86400', 09:12:52 INFO - 'USER': 'cltbld', 09:12:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 09:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:52 INFO - '_': '/tools/buildbot/bin/python'} 09:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:12:52 INFO - Cleaning up... 09:12:52 INFO - Return code: 0 09:12:52 INFO - Running post-action listener: _resource_record_post_action 09:12:52 INFO - Running post-action listener: _start_resource_monitoring 09:12:52 INFO - Starting resource monitoring. 09:12:52 INFO - [mozharness: 2016-10-14 16:12:52.431128Z] Finished create-virtualenv step (success) 09:12:52 INFO - [mozharness: 2016-10-14 16:12:52.431591Z] Running install step. 09:12:52 INFO - Running pre-action listener: _resource_record_pre_action 09:12:52 INFO - Running main action method: install 09:12:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:12:52 INFO - Reading from file tmpfile_stdout 09:12:52 INFO - Detecting whether we're running mozinstall >=1.0... 09:12:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:12:52 INFO - Reading from file tmpfile_stdout 09:12:52 INFO - Output received: 09:12:52 INFO - Usage: mozinstall [options] installer 09:12:52 INFO - Options: 09:12:52 INFO - -h, --help show this help message and exit 09:12:52 INFO - -d DEST, --destination=DEST 09:12:52 INFO - Directory to install application into. [default: 09:12:52 INFO - "/builds/slave/test"] 09:12:52 INFO - --app=APP Application being installed. [default: firefox] 09:12:52 INFO - mkdir: /builds/slave/test/build/application 09:12:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:13:08 INFO - Reading from file tmpfile_stdout 09:13:08 INFO - Output received: 09:13:08 INFO - /builds/slave/test/build/application/firefox/firefox 09:13:08 INFO - Running post-action listener: _resource_record_post_action 09:13:08 INFO - [mozharness: 2016-10-14 16:13:08.691879Z] Finished install step (success) 09:13:08 INFO - [mozharness: 2016-10-14 16:13:08.692123Z] Running run-tests step. 09:13:08 INFO - Running pre-action listener: _resource_record_pre_action 09:13:08 INFO - Running main action method: run_tests 09:13:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:13:08 INFO - Python 2.7.3 09:13:08 INFO - Return code: 0 09:13:08 INFO - grabbing minidump binary from tooltool 09:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:08 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 0x1ab3f60>, '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 0x1ab4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab51d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:13:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:13:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:13:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:13:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:13:08 INFO - Return code: 0 09:13:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:13:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:13:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:13:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:13:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:13:08 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/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:13:08 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/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:13:08 INFO - Using env: {'DISPLAY': ':0', 09:13:08 INFO - 'HOME': '/home/cltbld', 09:13:08 INFO - 'LANG': 'en_US.UTF-8', 09:13:08 INFO - 'LANGUAGE': 'en_US:en', 09:13:08 INFO - 'LOGNAME': 'cltbld', 09:13:08 INFO - 'MAIL': '/var/mail/cltbld', 09:13:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:13:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:08 INFO - 'MOZ_NO_REMOTE': '1', 09:13:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:08 INFO - 'NO_EM_RESTART': '1', 09:13:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:08 INFO - 'PWD': '/builds/slave/test', 09:13:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:13:08 INFO - 'SHELL': '/bin/bash', 09:13:08 INFO - 'SHLVL': '1', 09:13:08 INFO - 'TERM': 'linux', 09:13:08 INFO - 'TMOUT': '86400', 09:13:08 INFO - 'USER': 'cltbld', 09:13:08 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218', 09:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:08 INFO - '_': '/tools/buildbot/bin/python'} 09:13:08 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/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:13:08 INFO - mozversion application_buildid: 20161014061436 09:13:08 INFO - mozversion application_changeset: f061dfbab3ed719d9d1dc8f1e9cff51efd6d03a8 09:13:08 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:13:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:13:08 INFO - mozversion application_name: Firefox 09:13:08 INFO - mozversion application_remotingname: firefox-dev 09:13:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:13:08 INFO - mozversion application_vendor: Mozilla 09:13:08 INFO - mozversion application_version: 51.0a2 09:13:08 INFO - mozversion platform_buildid: 20161014061436 09:13:08 INFO - mozversion platform_changeset: f061dfbab3ed719d9d1dc8f1e9cff51efd6d03a8 09:13:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:13:08 INFO - mozversion platform_version: 51.0a2 09:13:08 INFO - using testdate: 1476461588 09:13:08 INFO - actual date: 1476461588 09:13:08 INFO - starting webserver on 'localhost:44476' 09:13:08 INFO - SUITE-START | Running 2 tests 09:13:08 INFO - TEST-START | dromaeo_css 09:13:08 INFO - operating with platform_type : linux_ 09:13:08 INFO - Initialising browser for dromaeo_css test... 09:13:08 INFO - TEST-INFO | started process 19491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwFGSf1/profile http://localhost:44476/getInfo.html) 09:13:13 INFO - PROCESS | 19491 | __metrics Screen width/height:1600/1200 09:13:13 INFO - PROCESS | 19491 | colorDepth:24 09:13:13 INFO - PROCESS | 19491 | Browser inner width/height: 1024/697 09:13:13 INFO - PROCESS | 19491 | __metrics 09:13:13 INFO - PROCESS | 19491 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:13:13 INFO - PROCESS | 19491 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:13:14 INFO - PROCESS | 19491 | console.error: PushService: 09:13:14 INFO - PROCESS | 19491 | stateChangeProcessEnqueue: Error transitioning state 09:13:14 INFO - PROCESS | 19491 | UnknownError 09:13:14 INFO - TEST-INFO | 19491: exit 0 09:13:14 INFO - Browser initialized. 09:13:14 INFO - Running cycle 1/1 for dromaeo_css test... 09:13:14 INFO - TEST-INFO | started process 19583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwFGSf1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:26 INFO - PROCESS | 19583 | RSS: Main: 144625664 09:13:26 INFO - PROCESS | 19583 | 09:14:17 INFO - PROCESS | 19583 | 1476461657672 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:16:26 INFO - PROCESS | 19583 | Cycle 1(1): loaded http://localhost:44476/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44476/tests/dromaeo/cssquery-ext.html) 09:16:27 INFO - PROCESS | 19583 | RSS: Main: 233529344 09:16:27 INFO - PROCESS | 19583 | 09:19:30 INFO - PROCESS | 19583 | Cycle 1(1): loaded http://localhost:44476/tests/dromaeo/cssquery-ext.html (next: http://localhost:44476/tests/dromaeo/cssquery-jquery.html) 09:19:30 INFO - PROCESS | 19583 | RSS: Main: 220835840 09:19:30 INFO - PROCESS | 19583 | 09:22:32 INFO - PROCESS | 19583 | Cycle 1(1): loaded http://localhost:44476/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44476/tests/dromaeo/cssquery-mootools.html) 09:22:33 INFO - PROCESS | 19583 | RSS: Main: 173690880 09:22:33 INFO - PROCESS | 19583 | 09:25:35 INFO - PROCESS | 19583 | Cycle 1(1): loaded http://localhost:44476/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44476/tests/dromaeo/cssquery-prototype.html) 09:25:35 INFO - PROCESS | 19583 | RSS: Main: 174501888 09:25:35 INFO - PROCESS | 19583 | 09:28:38 INFO - PROCESS | 19583 | Cycle 1(1): loaded http://localhost:44476/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44476/tests/dromaeo/cssquery-yui.html) 09:28:39 INFO - PROCESS | 19583 | RSS: Main: 175562752 09:28:39 INFO - PROCESS | 19583 | 09:31:41 INFO - PROCESS | 19583 | Cycle 1(1): loaded http://localhost:44476/tests/dromaeo/cssquery-yui.html (next: http://localhost:44476/tests/dromaeo/cssquery-dojo.html) 09:31:41 INFO - PROCESS | 19583 | RSS: Main: 265940992 09:31:41 INFO - PROCESS | 19583 | 09:31:41 INFO - PROCESS | 19583 | __start_tp_report 09:31:41 INFO - PROCESS | 19583 | _x_x_mozilla_page_load 09:31:41 INFO - PROCESS | 19583 | _x_x_mozilla_page_load_details 09:31:41 INFO - PROCESS | 19583 | |i|pagename|runs| 09:31:41 INFO - PROCESS | 19583 | |0;dojo.html;3131.217195701074;3168.2396224906024;3182.904512864615;3203.3593281343738;3219.1308346746378;5440.3743569489525;5548.86127846803;5557.3331200255925;5574.0802767543355;5601.747921343539;5517.206907754976;5566.997940370742;5573.860653483665;5597.216389705434;5598.664080155183;5012.573931215842;5032.069067222557;5032.57223136032;5077.164726121327;5123.1546794778815;4940.728259945701;4971.229459433794;5072.923906141411;5120.436751957282;5129.1536896412235;4946.258061290817;4962.131626965284;5017.147084995559;5091.592672586203;5146.974265128688;5147.639665223417;5158.509941555546;5222.033923724123;5223.791048358061;5250.921236181461;4846.612271018345;5127.384713834326;5138.409082955471;5194.298769666122;5214.243934629495;5407.297051383334;5466.398696143421;5468.890622187574;5520.613557051008;5590.748416321276;5864.677442740647;5872.941270587282;6003.159557661887;6008.699565021731;6012.6392416455155;5840.47435730782;6037.45662890342;6038.818835434944;6049.48579370754;6052.878942421127;5466.098093814516;5494.2582751328455;5521.861953451155;5529.474699903502;5556.944430555643;6096;6100.054491553817;6106;6107.9616465201025;6109.358517355702;5857.7949771757785;5858.56060795442;5869.207656966255;5869.618474799125;5871.6183448075735;5793.797217097382;5826.388229235954;5938.940610593925;5986.161937328778;5995.400459953969;6006.5495087868585;6006.579539432198;6006.6696331701305;6017.217761690952;6054.576179667381;5989.790357337472;5999.880002399927;6049.455549000611;6052.697365131726;6075.544334174954;4450.732956022649;4480.865574032784;4554.749488778149;4592.402987611656;4634.189016922025;4096.242195193899;4104.897377565585;4113.91772164561;4126.236646220459;4137.50349958001;5690.886182276331;5690.9146362804595;5700.087985922232;5701.4013528579735;5702.800401985911;5776.826695199066;5869.295684517885;5918.2898052234;6011.579189456696;6022.45797878193;5473;5511.696856672841;5557.360903496069;5557.944420555824;5563.944360556424;4841.564259216688;4846.660733748604;4855.902881942341;4858.951410485921;4876.390451193601;5952.523798096228;6013.909791353133;6016.849578760566;6024.849378765566;6026.276846778327;5876.823695289148;5931.288245410578;5954.255718035246;6006.069059295816;6010.639361638316;6247.5001999839;6261.78083767066;6263.373662633882;6263.592866463665;6268.467180289544;5962.52299816005;5965.492933100735;5966.254218222723;5973.193618861572;5996.040633498619;5791.797287094932;5849.766009359578;5885.558583106199;5985.610935289193;6070.453659170696;5704.971475142598;5802.1586869902785;5816.302043754777;5817.214676018683;5845.035569131046;5780;5797.072468405035;5797.159411885337;5809.186713859978;5815.680137592473;5522.6134170607675;5543.833684989457;5691;5705.543556515386;5723.656580605177;5796.797112101056;5904.61619994699;5925.644461332334;5952.970235148797;5955.702214889152;5716.657000579979;5780.364159942487;5780.7398667060925;5783.421657834351;5792.739326730223 09:31:41 INFO - PROCESS | 19583 | |1;ext.html;590.2179612014082;613.5919613457052;631.2298995225826;634.635084826225;658.2035736758523;35759.642403575956;38239.4264086039;46783.532164678385;47188.76405617976;47195;50110.74944625272;50480.74759626206;50498;50539.747301263444;50547;9304.860427093583;9417.62329506819;9425.858612120825;9429.858552121723;9442.480663563501;8313.95843020784;8534.74395768128;11012.559497620126;11240.831387529193;11250.156238282121;11189.49647265875;11285.097192224603;11287.717807054849;11293.548258069668;11298.548058077668;11146.498407571638;11179.66461006171;11187.105031597453;11218.719532011683;11221.158413118967;11083.833742493869;11136.665900023012;11143.554257829677;11143.832842507369;11144.387058711767;44718.55281447176;45075.323870141976;45148.77425612851;45156.77421612904;45204.54795452036;3833.290841194388;3844.6347596978244;4484.484284307314;4535;4633.397658304432;34720;34849.65150348515;35032.19742420626;35188.47217291743;36324.09189770251;4640.744759038252;4706.435227772689;4709.458412282597;4744.454387745419;4765.547273009059;331205;331968;332025;332939;333254;65506.67246663736;65812;65916;65948.67025664936;65973.67013164904;37846.81076594599;38502.80748596239;38640.42039369412;38718.80640596779;38759;17198.74201886973;17404;17421.564460888578;17426.12869356527;17429.12854357277;12622.936885315698;12870.9356453219;12996.740065198643;13007.089503734647;13018.739625207443;18317.267309307746;20367.898160509398;20858.895705521376;20995.685064724043;21708.240211592834;7261.3827824634445;7475.887861682079;7493.925060749431;7578.962105189439;7644.694212231449;963.5278713430368;988.2736188901152;1046.8078331475813;1095.0637205189448;1129.3054771315747;33817.32365352679;34788.652113479046;34806.47790283097;34811.82594087064;34869.30261394758;1119.2333251722596;1147.8163493841112;1188.44737197202;1191.7259030423052;1240.3054289597853;17824.732629010574;17898.373556925446;18070.457886263433;18150.364737234133;18193;556486;559610;562688;565321;565828;63124;63621.68189159025;63670.6816465924;63690.044649330295;64254.67872660607;1299.4477347127622;1333.7732585460494;1344.3009634989946;1374.7869080292571;1415.2287003582867;33330.5000424989;36487.55698378255;36609.267814643026;36751.816240918626;36771;55081.724591376784;55900;55924;55925.72037139951;55958.44041559532;410457;416983;419924;421020;421483;31655.366892662478;31957.36085278235;32028.839855800572;32222.516662249614;33608.83195584006;53704.73147634393;53819.19271211013;53956.30218488981;54001.18998214951;54172.45827541674;44740.55259447494;45143.548564513934;45218.09563808771;45566.544334557555;46514.53485465102;44271.21227869647;45976.77011614921;46195.30707039464;46450;46685.299720504896;44438.333424998;44773.776131119135;44882;44971;44974.77512612416;37612.2477550453;39423.60576394314;40080.39879401753;40320.798396007835;40507.59492405038;29079;29710.702892970792;29852.70147298586;29867.701322987363;30125.548116778704 09:31:41 INFO - PROCESS | 19583 | |2;jquery.html;391.172669803366;421.7701352762746;422.9619334259916;429.4095618524529;443.26639411773505;15578.766318505217;19246.615067698636;20384.388468345973;21604.783952160473;21736.021879015443;20339.796602033974;21089.789102108974;21090.578188436222;21149.15403383863;21179.57640847182;5797.65214087154;5811.912821307684;6026.517878569726;6029.909551356734;6030.155778191057;5907.527397808187;5939.732712027969;5974;5979.46184843364;5990.880182396371;5726.083826587746;5883.058710606304;5940.227770389865;5947.821565353046;5952.613080149798;5881.911771323412;5884.411558844125;5912.970435147839;5920.615160014629;5921.082232254007;5293.444188360205;5317.2821669074565;5340.786368545254;5354.571634269288;5358.3837858645975;23807.523849523084;24310.878445607836;24521.264362069167;24528.754712452825;24547.263582092564;2583.4962182374443;2619.528484872722;2669.9125202865935;2999.4001199760137;3036.5141577347517;10843.51204195813;11142.442877856074;11358.488868000959;11681.766364672743;11687.824682629767;1994.1524851938013;2033.857629965903;2042.1320938601036;2073.8029887160847;2082.916683332665;84921.57539212327;85306.57346713227;86059.56970215109;87618;88748.55625721895;10629.840552391566;11704.648860534198;11782.410879455992;11891.88108118925;11951.462184201731;15671;15780.68438631221;16396.590085247964;16664.33342666304;16717.164141792862;8272.214139656844;8295.751127466187;8341.749747507585;8436.831263374821;8639.91360086391;7913.564753938589;7984.84030319402;8022.839543209103;8149.796255093552;8156.469829461066;5086.54221120101;5164.431912489623;5190.6107041972;5269.241931596285;5314.1497360422145;2065.380385884229;2079.3657934330176;2091.4144039668918;2109.5148115933116;2146.7101941237734;948.7201275623707;970.1365784451843;990.7968866382519;1004.2769206171545;1024.3444195714749;19316.227350906087;19991.500212494804;20086.39740807778;20469;20699.58600827975;1003.5885287032281;1025.7999690060515;1027.9640212592524;1028.8559601655775;1105.6627728542871;10690.144788416908;10913.890861091446;11647;11916.642500724993;12345.93827030877;467619;476372;489612;491726;495033;87629;88674.55662721646;91172.54413728022;95567;107317;1023.6059117239768;1080.2276372393776;1082.2910993299402;1086.315621158665;1092.448313601626;18233.544161396072;18837.529061773566;18842.71735923935;18943.90528047406;18976.620467590295;40127.79936100301;42792.144157117305;43968.02143903596;44914;45730;57878.131828023455;58649.413505864395;58740;58873.411265886796;59542;8775.254103401283;8837.690680826141;8996.55017249122;9035.232005279362;9116.1339672731;12711.682207944505;12988.025898057494;13026.54407095747;13381.66545836362;13525.458981641017;11486;11778.823317650413;12104.939475302566;12414.81377779352;12442.688932776753;11218.719532011764;11356.716082098013;11665.183437159318;12099.213551119148;12132.696682583006;11481.885181148082;11711.472983715923;12154.696132596402;12168.2699038058;12545.435455404346;9010.684626038057;9323.20752736025;9342.39274447186;9381.296402769683;9766.21870250364;11498.25261358009;11846.703832404259;12119.939400302943;12198.268103913793;12371.195872268274 09:31:41 INFO - PROCESS | 19583 | |3;mootools.html;1383.0595195267226;1508.9622759431013;1548.2955255358809;1687.4009726547076;1826.6894627913252;7756.457048006635;8291.917080829198;8626.611802468888;8626.698065567707;8663.566821658915;8338.374621903351;8421.284190843786;8484.151584841513;8760.211580957712;8772.42979206351;2413.73448920619;2456.2876765738006;2458.139651122111;2458.6680798092298;2462.4828785954883;2400.0556074116703;2460.692413448319;2462.839915405502;2464.556379851626;2464.6795916530828;2404.927852164438;2410.650455683925;2434.610462326028;2451.0563433078305;2462.162864626027;2332.207049603143;2362.397588614901;2367.1359953616893;2367.6566897799894;2395.652630368604;2358.433975845802;2358.858468491896;2358.870262135582;2366.2309749331366;2367.3134790910617;8444.873326900102;8702;8710.825783484295;8715.738527844174;8733.956330218372;5203.16749320107;5378.381486129067;5398.514133727944;5412.675239485604;5415.214793854909;3321.451960426551;3332.96667033329;3349.765516413852;3364.7812892161933;3427.3830710472107;1293.508466782626;1296.6887946892773;1307.8495972963135;1331.9600411987656;1336.2850874781946;12155.453004614814;12403.75192496145;12406.565770198;12422.689432764253;12423.503059877594;4642.189546077033;4694.225452800318;4855.271709243571;4921.532454416824;4921.655484116149;10474.68575942723;10610.89389106099;10616;10617.150627949746;10624.575016999388;5510.779568817283;5516.779328826802;5517.944820551824;5519.724013799374;5525.143602741581;4477.417935668343;4596.6322694185055;4730.243161094278;4827.517248275144;5091.0581542414775;4192.685548583869;4250.596193361625;4321.13577284538;4326.437563116838;4367.75977321244;1329.7539955108336;1366.2349084512705;1388.666719987216;1421.069199674215;1423.608507660381;1039.8492218628407;1043.608646757466;1048.4024106259512;1051.600391851107;1056.8678915135454;6121.418465245794;6164.291106522807;6252.468540174136;6268.059791031291;6298.382121748796;477.0816178855689;477.5415601022987;482.973436460998;485.55086544945783;493.9431965323962;4446.710963787344;4461.107778444324;4478.932816007762;4643.373144625432;4718.457377401574;10704.78590428187;10840.078593319657;10897.727556810985;10907.618233361794;10911.727206819734;10185.33795303303;10775.084117849914;10878.347299162075;10886;10901.945490272497;7882;8210;8221.465604735673;8229.835403291901;8243.505389676639;5907.91138132937;6124.448799608057;6148.78479253224;6175.84560385994;6271.090691849565;9651.71044868655;9908.900910990798;9952.10431061208;9954.701358959242;9964.302498825302;10077.69766906994;10304.124149447382;10311.07200351972;10348.22388320894;10409.479526023517;6913.308669133046;6980.162380514371;7434.591097489473;7813.413993950363;8008.1191068983535;8413.62138703772;8590.09803970599;8659.6103175356;8692.78268043304;8698.217160455337;7596.240375962359;7690.500117492345;7714.151443341116;7834.569098699626;7881.724139655084;7606.467547271638;7652.38780897538;7700.8459830804195;7718.807029824075;7892.644830982505;7203.02759127511;7293.124825021031;7297.759380905365;7306.7077316906725;7315.890261645973;5295.655782374288;5326.121190003606;5393.325834270716;5487.725613719218;5671.6597004179885;5540.667559946416;5592.245046918614;5617.213590097472;5645.068563686946;5711.457411545896 09:31:41 INFO - PROCESS | 19583 | |4;prototype.html;356.7271037656193;359.73020234823883;360.4593110334498;362.22483884487184;366.7121309771828;5367.329083864517;5429.457054294574;5438.456154384559;5449.482299181582;5467.562594992401;5347.491988261118;5364.839054828351;5375.946240537593;5389.649672771267;5398.24424580558;3712.7586706863967;4018.236535058337;4208.347706105558;4251.6173544381;4258.808353624095;4230.238557059728;4242.260673124019;4246.893827654302;4257.914841703164;4281.12236991416;4234.978825105885;4255.361695745632;4259.339802330644;4263.87208383749;4269.50900646425;3981.144054028369;4033.838646454138;4155.439015732868;4260.467441569804;4274.615284624383;3758.7932663703486;3767.9058023549355;3773.7735735855663;3777.5466943966626;3778.9622103778884;5278.340207474066;5281.339832520935;5288.6826790392315;5294.444083371268;5311.336082989626;4676.760658425486;4791.5687588117235;4837.346958160639;4881.951180488185;4888.169011268093;5576.219329293902;5584.46947539983;5591.30108736408;5593.552515798727;5605;4103.835846566164;4113.856015039489;4121.91756164875;4127.174565086994;4127.938080928789;5615.7472913718575;5771.422857714237;5802.477777000048;5818.650880947114;5834.358220595688;4212.031232816469;4213.726107803044;4215.451991241181;4224.957750422518;4233;4254.680898932593;4269.5516970718245;4271.594198551133;4275.893102672458;4283.528811830696;4540.409746732904;4799.160146974265;4828.903421931542;4829.372181616438;4835.105505481497;5608.383077861432;5638.238837756932;5654.688992105392;5658.660480371191;5672.404397538199;1458.4020551573803;1466.2448838848002;1467.8624066348666;1472.1535117307592;1472.2417954753312;906.6353261862522;949.2168960607388;953.3374304858057;962.3023308101571;964.6768332608515;4831.637627177905;4832.855014349575;4833.613310935117;4838.201696720002;4887.828925987574;5122.231665250242;5128.538236690294;5135.537801597874;5146.963291657939;5149.382074151051;4636.86089417318;4819.734914579662;4823.589994850407;4825.817674669728;4845.75771211438;2683.5974603809195;2705.889406263118;2706.146289791499;2708.7291270872756;2715.5247831629385;5153.474797349272;5181.5595674368105;5257.975679363472;5263.4473380295285;5280.683159010395;4873.463918968911;5154.9484505155215;5242.7378631068295;5251.84889066557;5645.774169033275;5839.4379428548555;5840.88318233633;5957.642541447441;5957.821265362046;5985.551083668655;5732.2230108666445;5798.449147330997;5802.912956305574;5805;5817.621854579439;5528.917066243929;5715.056880660595;5741.3397459291045;5753.971230143822;5781.682007489629;5847.05323906353;5875.6203737486385;5930.762769489172;5933.970330148321;5947.275290165977;4187.288161012574;4192.119654872511;4206.642435393026;4209.200251952119;4212.4523811904255;5511.366192887869;5720.885582288414;5769.769209231584;5789.33422656383;5794.82615521535;5630.423481425208;5632.521690456186;5641.9435805641415;5644.294463192101;5645.887082258249;5368.604162917748;5586.787597131584;5592.874707611244;5600.747966341606;5619.550435965195;5589.301337332833;5597.608167428404;5598.720063996702;5599.272094627672;5607.41122182165;5657.688827114548;5660.905464977985;5667.0649342859615;5668.461496157858;5704.828855134353;5337.172738225581;5534.861628459321;5544.447554684533;5578.30271216098;5579.330480342385 09:31:41 INFO - PROCESS | 19583 | |5;yui.html;836.5733475927275;836.8451836410264;876.3427429427929;887.9778005549861;897.735168125403;15613.219339033045;16387.01677899324;16423.753643695352;16431;16435.506934791945;12216.389180540982;15906.920465397658;16062.678746425065;16079.356825726956;16113.919430402831;704.7744721689074;817.5094943034162;844.1221130024767;853.8335024670192;860.6987554355987;865.0182043380745;866.9219770220678;868.3574155125225;868.6916144768611;869.4956924983526;745.8545583611198;913.7943962608393;916.7891384981458;918.5177781664613;918.5682729117304;758.6699785593257;770.4260326057096;770.680167730394;877.2148926710558;908.5411867007185;661.2825084783016;667.6795138333628;668.3249917583275;668.4084585142135;668.8762578922915;14165.15009099447;14173.929130354385;14187.503437379746;14208.644783880382;14210.573682789533;13924.651883702887;14116.50592229267;14206.715865682629;14329.211893345862;14481.42074317026;13615.31923403826;13628.727425451436;13657.317134143253;13658.317084145852;14157.328081733003;4502.594766471033;4561.977190114028;4616.792244349012;4699.553542413465;4741;70165;70427.29572704309;72642.63678681626;80111;84250.15749842484;12078;12403.193792403465;12440.066994975232;12461.813072803916;12730.045246606356;23095.422614434774;23097.307080787603;23097.884510577675;23101.88449057744;23176.53646927052;8540.786480338042;9237.676681316121;9425.38734982224;9560.426374417557;10072.143867771321;4992.600591952635;5083.339165908482;5088.72012039334;5131.4868513148385;5333.066713325153;3640.3629364861044;3778.7165962552917;3788.242351529705;3793.981030094887;3795.867144649924;566.5241197394208;577.8500783440923;584.8245526342081;596.0225230621784;596.6420147911306;660.6696651674163;665.4975493502471;685.1025157044288;740.8703476891523;750.7072241825692;9937.950310248403;10097.192224622013;10138.797224055477;10251.436171010666;10598.31110977784;761.6974972796562;779.2091027606983;788.6056971514242;790.2887401338841;811.3671336357651;4719.834805781781;4790.568848803624;4804.711717296974;4889.926651100236;4918.852434426973;113974;118326.40836795761;121598.39200803939;121916;125465.37267313605;68363;107164.46417767862;107942.46028769806;107948;108557.45721271343;58871.41128588745;60982.39017609767;93523.53238233765;95702;96842.51578742202;9067.410618309788;9152;9217.907820921704;9289.16397524226;9388.389754665925;55801.44198558125;56202.43797561972;56312.43687563236;56497.43502565086;57455.42544574501;71160;78883;79869.60065199637;80319;81560.61263471887;13344.599662010156;13345.733085338434;13414.396352164371;13558.525451609146;13688.178709277476;13575.38910748999;13738.793918091436;13860.722785544434;14305.785413218602;14370.784438233644;12732.490700371882;13021.414036368576;13236.338183091;13281.867181328063;13834.308284585932;12027.45876435545;12045.33750643723;12151.756964860477;12166.635000949986;12168.817467738168;12654.557090501788;13047.543335983195;13134.474621015052;13316.06787524864;13345.733085338434;10467.110295624958;10680.786384272427;11287;11423.600173993871;11453.370064646524;11426.901222152606;11566.537338506365;11578.826317605075;11589.594364197214;11594.362310073027 09:31:41 INFO - PROCESS | 19583 | __end_tp_report 09:31:41 INFO - PROCESS | 19583 | __start_cc_report 09:31:41 INFO - PROCESS | 19583 | _x_x_mozilla_cycle_collect,845 09:31:41 INFO - PROCESS | 19583 | __end_cc_report 09:31:41 INFO - PROCESS | 19583 | __startTimestamp1476462701725__endTimestamp 09:31:41 INFO - PROCESS | 19583 | 09:31:41 INFO - PROCESS | 19583 | ------- Summary: start ------- 09:31:41 INFO - PROCESS | 19583 | Number of tests: 6 09:31:41 INFO - PROCESS | 19583 | 09:31:41 INFO - PROCESS | 19583 | [#0] dojo.html Cycles:165 Average:5524.71 Median:5776.83 stddev:638.06 (11.0%) stddev-sans-first:611.77 09:31:41 INFO - PROCESS | 19583 | Values: 3131.2 3168.2 3182.9 3203.4 3219.1 5440.4 5548.9 5557.3 5574.1 5601.7 5517.2 5567.0 5573.9 5597.2 5598.7 5012.6 5032.1 5032.6 5077.2 5123.2 4940.7 4971.2 5072.9 5120.4 5129.2 4946.3 4962.1 5017.1 5091.6 5147.0 5147.6 5158.5 5222.0 5223.8 5250.9 4846.6 5127.4 5138.4 5194.3 5214.2 5407.3 5466.4 5468.9 5520.6 5590.7 5864.7 5872.9 6003.2 6008.7 6012.6 5840.5 6037.5 6038.8 6049.5 6052.9 5466.1 5494.3 5521.9 5529.5 5556.9 6096.0 6100.1 6106.0 6108.0 6109.4 5857.8 5858.6 5869.2 5869.6 5871.6 5793.8 5826.4 5938.9 5986.2 5995.4 6006.5 6006.6 6006.7 6017.2 6054.6 5989.8 5999.9 6049.5 6052.7 6075.5 4450.7 4480.9 4554.7 4592.4 4634.2 4096.2 4104.9 4113.9 4126.2 4137.5 5690.9 5690.9 5700.1 5701.4 5702.8 5776.8 5869.3 5918.3 6011.6 6022.5 5473.0 5511.7 5557.4 5557.9 5563.9 4841.6 4846.7 4855.9 4859.0 4876.4 5952.5 6013.9 6016.8 6024.8 6026.3 5876.8 5931.3 5954.3 6006.1 6010.6 6247.5 6261.8 6263.4 6263.6 6268.5 5962.5 5965.5 5966.3 5973.2 5996.0 5791.8 5849.8 5885.6 5985.6 6070.5 5705.0 5802.2 5816.3 5817.2 5845.0 5780.0 5797.1 5797.2 5809.2 5815.7 5522.6 5543.8 5691.0 5705.5 5723.7 5796.8 5904.6 5925.6 5953.0 5955.7 5716.7 5780.4 5780.7 5783.4 5792.7 09:31:41 INFO - PROCESS | 19583 | 09:31:41 INFO - PROCESS | 19583 | [#1] ext.html Cycles:180 Average:61515.29 Median:39091.30 stddev:118460.21 (303.0%) stddev-sans-first:118704.21 09:31:41 INFO - PROCESS | 19583 | Values: 590.2 613.6 631.2 634.6 658.2 35759.6 38239.4 46783.5 47188.8 47195.0 50110.7 50480.7 50498.0 50539.7 50547.0 9304.9 9417.6 9425.9 9429.9 9442.5 8314.0 8534.7 11012.6 11240.8 11250.2 11189.5 11285.1 11287.7 11293.5 11298.5 11146.5 11179.7 11187.1 11218.7 11221.2 11083.8 11136.7 11143.6 11143.8 11144.4 44718.6 45075.3 45148.8 45156.8 45204.5 3833.3 3844.6 4484.5 4535.0 4633.4 34720.0 34849.7 35032.2 35188.5 36324.1 4640.7 4706.4 4709.5 4744.5 4765.5 331205.0 331968.0 332025.0 332939.0 333254.0 65506.7 65812.0 65916.0 65948.7 65973.7 37846.8 38502.8 38640.4 38718.8 38759.0 17198.7 17404.0 17421.6 17426.1 17429.1 12622.9 12870.9 12996.7 13007.1 13018.7 18317.3 20367.9 20858.9 20995.7 21708.2 7261.4 7475.9 7493.9 7579.0 7644.7 963.5 988.3 1046.8 1095.1 1129.3 33817.3 34788.7 34806.5 34811.8 34869.3 1119.2 1147.8 1188.4 1191.7 1240.3 17824.7 17898.4 18070.5 18150.4 18193.0 556486.0 559610.0 562688.0 565321.0 565828.0 63124.0 63621.7 63670.7 63690.0 64254.7 1299.4 1333.8 1344.3 1374.8 1415.2 33330.5 36487.6 36609.3 36751.8 36771.0 55081.7 55900.0 55924.0 55925.7 55958.4 410457.0 416983.0 419924.0 421020.0 421483.0 31655.4 31957.4 32028.8 32222.5 33608.8 53704.7 53819.2 53956.3 54001.2 54172.5 44740.6 45143.5 45218.1 45566.5 46514.5 44271.2 45976.8 46195.3 46450.0 46685.3 44438.3 44773.8 44882.0 44971.0 44974.8 37612.2 39423.6 40080.4 40320.8 40507.6 29079.0 29710.7 29852.7 29867.7 30125.5 09:31:41 INFO - PROCESS | 19583 | 09:31:41 INFO - PROCESS | 19583 | [#2] jquery.html Cycles:180 Average:29495.16 Median:24525.01 stddev:79971.72 (326.1%) stddev-sans-first:80166.20 09:31:41 INFO - PROCESS | 19583 | Values: 391.2 421.8 423.0 429.4 443.3 15578.8 19246.6 20384.4 21604.8 21736.0 20339.8 21089.8 21090.6 21149.2 21179.6 5797.7 5811.9 6026.5 6029.9 6030.2 5907.5 5939.7 5974.0 5979.5 5990.9 5726.1 5883.1 5940.2 5947.8 5952.6 5881.9 5884.4 5913.0 5920.6 5921.1 5293.4 5317.3 5340.8 5354.6 5358.4 23807.5 24310.9 24521.3 24528.8 24547.3 2583.5 2619.5 2669.9 2999.4 3036.5 10843.5 11142.4 11358.5 11681.8 11687.8 1994.2 2033.9 2042.1 2073.8 2082.9 84921.6 85306.6 86059.6 87618.0 88748.6 10629.8 11704.6 11782.4 11891.9 11951.5 15671.0 15780.7 16396.6 16664.3 16717.2 8272.2 8295.8 8341.7 8436.8 8639.9 7913.6 7984.8 8022.8 8149.8 8156.5 5086.5 5164.4 5190.6 5269.2 5314.1 2065.4 2079.4 2091.4 2109.5 2146.7 948.7 970.1 990.8 1004.3 1024.3 19316.2 19991.5 20086.4 20469.0 20699.6 1003.6 1025.8 1028.0 1028.9 1105.7 10690.1 10913.9 11647.0 11916.6 12345.9 467619.0 476372.0 489612.0 491726.0 495033.0 87629.0 88674.6 91172.5 95567.0 107317.0 1023.6 1080.2 1082.3 1086.3 1092.4 18233.5 18837.5 18842.7 18943.9 18976.6 40127.8 42792.1 43968.0 44914.0 45730.0 57878.1 58649.4 58740.0 58873.4 59542.0 8775.3 8837.7 8996.6 9035.2 9116.1 12711.7 12988.0 13026.5 13381.7 13525.5 11486.0 11778.8 12104.9 12414.8 12442.7 11218.7 11356.7 11665.2 12099.2 12132.7 11481.9 11711.5 12154.7 12168.3 12545.4 9010.7 9323.2 9342.4 9381.3 9766.2 11498.3 11846.7 12119.9 12198.3 12371.2 09:31:41 INFO - PROCESS | 19583 | 09:31:41 INFO - PROCESS | 19583 | [#3] mootools.html Cycles:180 Average:5865.85 Median:477.31 stddev:3256.35 (682.2%) stddev-sans-first:3248.05 09:31:41 INFO - PROCESS | 19583 | Values: 1383.1 1509.0 1548.3 1687.4 1826.7 7756.5 8291.9 8626.6 8626.7 8663.6 8338.4 8421.3 8484.2 8760.2 8772.4 2413.7 2456.3 2458.1 2458.7 2462.5 2400.1 2460.7 2462.8 2464.6 2464.7 2404.9 2410.7 2434.6 2451.1 2462.2 2332.2 2362.4 2367.1 2367.7 2395.7 2358.4 2358.9 2358.9 2366.2 2367.3 8444.9 8702.0 8710.8 8715.7 8734.0 5203.2 5378.4 5398.5 5412.7 5415.2 3321.5 3333.0 3349.8 3364.8 3427.4 1293.5 1296.7 1307.8 1332.0 1336.3 12155.5 12403.8 12406.6 12422.7 12423.5 4642.2 4694.2 4855.3 4921.5 4921.7 10474.7 10610.9 10616.0 10617.2 10624.6 5510.8 5516.8 5517.9 5519.7 5525.1 4477.4 4596.6 4730.2 4827.5 5091.1 4192.7 4250.6 4321.1 4326.4 4367.8 1329.8 1366.2 1388.7 1421.1 1423.6 1039.8 1043.6 1048.4 1051.6 1056.9 6121.4 6164.3 6252.5 6268.1 6298.4 477.1 477.5 483.0 485.6 493.9 4446.7 4461.1 4478.9 4643.4 4718.5 10704.8 10840.1 10897.7 10907.6 10911.7 10185.3 10775.1 10878.3 10886.0 10901.9 7882.0 8210.0 8221.5 8229.8 8243.5 5907.9 6124.4 6148.8 6175.8 6271.1 9651.7 9908.9 9952.1 9954.7 9964.3 10077.7 10304.1 10311.1 10348.2 10409.5 6913.3 6980.2 7434.6 7813.4 8008.1 8413.6 8590.1 8659.6 8692.8 8698.2 7596.2 7690.5 7714.2 7834.6 7881.7 7606.5 7652.4 7700.8 7718.8 7892.6 7203.0 7293.1 7297.8 7306.7 7315.9 5295.7 5326.1 5393.3 5487.7 5671.7 5540.7 5592.2 5617.2 5645.1 5711.5 09:31:41 INFO - PROCESS | 19583 | 09:31:41 INFO - PROCESS | 19583 | [#4] prototype.html Cycles:180 Average:4659.22 Median:5254.91 stddev:1353.58 (25.8%) stddev-sans-first:1318.29 09:31:41 INFO - PROCESS | 19583 | Values: 356.7 359.7 360.5 362.2 366.7 5367.3 5429.5 5438.5 5449.5 5467.6 5347.5 5364.8 5375.9 5389.6 5398.2 3712.8 4018.2 4208.3 4251.6 4258.8 4230.2 4242.3 4246.9 4257.9 4281.1 4235.0 4255.4 4259.3 4263.9 4269.5 3981.1 4033.8 4155.4 4260.5 4274.6 3758.8 3767.9 3773.8 3777.5 3779.0 5278.3 5281.3 5288.7 5294.4 5311.3 4676.8 4791.6 4837.3 4882.0 4888.2 5576.2 5584.5 5591.3 5593.6 5605.0 4103.8 4113.9 4121.9 4127.2 4127.9 5615.7 5771.4 5802.5 5818.7 5834.4 4212.0 4213.7 4215.5 4225.0 4233.0 4254.7 4269.6 4271.6 4275.9 4283.5 4540.4 4799.2 4828.9 4829.4 4835.1 5608.4 5638.2 5654.7 5658.7 5672.4 1458.4 1466.2 1467.9 1472.2 1472.2 906.6 949.2 953.3 962.3 964.7 4831.6 4832.9 4833.6 4838.2 4887.8 5122.2 5128.5 5135.5 5147.0 5149.4 4636.9 4819.7 4823.6 4825.8 4845.8 2683.6 2705.9 2706.1 2708.7 2715.5 5153.5 5181.6 5258.0 5263.4 5280.7 4873.5 5154.9 5242.7 5251.8 5645.8 5839.4 5840.9 5957.6 5957.8 5985.6 5732.2 5798.4 5802.9 5805.0 5817.6 5528.9 5715.1 5741.3 5754.0 5781.7 5847.1 5875.6 5930.8 5934.0 5947.3 4187.3 4192.1 4206.6 4209.2 4212.5 5511.4 5720.9 5769.8 5789.3 5794.8 5630.4 5632.5 5641.9 5644.3 5645.9 5368.6 5586.8 5592.9 5600.7 5619.6 5589.3 5597.6 5598.7 5599.3 5607.4 5657.7 5660.9 5667.1 5668.5 5704.8 5337.2 5534.9 5544.4 5578.3 5579.3 09:31:41 INFO - PROCESS | 19583 | 09:31:41 INFO - PROCESS | 19583 | [#5] yui.html Cycles:180 Average:21210.75 Median:4589.38 stddev:30715.17 (669.3%) stddev-sans-first:30763.24 09:31:41 INFO - PROCESS | 19583 | Values: 836.6 836.8 876.3 888.0 897.7 15613.2 16387.0 16423.8 16431.0 16435.5 12216.4 15906.9 16062.7 16079.4 16113.9 704.8 817.5 844.1 853.8 860.7 865.0 866.9 868.4 868.7 869.5 745.9 913.8 916.8 918.5 918.6 758.7 770.4 770.7 877.2 908.5 661.3 667.7 668.3 668.4 668.9 14165.2 14173.9 14187.5 14208.6 14210.6 13924.7 14116.5 14206.7 14329.2 14481.4 13615.3 13628.7 13657.3 13658.3 14157.3 4502.6 4562.0 4616.8 4699.6 4741.0 70165.0 70427.3 72642.6 80111.0 84250.2 12078.0 12403.2 12440.1 12461.8 12730.0 23095.4 23097.3 23097.9 23101.9 23176.5 8540.8 9237.7 9425.4 9560.4 10072.1 4992.6 5083.3 5088.7 5131.5 5333.1 3640.4 3778.7 3788.2 3794.0 3795.9 566.5 577.9 584.8 596.0 596.6 660.7 665.5 685.1 740.9 750.7 9938.0 10097.2 10138.8 10251.4 10598.3 761.7 779.2 788.6 790.3 811.4 4719.8 4790.6 4804.7 4889.9 4918.9 113974.0 118326.4 121598.4 121916.0 125465.4 68363.0 107164.5 107942.5 107948.0 108557.5 58871.4 60982.4 93523.5 95702.0 96842.5 9067.4 9152.0 9217.9 9289.2 9388.4 55801.4 56202.4 56312.4 56497.4 57455.4 71160.0 78883.0 79869.6 80319.0 81560.6 13344.6 13345.7 13414.4 13558.5 13688.2 13575.4 13738.8 13860.7 14305.8 14370.8 12732.5 13021.4 13236.3 13281.9 13834.3 12027.5 12045.3 12151.8 12166.6 12168.8 12654.6 13047.5 13134.5 13316.1 13345.7 10467.1 10680.8 11287.0 11423.6 11453.4 11426.9 11566.5 11578.8 11589.6 11594.4 09:31:41 INFO - PROCESS | 19583 | -------- Summary: end -------- 09:31:41 INFO - PROCESS | 19583 | 09:31:42 INFO - TEST-INFO | 19583: exit 0 09:31:42 INFO - TEST-OK | dromaeo_css | took 1113574ms 09:31:42 INFO - TEST-START | kraken 09:31:42 INFO - operating with platform_type : linux_ 09:31:42 INFO - Initialising browser for kraken test... 09:31:42 INFO - TEST-INFO | started process 19904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb5ojWj/profile http://localhost:44476/getInfo.html) 09:31:46 INFO - PROCESS | 19904 | __metrics Screen width/height:1600/1200 09:31:46 INFO - PROCESS | 19904 | colorDepth:24 09:31:46 INFO - PROCESS | 19904 | Browser inner width/height: 1024/697 09:31:46 INFO - PROCESS | 19904 | __metrics 09:31:47 INFO - PROCESS | 19904 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:31:47 INFO - PROCESS | 19904 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:31:47 INFO - PROCESS | 19904 | console.error: PushService: 09:31:47 INFO - PROCESS | 19904 | stateChangeProcessEnqueue: Error transitioning state 09:31:47 INFO - PROCESS | 19904 | UnknownError 09:31:48 INFO - TEST-INFO | 19904: exit 0 09:31:48 INFO - Browser initialized. 09:31:48 INFO - Running cycle 1/1 for kraken test... 09:31:48 INFO - TEST-INFO | started process 19996 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb5ojWj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:31:59 INFO - PROCESS | 19996 | RSS: Main: 144797696 09:31:59 INFO - PROCESS | 19996 | 09:32:02 INFO - PROCESS | 19996 | Cycle 1(1): loaded http://localhost:44476/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44476/tests/kraken/driver.html?testName=audio-beat-detection) 09:32:03 INFO - PROCESS | 19996 | RSS: Main: 185548800 09:32:03 INFO - PROCESS | 19996 | 09:32:05 INFO - PROCESS | 19996 | Cycle 1(1): loaded http://localhost:44476/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44476/tests/kraken/driver.html?testName=audio-dft) 09:32:06 INFO - PROCESS | 19996 | RSS: Main: 174977024 09:32:06 INFO - PROCESS | 19996 | 09:32:09 INFO - PROCESS | 19996 | Cycle 1(1): loaded http://localhost:44476/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44476/tests/kraken/driver.html?testName=audio-fft) 09:32:09 INFO - PROCESS | 19996 | RSS: Main: 267427840 09:32:09 INFO - PROCESS | 19996 | 09:32:11 INFO - PROCESS | 19996 | Cycle 1(1): loaded http://localhost:44476/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44476/tests/kraken/driver.html?testName=audio-oscillator) 09:32:12 INFO - PROCESS | 19996 | RSS: Main: 173092864 09:32:12 INFO - PROCESS | 19996 | 09:32:14 INFO - PROCESS | 19996 | Cycle 1(1): loaded http://localhost:44476/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44476/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:32:15 INFO - PROCESS | 19996 | RSS: Main: 174592000 09:32:15 INFO - PROCESS | 19996 | 09:32:18 INFO - PROCESS | 19996 | Cycle 1(1): loaded http://localhost:44476/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44476/tests/kraken/driver.html?testName=imaging-darkroom) 09:32:18 INFO - PROCESS | 19996 | RSS: Main: 211484672 09:32:18 INFO - PROCESS | 19996 | 09:32:22 INFO - PROCESS | 19996 | Cycle 1(1): loaded http://localhost:44476/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44476/tests/kraken/driver.html?testName=imaging-desaturate) 09:32:22 INFO - PROCESS | 19996 | RSS: Main: 209825792 09:32:22 INFO - PROCESS | 19996 | 09:32:25 INFO - PROCESS | 19996 | Cycle 1(1): loaded http://localhost:44476/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44476/tests/kraken/driver.html?testName=json-parse-financial) 09:32:26 INFO - PROCESS | 19996 | RSS: Main: 209465344 09:32:26 INFO - PROCESS | 19996 | 09:32:27 INFO - PROCESS | 19996 | Cycle 1(1): loaded http://localhost:44476/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44476/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:32:28 INFO - PROCESS | 19996 | RSS: Main: 171827200 09:32:28 INFO - PROCESS | 19996 | 09:32:29 INFO - PROCESS | 19996 | Cycle 1(1): loaded http://localhost:44476/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44476/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:32:30 INFO - PROCESS | 19996 | RSS: Main: 179396608 09:32:30 INFO - PROCESS | 19996 | 09:32:32 INFO - PROCESS | 19996 | Cycle 1(1): loaded http://localhost:44476/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44476/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:32:33 INFO - PROCESS | 19996 | RSS: Main: 188727296 09:32:33 INFO - PROCESS | 19996 | 09:32:35 INFO - PROCESS | 19996 | Cycle 1(1): loaded http://localhost:44476/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:32:36 INFO - PROCESS | 19996 | RSS: Main: 197402624 09:32:36 INFO - PROCESS | 19996 | 09:32:38 INFO - PROCESS | 19996 | Cycle 1(1): loaded http://localhost:44476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:32:39 INFO - PROCESS | 19996 | RSS: Main: 193368064 09:32:39 INFO - PROCESS | 19996 | 09:32:41 INFO - PROCESS | 19996 | Cycle 1(1): loaded http://localhost:44476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44476/tests/kraken/driver.html?testName=ai-astar) 09:32:41 INFO - PROCESS | 19996 | RSS: Main: 245272576 09:32:41 INFO - PROCESS | 19996 | 09:32:41 INFO - PROCESS | 19996 | __start_tp_report 09:32:41 INFO - PROCESS | 19996 | _x_x_mozilla_page_load 09:32:41 INFO - PROCESS | 19996 | _x_x_mozilla_page_load_details 09:32:41 INFO - PROCESS | 19996 | |i|pagename|runs| 09:32:41 INFO - PROCESS | 19996 | |0;ai-astar;109;110;111;110;113;110;111;112;110;111 09:32:41 INFO - PROCESS | 19996 | |1;audio-beat-detection;148;116;115;158;120;122;120;119;155;116 09:32:41 INFO - PROCESS | 19996 | |2;audio-dft;161;161;159;158;159;160;161;159;160;160 09:32:41 INFO - PROCESS | 19996 | |3;audio-fft;74;75;75;112;75;76;76;76;101;74 09:32:41 INFO - PROCESS | 19996 | |4;audio-oscillator;81;81;125;82;82;81;112;81;82;103 09:32:41 INFO - PROCESS | 19996 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;116;116;116 09:32:41 INFO - PROCESS | 19996 | |6;imaging-darkroom;146;146;145;146;146;145;146;146;146;147 09:32:41 INFO - PROCESS | 19996 | |7;imaging-desaturate;94;94;95;102;97;94;95;95;95;94 09:32:41 INFO - PROCESS | 19996 | |8;json-parse-financial;52;48;54;49;50;50;51;50;49;50 09:32:41 INFO - PROCESS | 19996 | |9;json-stringify-tinderbox;58;59;58;59;59;59;58;58;59;59 09:32:41 INFO - PROCESS | 19996 | |10;stanford-crypto-aes;74;75;74;75;74;73;74;74;73;73 09:32:41 INFO - PROCESS | 19996 | |11;stanford-crypto-ccm;122;121;119;120;122;123;117;131;164;121 09:32:41 INFO - PROCESS | 19996 | |12;stanford-crypto-pbkdf2;150;155;151;150;155;150;150;150;153;150 09:32:41 INFO - PROCESS | 19996 | |13;stanford-crypto-sha256-iterative;64;62;61;62;61;65;60;60;61;61 09:32:41 INFO - PROCESS | 19996 | __end_tp_report 09:32:41 INFO - PROCESS | 19996 | __start_cc_report 09:32:41 INFO - PROCESS | 19996 | _x_x_mozilla_cycle_collect,1605 09:32:41 INFO - PROCESS | 19996 | __end_cc_report 09:32:41 INFO - PROCESS | 19996 | __startTimestamp1476462761270__endTimestamp 09:32:41 INFO - PROCESS | 19996 | 09:32:41 INFO - PROCESS | 19996 | ------- Summary: start ------- 09:32:41 INFO - PROCESS | 19996 | Number of tests: 14 09:32:41 INFO - PROCESS | 19996 | 09:32:41 INFO - PROCESS | 19996 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.16 (1.0%) stddev-sans-first:1.05 09:32:41 INFO - PROCESS | 19996 | Values: 109.0 110.0 111.0 110.0 113.0 110.0 111.0 112.0 110.0 111.0 09:32:41 INFO - PROCESS | 19996 | 09:32:41 INFO - PROCESS | 19996 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:121.00 stddev:17.39 (14.4%) stddev-sans-first:17.02 09:32:41 INFO - PROCESS | 19996 | Values: 148.0 116.0 115.0 158.0 120.0 122.0 120.0 119.0 155.0 116.0 09:32:41 INFO - PROCESS | 19996 | 09:32:41 INFO - PROCESS | 19996 | [#2] audio-dft Cycles:10 Average:159.80 Median:160.00 stddev:1.03 (0.6%) stddev-sans-first:1.00 09:32:41 INFO - PROCESS | 19996 | Values: 161.0 161.0 159.0 158.0 159.0 160.0 161.0 159.0 160.0 160.0 09:32:41 INFO - PROCESS | 19996 | 09:32:41 INFO - PROCESS | 19996 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:13.50 (18.0%) stddev-sans-first:14.05 09:32:41 INFO - PROCESS | 19996 | Values: 74.0 75.0 75.0 112.0 75.0 76.0 76.0 76.0 101.0 74.0 09:32:41 INFO - PROCESS | 19996 | 09:32:41 INFO - PROCESS | 19996 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:81.00 stddev:16.28 (20.1%) stddev-sans-first:16.86 09:32:41 INFO - PROCESS | 19996 | Values: 81.0 81.0 125.0 82.0 82.0 81.0 112.0 81.0 82.0 103.0 09:32:41 INFO - PROCESS | 19996 | 09:32:41 INFO - PROCESS | 19996 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:32:41 INFO - PROCESS | 19996 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 09:32:41 INFO - PROCESS | 19996 | 09:32:41 INFO - PROCESS | 19996 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 09:32:41 INFO - PROCESS | 19996 | Values: 146.0 146.0 145.0 146.0 146.0 145.0 146.0 146.0 146.0 147.0 09:32:41 INFO - PROCESS | 19996 | 09:32:41 INFO - PROCESS | 19996 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:2.46 (2.6%) stddev-sans-first:2.55 09:32:41 INFO - PROCESS | 19996 | Values: 94.0 94.0 95.0 102.0 97.0 94.0 95.0 95.0 95.0 94.0 09:32:41 INFO - PROCESS | 19996 | 09:32:41 INFO - PROCESS | 19996 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.00 stddev:1.70 (3.4%) stddev-sans-first:1.69 09:32:41 INFO - PROCESS | 19996 | Values: 52.0 48.0 54.0 49.0 50.0 50.0 51.0 50.0 49.0 50.0 09:32:41 INFO - PROCESS | 19996 | 09:32:41 INFO - PROCESS | 19996 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 09:32:41 INFO - PROCESS | 19996 | Values: 58.0 59.0 58.0 59.0 59.0 59.0 58.0 58.0 59.0 59.0 09:32:41 INFO - PROCESS | 19996 | 09:32:41 INFO - PROCESS | 19996 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:74.00 stddev:0.74 (1.0%) stddev-sans-first:0.78 09:32:41 INFO - PROCESS | 19996 | Values: 74.0 75.0 74.0 75.0 74.0 73.0 74.0 74.0 73.0 73.0 09:32:41 INFO - PROCESS | 19996 | 09:32:41 INFO - PROCESS | 19996 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:122.00 stddev:13.85 (11.4%) stddev-sans-first:14.61 09:32:41 INFO - PROCESS | 19996 | Values: 122.0 121.0 119.0 120.0 122.0 123.0 117.0 131.0 164.0 121.0 09:32:41 INFO - PROCESS | 19996 | 09:32:41 INFO - PROCESS | 19996 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.40 Median:150.50 stddev:2.12 (1.4%) stddev-sans-first:2.19 09:32:41 INFO - PROCESS | 19996 | Values: 150.0 155.0 151.0 150.0 155.0 150.0 150.0 150.0 153.0 150.0 09:32:41 INFO - PROCESS | 19996 | 09:32:41 INFO - PROCESS | 19996 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:61.50 stddev:1.64 (2.7%) stddev-sans-first:1.51 09:32:41 INFO - PROCESS | 19996 | Values: 64.0 62.0 61.0 62.0 61.0 65.0 60.0 60.0 61.0 61.0 09:32:41 INFO - PROCESS | 19996 | -------- Summary: end -------- 09:32:41 INFO - PROCESS | 19996 | 09:32:42 INFO - TEST-INFO | 19996: exit 0 09:32:42 INFO - TEST-OK | kraken | took 59862ms 09:32:42 INFO - SUITE-END | took 1173s 09:32:42 INFO - Completed test suite (00:19:33) 09:32:42 INFO - javascript benchmark 09:32:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3131.217195701074, 3168.2396224906024, 3182.904512864615, 3203.3593281343738, 3219.1308346746378, 5440.3743569489525, 5548.86127846803, 5557.3331200255925, 5574.0802767543355, 5601.747921343539, 5517.206907754976, 5566.997940370742, 5573.860653483665, 5597.216389705434, 5598.664080155183, 5012.573931215842, 5032.069067222557, 5032.57223136032, 5077.164726121327, 5123.1546794778815, 4940.728259945701, 4971.229459433794, 5072.923906141411, 5120.436751957282, 5129.1536896412235, 4946.258061290817, 4962.131626965284, 5017.147084995559, 5091.592672586203, 5146.974265128688, 5147.639665223417, 5158.509941555546, 5222.033923724123, 5223.791048358061, 5250.921236181461, 4846.612271018345, 5127.384713834326, 5138.409082955471, 5194.298769666122, 5214.243934629495, 5407.297051383334, 5466.398696143421, 5468.890622187574, 5520.613557051008, 5590.748416321276, 5864.677442740647, 5872.941270587282, 6003.159557661887, 6008.699565021731, 6012.6392416455155, 5840.47435730782, 6037.45662890342, 6038.818835434944, 6049.48579370754, 6052.878942421127, 5466.098093814516, 5494.2582751328455, 5521.861953451155, 5529.474699903502, 5556.944430555643, 6096.0, 6100.054491553817, 6106.0, 6107.9616465201025, 6109.358517355702, 5857.7949771757785, 5858.56060795442, 5869.207656966255, 5869.618474799125, 5871.6183448075735, 5793.797217097382, 5826.388229235954, 5938.940610593925, 5986.161937328778, 5995.400459953969, 6006.5495087868585, 6006.579539432198, 6006.6696331701305, 6017.217761690952, 6054.576179667381, 5989.790357337472, 5999.880002399927, 6049.455549000611, 6052.697365131726, 6075.544334174954, 4450.732956022649, 4480.865574032784, 4554.749488778149, 4592.402987611656, 4634.189016922025, 4096.242195193899, 4104.897377565585, 4113.91772164561, 4126.236646220459, 4137.50349958001, 5690.886182276331, 5690.9146362804595, 5700.087985922232, 5701.4013528579735, 5702.800401985911, 5776.826695199066, 5869.295684517885, 5918.2898052234, 6011.579189456696, 6022.45797878193, 5473.0, 5511.696856672841, 5557.360903496069, 5557.944420555824, 5563.944360556424, 4841.564259216688, 4846.660733748604, 4855.902881942341, 4858.951410485921, 4876.390451193601, 5952.523798096228, 6013.909791353133, 6016.849578760566, 6024.849378765566, 6026.276846778327, 5876.823695289148, 5931.288245410578, 5954.255718035246, 6006.069059295816, 6010.639361638316, 6247.5001999839, 6261.78083767066, 6263.373662633882, 6263.592866463665, 6268.467180289544, 5962.52299816005, 5965.492933100735, 5966.254218222723, 5973.193618861572, 5996.040633498619, 5791.797287094932, 5849.766009359578, 5885.558583106199, 5985.610935289193, 6070.453659170696, 5704.971475142598, 5802.1586869902785, 5816.302043754777, 5817.214676018683, 5845.035569131046, 5780.0, 5797.072468405035, 5797.159411885337, 5809.186713859978, 5815.680137592473, 5522.6134170607675, 5543.833684989457, 5691.0, 5705.543556515386, 5723.656580605177, 5796.797112101056, 5904.61619994699, 5925.644461332334, 5952.970235148797, 5955.702214889152, 5716.657000579979, 5780.364159942487, 5780.7398667060925, 5783.421657834351, 5792.739326730223], "value": 5480.954820212504, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.2179612014082, 613.5919613457052, 631.2298995225826, 634.635084826225, 658.2035736758523, 35759.642403575956, 38239.4264086039, 46783.532164678385, 47188.76405617976, 47195.0, 50110.74944625272, 50480.74759626206, 50498.0, 50539.747301263444, 50547.0, 9304.860427093583, 9417.62329506819, 9425.858612120825, 9429.858552121723, 9442.480663563501, 8313.95843020784, 8534.74395768128, 11012.559497620126, 11240.831387529193, 11250.156238282121, 11189.49647265875, 11285.097192224603, 11287.717807054849, 11293.548258069668, 11298.548058077668, 11146.498407571638, 11179.66461006171, 11187.105031597453, 11218.719532011683, 11221.158413118967, 11083.833742493869, 11136.665900023012, 11143.554257829677, 11143.832842507369, 11144.387058711767, 44718.55281447176, 45075.323870141976, 45148.77425612851, 45156.77421612904, 45204.54795452036, 3833.290841194388, 3844.6347596978244, 4484.484284307314, 4535.0, 4633.397658304432, 34720.0, 34849.65150348515, 35032.19742420626, 35188.47217291743, 36324.09189770251, 4640.744759038252, 4706.435227772689, 4709.458412282597, 4744.454387745419, 4765.547273009059, 331205.0, 331968.0, 332025.0, 332939.0, 333254.0, 65506.67246663736, 65812.0, 65916.0, 65948.67025664936, 65973.67013164904, 37846.81076594599, 38502.80748596239, 38640.42039369412, 38718.80640596779, 38759.0, 17198.74201886973, 17404.0, 17421.564460888578, 17426.12869356527, 17429.12854357277, 12622.936885315698, 12870.9356453219, 12996.740065198643, 13007.089503734647, 13018.739625207443, 18317.267309307746, 20367.898160509398, 20858.895705521376, 20995.685064724043, 21708.240211592834, 7261.3827824634445, 7475.887861682079, 7493.925060749431, 7578.962105189439, 7644.694212231449, 963.5278713430368, 988.2736188901152, 1046.8078331475813, 1095.0637205189448, 1129.3054771315747, 33817.32365352679, 34788.652113479046, 34806.47790283097, 34811.82594087064, 34869.30261394758, 1119.2333251722596, 1147.8163493841112, 1188.44737197202, 1191.7259030423052, 1240.3054289597853, 17824.732629010574, 17898.373556925446, 18070.457886263433, 18150.364737234133, 18193.0, 556486.0, 559610.0, 562688.0, 565321.0, 565828.0, 63124.0, 63621.68189159025, 63670.6816465924, 63690.044649330295, 64254.67872660607, 1299.4477347127622, 1333.7732585460494, 1344.3009634989946, 1374.7869080292571, 1415.2287003582867, 33330.5000424989, 36487.55698378255, 36609.267814643026, 36751.816240918626, 36771.0, 55081.724591376784, 55900.0, 55924.0, 55925.72037139951, 55958.44041559532, 410457.0, 416983.0, 419924.0, 421020.0, 421483.0, 31655.366892662478, 31957.36085278235, 32028.839855800572, 32222.516662249614, 33608.83195584006, 53704.73147634393, 53819.19271211013, 53956.30218488981, 54001.18998214951, 54172.45827541674, 44740.55259447494, 45143.548564513934, 45218.09563808771, 45566.544334557555, 46514.53485465102, 44271.21227869647, 45976.77011614921, 46195.30707039464, 46450.0, 46685.299720504896, 44438.333424998, 44773.776131119135, 44882.0, 44971.0, 44974.77512612416, 37612.2477550453, 39423.60576394314, 40080.39879401753, 40320.798396007835, 40507.59492405038, 29079.0, 29710.702892970792, 29852.70147298586, 29867.701322987363, 30125.548116778704], "value": 21544.141501969487, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.172669803366, 421.7701352762746, 422.9619334259916, 429.4095618524529, 443.26639411773505, 15578.766318505217, 19246.615067698636, 20384.388468345973, 21604.783952160473, 21736.021879015443, 20339.796602033974, 21089.789102108974, 21090.578188436222, 21149.15403383863, 21179.57640847182, 5797.65214087154, 5811.912821307684, 6026.517878569726, 6029.909551356734, 6030.155778191057, 5907.527397808187, 5939.732712027969, 5974.0, 5979.46184843364, 5990.880182396371, 5726.083826587746, 5883.058710606304, 5940.227770389865, 5947.821565353046, 5952.613080149798, 5881.911771323412, 5884.411558844125, 5912.970435147839, 5920.615160014629, 5921.082232254007, 5293.444188360205, 5317.2821669074565, 5340.786368545254, 5354.571634269288, 5358.3837858645975, 23807.523849523084, 24310.878445607836, 24521.264362069167, 24528.754712452825, 24547.263582092564, 2583.4962182374443, 2619.528484872722, 2669.9125202865935, 2999.4001199760137, 3036.5141577347517, 10843.51204195813, 11142.442877856074, 11358.488868000959, 11681.766364672743, 11687.824682629767, 1994.1524851938013, 2033.857629965903, 2042.1320938601036, 2073.8029887160847, 2082.916683332665, 84921.57539212327, 85306.57346713227, 86059.56970215109, 87618.0, 88748.55625721895, 10629.840552391566, 11704.648860534198, 11782.410879455992, 11891.88108118925, 11951.462184201731, 15671.0, 15780.68438631221, 16396.590085247964, 16664.33342666304, 16717.164141792862, 8272.214139656844, 8295.751127466187, 8341.749747507585, 8436.831263374821, 8639.91360086391, 7913.564753938589, 7984.84030319402, 8022.839543209103, 8149.796255093552, 8156.469829461066, 5086.54221120101, 5164.431912489623, 5190.6107041972, 5269.241931596285, 5314.1497360422145, 2065.380385884229, 2079.3657934330176, 2091.4144039668918, 2109.5148115933116, 2146.7101941237734, 948.7201275623707, 970.1365784451843, 990.7968866382519, 1004.2769206171545, 1024.3444195714749, 19316.227350906087, 19991.500212494804, 20086.39740807778, 20469.0, 20699.58600827975, 1003.5885287032281, 1025.7999690060515, 1027.9640212592524, 1028.8559601655775, 1105.6627728542871, 10690.144788416908, 10913.890861091446, 11647.0, 11916.642500724993, 12345.93827030877, 467619.0, 476372.0, 489612.0, 491726.0, 495033.0, 87629.0, 88674.55662721646, 91172.54413728022, 95567.0, 107317.0, 1023.6059117239768, 1080.2276372393776, 1082.2910993299402, 1086.315621158665, 1092.448313601626, 18233.544161396072, 18837.529061773566, 18842.71735923935, 18943.90528047406, 18976.620467590295, 40127.79936100301, 42792.144157117305, 43968.02143903596, 44914.0, 45730.0, 57878.131828023455, 58649.413505864395, 58740.0, 58873.411265886796, 59542.0, 8775.254103401283, 8837.690680826141, 8996.55017249122, 9035.232005279362, 9116.1339672731, 12711.682207944505, 12988.025898057494, 13026.54407095747, 13381.66545836362, 13525.458981641017, 11486.0, 11778.823317650413, 12104.939475302566, 12414.81377779352, 12442.688932776753, 11218.719532011764, 11356.716082098013, 11665.183437159318, 12099.213551119148, 12132.696682583006, 11481.885181148082, 11711.472983715923, 12154.696132596402, 12168.2699038058, 12545.435455404346, 9010.684626038057, 9323.20752736025, 9342.39274447186, 9381.296402769683, 9766.21870250364, 11498.25261358009, 11846.703832404259, 12119.939400302943, 12198.268103913793, 12371.195872268274], "value": 9642.925799093418, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1383.0595195267226, 1508.9622759431013, 1548.2955255358809, 1687.4009726547076, 1826.6894627913252, 7756.457048006635, 8291.917080829198, 8626.611802468888, 8626.698065567707, 8663.566821658915, 8338.374621903351, 8421.284190843786, 8484.151584841513, 8760.211580957712, 8772.42979206351, 2413.73448920619, 2456.2876765738006, 2458.139651122111, 2458.6680798092298, 2462.4828785954883, 2400.0556074116703, 2460.692413448319, 2462.839915405502, 2464.556379851626, 2464.6795916530828, 2404.927852164438, 2410.650455683925, 2434.610462326028, 2451.0563433078305, 2462.162864626027, 2332.207049603143, 2362.397588614901, 2367.1359953616893, 2367.6566897799894, 2395.652630368604, 2358.433975845802, 2358.858468491896, 2358.870262135582, 2366.2309749331366, 2367.3134790910617, 8444.873326900102, 8702.0, 8710.825783484295, 8715.738527844174, 8733.956330218372, 5203.16749320107, 5378.381486129067, 5398.514133727944, 5412.675239485604, 5415.214793854909, 3321.451960426551, 3332.96667033329, 3349.765516413852, 3364.7812892161933, 3427.3830710472107, 1293.508466782626, 1296.6887946892773, 1307.8495972963135, 1331.9600411987656, 1336.2850874781946, 12155.453004614814, 12403.75192496145, 12406.565770198, 12422.689432764253, 12423.503059877594, 4642.189546077033, 4694.225452800318, 4855.271709243571, 4921.532454416824, 4921.655484116149, 10474.68575942723, 10610.89389106099, 10616.0, 10617.150627949746, 10624.575016999388, 5510.779568817283, 5516.779328826802, 5517.944820551824, 5519.724013799374, 5525.143602741581, 4477.417935668343, 4596.6322694185055, 4730.243161094278, 4827.517248275144, 5091.0581542414775, 4192.685548583869, 4250.596193361625, 4321.13577284538, 4326.437563116838, 4367.75977321244, 1329.7539955108336, 1366.2349084512705, 1388.666719987216, 1421.069199674215, 1423.608507660381, 1039.8492218628407, 1043.608646757466, 1048.4024106259512, 1051.600391851107, 1056.8678915135454, 6121.418465245794, 6164.291106522807, 6252.468540174136, 6268.059791031291, 6298.382121748796, 477.0816178855689, 477.5415601022987, 482.973436460998, 485.55086544945783, 493.9431965323962, 4446.710963787344, 4461.107778444324, 4478.932816007762, 4643.373144625432, 4718.457377401574, 10704.78590428187, 10840.078593319657, 10897.727556810985, 10907.618233361794, 10911.727206819734, 10185.33795303303, 10775.084117849914, 10878.347299162075, 10886.0, 10901.945490272497, 7882.0, 8210.0, 8221.465604735673, 8229.835403291901, 8243.505389676639, 5907.91138132937, 6124.448799608057, 6148.78479253224, 6175.84560385994, 6271.090691849565, 9651.71044868655, 9908.900910990798, 9952.10431061208, 9954.701358959242, 9964.302498825302, 10077.69766906994, 10304.124149447382, 10311.07200351972, 10348.22388320894, 10409.479526023517, 6913.308669133046, 6980.162380514371, 7434.591097489473, 7813.413993950363, 8008.1191068983535, 8413.62138703772, 8590.09803970599, 8659.6103175356, 8692.78268043304, 8698.217160455337, 7596.240375962359, 7690.500117492345, 7714.151443341116, 7834.569098699626, 7881.724139655084, 7606.467547271638, 7652.38780897538, 7700.8459830804195, 7718.807029824075, 7892.644830982505, 7203.02759127511, 7293.124825021031, 7297.759380905365, 7306.7077316906725, 7315.890261645973, 5295.655782374288, 5326.121190003606, 5393.325834270716, 5487.725613719218, 5671.6597004179885, 5540.667559946416, 5592.245046918614, 5617.213590097472, 5645.068563686946, 5711.457411545896], "value": 4680.872262205525, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.7271037656193, 359.73020234823883, 360.4593110334498, 362.22483884487184, 366.7121309771828, 5367.329083864517, 5429.457054294574, 5438.456154384559, 5449.482299181582, 5467.562594992401, 5347.491988261118, 5364.839054828351, 5375.946240537593, 5389.649672771267, 5398.24424580558, 3712.7586706863967, 4018.236535058337, 4208.347706105558, 4251.6173544381, 4258.808353624095, 4230.238557059728, 4242.260673124019, 4246.893827654302, 4257.914841703164, 4281.12236991416, 4234.978825105885, 4255.361695745632, 4259.339802330644, 4263.87208383749, 4269.50900646425, 3981.144054028369, 4033.838646454138, 4155.439015732868, 4260.467441569804, 4274.615284624383, 3758.7932663703486, 3767.9058023549355, 3773.7735735855663, 3777.5466943966626, 3778.9622103778884, 5278.340207474066, 5281.339832520935, 5288.6826790392315, 5294.444083371268, 5311.336082989626, 4676.760658425486, 4791.5687588117235, 4837.346958160639, 4881.951180488185, 4888.169011268093, 5576.219329293902, 5584.46947539983, 5591.30108736408, 5593.552515798727, 5605.0, 4103.835846566164, 4113.856015039489, 4121.91756164875, 4127.174565086994, 4127.938080928789, 5615.7472913718575, 5771.422857714237, 5802.477777000048, 5818.650880947114, 5834.358220595688, 4212.031232816469, 4213.726107803044, 4215.451991241181, 4224.957750422518, 4233.0, 4254.680898932593, 4269.5516970718245, 4271.594198551133, 4275.893102672458, 4283.528811830696, 4540.409746732904, 4799.160146974265, 4828.903421931542, 4829.372181616438, 4835.105505481497, 5608.383077861432, 5638.238837756932, 5654.688992105392, 5658.660480371191, 5672.404397538199, 1458.4020551573803, 1466.2448838848002, 1467.8624066348666, 1472.1535117307592, 1472.2417954753312, 906.6353261862522, 949.2168960607388, 953.3374304858057, 962.3023308101571, 964.6768332608515, 4831.637627177905, 4832.855014349575, 4833.613310935117, 4838.201696720002, 4887.828925987574, 5122.231665250242, 5128.538236690294, 5135.537801597874, 5146.963291657939, 5149.382074151051, 4636.86089417318, 4819.734914579662, 4823.589994850407, 4825.817674669728, 4845.75771211438, 2683.5974603809195, 2705.889406263118, 2706.146289791499, 2708.7291270872756, 2715.5247831629385, 5153.474797349272, 5181.5595674368105, 5257.975679363472, 5263.4473380295285, 5280.683159010395, 4873.463918968911, 5154.9484505155215, 5242.7378631068295, 5251.84889066557, 5645.774169033275, 5839.4379428548555, 5840.88318233633, 5957.642541447441, 5957.821265362046, 5985.551083668655, 5732.2230108666445, 5798.449147330997, 5802.912956305574, 5805.0, 5817.621854579439, 5528.917066243929, 5715.056880660595, 5741.3397459291045, 5753.971230143822, 5781.682007489629, 5847.05323906353, 5875.6203737486385, 5930.762769489172, 5933.970330148321, 5947.275290165977, 4187.288161012574, 4192.119654872511, 4206.642435393026, 4209.200251952119, 4212.4523811904255, 5511.366192887869, 5720.885582288414, 5769.769209231584, 5789.33422656383, 5794.82615521535, 5630.423481425208, 5632.521690456186, 5641.9435805641415, 5644.294463192101, 5645.887082258249, 5368.604162917748, 5586.787597131584, 5592.874707611244, 5600.747966341606, 5619.550435965195, 5589.301337332833, 5597.608167428404, 5598.720063996702, 5599.272094627672, 5607.41122182165, 5657.688827114548, 5660.905464977985, 5667.0649342859615, 5668.461496157858, 5704.828855134353, 5337.172738225581, 5534.861628459321, 5544.447554684533, 5578.30271216098, 5579.330480342385], "value": 4236.658122522901, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [836.5733475927275, 836.8451836410264, 876.3427429427929, 887.9778005549861, 897.735168125403, 15613.219339033045, 16387.01677899324, 16423.753643695352, 16431.0, 16435.506934791945, 12216.389180540982, 15906.920465397658, 16062.678746425065, 16079.356825726956, 16113.919430402831, 704.7744721689074, 817.5094943034162, 844.1221130024767, 853.8335024670192, 860.6987554355987, 865.0182043380745, 866.9219770220678, 868.3574155125225, 868.6916144768611, 869.4956924983526, 745.8545583611198, 913.7943962608393, 916.7891384981458, 918.5177781664613, 918.5682729117304, 758.6699785593257, 770.4260326057096, 770.680167730394, 877.2148926710558, 908.5411867007185, 661.2825084783016, 667.6795138333628, 668.3249917583275, 668.4084585142135, 668.8762578922915, 14165.15009099447, 14173.929130354385, 14187.503437379746, 14208.644783880382, 14210.573682789533, 13924.651883702887, 14116.50592229267, 14206.715865682629, 14329.211893345862, 14481.42074317026, 13615.31923403826, 13628.727425451436, 13657.317134143253, 13658.317084145852, 14157.328081733003, 4502.594766471033, 4561.977190114028, 4616.792244349012, 4699.553542413465, 4741.0, 70165.0, 70427.29572704309, 72642.63678681626, 80111.0, 84250.15749842484, 12078.0, 12403.193792403465, 12440.066994975232, 12461.813072803916, 12730.045246606356, 23095.422614434774, 23097.307080787603, 23097.884510577675, 23101.88449057744, 23176.53646927052, 8540.786480338042, 9237.676681316121, 9425.38734982224, 9560.426374417557, 10072.143867771321, 4992.600591952635, 5083.339165908482, 5088.72012039334, 5131.4868513148385, 5333.066713325153, 3640.3629364861044, 3778.7165962552917, 3788.242351529705, 3793.981030094887, 3795.867144649924, 566.5241197394208, 577.8500783440923, 584.8245526342081, 596.0225230621784, 596.6420147911306, 660.6696651674163, 665.4975493502471, 685.1025157044288, 740.8703476891523, 750.7072241825692, 9937.950310248403, 10097.192224622013, 10138.797224055477, 10251.436171010666, 10598.31110977784, 761.6974972796562, 779.2091027606983, 788.6056971514242, 790.2887401338841, 811.3671336357651, 4719.834805781781, 4790.568848803624, 4804.711717296974, 4889.926651100236, 4918.852434426973, 113974.0, 118326.40836795761, 121598.39200803939, 121916.0, 125465.37267313605, 68363.0, 107164.46417767862, 107942.46028769806, 107948.0, 108557.45721271343, 58871.41128588745, 60982.39017609767, 93523.53238233765, 95702.0, 96842.51578742202, 9067.410618309788, 9152.0, 9217.907820921704, 9289.16397524226, 9388.389754665925, 55801.44198558125, 56202.43797561972, 56312.43687563236, 56497.43502565086, 57455.42544574501, 71160.0, 78883.0, 79869.60065199637, 80319.0, 81560.61263471887, 13344.599662010156, 13345.733085338434, 13414.396352164371, 13558.525451609146, 13688.178709277476, 13575.38910748999, 13738.793918091436, 13860.722785544434, 14305.785413218602, 14370.784438233644, 12732.490700371882, 13021.414036368576, 13236.338183091, 13281.867181328063, 13834.308284585932, 12027.45876435545, 12045.33750643723, 12151.756964860477, 12166.635000949986, 12168.817467738168, 12654.557090501788, 13047.543335983195, 13134.474621015052, 13316.06787524864, 13345.733085338434, 10467.110295624958, 10680.786384272427, 11287.0, 11423.600173993871, 11453.370064646524, 11426.901222152606, 11566.537338506365, 11578.826317605075, 11589.594364197214, 11594.362310073027], "value": 7778.850362545287, "unit": "score"}], "name": "dromaeo_css", "value": 7483.725843981777, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 111.0, 110.0, 113.0, 110.0, 111.0, 112.0, 110.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 116.0, 115.0, 158.0, 120.0, 122.0, 120.0, 119.0, 155.0, 116.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 158.0, 159.0, 160.0, 161.0, 159.0, 160.0, 160.0], "value": 159.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 112.0, 75.0, 76.0, 76.0, 76.0, 101.0, 74.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 125.0, 82.0, 82.0, 81.0, 112.0, 81.0, 82.0, 103.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 147.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 102.0, 97.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 48.0, 54.0, 49.0, 50.0, 50.0, 51.0, 50.0, 49.0, 50.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 59.0, 59.0, 59.0, 58.0, 58.0, 59.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 75.0, 74.0, 73.0, 74.0, 74.0, 73.0, 73.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 121.0, 119.0, 120.0, 122.0, 123.0, 117.0, 131.0, 164.0, 121.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 155.0, 151.0, 150.0, 155.0, 150.0, 150.0, 150.0, 153.0, 150.0], "value": 151.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 61.0, 62.0, 61.0, 65.0, 60.0, 60.0, 61.0, 61.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1451.7000000000003, "alertThreshold": 2.0}]} 09:32:42 INFO - Return code: 0 09:32:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:32:42 INFO - # TBPL SUCCESS # 09:32:42 INFO - Running post-action listener: _resource_record_post_action 09:32:42 INFO - [mozharness: 2016-10-14 16:32:42.582566Z] Finished run-tests step (success) 09:32:42 INFO - Running post-run listener: _resource_record_post_run 09:32:42 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 12288; Write bytes: 368250880; Read time: 448; Write time: 246976 09:32:42 INFO - TinderboxPrint: CPU usage
13.0% 09:32:42 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 448 09:32:42 INFO - TinderboxPrint: I/O write bytes / time
368,250,880 / 246,976 09:32:42 INFO - TinderboxPrint: CPU idle
8,265.8 (87.0%) 09:32:42 INFO - TinderboxPrint: CPU user
1,187.3 (12.5%) 09:32:42 INFO - TinderboxPrint: Swap in / out
0 / 0 09:32:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 118759424; Read time: 204; Write time: 76140 09:32:42 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 249491456; Read time: 232; Write time: 170836 09:32:43 INFO - Running post-run listener: _upload_blobber_files 09:32:43 INFO - Blob upload gear active. 09:32:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:32:43 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:32:43 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:32:43 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:32:43 INFO - (blobuploader) - INFO - Open directory for files ... 09:32:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:32:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:32:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:32:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:32:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:32:44 INFO - (blobuploader) - INFO - Done attempting. 09:32:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:32:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:32:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:32:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:32:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:32:49 INFO - (blobuploader) - INFO - Done attempting. 09:32:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:32:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:32:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:32:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:32:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:32:50 INFO - (blobuploader) - INFO - Done attempting. 09:32:50 INFO - (blobuploader) - INFO - Iteration through files over. 09:32:50 INFO - Return code: 0 09:32:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:32:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:32:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d05d8786b1a612a676156ad26daf5c7d3dc4f78a8614eed12c255d680acfe27f78316b5ee89563497c658124f5bf83821da6a71c9e40e7870c7e3b4deb51b670", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d14c0ee782ce8f205fe2c7c7667541ca481b7796c1995e3701d0f7f76d0d039d2b67b0ae4cb3e9ec76bc577e2b3729e8c71a82da2d64effa85d651dc761fc512", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa587c170ebeb392715b849693b3750e136d4b0d188b42b433e22a8b8468536d6c8c1c97164d82da7bcbf1543bed2f6d7bb2d0cdaa5608c46b64145105da4d45"} 09:32:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:32:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:32:50 INFO - Contents: 09:32:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d05d8786b1a612a676156ad26daf5c7d3dc4f78a8614eed12c255d680acfe27f78316b5ee89563497c658124f5bf83821da6a71c9e40e7870c7e3b4deb51b670", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d14c0ee782ce8f205fe2c7c7667541ca481b7796c1995e3701d0f7f76d0d039d2b67b0ae4cb3e9ec76bc577e2b3729e8c71a82da2d64effa85d651dc761fc512", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa587c170ebeb392715b849693b3750e136d4b0d188b42b433e22a8b8468536d6c8c1c97164d82da7bcbf1543bed2f6d7bb2d0cdaa5608c46b64145105da4d45"} 09:32:50 INFO - Running post-run listener: copy_logs_to_upload_dir 09:32:50 INFO - Copying logs to upload dir... 09:32:50 INFO - mkdir: /builds/slave/test/build/upload/logs 09:32:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.772444 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-14 09:32:49.894067) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 09:32:49.897099) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218 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/d05d8786b1a612a676156ad26daf5c7d3dc4f78a8614eed12c255d680acfe27f78316b5ee89563497c658124f5bf83821da6a71c9e40e7870c7e3b4deb51b670", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d14c0ee782ce8f205fe2c7c7667541ca481b7796c1995e3701d0f7f76d0d039d2b67b0ae4cb3e9ec76bc577e2b3729e8c71a82da2d64effa85d651dc761fc512", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa587c170ebeb392715b849693b3750e136d4b0d188b42b433e22a8b8468536d6c8c1c97164d82da7bcbf1543bed2f6d7bb2d0cdaa5608c46b64145105da4d45"} build_url:https://queue.taskcluster.net/v1/task/WWfdABJaQPOTzStFwyOhtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011465 build_url: 'https://queue.taskcluster.net/v1/task/WWfdABJaQPOTzStFwyOhtQ/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/d05d8786b1a612a676156ad26daf5c7d3dc4f78a8614eed12c255d680acfe27f78316b5ee89563497c658124f5bf83821da6a71c9e40e7870c7e3b4deb51b670", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d14c0ee782ce8f205fe2c7c7667541ca481b7796c1995e3701d0f7f76d0d039d2b67b0ae4cb3e9ec76bc577e2b3729e8c71a82da2d64effa85d651dc761fc512", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa587c170ebeb392715b849693b3750e136d4b0d188b42b433e22a8b8468536d6c8c1c97164d82da7bcbf1543bed2f6d7bb2d0cdaa5608c46b64145105da4d45"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 09:32:49.925382) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:32:49.925718) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1476457902.573221-2096258218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:32:50.005533) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 09:32:50.006004) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 09:32:50.006278) ========= ========= Total master_lag: 0.17 =========