builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1477586364.26 results: success (0) buildid: 20161027063134 builduid: 02ec18061a3445c68d5d779eeda93445 revision: bf0d21da3297e8d0fe12b43790cc1458d85b2a3d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 09:39:24.261107) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 09:39:24.261601) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 09:39:24.261996) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 09:39:24.277955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 09:39:24.278452) ========= 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=31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-27 09:39:24-- 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% 226M=0s 2016-10-27 09:39:24 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149483 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 09:39:24.443130) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 09:39:24.443481) ========= 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=31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013971 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 09:39:24.493961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 09:39:24.494349) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bf0d21da3297e8d0fe12b43790cc1458d85b2a3d --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 bf0d21da3297e8d0fe12b43790cc1458d85b2a3d --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=31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-27 09:39:24,641 truncating revision to first 12 chars 2016-10-27 09:39:24,641 Setting DEBUG logging. 2016-10-27 09:39:24,641 attempt 1/10 2016-10-27 09:39:24,641 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bf0d21da3297?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-27 09:39:24,941 unpacking tar archive at: mozilla-aurora-bf0d21da3297/testing/mozharness/ program finished with exit code 0 elapsedTime=0.698016 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 09:39:25.205818) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 09:39:25.206137) ========= script_repo_revision: bf0d21da3297e8d0fe12b43790cc1458d85b2a3d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 09:39:25.209555) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 09:39:25.209850) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 09:39:25.220550) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-27 09:39:25.220922) ========= /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=31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:39:25 INFO - MultiFileLogger online at 20161027 09:39:25 in /builds/slave/test 09:39:25 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:39:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:39:25 INFO - {'append_to_log': False, 09:39:25 INFO - 'base_work_dir': '/builds/slave/test', 09:39:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:39:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:39:25 INFO - 'branch': 'Mozilla-Aurora', 09:39:25 INFO - 'buildbot_json_path': 'buildprops.json', 09:39:25 INFO - 'config_files': ('talos/linux_config.py',), 09:39:25 INFO - 'default_actions': ('clobber', 09:39:25 INFO - 'read-buildbot-config', 09:39:25 INFO - 'download-and-extract', 09:39:25 INFO - 'populate-webroot', 09:39:25 INFO - 'create-virtualenv', 09:39:25 INFO - 'install', 09:39:25 INFO - 'run-tests'), 09:39:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:39:25 INFO - 'download_minidump_stackwalk': True, 09:39:25 INFO - 'download_symbols': 'ondemand', 09:39:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:39:25 INFO - 'tooltool.py': '/tools/tooltool.py', 09:39:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:39:25 INFO - '/tools/misc-python/virtualenv.py')}, 09:39:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:39:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:39:25 INFO - 'installer_path': 'installer.exe', 09:39:25 INFO - 'log_level': 'info', 09:39:25 INFO - 'log_name': 'talos', 09:39:25 INFO - 'log_to_console': True, 09:39:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:39:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:39:25 INFO - 'opt_config_files': (), 09:39:25 INFO - 'pip_index': False, 09:39:25 INFO - 'sps_profile': False, 09:39:25 INFO - 'sps_profile_interval': 0, 09:39:25 INFO - 'suite': 'dromaeojs', 09:39:25 INFO - 'system_bits': '32', 09:39:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:39:25 INFO - 'title': 'talos-linux64-ix-014', 09:39:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:39:25 INFO - 'use_talos_json': True, 09:39:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:39:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:39:25 INFO - 'work_dir': 'build'} 09:39:25 INFO - [mozharness: 2016-10-27 16:39:25.461744Z] Running clobber step. 09:39:25 INFO - Running pre-action listener: _resource_record_pre_action 09:39:25 INFO - Running main action method: clobber 09:39:25 INFO - rmtree: /builds/slave/test/build 09:39:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:39:26 INFO - Running post-action listener: _resource_record_post_action 09:39:26 INFO - [mozharness: 2016-10-27 16:39:26.449318Z] Finished clobber step (success) 09:39:26 INFO - [mozharness: 2016-10-27 16:39:26.449418Z] Running read-buildbot-config step. 09:39:26 INFO - Running pre-action listener: _resource_record_pre_action 09:39:26 INFO - Running main action method: read_buildbot_config 09:39:26 INFO - Using buildbot properties: 09:39:26 INFO - { 09:39:26 INFO - "project": "", 09:39:26 INFO - "product": "firefox", 09:39:26 INFO - "script_repo_revision": "production", 09:39:26 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:39:26 INFO - "repository": "", 09:39:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:39:26 INFO - "buildid": "20161027063134", 09:39:26 INFO - "pgo_build": "True", 09:39:26 INFO - "basedir": "/builds/slave/test", 09:39:26 INFO - "buildnumber": 595, 09:39:26 INFO - "slavename": "talos-linux64-ix-014", 09:39:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:39:26 INFO - "platform": "ubuntu64_hw", 09:39:26 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:39:26 INFO - "branch": "mozilla-aurora", 09:39:26 INFO - "repo_path": "releases/mozilla-aurora", 09:39:26 INFO - "revision": "bf0d21da3297e8d0fe12b43790cc1458d85b2a3d", 09:39:26 INFO - "stage_platform": "linux64-pgo", 09:39:26 INFO - "builduid": "02ec18061a3445c68d5d779eeda93445", 09:39:26 INFO - "slavebuilddir": "test" 09:39:26 INFO - } 09:39:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/DpNGKV7iRAiGl9otNKKrxQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 09:39:26 INFO - Running post-action listener: _resource_record_post_action 09:39:26 INFO - [mozharness: 2016-10-27 16:39:26.452360Z] Finished read-buildbot-config step (success) 09:39:26 INFO - [mozharness: 2016-10-27 16:39:26.452450Z] Running download-and-extract step. 09:39:26 INFO - Running pre-action listener: _resource_record_pre_action 09:39:26 INFO - Running main action method: download_and_extract 09:39:26 INFO - mkdir: /builds/slave/test/build/tests 09:39:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:26 INFO - trying https://queue.taskcluster.net/v1/task/DpNGKV7iRAiGl9otNKKrxQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 09:39:26 INFO - Downloading https://queue.taskcluster.net/v1/task/DpNGKV7iRAiGl9otNKKrxQ/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:39:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DpNGKV7iRAiGl9otNKKrxQ/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:39:27 INFO - Downloaded 1361 bytes. 09:39:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 09:39:27 INFO - Using the following test package requirements: 09:39:27 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 09:39:27 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:39:27 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:39:27 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:39:27 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:39:27 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:39:27 INFO - u'jsshell-linux-x86_64.zip'], 09:39:27 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:39:27 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:39:27 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 09:39:27 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:39:27 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:39:27 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:39:27 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:39:27 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:39:27 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:39:27 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:39:27 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:39:27 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:39:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DpNGKV7iRAiGl9otNKKrxQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 09:39:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DpNGKV7iRAiGl9otNKKrxQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:39:27 INFO - Fetch https://queue.taskcluster.net/v1/task/DpNGKV7iRAiGl9otNKKrxQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:39:27 INFO - Expected file size: 21893901 09:39:31 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:39:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DpNGKV7iRAiGl9otNKKrxQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 09:39:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DpNGKV7iRAiGl9otNKKrxQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:39:31 INFO - Fetch https://queue.taskcluster.net/v1/task/DpNGKV7iRAiGl9otNKKrxQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:39:32 INFO - Expected file size: 21893901 09:39:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DpNGKV7iRAiGl9otNKKrxQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 09:39:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DpNGKV7iRAiGl9otNKKrxQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:39:37 INFO - Fetch https://queue.taskcluster.net/v1/task/DpNGKV7iRAiGl9otNKKrxQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:39:37 INFO - Expected file size: 14414081 09:39: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:39:38 INFO - trying https://queue.taskcluster.net/v1/task/DpNGKV7iRAiGl9otNKKrxQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 09:39:38 INFO - Downloading https://queue.taskcluster.net/v1/task/DpNGKV7iRAiGl9otNKKrxQ/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:39:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DpNGKV7iRAiGl9otNKKrxQ/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:39:39 INFO - Downloaded 63966673 bytes. 09:39:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DpNGKV7iRAiGl9otNKKrxQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 09:39:39 INFO - mkdir: /builds/slave/test/properties 09:39:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:39:39 INFO - Writing to file /builds/slave/test/properties/build_url 09:39:39 INFO - Contents: 09:39:39 INFO - build_url:https://queue.taskcluster.net/v1/task/DpNGKV7iRAiGl9otNKKrxQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 09:39:40 INFO - Running post-action listener: _resource_record_post_action 09:39:40 INFO - Running post-action listener: set_extra_try_arguments 09:39:40 INFO - [mozharness: 2016-10-27 16:39:40.229991Z] Finished download-and-extract step (success) 09:39:40 INFO - [mozharness: 2016-10-27 16:39:40.230221Z] Running populate-webroot step. 09:39:40 INFO - Running pre-action listener: _resource_record_pre_action 09:39:40 INFO - Running main action method: populate_webroot 09:39:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:39:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:39:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:39:40 INFO - '--tppagecycles', 09:39:40 INFO - '7'], 09:39:40 INFO - 'tests': ['tsvgm']}}, 09:39:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:39:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:39:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:39:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:39:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:39:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:39:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:40 INFO - 'talos_options': ['--disable-e10s'], 09:39:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:40 INFO - 'talos_options': ['--disable-e10s'], 09:39:40 INFO - 'tests': ['damp', 'tps']}, 09:39:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:40 INFO - 'tests': ['damp', 'tps']}, 09:39:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:39:40 INFO - 'tests': ['dromaeo_dom']}, 09:39:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:39:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:39:40 INFO - 'tests': ['basic_compositor_video']}, 09:39:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:39:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:39:40 INFO - 'tests': ['a11yr', 09:39:40 INFO - 'ts_paint', 09:39:40 INFO - 'tpaint', 09:39:40 INFO - 'sessionrestore', 09:39:40 INFO - 'sessionrestore_no_auto_restore', 09:39:40 INFO - 'tabpaint']}, 09:39:40 INFO - 'other-e10s': {'tests': ['a11yr', 09:39:40 INFO - 'ts_paint', 09:39:40 INFO - 'tpaint', 09:39:40 INFO - 'sessionrestore', 09:39:40 INFO - 'sessionrestore_no_auto_restore', 09:39:40 INFO - 'tabpaint']}, 09:39:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:39:40 INFO - 'ts_paint', 09:39:40 INFO - 'tpaint', 09:39:40 INFO - 'sessionrestore', 09:39:40 INFO - 'sessionrestore_no_auto_restore', 09:39:40 INFO - 'tabpaint']}, 09:39:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:39:40 INFO - 'ts_paint', 09:39:40 INFO - 'tpaint', 09:39:40 INFO - 'sessionrestore', 09:39:40 INFO - 'sessionrestore_no_auto_restore', 09:39:40 INFO - 'tabpaint']}, 09:39:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:39:40 INFO - 'tests': ['a11yr', 09:39:40 INFO - 'ts_paint', 09:39:40 INFO - 'tpaint', 09:39:40 INFO - 'sessionrestore', 09:39:40 INFO - 'sessionrestore_no_auto_restore', 09:39:40 INFO - 'tabpaint']}, 09:39:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:39:40 INFO - 'tests': ['a11yr', 09:39:40 INFO - 'ts_paint', 09:39:40 INFO - 'tpaint', 09:39:40 INFO - 'sessionrestore', 09:39:40 INFO - 'sessionrestore_no_auto_restore', 09:39:40 INFO - 'tabpaint']}, 09:39:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:39:40 INFO - 'tests': ['tsvgx', 09:39:40 INFO - 'tsvgr_opacity', 09:39:40 INFO - 'tart', 09:39:40 INFO - 'tscrollx', 09:39:40 INFO - 'cart']}, 09:39:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:39:40 INFO - 'tsvgr_opacity', 09:39:40 INFO - 'tart', 09:39:40 INFO - 'tscrollx', 09:39:40 INFO - 'cart']}, 09:39:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:40 INFO - 'talos_options': ['--disable-e10s'], 09:39:40 INFO - 'tests': ['tp5o']}, 09:39:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:40 INFO - 'tests': ['tp5o']}, 09:39:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:40 INFO - 'talos_options': ['--disable-e10s', 09:39:40 INFO - '--xperf_path', 09:39:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:40 INFO - 'tests': ['tp5n']}, 09:39:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:40 INFO - 'talos_options': ['--xperf_path', 09:39:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:40 INFO - 'tests': ['tp5n']}}, 09:39:40 INFO - 'talos.zip': {'path': '', 09:39:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:39:40 INFO - Running post-action listener: _resource_record_post_action 09:39:40 INFO - [mozharness: 2016-10-27 16:39:40.251492Z] Finished populate-webroot step (success) 09:39:40 INFO - [mozharness: 2016-10-27 16:39:40.251581Z] Running create-virtualenv step. 09:39:40 INFO - Running pre-action listener: _resource_record_pre_action 09:39:40 INFO - Running main action method: create_virtualenv 09:39:40 INFO - Creating virtualenv /builds/slave/test/build/venv 09:39:40 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:39:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:39:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:39:40 INFO - Using real prefix '/usr' 09:39:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:39:40 INFO - Installing distribute.............................................................................................................................................................................................done. 09:39:42 INFO - Installing pip.................done. 09:39:42 INFO - Return code: 0 09:39:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:39:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:42 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 0x7fc299c88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a78f60>, '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 0x2a79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', '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:39:42 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:39:42 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:39:42 INFO - Using env: {'DISPLAY': ':0', 09:39:42 INFO - 'HOME': '/home/cltbld', 09:39:42 INFO - 'LANG': 'en_US.UTF-8', 09:39:42 INFO - 'LANGUAGE': 'en_US:en', 09:39:42 INFO - 'LOGNAME': 'cltbld', 09:39:42 INFO - 'MAIL': '/var/mail/cltbld', 09:39:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:42 INFO - 'MOZ_NO_REMOTE': '1', 09:39:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:42 INFO - 'NO_EM_RESTART': '1', 09:39:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:42 INFO - 'PWD': '/builds/slave/test', 09:39:42 INFO - 'SHELL': '/bin/bash', 09:39:42 INFO - 'SHLVL': '1', 09:39:42 INFO - 'TERM': 'linux', 09:39:42 INFO - 'TMOUT': '86400', 09:39:42 INFO - 'USER': 'cltbld', 09:39:42 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', 09:39:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:42 INFO - '_': '/tools/buildbot/bin/python'} 09:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:43 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:39:43 INFO - Cleaning up... 09:39:43 INFO - Return code: 0 09:39:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:43 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 0x7fc299c88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a78f60>, '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 0x2a79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', '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:39:43 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:39:43 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:39:43 INFO - Using env: {'DISPLAY': ':0', 09:39:43 INFO - 'HOME': '/home/cltbld', 09:39:43 INFO - 'LANG': 'en_US.UTF-8', 09:39:43 INFO - 'LANGUAGE': 'en_US:en', 09:39:43 INFO - 'LOGNAME': 'cltbld', 09:39:43 INFO - 'MAIL': '/var/mail/cltbld', 09:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:43 INFO - 'MOZ_NO_REMOTE': '1', 09:39:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:43 INFO - 'NO_EM_RESTART': '1', 09:39:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:43 INFO - 'PWD': '/builds/slave/test', 09:39:43 INFO - 'SHELL': '/bin/bash', 09:39:43 INFO - 'SHLVL': '1', 09:39:43 INFO - 'TERM': 'linux', 09:39:43 INFO - 'TMOUT': '86400', 09:39:43 INFO - 'USER': 'cltbld', 09:39:43 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', 09:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:43 INFO - '_': '/tools/buildbot/bin/python'} 09:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:43 INFO - Downloading/unpacking psutil>=3.1.1 09:39: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:39: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:39: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:39: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:39: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:39: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:39:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:39:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:39:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:39:45 INFO - Installing collected packages: psutil 09:39:45 INFO - Running setup.py install for psutil 09:39:45 INFO - building 'psutil._psutil_linux' extension 09:39:45 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:39:45 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:39:45 INFO - building 'psutil._psutil_posix' extension 09:39:45 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:39:45 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:39:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:39:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:39:45 INFO - Successfully installed psutil 09:39:45 INFO - Cleaning up... 09:39:45 INFO - Return code: 0 09:39:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:45 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 0x7fc299c88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a78f60>, '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 0x2a79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', '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:39:45 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:39:45 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:39:45 INFO - Using env: {'DISPLAY': ':0', 09:39:45 INFO - 'HOME': '/home/cltbld', 09:39:45 INFO - 'LANG': 'en_US.UTF-8', 09:39:45 INFO - 'LANGUAGE': 'en_US:en', 09:39:45 INFO - 'LOGNAME': 'cltbld', 09:39:45 INFO - 'MAIL': '/var/mail/cltbld', 09:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:45 INFO - 'MOZ_NO_REMOTE': '1', 09:39:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:45 INFO - 'NO_EM_RESTART': '1', 09:39:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:45 INFO - 'PWD': '/builds/slave/test', 09:39:45 INFO - 'SHELL': '/bin/bash', 09:39:45 INFO - 'SHLVL': '1', 09:39:45 INFO - 'TERM': 'linux', 09:39:45 INFO - 'TMOUT': '86400', 09:39:45 INFO - 'USER': 'cltbld', 09:39:45 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', 09:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:45 INFO - '_': '/tools/buildbot/bin/python'} 09:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:39:46 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:39:46 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:39:46 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:39:46 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:39:46 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:39:46 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:39:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:39:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:39:48 INFO - Installing collected packages: mozsystemmonitor 09:39:48 INFO - Running setup.py install for mozsystemmonitor 09:39:48 INFO - Successfully installed mozsystemmonitor 09:39:48 INFO - Cleaning up... 09:39:48 INFO - Return code: 0 09:39:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:39: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:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:48 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 0x7fc299c88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a78f60>, '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 0x2a79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', '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:39:48 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:39:48 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:39:48 INFO - Using env: {'DISPLAY': ':0', 09:39:48 INFO - 'HOME': '/home/cltbld', 09:39:48 INFO - 'LANG': 'en_US.UTF-8', 09:39:48 INFO - 'LANGUAGE': 'en_US:en', 09:39:48 INFO - 'LOGNAME': 'cltbld', 09:39:48 INFO - 'MAIL': '/var/mail/cltbld', 09:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:48 INFO - 'MOZ_NO_REMOTE': '1', 09:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:48 INFO - 'NO_EM_RESTART': '1', 09:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:48 INFO - 'PWD': '/builds/slave/test', 09:39:48 INFO - 'SHELL': '/bin/bash', 09:39:48 INFO - 'SHLVL': '1', 09:39:48 INFO - 'TERM': 'linux', 09:39:48 INFO - 'TMOUT': '86400', 09:39:48 INFO - 'USER': 'cltbld', 09:39:48 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', 09:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:48 INFO - '_': '/tools/buildbot/bin/python'} 09:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:48 INFO - Downloading/unpacking jsonschema==2.5.1 09:39:48 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:39:48 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:39:48 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:39:48 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:39:48 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:39:48 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:39:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:39:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:39:50 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:39:50 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:39:50 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:39:50 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:39:50 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:39:50 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:39:50 INFO - Downloading functools32-3.2.3-2.tar.gz 09:39:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:39:50 INFO - warning: no files found matching '*.txt' 09:39:50 INFO - no previously-included directories found matching 'build' 09:39:50 INFO - no previously-included directories found matching 'dist' 09:39:50 INFO - no previously-included directories found matching '.git*' 09:39:50 INFO - Installing collected packages: jsonschema, functools32 09:39:50 INFO - Running setup.py install for functools32 09:39:50 INFO - warning: no files found matching '*.txt' 09:39:50 INFO - no previously-included directories found matching 'build' 09:39:50 INFO - no previously-included directories found matching 'dist' 09:39:50 INFO - no previously-included directories found matching '.git*' 09:39:50 INFO - Successfully installed jsonschema functools32 09:39:50 INFO - Cleaning up... 09:39:50 INFO - Return code: 0 09:39:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:39:50 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:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:50 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:39:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:50 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 0x7fc299c88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a78f60>, '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 0x2a79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', '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:39:50 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:39:50 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:39:50 INFO - Using env: {'DISPLAY': ':0', 09:39:50 INFO - 'HOME': '/home/cltbld', 09:39:50 INFO - 'LANG': 'en_US.UTF-8', 09:39:50 INFO - 'LANGUAGE': 'en_US:en', 09:39:50 INFO - 'LOGNAME': 'cltbld', 09:39:50 INFO - 'MAIL': '/var/mail/cltbld', 09:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:50 INFO - 'MOZ_NO_REMOTE': '1', 09:39:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:50 INFO - 'NO_EM_RESTART': '1', 09:39:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:50 INFO - 'PWD': '/builds/slave/test', 09:39:50 INFO - 'SHELL': '/bin/bash', 09:39:50 INFO - 'SHLVL': '1', 09:39:50 INFO - 'TERM': 'linux', 09:39:50 INFO - 'TMOUT': '86400', 09:39:50 INFO - 'USER': 'cltbld', 09:39:50 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', 09:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:50 INFO - '_': '/tools/buildbot/bin/python'} 09:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:39:51 INFO - Cleaning up... 09:39:51 INFO - Return code: 0 09:39:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:39: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:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:51 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 0x7fc299c88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a78f60>, '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 0x2a79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', '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:39:51 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:39:51 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:39:51 INFO - Using env: {'DISPLAY': ':0', 09:39:51 INFO - 'HOME': '/home/cltbld', 09:39:51 INFO - 'LANG': 'en_US.UTF-8', 09:39:51 INFO - 'LANGUAGE': 'en_US:en', 09:39:51 INFO - 'LOGNAME': 'cltbld', 09:39:51 INFO - 'MAIL': '/var/mail/cltbld', 09:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:51 INFO - 'MOZ_NO_REMOTE': '1', 09:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:51 INFO - 'NO_EM_RESTART': '1', 09:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:51 INFO - 'PWD': '/builds/slave/test', 09:39:51 INFO - 'SHELL': '/bin/bash', 09:39:51 INFO - 'SHLVL': '1', 09:39:51 INFO - 'TERM': 'linux', 09:39:51 INFO - 'TMOUT': '86400', 09:39:51 INFO - 'USER': 'cltbld', 09:39:51 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', 09:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:51 INFO - '_': '/tools/buildbot/bin/python'} 09:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:51 INFO - Downloading/unpacking blobuploader==1.2.4 09:39:51 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:39:51 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:39:51 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:39:51 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:39:51 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:39:51 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:39:53 INFO - Downloading blobuploader-1.2.4.tar.gz 09:39:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:39:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:39:53 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:39:53 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:39:53 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:39:53 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:39:53 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:39:53 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:39:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:39:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:39:53 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:39:53 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:39:53 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:39:53 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:39:53 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:39:53 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:39:53 INFO - Downloading docopt-0.6.1.tar.gz 09:39:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:39:53 INFO - Installing collected packages: blobuploader, requests, docopt 09:39:53 INFO - Running setup.py install for blobuploader 09:39:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:39:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:39:54 INFO - Running setup.py install for requests 09:39:54 INFO - Running setup.py install for docopt 09:39:54 INFO - Successfully installed blobuploader requests docopt 09:39:54 INFO - Cleaning up... 09:39:54 INFO - Return code: 0 09:39:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:54 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:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:54 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:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:54 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 0x7fc299c88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a78f60>, '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 0x2a79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', '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:39:54 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:39:54 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:39:54 INFO - Using env: {'DISPLAY': ':0', 09:39:54 INFO - 'HOME': '/home/cltbld', 09:39:54 INFO - 'LANG': 'en_US.UTF-8', 09:39:54 INFO - 'LANGUAGE': 'en_US:en', 09:39:54 INFO - 'LOGNAME': 'cltbld', 09:39:54 INFO - 'MAIL': '/var/mail/cltbld', 09:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:54 INFO - 'MOZ_NO_REMOTE': '1', 09:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:54 INFO - 'NO_EM_RESTART': '1', 09:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:54 INFO - 'PWD': '/builds/slave/test', 09:39:54 INFO - 'SHELL': '/bin/bash', 09:39:54 INFO - 'SHLVL': '1', 09:39:54 INFO - 'TERM': 'linux', 09:39:54 INFO - 'TMOUT': '86400', 09:39:54 INFO - 'USER': 'cltbld', 09:39:54 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', 09:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:54 INFO - '_': '/tools/buildbot/bin/python'} 09:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:39:54 INFO - Running setup.py (path:/tmp/pip-Mh_Wwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:39:54 INFO - Running setup.py (path:/tmp/pip-ifgVmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:39:54 INFO - Running setup.py (path:/tmp/pip-oapnxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:39:55 INFO - Running setup.py (path:/tmp/pip-GS25ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:39:55 INFO - Running setup.py (path:/tmp/pip-m_MFHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:39:55 INFO - Running setup.py (path:/tmp/pip-vXMwW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:39:55 INFO - Running setup.py (path:/tmp/pip-vbTYAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:39:55 INFO - Running setup.py (path:/tmp/pip-lM7Rrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:39:55 INFO - Running setup.py (path:/tmp/pip-LQLCLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:39:55 INFO - Running setup.py (path:/tmp/pip-4xekBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:39:55 INFO - Running setup.py (path:/tmp/pip-QOQL2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:39:55 INFO - Running setup.py (path:/tmp/pip-TZi0q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:39:55 INFO - Running setup.py (path:/tmp/pip-hzf1Xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:39:55 INFO - Running setup.py (path:/tmp/pip-I4XAQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:55 INFO - Running setup.py (path:/tmp/pip-BH4URy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:39:55 INFO - Running setup.py (path:/tmp/pip-iodQYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:39:55 INFO - Running setup.py (path:/tmp/pip-n3jYg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:39:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:39:56 INFO - Running setup.py install for manifestparser 09:39:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:39:56 INFO - Running setup.py install for mozcrash 09:39:56 INFO - Running setup.py install for mozdebug 09:39:56 INFO - Running setup.py install for mozdevice 09:39:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:39:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:39:56 INFO - Running setup.py install for mozfile 09:39:56 INFO - Running setup.py install for mozhttpd 09:39:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:39:56 INFO - Running setup.py install for mozinfo 09:39:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:39:56 INFO - Running setup.py install for mozInstall 09:39:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:39:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:39:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:39:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:39:56 INFO - Running setup.py install for mozleak 09:39:56 INFO - Running setup.py install for mozlog 09:39:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:39:57 INFO - Running setup.py install for moznetwork 09:39:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:39:57 INFO - Running setup.py install for mozprocess 09:39:57 INFO - Running setup.py install for mozprofile 09:39:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:39:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:39:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:39:57 INFO - Running setup.py install for mozrunner 09:39:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:39:57 INFO - Running setup.py install for mozscreenshot 09:39:57 INFO - Running setup.py install for moztest 09:39:57 INFO - Running setup.py install for mozversion 09:39:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:39:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:39:57 INFO - Cleaning up... 09:39:57 INFO - Return code: 0 09:39:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:57 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:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:57 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:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:57 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 0x7fc299c88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a78f60>, '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 0x2a79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', '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:39:57 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:39:57 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:39:57 INFO - Using env: {'DISPLAY': ':0', 09:39:57 INFO - 'HOME': '/home/cltbld', 09:39:57 INFO - 'LANG': 'en_US.UTF-8', 09:39:57 INFO - 'LANGUAGE': 'en_US:en', 09:39:57 INFO - 'LOGNAME': 'cltbld', 09:39:57 INFO - 'MAIL': '/var/mail/cltbld', 09:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:57 INFO - 'MOZ_NO_REMOTE': '1', 09:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:57 INFO - 'NO_EM_RESTART': '1', 09:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:57 INFO - 'PWD': '/builds/slave/test', 09:39:57 INFO - 'SHELL': '/bin/bash', 09:39:57 INFO - 'SHLVL': '1', 09:39:57 INFO - 'TERM': 'linux', 09:39:57 INFO - 'TMOUT': '86400', 09:39:57 INFO - 'USER': 'cltbld', 09:39:57 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', 09:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:57 INFO - '_': '/tools/buildbot/bin/python'} 09:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:39:58 INFO - Running setup.py (path:/tmp/pip-sw5EZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:39:58 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:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:39:58 INFO - Running setup.py (path:/tmp/pip-HGJw2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:39:58 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:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:39:58 INFO - Running setup.py (path:/tmp/pip-bmWUiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:39:58 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:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:39:58 INFO - Running setup.py (path:/tmp/pip-b00_Ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:39:58 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:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:39:58 INFO - Running setup.py (path:/tmp/pip-6J32Zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:39:58 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:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:39:58 INFO - Running setup.py (path:/tmp/pip-1EXoNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:39:58 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:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:39:58 INFO - Running setup.py (path:/tmp/pip-jA9rSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:39:58 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:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:39:58 INFO - Running setup.py (path:/tmp/pip-2w1kGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:39:58 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:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:39:58 INFO - Running setup.py (path:/tmp/pip-ZJbrIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:39:58 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:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:39:58 INFO - Running setup.py (path:/tmp/pip-_RwDJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:39:58 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:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:39:58 INFO - Running setup.py (path:/tmp/pip-Q86zdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:39:58 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:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:39:58 INFO - Running setup.py (path:/tmp/pip-RdqLul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:39:58 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:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:39:58 INFO - Running setup.py (path:/tmp/pip-MDWm2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:39:59 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:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:39:59 INFO - Running setup.py (path:/tmp/pip-Ik0zpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:39:59 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:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:59 INFO - Running setup.py (path:/tmp/pip-HDTc7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:59 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:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:39:59 INFO - Running setup.py (path:/tmp/pip-GOl6an-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:39:59 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:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:39:59 INFO - Running setup.py (path:/tmp/pip-_zOeEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:39:59 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:39:59 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:39:59 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:39:59 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:39:59 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:39:59 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:39:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:39:59 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:39:59 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:39:59 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:39:59 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:39:59 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:39:59 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:40:01 INFO - Downloading blessings-1.6.tar.gz 09:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:40:01 INFO - Installing collected packages: blessings 09:40:01 INFO - Running setup.py install for blessings 09:40:01 INFO - Successfully installed blessings 09:40:01 INFO - Cleaning up... 09:40:01 INFO - Return code: 0 09:40:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:40:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:01 INFO - Reading from file tmpfile_stdout 09:40:01 INFO - Current package versions: 09:40:01 INFO - argparse == 1.2.1 09:40:01 INFO - blessings == 1.6 09:40:01 INFO - blobuploader == 1.2.4 09:40:01 INFO - docopt == 0.6.1 09:40:01 INFO - functools32 == 3.2.3-2 09:40:01 INFO - jsonschema == 2.5.1 09:40:01 INFO - manifestparser == 1.1 09:40:01 INFO - mozInstall == 1.12 09:40:01 INFO - mozcrash == 0.17 09:40:01 INFO - mozdebug == 0.1 09:40:01 INFO - mozdevice == 0.48 09:40:01 INFO - mozfile == 1.2 09:40:01 INFO - mozhttpd == 0.7 09:40:01 INFO - mozinfo == 0.9 09:40:01 INFO - mozleak == 0.1 09:40:01 INFO - mozlog == 3.4 09:40:01 INFO - moznetwork == 0.27 09:40:01 INFO - mozprocess == 0.23 09:40:01 INFO - mozprofile == 0.28 09:40:01 INFO - mozrunner == 6.12 09:40:01 INFO - mozscreenshot == 0.1 09:40:01 INFO - mozsystemmonitor == 0.3 09:40:01 INFO - moztest == 0.7 09:40:01 INFO - mozversion == 1.4 09:40:01 INFO - psutil == 3.1.1 09:40:01 INFO - requests == 1.2.3 09:40:01 INFO - wsgiref == 0.1.2 09:40:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:01 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:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:01 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:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:01 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 0x7fc299c88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a78f60>, '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 0x2a79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', '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:40:01 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:40:01 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:40:01 INFO - Using env: {'DISPLAY': ':0', 09:40:01 INFO - 'HOME': '/home/cltbld', 09:40:01 INFO - 'LANG': 'en_US.UTF-8', 09:40:01 INFO - 'LANGUAGE': 'en_US:en', 09:40:01 INFO - 'LOGNAME': 'cltbld', 09:40:01 INFO - 'MAIL': '/var/mail/cltbld', 09:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:01 INFO - 'MOZ_NO_REMOTE': '1', 09:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:01 INFO - 'NO_EM_RESTART': '1', 09:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:01 INFO - 'PWD': '/builds/slave/test', 09:40:01 INFO - 'SHELL': '/bin/bash', 09:40:01 INFO - 'SHLVL': '1', 09:40:01 INFO - 'TERM': 'linux', 09:40:01 INFO - 'TMOUT': '86400', 09:40:01 INFO - 'USER': 'cltbld', 09:40:01 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', 09:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:01 INFO - '_': '/tools/buildbot/bin/python'} 09:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:01 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:40:01 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:40:01 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:40:01 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:40:01 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:40:01 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:40:01 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:40:01 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:40:01 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:40:01 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:40:01 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:40:01 INFO - Cleaning up... 09:40:01 INFO - Return code: 0 09:40:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:40:01 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:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:01 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:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:01 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 0x7fc299c88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a78f60>, '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 0x2a79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', '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:40:01 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:40:01 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:40:01 INFO - Using env: {'DISPLAY': ':0', 09:40:01 INFO - 'HOME': '/home/cltbld', 09:40:01 INFO - 'LANG': 'en_US.UTF-8', 09:40:01 INFO - 'LANGUAGE': 'en_US:en', 09:40:01 INFO - 'LOGNAME': 'cltbld', 09:40:01 INFO - 'MAIL': '/var/mail/cltbld', 09:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:01 INFO - 'MOZ_NO_REMOTE': '1', 09:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:01 INFO - 'NO_EM_RESTART': '1', 09:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:01 INFO - 'PWD': '/builds/slave/test', 09:40:01 INFO - 'SHELL': '/bin/bash', 09:40:01 INFO - 'SHLVL': '1', 09:40:01 INFO - 'TERM': 'linux', 09:40:01 INFO - 'TMOUT': '86400', 09:40:01 INFO - 'USER': 'cltbld', 09:40:01 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', 09:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:01 INFO - '_': '/tools/buildbot/bin/python'} 09:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:40:02 INFO - Cleaning up... 09:40:02 INFO - Return code: 0 09:40:02 INFO - Running post-action listener: _resource_record_post_action 09:40:02 INFO - Running post-action listener: _start_resource_monitoring 09:40:02 INFO - Starting resource monitoring. 09:40:02 INFO - [mozharness: 2016-10-27 16:40:02.159067Z] Finished create-virtualenv step (success) 09:40:02 INFO - [mozharness: 2016-10-27 16:40:02.159518Z] Running install step. 09:40:02 INFO - Running pre-action listener: _resource_record_pre_action 09:40:02 INFO - Running main action method: install 09:40:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:02 INFO - Reading from file tmpfile_stdout 09:40:02 INFO - Detecting whether we're running mozinstall >=1.0... 09:40:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:40:02 INFO - Reading from file tmpfile_stdout 09:40:02 INFO - Output received: 09:40:02 INFO - Usage: mozinstall [options] installer 09:40:02 INFO - Options: 09:40:02 INFO - -h, --help show this help message and exit 09:40:02 INFO - -d DEST, --destination=DEST 09:40:02 INFO - Directory to install application into. [default: 09:40:02 INFO - "/builds/slave/test"] 09:40:02 INFO - --app=APP Application being installed. [default: firefox] 09:40:02 INFO - mkdir: /builds/slave/test/build/application 09:40:02 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:40:02 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:40:18 INFO - Reading from file tmpfile_stdout 09:40:18 INFO - Output received: 09:40:18 INFO - /builds/slave/test/build/application/firefox/firefox 09:40:18 INFO - Running post-action listener: _resource_record_post_action 09:40:18 INFO - [mozharness: 2016-10-27 16:40:18.428228Z] Finished install step (success) 09:40:18 INFO - [mozharness: 2016-10-27 16:40:18.428473Z] Running run-tests step. 09:40:18 INFO - Running pre-action listener: _resource_record_pre_action 09:40:18 INFO - Running main action method: run_tests 09:40:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:40:18 INFO - Python 2.7.3 09:40:18 INFO - Return code: 0 09:40:18 INFO - grabbing minidump binary from tooltool 09:40:18 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:40:18 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 0x2a78f60>, '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 0x2a79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:40:18 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:40:18 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:40:18 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:40:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:40:18 INFO - Return code: 0 09:40:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:40:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:40:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:40:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:40:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:40:18 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/DpNGKV7iRAiGl9otNKKrxQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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:40:18 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/DpNGKV7iRAiGl9otNKKrxQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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:40:18 INFO - Using env: {'DISPLAY': ':0', 09:40:18 INFO - 'HOME': '/home/cltbld', 09:40:18 INFO - 'LANG': 'en_US.UTF-8', 09:40:18 INFO - 'LANGUAGE': 'en_US:en', 09:40:18 INFO - 'LOGNAME': 'cltbld', 09:40:18 INFO - 'MAIL': '/var/mail/cltbld', 09:40:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:40:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:18 INFO - 'MOZ_NO_REMOTE': '1', 09:40:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:40:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:18 INFO - 'NO_EM_RESTART': '1', 09:40:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:18 INFO - 'PWD': '/builds/slave/test', 09:40:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:40:18 INFO - 'SHELL': '/bin/bash', 09:40:18 INFO - 'SHLVL': '1', 09:40:18 INFO - 'TERM': 'linux', 09:40:18 INFO - 'TMOUT': '86400', 09:40:18 INFO - 'USER': 'cltbld', 09:40:18 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354', 09:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:18 INFO - '_': '/tools/buildbot/bin/python'} 09:40:18 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/DpNGKV7iRAiGl9otNKKrxQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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:40:18 INFO - mozversion application_buildid: 20161027063134 09:40:18 INFO - mozversion application_changeset: bf0d21da3297e8d0fe12b43790cc1458d85b2a3d 09:40:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:40:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:40:18 INFO - mozversion application_name: Firefox 09:40:18 INFO - mozversion application_remotingname: firefox-dev 09:40:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:40:18 INFO - mozversion application_vendor: Mozilla 09:40:18 INFO - mozversion application_version: 51.0a2 09:40:18 INFO - mozversion platform_buildid: 20161027063134 09:40:18 INFO - mozversion platform_changeset: bf0d21da3297e8d0fe12b43790cc1458d85b2a3d 09:40:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:40:18 INFO - mozversion platform_version: 51.0a2 09:40:18 INFO - using testdate: 1477586418 09:40:18 INFO - actual date: 1477586418 09:40:18 INFO - starting webserver on 'localhost:57714' 09:40:18 INFO - SUITE-START | Running 2 tests 09:40:18 INFO - TEST-START | dromaeo_css 09:40:18 INFO - operating with platform_type : linux_ 09:40:18 INFO - Initialising browser for dromaeo_css test... 09:40:18 INFO - TEST-INFO | started process 22968 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprslug4/profile http://localhost:57714/getInfo.html) 09:40:22 INFO - PROCESS | 22968 | __metrics Screen width/height:1600/1200 09:40:22 INFO - PROCESS | 22968 | colorDepth:24 09:40:22 INFO - PROCESS | 22968 | Browser inner width/height: 1024/697 09:40:22 INFO - PROCESS | 22968 | __metrics 09:40:22 INFO - PROCESS | 22968 | 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:40:22 INFO - PROCESS | 22968 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:40:23 INFO - PROCESS | 22968 | console.error: PushService: 09:40:23 INFO - PROCESS | 22968 | stateChangeProcessEnqueue: Error transitioning state 09:40:23 INFO - PROCESS | 22968 | UnknownError 09:40:24 INFO - TEST-INFO | 22968: exit 0 09:40:24 INFO - Browser initialized. 09:40:24 INFO - Running cycle 1/1 for dromaeo_css test... 09:40:24 INFO - TEST-INFO | started process 23056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprslug4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:35 INFO - PROCESS | 23056 | RSS: Main: 145215488 09:40:35 INFO - PROCESS | 23056 | 09:41:26 INFO - PROCESS | 23056 | 1477586486853 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:43:36 INFO - PROCESS | 23056 | Cycle 1(1): loaded http://localhost:57714/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57714/tests/dromaeo/cssquery-ext.html) 09:43:37 INFO - PROCESS | 23056 | RSS: Main: 253116416 09:43:37 INFO - PROCESS | 23056 | 09:46:39 INFO - PROCESS | 23056 | Cycle 1(1): loaded http://localhost:57714/tests/dromaeo/cssquery-ext.html (next: http://localhost:57714/tests/dromaeo/cssquery-jquery.html) 09:46:40 INFO - PROCESS | 23056 | RSS: Main: 226390016 09:46:40 INFO - PROCESS | 23056 | 09:49:42 INFO - PROCESS | 23056 | Cycle 1(1): loaded http://localhost:57714/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57714/tests/dromaeo/cssquery-mootools.html) 09:49:42 INFO - PROCESS | 23056 | RSS: Main: 176119808 09:49:42 INFO - PROCESS | 23056 | 09:52:44 INFO - PROCESS | 23056 | Cycle 1(1): loaded http://localhost:57714/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57714/tests/dromaeo/cssquery-prototype.html) 09:52:45 INFO - PROCESS | 23056 | RSS: Main: 217251840 09:52:45 INFO - PROCESS | 23056 | 09:55:47 INFO - PROCESS | 23056 | Cycle 1(1): loaded http://localhost:57714/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57714/tests/dromaeo/cssquery-yui.html) 09:55:48 INFO - PROCESS | 23056 | RSS: Main: 177602560 09:55:48 INFO - PROCESS | 23056 | 09:58:51 INFO - PROCESS | 23056 | Cycle 1(1): loaded http://localhost:57714/tests/dromaeo/cssquery-yui.html (next: http://localhost:57714/tests/dromaeo/cssquery-dojo.html) 09:58:51 INFO - PROCESS | 23056 | RSS: Main: 267952128 09:58:51 INFO - PROCESS | 23056 | 09:58:51 INFO - PROCESS | 23056 | __start_tp_report 09:58:51 INFO - PROCESS | 23056 | _x_x_mozilla_page_load 09:58:51 INFO - PROCESS | 23056 | _x_x_mozilla_page_load_details 09:58:51 INFO - PROCESS | 23056 | |i|pagename|runs| 09:58:51 INFO - PROCESS | 23056 | |0;dojo.html;3112.9533057004146;3162.320101178247;3174.9523757143634;3189.760767942405;3211.9678803211978;5574.442555744424;5686.175504551838;5686.5735069869825;5703.116017017363;5705.286839145107;5644.322681278242;5700.515456186229;5703.458171473714;5711.457411545896;5744.885102297952;5120.743962801864;5135.666181698178;5137.6403651744395;5172.560332371753;5217.791288348461;5058.165402708549;5230.869228269305;5233.3981592116825;5233.8953220935555;5241.580673546107;5020.196768517038;5070.543651071403;5084.491550844905;5093.668911520739;5120.743962801864;5069.847904562869;5079.542841144296;5098.898022039557;5147.510986456281;5181.171012637998;4985.925211121836;5060.898782024376;5103.157978933472;5120.15517439622;5120.718360490171;5391.973040134813;5440.619156659035;5482.150266708666;5493;5519.724013799334;5902.911456328158;5915.053591425394;5920.141579470953;5999.580029397944;6031.487323577501;6067.848303792396;6068.939310606882;6080.513558915276;6080.574359794816;6081.057436097368;5499.230107784913;5541.113421852525;5542.722863856791;5576.6096373254295;5580.720963951786;6094.939050609526;6161.876762464815;6162.352952939967;6165.784197553154;6166;5742.511886489695;5907.232059832194;5912.17229587858;5914.704264786744;5915.260592425947;5881.617694849907;5929.851753706192;5995.850103747354;5999.070144127667;6098.603590766586;6024.307204671519;6026.7890623828835;6029.6683682397015;6035.215421995113;6043.7884674036195;5833.095870140135;5982.670953097621;6045.183900173508;6051.667158306247;6085.421884920926;4536.002079542495;4557.6581756368405;4596.034832685106;4607.585317321457;4662.743549104832;4057.7159598827798;4100.958990410118;4104.692148088905;4105.158442519277;4132.876013719593;5770.798022069207;5785.30576330843;5785.913211301834;5789.797357092481;5820.156077368758;5827.737751801179;5836.445537673914;5842.5618078644275;5873.970630146908;5876.7355469004;5599.272094627672;5630.0991841305195;5651.9152212716845;5658.066419040894;5660.2075709400715;5140.614453915971;5170.3278573785165;5174;5181.611379146579;5206.557442617344;5993.250843644544;6121.296050954108;6122.295935967331;6139.492138333381;6143.109249158847;6049.485793707584;6051.515878729603;6063.909041364472;6065.514758819196;6097.024476083982;6193.535484838565;6212.285587157535;6258.687065646791;6259.561830671809;6259.78090766821;5692.971535142297;5702.258706368146;5860.355360910211;5956.672383018976;5988.311344195473;6002.639841609517;6089.786857459968;6108.11432342299;6120.204373431426;6132.049532322497;5895.734691938787;5935.554833387427;5936.940630593639;5943.138244954371;5946.048632218824;5678.119891416837;5780.277465316835;5926.911096333472;5929.970350148222;5941.079132734433;5802.390748971297;5842.415758424124;5849.970750146222;5900.911486327623;5926.851828704317;5959.076343166643;5962.224910761746;5963.4334738199805;5965.492933100735;5972.970135149297;5667.2349232854685;5669.3480249770155;5712.02895507773;5806.65160090396;5819.82540523785 09:58:51 INFO - PROCESS | 23056 | |1;ext.html;604.3291945940009;605.3069235725095;608.4584719599557;621.741977079512;644.1368566121398;45162.32256516151;46539.06921861561;46564.76717616412;46618;49933.25100123492;47127.764361178146;47499;47592.76203618986;47662.52337476633;47747.28379074308;8370.832583348329;8556.743297701049;9237.521996480564;9379.390339627902;9392.62429502819;10884.401357925311;11010.614628488005;11157.72105697356;11466.656000320003;11477.598284060059;10987.450627468634;11058.834117488244;11059.557617695324;11069.723256918602;11076;11125.777484450306;11147.442627868655;11164.218504704673;11169.162312826571;11172.553097876116;11003.504842282116;11073.390963497004;11077.335359878432;11082.612108576242;11086.16853735965;45210.32184517235;45525;45529.317060244124;45545;45590.772046139886;3653.8173091345593;3707.925841483182;3719.4048952167796;3855.6915446764474;4076.5923407659293;33889;34213.14467138317;34493.13767155816;34543.309133817434;35505.11237219064;4657.3246879202325;4717.363155973968;4744.478107408182;4752.334673145762;4835.1296766582;388323;388578;388906;391382;392817;38276;39649.60350396517;57498.7125064372;57560;57782.42217577854;41415.378769318486;41550;41729.374059389134;41807.37288940668;41844.372334415006;16790.412335568442;17072.57318567046;17073.40243091486;17074.231659575347;17076.487705368858;12681.556145534862;12759.362031898554;12840.55058072963;12957.287349195696;14379.92810035964;9480.57337419804;9518.428894266366;9531.952340238393;9559.852817661926;9577.23382129428;3608.711303095746;3630.945535816912;3651.8174091295327;3664;3765.3975363941636;1043;1046.6232156423682;1108.7560736637927;1123.4270522033657;1201.0151675625902;33952;33952.660473395445;34152.829235853664;34426.48360274598;34636.653633463844;1123.741539445932;1163.1450883600546;1201.7055821323831;1221.3343727668441;1227.9017678585692;17552.64894702099;17629.686633319394;17638.91180544115;17685;17726.556836078944;528485;530071;530430;530934;537236;62094.379056209764;62680.05979910305;62771.37228627655;62865;62874.685626571576;1318.6637407461037;1349.9055066145472;1422.4168091082606;1427.3291552970295;1535.854093861059;30818.075457736304;34086;35986.280274393845;36108.63891361053;36452.27095458023;53199.46800531945;60931.69534152301;62874;63205.68397157985;67929.66035169792;473715;479112;479841;480900;482376;46502;47058.29412558746;47584.286235707186;47993.28010079782;48130.27804582864;51228.74385628048;51706;51711.22433163581;51771.482285176666;52056.47943520516;43023.78488107539;43136.568634313255;43344.56655433532;43584.34623480714;44641.77679111584;42839.656059674744;43373.13253734844;43562.56437435712;44188;44258;39071.80464097661;39877;44173.77913110414;44502;44567.10865782731;35021.82489087538;37983;38583.42124868073;38658.80670596629;38831.41752873653;28973.56539651949;29035.7096429033;29058.7094129056;29197.562036569045;29213.269668258465 09:58:51 INFO - PROCESS | 23056 | |2;jquery.html;386.27958856732204;430.31340830919396;430.4554738256106;442.6193473612694;443.15136513576505;17019;21866.671999920014;22188.77811221887;22248.666270005942;22274.443138921535;20733.585328293426;20749.896250518726;20965.68551471729;21018.894905525452;21019.474513137142;4341.2836881914445;4539.251023581105;4667.88330291742;5991.700414979256;6058.787942422016;6253.624782513041;6562.704678289489;6578.671066446683;6681.164854393201;6690.832729181785;6408.455281301095;6577.243616984037;6592.835179120512;6601;6634.5355825092265;5800.651960882361;6534.54258201926;6559.540832141752;6562.93437065628;6585.275619681831;5853.09277062056;5941.168236446901;5955.553333499962;5956.97021514894;5957.1957785698805;14778.482753103697;15039;15161.24193790317;15200.087994720241;15305;2358.705161854768;2417.891194896234;2434.0263894442187;2448.8530688158767;2456.312232574882;10541.736456588647;10924.180686448468;10956.28784129037;11041.85041672035;11072.39101849398;1898.6677331466938;1914.473519782071;1958.432054704134;1969.1237399357292;1982.5638359561017;51918.48081519212;53747.73126134344;84839;84922.57538712329;87021;11529.711757206136;11530.192886497865;11660.242084264495;11751.706207344885;11755.412229388667;16650.83349166517;16680.082595457123;16690.83309166917;16702.832971670126;16704.749428758336;8775.736727898173;8782.353817874606;8860.512671803113;8889.333300002525;8896.8665470018;8711.34664900135;8796.428232164888;8872.83107187594;8915.37592368541;9017.954910225539;4567.931481027787;4854.951450485521;5007.9499205008215;5026.79892804291;5079.466656001066;1790.3223454972135;1952.9414117576496;2076.377086873962;2100.380387785576;2101.6112019276484;930.3952430919957;997.7006897930592;1016.7153197104823;1073.2487258918788;1078.487718333785;19940.50148746293;20160.899195503927;20361.898190508953;20380.592388152152;20476.69284960727;1036.5076588620345;1044.738815296176;1055.4775386183887;1058.2433560004479;1079.1798233342715;10577.84133238002;11353.886461135284;11416.372099534605;11437.771244575228;11562.94218528902;538267;552982;555212;566212;573469;94552;97509;98200.50899745456;99326;99919.50040249752;1017.7557386227252;1045.8378951262414;1080.502968634437;1097.9945100274447;1099.1811100730008;17175.742363864803;17397.739033914248;17762.289508420035;17876.91061544684;18040.729389059437;43169.568304317814;44015.339769902836;44219.33670995002;44542;44746.801135826885;60466.39533604783;60653.39346606654;60845.695771520855;61083;62875.37124628695;7873;8317.459365141247;8967.865482017645;8972.28221742246;9281.257499399897;13379.197248165141;13668.726625467634;13807.378667960167;13816.378262977989;14126.152430854181;11309.434528273718;11374.488148033193;11419.657410277705;11507.194496385173;11646.475908584303;11644;11873.346965916957;11998.220115692453;12140.453679584263;12305.138640295094;11141;11168.66494005181;11224.831627525431;11350.148738844784;11758.764824703629;7993.600319984093;8312.418130731032;8411.53736544496;8483;8515.8722619162;10373.429461379697;11123;11167.1066314693;11193.216474846682;11456.255343402652 09:58:51 INFO - PROCESS | 23056 | |3;mootools.html;1378.6622277542003;1520.6578519833038;1523.070926734692;1703.5230135562047;1846.9261229550818;8080.0707918589305;9278.675246366378;9561.569729362187;9566.952165239163;9937.552810123543;9654.758631034229;9700.514974251295;9702.078302561264;9717.562709678064;9722.611095556187;2537.949241015179;2564.269183282765;2564.4999225151105;2565.256075738034;2566.6278389633494;2444.2422848916895;2556.987215063922;2562.231330600822;2562.6668533090765;2567.2298310506867;2538.860362680052;2551.8213725039254;2569.2420735882865;2578.5745352016893;2578.8323758955703;2466.235467005225;2479.9752002479927;2487.9004839806385;2505.711843138044;2528.266802627236;2486.689163854518;2512.2463261021803;2521.0294036795967;2525.02786427225;2542.224621490445;9306.906930930672;9620.470874101922;9635;9635.518224088768;9712.660056898045;5749.8275051748515;5928.140419639171;5928.940710592925;5935.050391937312;5940.34656187819;3731.458938453909;3799.6580307772433;3815.065308999285;3880.6701430378453;3890.8832735017995;1284.8137020132028;1296.0603562417266;1304.8303720516367;1309.6987692830703;1344.482374285897;12174.878251217464;12275.2021118627;12289;12294.077944154134;12320.383980800923;4830.985493046429;5017.774200161001;5075.974620126875;5170.741462926839;5204.167333226741;10602.787944241072;10662.786744265071;10666.626668066581;10699.679009629723;10710.036096751173;5731.369549349568;5735.655860648374;5775.711214439261;5794.275715535558;5795.217645617872;4471.374007638933;4660.161170989254;4741.146593613183;4756.143894099096;5348.598855085884;4150.709450338447;4219.198352313051;4229.281022226229;4340.218760623118;4349.369341445473;1269.2321145706899;1288.2335010668637;1312.6718320419895;1321.5242512695422;1324.132693086011;917.5091326140483;994.4428195378806;1008.1380419741163;1010.1867996262932;1015.5125539740966;6213.378662133841;6269.843253918689;6275.560710750204;6418.967905160538;6481.611103333815;1056.2606175677056;1083.2200815412891;1085.6200329884634;1092.8907109289166;1097.3361116524547;4242.851500197478;4264.530901600821;4393.648508119343;4394;4447.533009034069;11645.301281923112;12064.21582597146;12068.275903445821;12115.030797536176;12124.939375303244;11948.34284114382;11977.880221197851;11991.280523168463;11994.580189693319;12010.459529321202;8323.95838020806;8728.039915609277;8760.693375731818;8778.29773618109;8890.110988901188;6203.193584833943;6338.492920566436;6491.05879647439;6535.3137920517665;6629.3039230882;10813.080888124598;10991.285566438475;11202.15983801202;11246.550137994389;11406.429678515875;9503.334766566273;9760;11146.888531114586;11360.9431952843;11492.138089643144;7695.653695583824;7842.607869606611;7850.057993040871;7911.28798408146;7979.241972012649;9013.95493022557;9018.909810901807;9091.636334546543;9092.636294548409;9093.090690930854;7968.920310796818;7992.840143196987;8088.83822323562;8100.594970251582;8148.348132149533;7883.172266912121;7946.324562412028;8016.9198308016175;8112.75661730149;8120.187981201832;7437.293457121565;7532.623368831646;7550.056242969629;7554.546727196386;7567.508111972704;4980.800767969386;5004.324416203766;5056.974715126401;5058.342415485963;5208.661437006583;5030.119729047329;5073.365829271341;5092.439831618445;5100.107481190851;5172.818951336685 09:58:51 INFO - PROCESS | 23056 | |4;prototype.html;352.73368606701933;362.70439591732736;366.15783697495755;370.684917819853;372.5213101165;5199.766010529525;5351.384590772062;5377.973110134453;5424.264235444654;5432.538234250089;5201.479852014797;5327.467253274671;5354.678719276846;5366.141417373221;5370.194470829378;4281.422008028923;4282.250606143913;4295.699301048928;4300.98926752213;4301.591348821873;4201.6008479194425;4269.466316710411;4269.679774016946;4271.871843844674;4285.228658841407;4234.9153016939645;4236.406903033578;4237.555056719047;4240.427542281799;4249.51130619978;4229.978850105746;4236.2798324284795;4247.447831781879;4250.426192464009;4266.762638834734;3722.7394082414244;3831.291211125923;3846.826892789803;3846.8653597123966;3851.287511810296;5166.819161329336;5202.479752024768;5203.453637368059;5206.323177986837;5214.582833373359;4841.03179364125;4867.780949857265;4869.780859861315;4871;4877.366082362413;5320.334958130234;5548.306461692288;5560.165975103726;5569.415211402826;5581.190727344553;4139.337705967061;4159.480064991876;4171.7496950182785;4175.331946888514;4185.916281674349;5850.23946886902;5852.9807216510235;5859.707014649293;5888.970555147197;5893.941060589382;4031.113155105872;4203.852865149705;4207.936880946788;4208.390797705442;4210.200061988213;4204.411382406465;4222.218889505451;4243.766592837362;4246.214450326699;4252.4046633471335;4809.509052193831;4821.156297647897;4823.903521929542;4826.348442960226;4832.975835120802;5513.558915286768;5642.689652069093;5658.179563963202;5660.97169514158;5675.63784691671;1464.406915199346;1471.830739464954;1476.5201309574215;1481.7110663420744;1485.0569888121122;898.9392516830072;924.4407133684159;926.893407258174;927.1099744245465;956.4357029352715;4848.884756506023;4878.975605121952;4918.483559226302;4933.777979990909;4938.950610493921;5167.896642067138;5175.534201921845;5187.533122019036;5195.246689230041;5205.45342739007;4614.707881793103;4867.294242334841;4869.805207791719;4877.3903262092235;4928.433230178503;2697.85161816102;2708.6478757761365;2711.9322016949736;2717.334253108001;2720.3813730830125;5235.973820130875;5243.8164664236565;5250.606204534675;5261.263423120766;5272.604554658416;4850.805967761321;5077.517635824591;5133.794648214104;5197.870053248624;5201.817936372209;5195.376554813447;5222.895542089137;5227.973860130675;5236.973815130977;5253.50091741284;5068;5069.062223488519;5079.019182518895;5093.567046800915;5148.43367229597;4747.335373047845;5070.949290507196;5092.719900405513;5094.847154585368;5111.693298402108;5254.422013578427;5258.290130832289;5291.788328466818;5291.814786482455;5315.734213289397;3854.710896682816;3862.478565393636;3990.7006974477613;4096.32410652239;4145.8963525912095;5661.0093233684765;5752.426820677488;5757.424257574209;5759.625624334405;5764.365919748908;5622.072358061037;5628.1557766333735;5629.380768115422;5633.718314084197;5638.436156384493;5433.402325744244;5603.299587551556;5620.381758006534;5655.1517272409465;5671.319441667027;5529.115341545334;5573.303337082864;5580.386157522588;5650.654978184172;5659.151127330769;5465.72671366438;5624.100143976944;5627.606067575394;5638.646724786104;5647.88704225905;5517.420670829505;5525;5532.612717109763;5543.695096769555;5549.611527193058 09:58:51 INFO - PROCESS | 23056 | |5;yui.html;830.0786127398591;843.8860753798235;843.9071702112767;844.6494704697551;880.9604666493535;14622.926885365572;15387.076775393483;15393.076415415084;15458.227088645579;15623.921880390582;14202.78695819561;15950.76073858893;16452.506424807274;16498.092604906724;16500.42248521302;844.0926004545108;874.9300055995537;876.0976194519654;877.7191298784392;877.934154938379;861.8276344731048;863.6502216602255;864.4337958637103;864.4683519635411;864.5158711121792;926.4996901673088;926.5552534783308;927.1516562345446;928.2434815625244;928.2852203803068;911.3620465673988;917.3486824354716;918.8575770755543;919.016652182162;919.4253591505309;677.7966610016975;681.505908216544;681.5910453727773;682.5188242289224;682.8019874236516;15097.773533397009;15137.470188543459;15151.393944242218;15254.847451525453;15368.846311536854;16123;16660.250288737036;16744.16279186036;17222.655546888993;17599.472015839547;13420.731585368336;13454.394552245074;13699.29777795464;13784.241866697328;13853.238071906042;4148.23257697327;4187.958120418818;4223.767692776896;4308.030693094061;4349.064951035511;64592;67250.66374668144;69445;78896.60551697205;82782;11902.404879755977;12063.879361206451;12168.452419641137;12231.93884030592;12251.32617706017;20325.390238292875;20364;20367.287144949856;20372.388828335173;20385.694214586794;9081.636734530544;9138.68014619485;9167.724968250963;9239;9249.722508324761;4777.976110119496;4815.133276010281;4824.638152138534;4858.80564777412;5047.747612619354;3667.3765459871884;3802.0304822270696;3810;3812.199438118026;3823.1397935464856;637.5186734015881;643.2506130358174;645.2579533536377;653.6568301641677;676.9492288078413;659.2550418027598;665.1286814273318;709.7303024850523;729.2998721227681;741.8034220931457;9298.209652179505;9399.812003759887;9478.199142162966;9496.240300775922;9536.713898583053;699.3006993006993;714.3535100733844;717.5694583250008;725.6952080126359;739.9556026638419;4732.432108146975;4834.661573689808;4890.168671325883;4893.657443978887;4964.429090654621;76729.23270767221;101223.49388253012;103219;104847.4757626207;119133;71441.2855871445;85036;107253.4637326824;108993.45503272433;109958.45020774845;71504.64247678728;79240;80008;89443.55278223567;89790.55104724565;9032.864507032531;9203.263738901005;9535.666251681158;9728.951355243178;9780.462074585967;38181.61818381781;43653;48234.758826205645;54056.72971635117;54061.459385405644;77137.61431192808;78037;79237.20762792298;79579.2042079595;79743.60128199322;13376.866231337952;13415;13549.25479098659;13712.794308085187;13928.303584820516;15196.696066078837;15540.145292009049;15545.611359716098;15990.360385584912;16825.158742062602;13100.279484628438;13115.540956066492;13202;13690.726185476435;13987.090839095426;13243.072984890965;13281.269530175932;13311.66720831987;13889.829664309274;14695.632609184855;12219.26684398939;12536.185147965352;12566.685832854251;12943.288119153536;13096.214227146402;11337.26307789991;11691.707707307385;11808.586699465477;12028.458719357475;12363.75272494563;10063.597456101674;10350.956018171953;10869.51087201062;11138.554457821596;11315.943420282845 09:58:51 INFO - PROCESS | 23056 | __end_tp_report 09:58:51 INFO - PROCESS | 23056 | __start_cc_report 09:58:51 INFO - PROCESS | 23056 | _x_x_mozilla_cycle_collect,918 09:58:51 INFO - PROCESS | 23056 | __end_cc_report 09:58:51 INFO - PROCESS | 23056 | __startTimestamp1477587531292__endTimestamp 09:58:51 INFO - PROCESS | 23056 | 09:58:51 INFO - PROCESS | 23056 | ------- Summary: start ------- 09:58:51 INFO - PROCESS | 23056 | Number of tests: 6 09:58:51 INFO - PROCESS | 23056 | 09:58:51 INFO - PROCESS | 23056 | [#0] dojo.html Cycles:165 Average:5578.40 Median:5802.39 stddev:641.15 (11.0%) stddev-sans-first:613.25 09:58:51 INFO - PROCESS | 23056 | Values: 3113.0 3162.3 3175.0 3189.8 3212.0 5574.4 5686.2 5686.6 5703.1 5705.3 5644.3 5700.5 5703.5 5711.5 5744.9 5120.7 5135.7 5137.6 5172.6 5217.8 5058.2 5230.9 5233.4 5233.9 5241.6 5020.2 5070.5 5084.5 5093.7 5120.7 5069.8 5079.5 5098.9 5147.5 5181.2 4985.9 5060.9 5103.2 5120.2 5120.7 5392.0 5440.6 5482.2 5493.0 5519.7 5902.9 5915.1 5920.1 5999.6 6031.5 6067.8 6068.9 6080.5 6080.6 6081.1 5499.2 5541.1 5542.7 5576.6 5580.7 6094.9 6161.9 6162.4 6165.8 6166.0 5742.5 5907.2 5912.2 5914.7 5915.3 5881.6 5929.9 5995.9 5999.1 6098.6 6024.3 6026.8 6029.7 6035.2 6043.8 5833.1 5982.7 6045.2 6051.7 6085.4 4536.0 4557.7 4596.0 4607.6 4662.7 4057.7 4101.0 4104.7 4105.2 4132.9 5770.8 5785.3 5785.9 5789.8 5820.2 5827.7 5836.4 5842.6 5874.0 5876.7 5599.3 5630.1 5651.9 5658.1 5660.2 5140.6 5170.3 5174.0 5181.6 5206.6 5993.3 6121.3 6122.3 6139.5 6143.1 6049.5 6051.5 6063.9 6065.5 6097.0 6193.5 6212.3 6258.7 6259.6 6259.8 5693.0 5702.3 5860.4 5956.7 5988.3 6002.6 6089.8 6108.1 6120.2 6132.0 5895.7 5935.6 5936.9 5943.1 5946.0 5678.1 5780.3 5926.9 5930.0 5941.1 5802.4 5842.4 5850.0 5900.9 5926.9 5959.1 5962.2 5963.4 5965.5 5973.0 5667.2 5669.3 5712.0 5806.7 5819.8 09:58:51 INFO - PROCESS | 23056 | 09:58:51 INFO - PROCESS | 23056 | [#1] ext.html Cycles:180 Average:63420.48 Median:216233.30 stddev:124606.88 (57.6%) stddev-sans-first:124867.18 09:58:51 INFO - PROCESS | 23056 | Values: 604.3 605.3 608.5 621.7 644.1 45162.3 46539.1 46564.8 46618.0 49933.3 47127.8 47499.0 47592.8 47662.5 47747.3 8370.8 8556.7 9237.5 9379.4 9392.6 10884.4 11010.6 11157.7 11466.7 11477.6 10987.5 11058.8 11059.6 11069.7 11076.0 11125.8 11147.4 11164.2 11169.2 11172.6 11003.5 11073.4 11077.3 11082.6 11086.2 45210.3 45525.0 45529.3 45545.0 45590.8 3653.8 3707.9 3719.4 3855.7 4076.6 33889.0 34213.1 34493.1 34543.3 35505.1 4657.3 4717.4 4744.5 4752.3 4835.1 388323.0 388578.0 388906.0 391382.0 392817.0 38276.0 39649.6 57498.7 57560.0 57782.4 41415.4 41550.0 41729.4 41807.4 41844.4 16790.4 17072.6 17073.4 17074.2 17076.5 12681.6 12759.4 12840.6 12957.3 14379.9 9480.6 9518.4 9532.0 9559.9 9577.2 3608.7 3630.9 3651.8 3664.0 3765.4 1043.0 1046.6 1108.8 1123.4 1201.0 33952.0 33952.7 34152.8 34426.5 34636.7 1123.7 1163.1 1201.7 1221.3 1227.9 17552.6 17629.7 17638.9 17685.0 17726.6 528485.0 530071.0 530430.0 530934.0 537236.0 62094.4 62680.1 62771.4 62865.0 62874.7 1318.7 1349.9 1422.4 1427.3 1535.9 30818.1 34086.0 35986.3 36108.6 36452.3 53199.5 60931.7 62874.0 63205.7 67929.7 473715.0 479112.0 479841.0 480900.0 482376.0 46502.0 47058.3 47584.3 47993.3 48130.3 51228.7 51706.0 51711.2 51771.5 52056.5 43023.8 43136.6 43344.6 43584.3 44641.8 42839.7 43373.1 43562.6 44188.0 44258.0 39071.8 39877.0 44173.8 44502.0 44567.1 35021.8 37983.0 38583.4 38658.8 38831.4 28973.6 29035.7 29058.7 29197.6 29213.3 09:58:51 INFO - PROCESS | 23056 | 09:58:51 INFO - PROCESS | 23056 | [#2] jquery.html Cycles:180 Average:31061.94 Median:22218.72 stddev:91610.95 (412.3%) stddev-sans-first:91838.99 09:58:51 INFO - PROCESS | 23056 | Values: 386.3 430.3 430.5 442.6 443.2 17019.0 21866.7 22188.8 22248.7 22274.4 20733.6 20749.9 20965.7 21018.9 21019.5 4341.3 4539.3 4667.9 5991.7 6058.8 6253.6 6562.7 6578.7 6681.2 6690.8 6408.5 6577.2 6592.8 6601.0 6634.5 5800.7 6534.5 6559.5 6562.9 6585.3 5853.1 5941.2 5955.6 5957.0 5957.2 14778.5 15039.0 15161.2 15200.1 15305.0 2358.7 2417.9 2434.0 2448.9 2456.3 10541.7 10924.2 10956.3 11041.9 11072.4 1898.7 1914.5 1958.4 1969.1 1982.6 51918.5 53747.7 84839.0 84922.6 87021.0 11529.7 11530.2 11660.2 11751.7 11755.4 16650.8 16680.1 16690.8 16702.8 16704.7 8775.7 8782.4 8860.5 8889.3 8896.9 8711.3 8796.4 8872.8 8915.4 9018.0 4567.9 4855.0 5007.9 5026.8 5079.5 1790.3 1952.9 2076.4 2100.4 2101.6 930.4 997.7 1016.7 1073.2 1078.5 19940.5 20160.9 20361.9 20380.6 20476.7 1036.5 1044.7 1055.5 1058.2 1079.2 10577.8 11353.9 11416.4 11437.8 11562.9 538267.0 552982.0 555212.0 566212.0 573469.0 94552.0 97509.0 98200.5 99326.0 99919.5 1017.8 1045.8 1080.5 1098.0 1099.2 17175.7 17397.7 17762.3 17876.9 18040.7 43169.6 44015.3 44219.3 44542.0 44746.8 60466.4 60653.4 60845.7 61083.0 62875.4 7873.0 8317.5 8967.9 8972.3 9281.3 13379.2 13668.7 13807.4 13816.4 14126.2 11309.4 11374.5 11419.7 11507.2 11646.5 11644.0 11873.3 11998.2 12140.5 12305.1 11141.0 11168.7 11224.8 11350.1 11758.8 7993.6 8312.4 8411.5 8483.0 8515.9 10373.4 11123.0 11167.1 11193.2 11456.3 09:58:51 INFO - PROCESS | 23056 | 09:58:51 INFO - PROCESS | 23056 | [#3] mootools.html Cycles:180 Average:6175.62 Median:4459.45 stddev:3494.18 (78.4%) stddev-sans-first:3485.38 09:58:51 INFO - PROCESS | 23056 | Values: 1378.7 1520.7 1523.1 1703.5 1846.9 8080.1 9278.7 9561.6 9567.0 9937.6 9654.8 9700.5 9702.1 9717.6 9722.6 2537.9 2564.3 2564.5 2565.3 2566.6 2444.2 2557.0 2562.2 2562.7 2567.2 2538.9 2551.8 2569.2 2578.6 2578.8 2466.2 2480.0 2487.9 2505.7 2528.3 2486.7 2512.2 2521.0 2525.0 2542.2 9306.9 9620.5 9635.0 9635.5 9712.7 5749.8 5928.1 5928.9 5935.1 5940.3 3731.5 3799.7 3815.1 3880.7 3890.9 1284.8 1296.1 1304.8 1309.7 1344.5 12174.9 12275.2 12289.0 12294.1 12320.4 4831.0 5017.8 5076.0 5170.7 5204.2 10602.8 10662.8 10666.6 10699.7 10710.0 5731.4 5735.7 5775.7 5794.3 5795.2 4471.4 4660.2 4741.1 4756.1 5348.6 4150.7 4219.2 4229.3 4340.2 4349.4 1269.2 1288.2 1312.7 1321.5 1324.1 917.5 994.4 1008.1 1010.2 1015.5 6213.4 6269.8 6275.6 6419.0 6481.6 1056.3 1083.2 1085.6 1092.9 1097.3 4242.9 4264.5 4393.6 4394.0 4447.5 11645.3 12064.2 12068.3 12115.0 12124.9 11948.3 11977.9 11991.3 11994.6 12010.5 8324.0 8728.0 8760.7 8778.3 8890.1 6203.2 6338.5 6491.1 6535.3 6629.3 10813.1 10991.3 11202.2 11246.6 11406.4 9503.3 9760.0 11146.9 11360.9 11492.1 7695.7 7842.6 7850.1 7911.3 7979.2 9014.0 9018.9 9091.6 9092.6 9093.1 7968.9 7992.8 8088.8 8100.6 8148.3 7883.2 7946.3 8016.9 8112.8 8120.2 7437.3 7532.6 7550.1 7554.5 7567.5 4980.8 5004.3 5057.0 5058.3 5208.7 5030.1 5073.4 5092.4 5100.1 5172.8 09:58:51 INFO - PROCESS | 23056 | 09:58:51 INFO - PROCESS | 23056 | [#4] prototype.html Cycles:180 Average:4585.37 Median:5122.74 stddev:1300.66 (25.4%) stddev-sans-first:1264.92 09:58:51 INFO - PROCESS | 23056 | Values: 352.7 362.7 366.2 370.7 372.5 5199.8 5351.4 5378.0 5424.3 5432.5 5201.5 5327.5 5354.7 5366.1 5370.2 4281.4 4282.3 4295.7 4301.0 4301.6 4201.6 4269.5 4269.7 4271.9 4285.2 4234.9 4236.4 4237.6 4240.4 4249.5 4230.0 4236.3 4247.4 4250.4 4266.8 3722.7 3831.3 3846.8 3846.9 3851.3 5166.8 5202.5 5203.5 5206.3 5214.6 4841.0 4867.8 4869.8 4871.0 4877.4 5320.3 5548.3 5560.2 5569.4 5581.2 4139.3 4159.5 4171.7 4175.3 4185.9 5850.2 5853.0 5859.7 5889.0 5893.9 4031.1 4203.9 4207.9 4208.4 4210.2 4204.4 4222.2 4243.8 4246.2 4252.4 4809.5 4821.2 4823.9 4826.3 4833.0 5513.6 5642.7 5658.2 5661.0 5675.6 1464.4 1471.8 1476.5 1481.7 1485.1 898.9 924.4 926.9 927.1 956.4 4848.9 4879.0 4918.5 4933.8 4939.0 5167.9 5175.5 5187.5 5195.2 5205.5 4614.7 4867.3 4869.8 4877.4 4928.4 2697.9 2708.6 2711.9 2717.3 2720.4 5236.0 5243.8 5250.6 5261.3 5272.6 4850.8 5077.5 5133.8 5197.9 5201.8 5195.4 5222.9 5228.0 5237.0 5253.5 5068.0 5069.1 5079.0 5093.6 5148.4 4747.3 5070.9 5092.7 5094.8 5111.7 5254.4 5258.3 5291.8 5291.8 5315.7 3854.7 3862.5 3990.7 4096.3 4145.9 5661.0 5752.4 5757.4 5759.6 5764.4 5622.1 5628.2 5629.4 5633.7 5638.4 5433.4 5603.3 5620.4 5655.2 5671.3 5529.1 5573.3 5580.4 5650.7 5659.2 5465.7 5624.1 5627.6 5638.6 5647.9 5517.4 5525.0 5532.6 5543.7 5549.6 09:58:51 INFO - PROCESS | 23056 | 09:58:51 INFO - PROCESS | 23056 | [#5] yui.html Cycles:180 Average:20354.28 Median:4796.55 stddev:28442.57 (593.0%) stddev-sans-first:28484.58 09:58:51 INFO - PROCESS | 23056 | Values: 830.1 843.9 843.9 844.6 881.0 14622.9 15387.1 15393.1 15458.2 15623.9 14202.8 15950.8 16452.5 16498.1 16500.4 844.1 874.9 876.1 877.7 877.9 861.8 863.7 864.4 864.5 864.5 926.5 926.6 927.2 928.2 928.3 911.4 917.3 918.9 919.0 919.4 677.8 681.5 681.6 682.5 682.8 15097.8 15137.5 15151.4 15254.8 15368.8 16123.0 16660.3 16744.2 17222.7 17599.5 13420.7 13454.4 13699.3 13784.2 13853.2 4148.2 4188.0 4223.8 4308.0 4349.1 64592.0 67250.7 69445.0 78896.6 82782.0 11902.4 12063.9 12168.5 12231.9 12251.3 20325.4 20364.0 20367.3 20372.4 20385.7 9081.6 9138.7 9167.7 9239.0 9249.7 4778.0 4815.1 4824.6 4858.8 5047.7 3667.4 3802.0 3810.0 3812.2 3823.1 637.5 643.3 645.3 653.7 676.9 659.3 665.1 709.7 729.3 741.8 9298.2 9399.8 9478.2 9496.2 9536.7 699.3 714.4 717.6 725.7 740.0 4732.4 4834.7 4890.2 4893.7 4964.4 76729.2 101223.5 103219.0 104847.5 119133.0 71441.3 85036.0 107253.5 108993.5 109958.5 71504.6 79240.0 80008.0 89443.6 89790.6 9032.9 9203.3 9535.7 9729.0 9780.5 38181.6 43653.0 48234.8 54056.7 54061.5 77137.6 78037.0 79237.2 79579.2 79743.6 13376.9 13415.0 13549.3 13712.8 13928.3 15196.7 15540.1 15545.6 15990.4 16825.2 13100.3 13115.5 13202.0 13690.7 13987.1 13243.1 13281.3 13311.7 13889.8 14695.6 12219.3 12536.2 12566.7 12943.3 13096.2 11337.3 11691.7 11808.6 12028.5 12363.8 10063.6 10351.0 10869.5 11138.6 11315.9 09:58:51 INFO - PROCESS | 23056 | -------- Summary: end -------- 09:58:51 INFO - PROCESS | 23056 | 09:58:52 INFO - TEST-INFO | 23056: exit 0 09:58:52 INFO - TEST-OK | dromaeo_css | took 1113356ms 09:58:52 INFO - TEST-START | kraken 09:58:52 INFO - operating with platform_type : linux_ 09:58:52 INFO - Initialising browser for kraken test... 09:58:52 INFO - TEST-INFO | started process 23369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0vIvCT/profile http://localhost:57714/getInfo.html) 09:58:55 INFO - PROCESS | 23369 | __metrics Screen width/height:1600/1200 09:58:55 INFO - PROCESS | 23369 | colorDepth:24 09:58:55 INFO - PROCESS | 23369 | Browser inner width/height: 1024/697 09:58:55 INFO - PROCESS | 23369 | __metrics 09:58:56 INFO - PROCESS | 23369 | 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:58:56 INFO - PROCESS | 23369 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:58:56 INFO - PROCESS | 23369 | console.error: PushService: 09:58:56 INFO - PROCESS | 23369 | stateChangeProcessEnqueue: Error transitioning state 09:58:56 INFO - PROCESS | 23369 | UnknownError 09:58:57 INFO - TEST-INFO | 23369: exit 0 09:58:57 INFO - Browser initialized. 09:58:57 INFO - Running cycle 1/1 for kraken test... 09:58:57 INFO - TEST-INFO | started process 23464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0vIvCT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:09 INFO - PROCESS | 23464 | RSS: Main: 144699392 09:59:09 INFO - PROCESS | 23464 | 09:59:11 INFO - PROCESS | 23464 | Cycle 1(1): loaded http://localhost:57714/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57714/tests/kraken/driver.html?testName=audio-beat-detection) 09:59:12 INFO - PROCESS | 23464 | RSS: Main: 185958400 09:59:12 INFO - PROCESS | 23464 | 09:59:15 INFO - PROCESS | 23464 | Cycle 1(1): loaded http://localhost:57714/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57714/tests/kraken/driver.html?testName=audio-dft) 09:59:15 INFO - PROCESS | 23464 | RSS: Main: 175558656 09:59:15 INFO - PROCESS | 23464 | 09:59:18 INFO - PROCESS | 23464 | Cycle 1(1): loaded http://localhost:57714/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57714/tests/kraken/driver.html?testName=audio-fft) 09:59:19 INFO - PROCESS | 23464 | RSS: Main: 267251712 09:59:19 INFO - PROCESS | 23464 | 09:59:21 INFO - PROCESS | 23464 | Cycle 1(1): loaded http://localhost:57714/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57714/tests/kraken/driver.html?testName=audio-oscillator) 09:59:21 INFO - PROCESS | 23464 | RSS: Main: 172662784 09:59:21 INFO - PROCESS | 23464 | 09:59:23 INFO - PROCESS | 23464 | Cycle 1(1): loaded http://localhost:57714/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57714/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:59:24 INFO - PROCESS | 23464 | RSS: Main: 174841856 09:59:24 INFO - PROCESS | 23464 | 09:59:27 INFO - PROCESS | 23464 | Cycle 1(1): loaded http://localhost:57714/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57714/tests/kraken/driver.html?testName=imaging-darkroom) 09:59:28 INFO - PROCESS | 23464 | RSS: Main: 211189760 09:59:28 INFO - PROCESS | 23464 | 09:59:31 INFO - PROCESS | 23464 | Cycle 1(1): loaded http://localhost:57714/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57714/tests/kraken/driver.html?testName=imaging-desaturate) 09:59:32 INFO - PROCESS | 23464 | RSS: Main: 209920000 09:59:32 INFO - PROCESS | 23464 | 09:59:34 INFO - PROCESS | 23464 | Cycle 1(1): loaded http://localhost:57714/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57714/tests/kraken/driver.html?testName=json-parse-financial) 09:59:35 INFO - PROCESS | 23464 | RSS: Main: 208773120 09:59:35 INFO - PROCESS | 23464 | 09:59:36 INFO - PROCESS | 23464 | Cycle 1(1): loaded http://localhost:57714/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57714/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:59:37 INFO - PROCESS | 23464 | RSS: Main: 171126784 09:59:37 INFO - PROCESS | 23464 | 09:59:39 INFO - PROCESS | 23464 | Cycle 1(1): loaded http://localhost:57714/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57714/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:59:39 INFO - PROCESS | 23464 | RSS: Main: 179445760 09:59:39 INFO - PROCESS | 23464 | 09:59:41 INFO - PROCESS | 23464 | Cycle 1(1): loaded http://localhost:57714/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57714/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:59:42 INFO - PROCESS | 23464 | RSS: Main: 188497920 09:59:42 INFO - PROCESS | 23464 | 09:59:44 INFO - PROCESS | 23464 | Cycle 1(1): loaded http://localhost:57714/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:59:45 INFO - PROCESS | 23464 | RSS: Main: 197156864 09:59:45 INFO - PROCESS | 23464 | 09:59:48 INFO - PROCESS | 23464 | Cycle 1(1): loaded http://localhost:57714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:59:48 INFO - PROCESS | 23464 | RSS: Main: 193331200 09:59:48 INFO - PROCESS | 23464 | 09:59:50 INFO - PROCESS | 23464 | Cycle 1(1): loaded http://localhost:57714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57714/tests/kraken/driver.html?testName=ai-astar) 09:59:50 INFO - PROCESS | 23464 | RSS: Main: 244678656 09:59:50 INFO - PROCESS | 23464 | 09:59:50 INFO - PROCESS | 23464 | __start_tp_report 09:59:50 INFO - PROCESS | 23464 | _x_x_mozilla_page_load 09:59:50 INFO - PROCESS | 23464 | _x_x_mozilla_page_load_details 09:59:50 INFO - PROCESS | 23464 | |i|pagename|runs| 09:59:50 INFO - PROCESS | 23464 | |0;ai-astar;108;110;111;111;112;111;112;112;109;111 09:59:50 INFO - PROCESS | 23464 | |1;audio-beat-detection;146;118;118;157;120;125;119;118;152;116 09:59:50 INFO - PROCESS | 23464 | |2;audio-dft;161;159;162;161;161;162;162;160;162;162 09:59:50 INFO - PROCESS | 23464 | |3;audio-fft;75;74;74;118;76;76;74;75;101;75 09:59:50 INFO - PROCESS | 23464 | |4;audio-oscillator;82;82;108;82;82;82;101;81;81;107 09:59:50 INFO - PROCESS | 23464 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;117;117 09:59:50 INFO - PROCESS | 23464 | |6;imaging-darkroom;146;146;146;145;147;147;146;146;145;147 09:59:50 INFO - PROCESS | 23464 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 09:59:50 INFO - PROCESS | 23464 | |8;json-parse-financial;51;54;50;50;51;51;51;51;50;50 09:59:50 INFO - PROCESS | 23464 | |9;json-stringify-tinderbox;58;59;58;59;59;58;58;58;59;59 09:59:50 INFO - PROCESS | 23464 | |10;stanford-crypto-aes;79;73;73;79;78;74;73;78;73;73 09:59:50 INFO - PROCESS | 23464 | |11;stanford-crypto-ccm;122;124;121;129;125;119;130;126;169;121 09:59:50 INFO - PROCESS | 23464 | |12;stanford-crypto-pbkdf2;154;153;152;155;152;152;152;153;153;153 09:59:50 INFO - PROCESS | 23464 | |13;stanford-crypto-sha256-iterative;62;63;63;61;63;62;71;62;63;61 09:59:50 INFO - PROCESS | 23464 | __end_tp_report 09:59:50 INFO - PROCESS | 23464 | __start_cc_report 09:59:50 INFO - PROCESS | 23464 | _x_x_mozilla_cycle_collect,1640 09:59:50 INFO - PROCESS | 23464 | __end_cc_report 09:59:50 INFO - PROCESS | 23464 | __startTimestamp1477587590709__endTimestamp 09:59:50 INFO - PROCESS | 23464 | 09:59:50 INFO - PROCESS | 23464 | ------- Summary: start ------- 09:59:50 INFO - PROCESS | 23464 | Number of tests: 14 09:59:50 INFO - PROCESS | 23464 | 09:59:50 INFO - PROCESS | 23464 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.34 (1.2%) stddev-sans-first:1.00 09:59:50 INFO - PROCESS | 23464 | Values: 108.0 110.0 111.0 111.0 112.0 111.0 112.0 112.0 109.0 111.0 09:59:50 INFO - PROCESS | 23464 | 09:59:50 INFO - PROCESS | 23464 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:122.50 stddev:16.09 (13.1%) stddev-sans-first:15.84 09:59:50 INFO - PROCESS | 23464 | Values: 146.0 118.0 118.0 157.0 120.0 125.0 119.0 118.0 152.0 116.0 09:59:50 INFO - PROCESS | 23464 | 09:59:50 INFO - PROCESS | 23464 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 09:59:50 INFO - PROCESS | 23464 | Values: 161.0 159.0 162.0 161.0 161.0 162.0 162.0 160.0 162.0 162.0 09:59:50 INFO - PROCESS | 23464 | 09:59:50 INFO - PROCESS | 23464 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.00 stddev:15.16 (20.2%) stddev-sans-first:15.88 09:59:50 INFO - PROCESS | 23464 | Values: 75.0 74.0 74.0 118.0 76.0 76.0 74.0 75.0 101.0 75.0 09:59:50 INFO - PROCESS | 23464 | 09:59:50 INFO - PROCESS | 23464 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:82.00 stddev:11.55 (14.1%) stddev-sans-first:11.99 09:59:50 INFO - PROCESS | 23464 | Values: 82.0 82.0 108.0 82.0 82.0 82.0 101.0 81.0 81.0 107.0 09:59:50 INFO - PROCESS | 23464 | 09:59:50 INFO - PROCESS | 23464 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:59:50 INFO - PROCESS | 23464 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 09:59:50 INFO - PROCESS | 23464 | 09:59:50 INFO - PROCESS | 23464 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 09:59:50 INFO - PROCESS | 23464 | Values: 146.0 146.0 146.0 145.0 147.0 147.0 146.0 146.0 145.0 147.0 09:59:50 INFO - PROCESS | 23464 | 09:59:50 INFO - PROCESS | 23464 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:59:50 INFO - PROCESS | 23464 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 09:59:50 INFO - PROCESS | 23464 | 09:59:50 INFO - PROCESS | 23464 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:51.00 stddev:1.20 (2.3%) stddev-sans-first:1.27 09:59:50 INFO - PROCESS | 23464 | Values: 51.0 54.0 50.0 50.0 51.0 51.0 51.0 51.0 50.0 50.0 09:59:50 INFO - PROCESS | 23464 | 09:59:50 INFO - PROCESS | 23464 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:59.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 09:59:50 INFO - PROCESS | 23464 | Values: 58.0 59.0 58.0 59.0 59.0 58.0 58.0 58.0 59.0 59.0 09:59:50 INFO - PROCESS | 23464 | 09:59:50 INFO - PROCESS | 23464 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:76.00 stddev:2.79 (3.7%) stddev-sans-first:2.62 09:59:50 INFO - PROCESS | 23464 | Values: 79.0 73.0 73.0 79.0 78.0 74.0 73.0 78.0 73.0 73.0 09:59:50 INFO - PROCESS | 23464 | 09:59:50 INFO - PROCESS | 23464 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:125.50 stddev:14.63 (11.7%) stddev-sans-first:15.32 09:59:50 INFO - PROCESS | 23464 | Values: 122.0 124.0 121.0 129.0 125.0 119.0 130.0 126.0 169.0 121.0 09:59:50 INFO - PROCESS | 23464 | 09:59:50 INFO - PROCESS | 23464 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.90 Median:153.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 09:59:50 INFO - PROCESS | 23464 | Values: 154.0 153.0 152.0 155.0 152.0 152.0 152.0 153.0 153.0 153.0 09:59:50 INFO - PROCESS | 23464 | 09:59:50 INFO - PROCESS | 23464 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:2.88 (4.6%) stddev-sans-first:3.03 09:59:50 INFO - PROCESS | 23464 | Values: 62.0 63.0 63.0 61.0 63.0 62.0 71.0 62.0 63.0 61.0 09:59:50 INFO - PROCESS | 23464 | -------- Summary: end -------- 09:59:50 INFO - PROCESS | 23464 | 09:59:51 INFO - TEST-INFO | 23464: exit 0 09:59:51 INFO - TEST-OK | kraken | took 59804ms 09:59:51 INFO - SUITE-END | took 1173s 09:59:52 INFO - Completed test suite (00:19:33) 09:59:52 INFO - javascript benchmark 09:59:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3112.9533057004146, 3162.320101178247, 3174.9523757143634, 3189.760767942405, 3211.9678803211978, 5574.442555744424, 5686.175504551838, 5686.5735069869825, 5703.116017017363, 5705.286839145107, 5644.322681278242, 5700.515456186229, 5703.458171473714, 5711.457411545896, 5744.885102297952, 5120.743962801864, 5135.666181698178, 5137.6403651744395, 5172.560332371753, 5217.791288348461, 5058.165402708549, 5230.869228269305, 5233.3981592116825, 5233.8953220935555, 5241.580673546107, 5020.196768517038, 5070.543651071403, 5084.491550844905, 5093.668911520739, 5120.743962801864, 5069.847904562869, 5079.542841144296, 5098.898022039557, 5147.510986456281, 5181.171012637998, 4985.925211121836, 5060.898782024376, 5103.157978933472, 5120.15517439622, 5120.718360490171, 5391.973040134813, 5440.619156659035, 5482.150266708666, 5493.0, 5519.724013799334, 5902.911456328158, 5915.053591425394, 5920.141579470953, 5999.580029397944, 6031.487323577501, 6067.848303792396, 6068.939310606882, 6080.513558915276, 6080.574359794816, 6081.057436097368, 5499.230107784913, 5541.113421852525, 5542.722863856791, 5576.6096373254295, 5580.720963951786, 6094.939050609526, 6161.876762464815, 6162.352952939967, 6165.784197553154, 6166.0, 5742.511886489695, 5907.232059832194, 5912.17229587858, 5914.704264786744, 5915.260592425947, 5881.617694849907, 5929.851753706192, 5995.850103747354, 5999.070144127667, 6098.603590766586, 6024.307204671519, 6026.7890623828835, 6029.6683682397015, 6035.215421995113, 6043.7884674036195, 5833.095870140135, 5982.670953097621, 6045.183900173508, 6051.667158306247, 6085.421884920926, 4536.002079542495, 4557.6581756368405, 4596.034832685106, 4607.585317321457, 4662.743549104832, 4057.7159598827798, 4100.958990410118, 4104.692148088905, 4105.158442519277, 4132.876013719593, 5770.798022069207, 5785.30576330843, 5785.913211301834, 5789.797357092481, 5820.156077368758, 5827.737751801179, 5836.445537673914, 5842.5618078644275, 5873.970630146908, 5876.7355469004, 5599.272094627672, 5630.0991841305195, 5651.9152212716845, 5658.066419040894, 5660.2075709400715, 5140.614453915971, 5170.3278573785165, 5174.0, 5181.611379146579, 5206.557442617344, 5993.250843644544, 6121.296050954108, 6122.295935967331, 6139.492138333381, 6143.109249158847, 6049.485793707584, 6051.515878729603, 6063.909041364472, 6065.514758819196, 6097.024476083982, 6193.535484838565, 6212.285587157535, 6258.687065646791, 6259.561830671809, 6259.78090766821, 5692.971535142297, 5702.258706368146, 5860.355360910211, 5956.672383018976, 5988.311344195473, 6002.639841609517, 6089.786857459968, 6108.11432342299, 6120.204373431426, 6132.049532322497, 5895.734691938787, 5935.554833387427, 5936.940630593639, 5943.138244954371, 5946.048632218824, 5678.119891416837, 5780.277465316835, 5926.911096333472, 5929.970350148222, 5941.079132734433, 5802.390748971297, 5842.415758424124, 5849.970750146222, 5900.911486327623, 5926.851828704317, 5959.076343166643, 5962.224910761746, 5963.4334738199805, 5965.492933100735, 5972.970135149297, 5667.2349232854685, 5669.3480249770155, 5712.02895507773, 5806.65160090396, 5819.82540523785], "value": 5533.991411233297, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.3291945940009, 605.3069235725095, 608.4584719599557, 621.741977079512, 644.1368566121398, 45162.32256516151, 46539.06921861561, 46564.76717616412, 46618.0, 49933.25100123492, 47127.764361178146, 47499.0, 47592.76203618986, 47662.52337476633, 47747.28379074308, 8370.832583348329, 8556.743297701049, 9237.521996480564, 9379.390339627902, 9392.62429502819, 10884.401357925311, 11010.614628488005, 11157.72105697356, 11466.656000320003, 11477.598284060059, 10987.450627468634, 11058.834117488244, 11059.557617695324, 11069.723256918602, 11076.0, 11125.777484450306, 11147.442627868655, 11164.218504704673, 11169.162312826571, 11172.553097876116, 11003.504842282116, 11073.390963497004, 11077.335359878432, 11082.612108576242, 11086.16853735965, 45210.32184517235, 45525.0, 45529.317060244124, 45545.0, 45590.772046139886, 3653.8173091345593, 3707.925841483182, 3719.4048952167796, 3855.6915446764474, 4076.5923407659293, 33889.0, 34213.14467138317, 34493.13767155816, 34543.309133817434, 35505.11237219064, 4657.3246879202325, 4717.363155973968, 4744.478107408182, 4752.334673145762, 4835.1296766582, 388323.0, 388578.0, 388906.0, 391382.0, 392817.0, 38276.0, 39649.60350396517, 57498.7125064372, 57560.0, 57782.42217577854, 41415.378769318486, 41550.0, 41729.374059389134, 41807.37288940668, 41844.372334415006, 16790.412335568442, 17072.57318567046, 17073.40243091486, 17074.231659575347, 17076.487705368858, 12681.556145534862, 12759.362031898554, 12840.55058072963, 12957.287349195696, 14379.92810035964, 9480.57337419804, 9518.428894266366, 9531.952340238393, 9559.852817661926, 9577.23382129428, 3608.711303095746, 3630.945535816912, 3651.8174091295327, 3664.0, 3765.3975363941636, 1043.0, 1046.6232156423682, 1108.7560736637927, 1123.4270522033657, 1201.0151675625902, 33952.0, 33952.660473395445, 34152.829235853664, 34426.48360274598, 34636.653633463844, 1123.741539445932, 1163.1450883600546, 1201.7055821323831, 1221.3343727668441, 1227.9017678585692, 17552.64894702099, 17629.686633319394, 17638.91180544115, 17685.0, 17726.556836078944, 528485.0, 530071.0, 530430.0, 530934.0, 537236.0, 62094.379056209764, 62680.05979910305, 62771.37228627655, 62865.0, 62874.685626571576, 1318.6637407461037, 1349.9055066145472, 1422.4168091082606, 1427.3291552970295, 1535.854093861059, 30818.075457736304, 34086.0, 35986.280274393845, 36108.63891361053, 36452.27095458023, 53199.46800531945, 60931.69534152301, 62874.0, 63205.68397157985, 67929.66035169792, 473715.0, 479112.0, 479841.0, 480900.0, 482376.0, 46502.0, 47058.29412558746, 47584.286235707186, 47993.28010079782, 48130.27804582864, 51228.74385628048, 51706.0, 51711.22433163581, 51771.482285176666, 52056.47943520516, 43023.78488107539, 43136.568634313255, 43344.56655433532, 43584.34623480714, 44641.77679111584, 42839.656059674744, 43373.13253734844, 43562.56437435712, 44188.0, 44258.0, 39071.80464097661, 39877.0, 44173.77913110414, 44502.0, 44567.10865782731, 35021.82489087538, 37983.0, 38583.42124868073, 38658.80670596629, 38831.41752873653, 28973.56539651949, 29035.7096429033, 29058.7094129056, 29197.562036569045, 29213.269668258465], "value": 20803.306208749604, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.27958856732204, 430.31340830919396, 430.4554738256106, 442.6193473612694, 443.15136513576505, 17019.0, 21866.671999920014, 22188.77811221887, 22248.666270005942, 22274.443138921535, 20733.585328293426, 20749.896250518726, 20965.68551471729, 21018.894905525452, 21019.474513137142, 4341.2836881914445, 4539.251023581105, 4667.88330291742, 5991.700414979256, 6058.787942422016, 6253.624782513041, 6562.704678289489, 6578.671066446683, 6681.164854393201, 6690.832729181785, 6408.455281301095, 6577.243616984037, 6592.835179120512, 6601.0, 6634.5355825092265, 5800.651960882361, 6534.54258201926, 6559.540832141752, 6562.93437065628, 6585.275619681831, 5853.09277062056, 5941.168236446901, 5955.553333499962, 5956.97021514894, 5957.1957785698805, 14778.482753103697, 15039.0, 15161.24193790317, 15200.087994720241, 15305.0, 2358.705161854768, 2417.891194896234, 2434.0263894442187, 2448.8530688158767, 2456.312232574882, 10541.736456588647, 10924.180686448468, 10956.28784129037, 11041.85041672035, 11072.39101849398, 1898.6677331466938, 1914.473519782071, 1958.432054704134, 1969.1237399357292, 1982.5638359561017, 51918.48081519212, 53747.73126134344, 84839.0, 84922.57538712329, 87021.0, 11529.711757206136, 11530.192886497865, 11660.242084264495, 11751.706207344885, 11755.412229388667, 16650.83349166517, 16680.082595457123, 16690.83309166917, 16702.832971670126, 16704.749428758336, 8775.736727898173, 8782.353817874606, 8860.512671803113, 8889.333300002525, 8896.8665470018, 8711.34664900135, 8796.428232164888, 8872.83107187594, 8915.37592368541, 9017.954910225539, 4567.931481027787, 4854.951450485521, 5007.9499205008215, 5026.79892804291, 5079.466656001066, 1790.3223454972135, 1952.9414117576496, 2076.377086873962, 2100.380387785576, 2101.6112019276484, 930.3952430919957, 997.7006897930592, 1016.7153197104823, 1073.2487258918788, 1078.487718333785, 19940.50148746293, 20160.899195503927, 20361.898190508953, 20380.592388152152, 20476.69284960727, 1036.5076588620345, 1044.738815296176, 1055.4775386183887, 1058.2433560004479, 1079.1798233342715, 10577.84133238002, 11353.886461135284, 11416.372099534605, 11437.771244575228, 11562.94218528902, 538267.0, 552982.0, 555212.0, 566212.0, 573469.0, 94552.0, 97509.0, 98200.50899745456, 99326.0, 99919.50040249752, 1017.7557386227252, 1045.8378951262414, 1080.502968634437, 1097.9945100274447, 1099.1811100730008, 17175.742363864803, 17397.739033914248, 17762.289508420035, 17876.91061544684, 18040.729389059437, 43169.568304317814, 44015.339769902836, 44219.33670995002, 44542.0, 44746.801135826885, 60466.39533604783, 60653.39346606654, 60845.695771520855, 61083.0, 62875.37124628695, 7873.0, 8317.459365141247, 8967.865482017645, 8972.28221742246, 9281.257499399897, 13379.197248165141, 13668.726625467634, 13807.378667960167, 13816.378262977989, 14126.152430854181, 11309.434528273718, 11374.488148033193, 11419.657410277705, 11507.194496385173, 11646.475908584303, 11644.0, 11873.346965916957, 11998.220115692453, 12140.453679584263, 12305.138640295094, 11141.0, 11168.66494005181, 11224.831627525431, 11350.148738844784, 11758.764824703629, 7993.600319984093, 8312.418130731032, 8411.53736544496, 8483.0, 8515.8722619162, 10373.429461379697, 11123.0, 11167.1066314693, 11193.216474846682, 11456.255343402652], "value": 9497.338029133305, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.6622277542003, 1520.6578519833038, 1523.070926734692, 1703.5230135562047, 1846.9261229550818, 8080.0707918589305, 9278.675246366378, 9561.569729362187, 9566.952165239163, 9937.552810123543, 9654.758631034229, 9700.514974251295, 9702.078302561264, 9717.562709678064, 9722.611095556187, 2537.949241015179, 2564.269183282765, 2564.4999225151105, 2565.256075738034, 2566.6278389633494, 2444.2422848916895, 2556.987215063922, 2562.231330600822, 2562.6668533090765, 2567.2298310506867, 2538.860362680052, 2551.8213725039254, 2569.2420735882865, 2578.5745352016893, 2578.8323758955703, 2466.235467005225, 2479.9752002479927, 2487.9004839806385, 2505.711843138044, 2528.266802627236, 2486.689163854518, 2512.2463261021803, 2521.0294036795967, 2525.02786427225, 2542.224621490445, 9306.906930930672, 9620.470874101922, 9635.0, 9635.518224088768, 9712.660056898045, 5749.8275051748515, 5928.140419639171, 5928.940710592925, 5935.050391937312, 5940.34656187819, 3731.458938453909, 3799.6580307772433, 3815.065308999285, 3880.6701430378453, 3890.8832735017995, 1284.8137020132028, 1296.0603562417266, 1304.8303720516367, 1309.6987692830703, 1344.482374285897, 12174.878251217464, 12275.2021118627, 12289.0, 12294.077944154134, 12320.383980800923, 4830.985493046429, 5017.774200161001, 5075.974620126875, 5170.741462926839, 5204.167333226741, 10602.787944241072, 10662.786744265071, 10666.626668066581, 10699.679009629723, 10710.036096751173, 5731.369549349568, 5735.655860648374, 5775.711214439261, 5794.275715535558, 5795.217645617872, 4471.374007638933, 4660.161170989254, 4741.146593613183, 4756.143894099096, 5348.598855085884, 4150.709450338447, 4219.198352313051, 4229.281022226229, 4340.218760623118, 4349.369341445473, 1269.2321145706899, 1288.2335010668637, 1312.6718320419895, 1321.5242512695422, 1324.132693086011, 917.5091326140483, 994.4428195378806, 1008.1380419741163, 1010.1867996262932, 1015.5125539740966, 6213.378662133841, 6269.843253918689, 6275.560710750204, 6418.967905160538, 6481.611103333815, 1056.2606175677056, 1083.2200815412891, 1085.6200329884634, 1092.8907109289166, 1097.3361116524547, 4242.851500197478, 4264.530901600821, 4393.648508119343, 4394.0, 4447.533009034069, 11645.301281923112, 12064.21582597146, 12068.275903445821, 12115.030797536176, 12124.939375303244, 11948.34284114382, 11977.880221197851, 11991.280523168463, 11994.580189693319, 12010.459529321202, 8323.95838020806, 8728.039915609277, 8760.693375731818, 8778.29773618109, 8890.110988901188, 6203.193584833943, 6338.492920566436, 6491.05879647439, 6535.3137920517665, 6629.3039230882, 10813.080888124598, 10991.285566438475, 11202.15983801202, 11246.550137994389, 11406.429678515875, 9503.334766566273, 9760.0, 11146.888531114586, 11360.9431952843, 11492.138089643144, 7695.653695583824, 7842.607869606611, 7850.057993040871, 7911.28798408146, 7979.241972012649, 9013.95493022557, 9018.909810901807, 9091.636334546543, 9092.636294548409, 9093.090690930854, 7968.920310796818, 7992.840143196987, 8088.83822323562, 8100.594970251582, 8148.348132149533, 7883.172266912121, 7946.324562412028, 8016.9198308016175, 8112.75661730149, 8120.187981201832, 7437.293457121565, 7532.623368831646, 7550.056242969629, 7554.546727196386, 7567.508111972704, 4980.800767969386, 5004.324416203766, 5056.974715126401, 5058.342415485963, 5208.661437006583, 5030.119729047329, 5073.365829271341, 5092.439831618445, 5100.107481190851, 5172.818951336685], "value": 4959.742890461417, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.73368606701933, 362.70439591732736, 366.15783697495755, 370.684917819853, 372.5213101165, 5199.766010529525, 5351.384590772062, 5377.973110134453, 5424.264235444654, 5432.538234250089, 5201.479852014797, 5327.467253274671, 5354.678719276846, 5366.141417373221, 5370.194470829378, 4281.422008028923, 4282.250606143913, 4295.699301048928, 4300.98926752213, 4301.591348821873, 4201.6008479194425, 4269.466316710411, 4269.679774016946, 4271.871843844674, 4285.228658841407, 4234.9153016939645, 4236.406903033578, 4237.555056719047, 4240.427542281799, 4249.51130619978, 4229.978850105746, 4236.2798324284795, 4247.447831781879, 4250.426192464009, 4266.762638834734, 3722.7394082414244, 3831.291211125923, 3846.826892789803, 3846.8653597123966, 3851.287511810296, 5166.819161329336, 5202.479752024768, 5203.453637368059, 5206.323177986837, 5214.582833373359, 4841.03179364125, 4867.780949857265, 4869.780859861315, 4871.0, 4877.366082362413, 5320.334958130234, 5548.306461692288, 5560.165975103726, 5569.415211402826, 5581.190727344553, 4139.337705967061, 4159.480064991876, 4171.7496950182785, 4175.331946888514, 4185.916281674349, 5850.23946886902, 5852.9807216510235, 5859.707014649293, 5888.970555147197, 5893.941060589382, 4031.113155105872, 4203.852865149705, 4207.936880946788, 4208.390797705442, 4210.200061988213, 4204.411382406465, 4222.218889505451, 4243.766592837362, 4246.214450326699, 4252.4046633471335, 4809.509052193831, 4821.156297647897, 4823.903521929542, 4826.348442960226, 4832.975835120802, 5513.558915286768, 5642.689652069093, 5658.179563963202, 5660.97169514158, 5675.63784691671, 1464.406915199346, 1471.830739464954, 1476.5201309574215, 1481.7110663420744, 1485.0569888121122, 898.9392516830072, 924.4407133684159, 926.893407258174, 927.1099744245465, 956.4357029352715, 4848.884756506023, 4878.975605121952, 4918.483559226302, 4933.777979990909, 4938.950610493921, 5167.896642067138, 5175.534201921845, 5187.533122019036, 5195.246689230041, 5205.45342739007, 4614.707881793103, 4867.294242334841, 4869.805207791719, 4877.3903262092235, 4928.433230178503, 2697.85161816102, 2708.6478757761365, 2711.9322016949736, 2717.334253108001, 2720.3813730830125, 5235.973820130875, 5243.8164664236565, 5250.606204534675, 5261.263423120766, 5272.604554658416, 4850.805967761321, 5077.517635824591, 5133.794648214104, 5197.870053248624, 5201.817936372209, 5195.376554813447, 5222.895542089137, 5227.973860130675, 5236.973815130977, 5253.50091741284, 5068.0, 5069.062223488519, 5079.019182518895, 5093.567046800915, 5148.43367229597, 4747.335373047845, 5070.949290507196, 5092.719900405513, 5094.847154585368, 5111.693298402108, 5254.422013578427, 5258.290130832289, 5291.788328466818, 5291.814786482455, 5315.734213289397, 3854.710896682816, 3862.478565393636, 3990.7006974477613, 4096.32410652239, 4145.8963525912095, 5661.0093233684765, 5752.426820677488, 5757.424257574209, 5759.625624334405, 5764.365919748908, 5622.072358061037, 5628.1557766333735, 5629.380768115422, 5633.718314084197, 5638.436156384493, 5433.402325744244, 5603.299587551556, 5620.381758006534, 5655.1517272409465, 5671.319441667027, 5529.115341545334, 5573.303337082864, 5580.386157522588, 5650.654978184172, 5659.151127330769, 5465.72671366438, 5624.100143976944, 5627.606067575394, 5638.646724786104, 5647.88704225905, 5517.420670829505, 5525.0, 5532.612717109763, 5543.695096769555, 5549.611527193058], "value": 4180.584801138549, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.0786127398591, 843.8860753798235, 843.9071702112767, 844.6494704697551, 880.9604666493535, 14622.926885365572, 15387.076775393483, 15393.076415415084, 15458.227088645579, 15623.921880390582, 14202.78695819561, 15950.76073858893, 16452.506424807274, 16498.092604906724, 16500.42248521302, 844.0926004545108, 874.9300055995537, 876.0976194519654, 877.7191298784392, 877.934154938379, 861.8276344731048, 863.6502216602255, 864.4337958637103, 864.4683519635411, 864.5158711121792, 926.4996901673088, 926.5552534783308, 927.1516562345446, 928.2434815625244, 928.2852203803068, 911.3620465673988, 917.3486824354716, 918.8575770755543, 919.016652182162, 919.4253591505309, 677.7966610016975, 681.505908216544, 681.5910453727773, 682.5188242289224, 682.8019874236516, 15097.773533397009, 15137.470188543459, 15151.393944242218, 15254.847451525453, 15368.846311536854, 16123.0, 16660.250288737036, 16744.16279186036, 17222.655546888993, 17599.472015839547, 13420.731585368336, 13454.394552245074, 13699.29777795464, 13784.241866697328, 13853.238071906042, 4148.23257697327, 4187.958120418818, 4223.767692776896, 4308.030693094061, 4349.064951035511, 64592.0, 67250.66374668144, 69445.0, 78896.60551697205, 82782.0, 11902.404879755977, 12063.879361206451, 12168.452419641137, 12231.93884030592, 12251.32617706017, 20325.390238292875, 20364.0, 20367.287144949856, 20372.388828335173, 20385.694214586794, 9081.636734530544, 9138.68014619485, 9167.724968250963, 9239.0, 9249.722508324761, 4777.976110119496, 4815.133276010281, 4824.638152138534, 4858.80564777412, 5047.747612619354, 3667.3765459871884, 3802.0304822270696, 3810.0, 3812.199438118026, 3823.1397935464856, 637.5186734015881, 643.2506130358174, 645.2579533536377, 653.6568301641677, 676.9492288078413, 659.2550418027598, 665.1286814273318, 709.7303024850523, 729.2998721227681, 741.8034220931457, 9298.209652179505, 9399.812003759887, 9478.199142162966, 9496.240300775922, 9536.713898583053, 699.3006993006993, 714.3535100733844, 717.5694583250008, 725.6952080126359, 739.9556026638419, 4732.432108146975, 4834.661573689808, 4890.168671325883, 4893.657443978887, 4964.429090654621, 76729.23270767221, 101223.49388253012, 103219.0, 104847.4757626207, 119133.0, 71441.2855871445, 85036.0, 107253.4637326824, 108993.45503272433, 109958.45020774845, 71504.64247678728, 79240.0, 80008.0, 89443.55278223567, 89790.55104724565, 9032.864507032531, 9203.263738901005, 9535.666251681158, 9728.951355243178, 9780.462074585967, 38181.61818381781, 43653.0, 48234.758826205645, 54056.72971635117, 54061.459385405644, 77137.61431192808, 78037.0, 79237.20762792298, 79579.2042079595, 79743.60128199322, 13376.866231337952, 13415.0, 13549.25479098659, 13712.794308085187, 13928.303584820516, 15196.696066078837, 15540.145292009049, 15545.611359716098, 15990.360385584912, 16825.158742062602, 13100.279484628438, 13115.540956066492, 13202.0, 13690.726185476435, 13987.090839095426, 13243.072984890965, 13281.269530175932, 13311.66720831987, 13889.829664309274, 14695.632609184855, 12219.26684398939, 12536.185147965352, 12566.685832854251, 12943.288119153536, 13096.214227146402, 11337.26307789991, 11691.707707307385, 11808.586699465477, 12028.458719357475, 12363.75272494563, 10063.597456101674, 10350.956018171953, 10869.51087201062, 11138.554457821596, 11315.943420282845], "value": 7765.669249055168, "unit": "score"}], "name": "dromaeo_css", "value": 7486.555272019697, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 111.0, 111.0, 112.0, 111.0, 112.0, 112.0, 109.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 118.0, 157.0, 120.0, 125.0, 119.0, 118.0, 152.0, 116.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 162.0, 161.0, 161.0, 162.0, 162.0, 160.0, 162.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 118.0, 76.0, 76.0, 74.0, 75.0, 101.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 108.0, 82.0, 82.0, 82.0, 101.0, 81.0, 81.0, 107.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 147.0, 147.0, 146.0, 146.0, 145.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 54.0, 50.0, 50.0, 51.0, 51.0, 51.0, 51.0, 50.0, 50.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 59.0, 59.0, 58.0, 58.0, 58.0, 59.0, 59.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 73.0, 79.0, 78.0, 74.0, 73.0, 78.0, 73.0, 73.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 124.0, 121.0, 129.0, 125.0, 119.0, 130.0, 126.0, 169.0, 121.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 153.0, 152.0, 155.0, 152.0, 152.0, 152.0, 153.0, 153.0, 153.0], "value": 152.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 61.0, 63.0, 62.0, 71.0, 62.0, 63.0, 61.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1458.6999999999998, "alertThreshold": 2.0}]} 09:59:52 INFO - Return code: 0 09:59:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:59:52 INFO - # TBPL SUCCESS # 09:59:52 INFO - Running post-action listener: _resource_record_post_action 09:59:52 INFO - [mozharness: 2016-10-27 16:59:52.526388Z] Finished run-tests step (success) 09:59:52 INFO - Running post-run listener: _resource_record_post_run 09:59:52 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 1998848; Write bytes: 364740608; Read time: 56; Write time: 264416 09:59:52 INFO - TinderboxPrint: CPU usage
13.0% 09:59:52 INFO - TinderboxPrint: I/O read bytes / time
1,998,848 / 56 09:59:52 INFO - TinderboxPrint: I/O write bytes / time
364,740,608 / 264,416 09:59:52 INFO - TinderboxPrint: CPU idle
8,262.0 (87.0%) 09:59:52 INFO - TinderboxPrint: CPU user
1,190.2 (12.5%) 09:59:52 INFO - TinderboxPrint: Swap in / out
0 / 0 09:59:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115310592; Read time: 0; Write time: 108608 09:59:52 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 249430016; Read time: 20; Write time: 155808 09:59:53 INFO - Running post-run listener: _upload_blobber_files 09:59:53 INFO - Blob upload gear active. 09:59:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:59:53 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:59:53 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:59:53 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:59:53 INFO - (blobuploader) - INFO - Open directory for files ... 09:59:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:59:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:59:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:54 INFO - (blobuploader) - INFO - Done attempting. 09:59:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:59:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:59:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:58 INFO - (blobuploader) - INFO - Done attempting. 09:59:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:59:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:59:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:58 INFO - (blobuploader) - INFO - Done attempting. 09:59:58 INFO - (blobuploader) - INFO - Iteration through files over. 09:59:58 INFO - Return code: 0 09:59:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:59:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:59:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7668c579d9440133feec15294a12d6e02c613082c0ace78637af2d9921ece5fb3a6256a743a501264d7789681e79d5afd05f4229e8726394d793760dc12e71ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b03357246435eee8135413f6add811c6396818c521f212e5f7aa7b9c84cc814e73feb64d026e5ce5a27c81faace4e9d51cf30b823b1c8a92e837b5d5641ea301", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05b178b333199f0e2e02da52bb7a8e585cbca623e38c7e5267072756871f63044f486a474af49e6feaccf166325aa0ca7414e61ba73d81412d4a5404ded48285"} 09:59:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:59:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:59:58 INFO - Contents: 09:59:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7668c579d9440133feec15294a12d6e02c613082c0ace78637af2d9921ece5fb3a6256a743a501264d7789681e79d5afd05f4229e8726394d793760dc12e71ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b03357246435eee8135413f6add811c6396818c521f212e5f7aa7b9c84cc814e73feb64d026e5ce5a27c81faace4e9d51cf30b823b1c8a92e837b5d5641ea301", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05b178b333199f0e2e02da52bb7a8e585cbca623e38c7e5267072756871f63044f486a474af49e6feaccf166325aa0ca7414e61ba73d81412d4a5404ded48285"} 09:59:58 INFO - Running post-run listener: copy_logs_to_upload_dir 09:59:58 INFO - Copying logs to upload dir... 09:59:58 INFO - mkdir: /builds/slave/test/build/upload/logs 09:59:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.662429 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-27 09:59:58.901159) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 09:59:58.905007) ========= 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=31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354 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/7668c579d9440133feec15294a12d6e02c613082c0ace78637af2d9921ece5fb3a6256a743a501264d7789681e79d5afd05f4229e8726394d793760dc12e71ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b03357246435eee8135413f6add811c6396818c521f212e5f7aa7b9c84cc814e73feb64d026e5ce5a27c81faace4e9d51cf30b823b1c8a92e837b5d5641ea301", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05b178b333199f0e2e02da52bb7a8e585cbca623e38c7e5267072756871f63044f486a474af49e6feaccf166325aa0ca7414e61ba73d81412d4a5404ded48285"} build_url:https://queue.taskcluster.net/v1/task/DpNGKV7iRAiGl9otNKKrxQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011190 build_url: 'https://queue.taskcluster.net/v1/task/DpNGKV7iRAiGl9otNKKrxQ/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/7668c579d9440133feec15294a12d6e02c613082c0ace78637af2d9921ece5fb3a6256a743a501264d7789681e79d5afd05f4229e8726394d793760dc12e71ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b03357246435eee8135413f6add811c6396818c521f212e5f7aa7b9c84cc814e73feb64d026e5ce5a27c81faace4e9d51cf30b823b1c8a92e837b5d5641ea301", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05b178b333199f0e2e02da52bb7a8e585cbca623e38c7e5267072756871f63044f486a474af49e6feaccf166325aa0ca7414e61ba73d81412d4a5404ded48285"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 09:59:58.931181) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 09:59:58.931526) ========= 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=31acecf42b6a79ec49471d4a000001bb-1477586363.645238-652796354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 09:59:59.016718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 09:59:59.017036) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 09:59:59.017339) ========= ========= Total master_lag: 0.18 =========