builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1477256579.45 results: success (0) buildid: 20161023110422 builduid: 8e648f0e028646878a4f867fcf464f2f revision: 3f38f335bb384a9c37b4d3ddee6fdf47e37a79fe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-23 14:02:59.447900) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-23 14:02:59.448325) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-23 14:02:59.448644) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-23 14:02:59.478423) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 14:02:59.478714) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-23 14:02:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.6M=0s 2016-10-23 14:02:59 (33.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.164964 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 14:02:59.662837) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 14:02:59.663154) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020365 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 14:02:59.712850) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 14:02:59.713191) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3f38f335bb384a9c37b4d3ddee6fdf47e37a79fe --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 3f38f335bb384a9c37b4d3ddee6fdf47e37a79fe --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=5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-23 14:02:59,819 truncating revision to first 12 chars 2016-10-23 14:02:59,819 Setting DEBUG logging. 2016-10-23 14:02:59,819 attempt 1/10 2016-10-23 14:02:59,819 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3f38f335bb38?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-23 14:03:00,120 unpacking tar archive at: mozilla-aurora-3f38f335bb38/testing/mozharness/ program finished with exit code 0 elapsedTime=0.664495 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 14:03:00.391557) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-23 14:03:00.391829) ========= script_repo_revision: 3f38f335bb384a9c37b4d3ddee6fdf47e37a79fe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-23 14:03:00.392215) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-23 14:03:00.392500) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-23 14:03:00.403355) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-23 14:03:00.403688) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:03:00 INFO - MultiFileLogger online at 20161023 14:03:00 in /builds/slave/test 14:03:00 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 14:03:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:03:00 INFO - {'append_to_log': False, 14:03:00 INFO - 'base_work_dir': '/builds/slave/test', 14:03:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:03:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:03:00 INFO - 'branch': 'Mozilla-Aurora', 14:03:00 INFO - 'buildbot_json_path': 'buildprops.json', 14:03:00 INFO - 'config_files': ('talos/linux_config.py',), 14:03:00 INFO - 'default_actions': ('clobber', 14:03:00 INFO - 'read-buildbot-config', 14:03:00 INFO - 'download-and-extract', 14:03:00 INFO - 'populate-webroot', 14:03:00 INFO - 'create-virtualenv', 14:03:00 INFO - 'install', 14:03:00 INFO - 'run-tests'), 14:03:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:03:00 INFO - 'download_minidump_stackwalk': True, 14:03:00 INFO - 'download_symbols': 'ondemand', 14:03:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:03:00 INFO - 'tooltool.py': '/tools/tooltool.py', 14:03:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:03:00 INFO - '/tools/misc-python/virtualenv.py')}, 14:03:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:03:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:03:00 INFO - 'installer_path': 'installer.exe', 14:03:00 INFO - 'log_level': 'info', 14:03:00 INFO - 'log_name': 'talos', 14:03:00 INFO - 'log_to_console': True, 14:03:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:03:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:03:00 INFO - 'opt_config_files': (), 14:03:00 INFO - 'pip_index': False, 14:03:00 INFO - 'sps_profile': False, 14:03:00 INFO - 'sps_profile_interval': 0, 14:03:00 INFO - 'suite': 'dromaeojs', 14:03:00 INFO - 'system_bits': '32', 14:03:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:03:00 INFO - 'title': 'talos-linux64-ix-051', 14:03:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:03:00 INFO - 'use_talos_json': True, 14:03:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:03:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:03:00 INFO - 'work_dir': 'build'} 14:03:00 INFO - [mozharness: 2016-10-23 21:03:00.698690Z] Running clobber step. 14:03:00 INFO - Running pre-action listener: _resource_record_pre_action 14:03:00 INFO - Running main action method: clobber 14:03:00 INFO - rmtree: /builds/slave/test/build 14:03:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:03:01 INFO - Running post-action listener: _resource_record_post_action 14:03:01 INFO - [mozharness: 2016-10-23 21:03:01.114176Z] Finished clobber step (success) 14:03:01 INFO - [mozharness: 2016-10-23 21:03:01.114283Z] Running read-buildbot-config step. 14:03:01 INFO - Running pre-action listener: _resource_record_pre_action 14:03:01 INFO - Running main action method: read_buildbot_config 14:03:01 INFO - Using buildbot properties: 14:03:01 INFO - { 14:03:01 INFO - "project": "", 14:03:01 INFO - "product": "firefox", 14:03:01 INFO - "script_repo_revision": "production", 14:03:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:03:01 INFO - "repository": "", 14:03:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 14:03:01 INFO - "buildid": "20161023110422", 14:03:01 INFO - "pgo_build": "True", 14:03:01 INFO - "basedir": "/builds/slave/test", 14:03:01 INFO - "buildnumber": 549, 14:03:01 INFO - "slavename": "talos-linux64-ix-051", 14:03:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:03:01 INFO - "platform": "ubuntu64_hw", 14:03:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:03:01 INFO - "branch": "mozilla-aurora", 14:03:01 INFO - "repo_path": "releases/mozilla-aurora", 14:03:01 INFO - "revision": "3f38f335bb384a9c37b4d3ddee6fdf47e37a79fe", 14:03:01 INFO - "stage_platform": "linux64-pgo", 14:03:01 INFO - "builduid": "8e648f0e028646878a4f867fcf464f2f", 14:03:01 INFO - "slavebuilddir": "test" 14:03:01 INFO - } 14:03:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/NBDzGw1iTTKuxYYR7sfxIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 14:03:01 INFO - Running post-action listener: _resource_record_post_action 14:03:01 INFO - [mozharness: 2016-10-23 21:03:01.116721Z] Finished read-buildbot-config step (success) 14:03:01 INFO - [mozharness: 2016-10-23 21:03:01.116809Z] Running download-and-extract step. 14:03:01 INFO - Running pre-action listener: _resource_record_pre_action 14:03:01 INFO - Running main action method: download_and_extract 14:03:01 INFO - mkdir: /builds/slave/test/build/tests 14:03: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')]} 14:03:01 INFO - trying https://queue.taskcluster.net/v1/task/NBDzGw1iTTKuxYYR7sfxIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 14:03:01 INFO - Downloading https://queue.taskcluster.net/v1/task/NBDzGw1iTTKuxYYR7sfxIQ/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 14:03:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NBDzGw1iTTKuxYYR7sfxIQ/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 14:03:01 INFO - Downloaded 1361 bytes. 14:03:01 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 14:03:01 INFO - Using the following test package requirements: 14:03:01 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 14:03:01 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:03:01 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:03:01 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:03:01 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:03:01 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:03:01 INFO - u'jsshell-linux-x86_64.zip'], 14:03:01 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:03:01 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:03:01 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 14:03:01 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:03:01 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:03:01 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:03:01 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:03:01 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:03:01 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:03:01 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:03:01 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:03:01 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:03:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NBDzGw1iTTKuxYYR7sfxIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 14:03:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NBDzGw1iTTKuxYYR7sfxIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:03:01 INFO - Fetch https://queue.taskcluster.net/v1/task/NBDzGw1iTTKuxYYR7sfxIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:03:02 INFO - Expected file size: 21908254 14:03:07 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 14:03:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NBDzGw1iTTKuxYYR7sfxIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 14:03:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NBDzGw1iTTKuxYYR7sfxIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:03:07 INFO - Fetch https://queue.taskcluster.net/v1/task/NBDzGw1iTTKuxYYR7sfxIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:03:08 INFO - Expected file size: 21908254 14:03:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NBDzGw1iTTKuxYYR7sfxIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 14:03:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NBDzGw1iTTKuxYYR7sfxIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:03:13 INFO - Fetch https://queue.taskcluster.net/v1/task/NBDzGw1iTTKuxYYR7sfxIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 14:03:14 INFO - Expected file size: 14414081 14:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:15 INFO - trying https://queue.taskcluster.net/v1/task/NBDzGw1iTTKuxYYR7sfxIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:03:15 INFO - Downloading https://queue.taskcluster.net/v1/task/NBDzGw1iTTKuxYYR7sfxIQ/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 14:03:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NBDzGw1iTTKuxYYR7sfxIQ/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 14:03:17 INFO - Downloaded 64021759 bytes. 14:03:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NBDzGw1iTTKuxYYR7sfxIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:03:17 INFO - mkdir: /builds/slave/test/properties 14:03:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:03:17 INFO - Writing to file /builds/slave/test/properties/build_url 14:03:17 INFO - Contents: 14:03:17 INFO - build_url:https://queue.taskcluster.net/v1/task/NBDzGw1iTTKuxYYR7sfxIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:03:18 INFO - Running post-action listener: _resource_record_post_action 14:03:18 INFO - Running post-action listener: set_extra_try_arguments 14:03:18 INFO - [mozharness: 2016-10-23 21:03:18.517818Z] Finished download-and-extract step (success) 14:03:18 INFO - [mozharness: 2016-10-23 21:03:18.518044Z] Running populate-webroot step. 14:03:18 INFO - Running pre-action listener: _resource_record_pre_action 14:03:18 INFO - Running main action method: populate_webroot 14:03:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:03:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:03:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:03:18 INFO - '--tppagecycles', 14:03:18 INFO - '7'], 14:03:18 INFO - 'tests': ['tsvgm']}}, 14:03:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:03:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:03:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:03:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:03:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:03:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:03:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:18 INFO - 'talos_options': ['--disable-e10s'], 14:03:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:03:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:03:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:18 INFO - 'talos_options': ['--disable-e10s'], 14:03:18 INFO - 'tests': ['damp', 'tps']}, 14:03:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:18 INFO - 'tests': ['damp', 'tps']}, 14:03:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:03:18 INFO - 'tests': ['dromaeo_dom']}, 14:03:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:03:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:03:18 INFO - 'tests': ['basic_compositor_video']}, 14:03:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:03:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:03:18 INFO - 'tests': ['a11yr', 14:03:18 INFO - 'ts_paint', 14:03:18 INFO - 'tpaint', 14:03:18 INFO - 'sessionrestore', 14:03:18 INFO - 'sessionrestore_no_auto_restore', 14:03:18 INFO - 'tabpaint']}, 14:03:18 INFO - 'other-e10s': {'tests': ['a11yr', 14:03:18 INFO - 'ts_paint', 14:03:18 INFO - 'tpaint', 14:03:18 INFO - 'sessionrestore', 14:03:18 INFO - 'sessionrestore_no_auto_restore', 14:03:18 INFO - 'tabpaint']}, 14:03:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:03:18 INFO - 'ts_paint', 14:03:18 INFO - 'tpaint', 14:03:18 INFO - 'sessionrestore', 14:03:18 INFO - 'sessionrestore_no_auto_restore', 14:03:18 INFO - 'tabpaint']}, 14:03:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:03:18 INFO - 'ts_paint', 14:03:18 INFO - 'tpaint', 14:03:18 INFO - 'sessionrestore', 14:03:18 INFO - 'sessionrestore_no_auto_restore', 14:03:18 INFO - 'tabpaint']}, 14:03:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:03:18 INFO - 'tests': ['a11yr', 14:03:18 INFO - 'ts_paint', 14:03:18 INFO - 'tpaint', 14:03:18 INFO - 'sessionrestore', 14:03:18 INFO - 'sessionrestore_no_auto_restore', 14:03:18 INFO - 'tabpaint']}, 14:03:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:03:18 INFO - 'tests': ['a11yr', 14:03:18 INFO - 'ts_paint', 14:03:18 INFO - 'tpaint', 14:03:18 INFO - 'sessionrestore', 14:03:18 INFO - 'sessionrestore_no_auto_restore', 14:03:18 INFO - 'tabpaint']}, 14:03:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:03:18 INFO - 'tests': ['tsvgx', 14:03:18 INFO - 'tsvgr_opacity', 14:03:18 INFO - 'tart', 14:03:18 INFO - 'tscrollx', 14:03:18 INFO - 'cart']}, 14:03:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:03:18 INFO - 'tsvgr_opacity', 14:03:18 INFO - 'tart', 14:03:18 INFO - 'tscrollx', 14:03:18 INFO - 'cart']}, 14:03:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:18 INFO - 'talos_options': ['--disable-e10s'], 14:03:18 INFO - 'tests': ['tp5o']}, 14:03:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:18 INFO - 'tests': ['tp5o']}, 14:03:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:18 INFO - 'talos_options': ['--disable-e10s', 14:03:18 INFO - '--xperf_path', 14:03:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:03:18 INFO - 'tests': ['tp5n']}, 14:03:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:18 INFO - 'talos_options': ['--xperf_path', 14:03:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:03:18 INFO - 'tests': ['tp5n']}}, 14:03:18 INFO - 'talos.zip': {'path': '', 14:03:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:03:18 INFO - Running post-action listener: _resource_record_post_action 14:03:18 INFO - [mozharness: 2016-10-23 21:03:18.539094Z] Finished populate-webroot step (success) 14:03:18 INFO - [mozharness: 2016-10-23 21:03:18.539181Z] Running create-virtualenv step. 14:03:18 INFO - Running pre-action listener: _resource_record_pre_action 14:03:18 INFO - Running main action method: create_virtualenv 14:03:18 INFO - Creating virtualenv /builds/slave/test/build/venv 14:03:18 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 14:03:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:03:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:03:18 INFO - Using real prefix '/usr' 14:03:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:03:19 INFO - Installing distribute.............................................................................................................................................................................................done. 14:03:21 INFO - Installing pip.................done. 14:03:21 INFO - Return code: 0 14:03:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:03:21 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')]} 14:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:21 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')]} 14:03:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:21 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 0x7f0d931c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2758ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2755f60>, '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 0x2756d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27571d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', '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 14:03:21 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 14:03:21 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 14:03:21 INFO - Using env: {'DISPLAY': ':0', 14:03:21 INFO - 'HOME': '/home/cltbld', 14:03:21 INFO - 'LANG': 'en_US.UTF-8', 14:03:21 INFO - 'LANGUAGE': 'en_US:en', 14:03:21 INFO - 'LOGNAME': 'cltbld', 14:03:21 INFO - 'MAIL': '/var/mail/cltbld', 14:03:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:21 INFO - 'MOZ_NO_REMOTE': '1', 14:03:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:21 INFO - 'NO_EM_RESTART': '1', 14:03:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:21 INFO - 'PWD': '/builds/slave/test', 14:03:21 INFO - 'SHELL': '/bin/bash', 14:03:21 INFO - 'SHLVL': '1', 14:03:21 INFO - 'TERM': 'linux', 14:03:21 INFO - 'TMOUT': '86400', 14:03:21 INFO - 'USER': 'cltbld', 14:03:21 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', 14:03:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:21 INFO - '_': '/tools/buildbot/bin/python'} 14:03:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:21 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 14:03:21 INFO - Cleaning up... 14:03:21 INFO - Return code: 0 14:03:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:03:21 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')]} 14:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:21 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')]} 14:03:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:21 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 0x7f0d931c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2758ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2755f60>, '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 0x2756d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27571d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', '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 14:03:21 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 14:03:21 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 14:03:21 INFO - Using env: {'DISPLAY': ':0', 14:03:21 INFO - 'HOME': '/home/cltbld', 14:03:21 INFO - 'LANG': 'en_US.UTF-8', 14:03:21 INFO - 'LANGUAGE': 'en_US:en', 14:03:21 INFO - 'LOGNAME': 'cltbld', 14:03:21 INFO - 'MAIL': '/var/mail/cltbld', 14:03:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:21 INFO - 'MOZ_NO_REMOTE': '1', 14:03:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:21 INFO - 'NO_EM_RESTART': '1', 14:03:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:21 INFO - 'PWD': '/builds/slave/test', 14:03:21 INFO - 'SHELL': '/bin/bash', 14:03:21 INFO - 'SHLVL': '1', 14:03:21 INFO - 'TERM': 'linux', 14:03:21 INFO - 'TMOUT': '86400', 14:03:21 INFO - 'USER': 'cltbld', 14:03:21 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', 14:03:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:21 INFO - '_': '/tools/buildbot/bin/python'} 14:03:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:21 INFO - Downloading/unpacking psutil>=3.1.1 14:03:21 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 14:03:21 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 14:03:21 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 14:03:21 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 14:03:21 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 14:03:21 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 14:03:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:03:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:03:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:03:23 INFO - Installing collected packages: psutil 14:03:23 INFO - Running setup.py install for psutil 14:03:23 INFO - building 'psutil._psutil_linux' extension 14:03:23 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 14:03:25 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 14:03:25 INFO - building 'psutil._psutil_posix' extension 14:03:25 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 14:03:25 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 14:03:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:03:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:03:25 INFO - Successfully installed psutil 14:03:25 INFO - Cleaning up... 14:03:25 INFO - Return code: 0 14:03:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:03:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:25 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 0x7f0d931c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2758ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2755f60>, '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 0x2756d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27571d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', '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 14:03:25 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 14:03:25 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 14:03:25 INFO - Using env: {'DISPLAY': ':0', 14:03:25 INFO - 'HOME': '/home/cltbld', 14:03:25 INFO - 'LANG': 'en_US.UTF-8', 14:03:25 INFO - 'LANGUAGE': 'en_US:en', 14:03:25 INFO - 'LOGNAME': 'cltbld', 14:03:25 INFO - 'MAIL': '/var/mail/cltbld', 14:03:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:25 INFO - 'MOZ_NO_REMOTE': '1', 14:03:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:25 INFO - 'NO_EM_RESTART': '1', 14:03:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:25 INFO - 'PWD': '/builds/slave/test', 14:03:25 INFO - 'SHELL': '/bin/bash', 14:03:25 INFO - 'SHLVL': '1', 14:03:25 INFO - 'TERM': 'linux', 14:03:25 INFO - 'TMOUT': '86400', 14:03:25 INFO - 'USER': 'cltbld', 14:03:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', 14:03:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:25 INFO - '_': '/tools/buildbot/bin/python'} 14:03:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:03:25 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 14:03:25 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 14:03:25 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 14:03:25 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 14:03:25 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 14:03:25 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 14:03:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:03:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:03:27 INFO - Installing collected packages: mozsystemmonitor 14:03:27 INFO - Running setup.py install for mozsystemmonitor 14:03:27 INFO - Successfully installed mozsystemmonitor 14:03:27 INFO - Cleaning up... 14:03:27 INFO - Return code: 0 14:03:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:03:27 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')]} 14:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:27 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')]} 14:03:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:27 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 0x7f0d931c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2758ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2755f60>, '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 0x2756d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27571d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', '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 14:03:27 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 14:03:27 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 14:03:27 INFO - Using env: {'DISPLAY': ':0', 14:03:27 INFO - 'HOME': '/home/cltbld', 14:03:27 INFO - 'LANG': 'en_US.UTF-8', 14:03:27 INFO - 'LANGUAGE': 'en_US:en', 14:03:27 INFO - 'LOGNAME': 'cltbld', 14:03:27 INFO - 'MAIL': '/var/mail/cltbld', 14:03:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:27 INFO - 'MOZ_NO_REMOTE': '1', 14:03:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:27 INFO - 'NO_EM_RESTART': '1', 14:03:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:27 INFO - 'PWD': '/builds/slave/test', 14:03:27 INFO - 'SHELL': '/bin/bash', 14:03:27 INFO - 'SHLVL': '1', 14:03:27 INFO - 'TERM': 'linux', 14:03:27 INFO - 'TMOUT': '86400', 14:03:27 INFO - 'USER': 'cltbld', 14:03:27 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', 14:03:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:27 INFO - '_': '/tools/buildbot/bin/python'} 14:03:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:28 INFO - Downloading/unpacking jsonschema==2.5.1 14:03:28 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 14:03:28 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 14:03:28 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 14:03:28 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 14:03:28 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 14:03:28 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 14:03:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:03:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:03:30 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 14:03:30 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 14:03:30 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 14:03:30 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 14:03:30 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 14:03:30 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 14:03:30 INFO - Downloading functools32-3.2.3-2.tar.gz 14:03:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:03:30 INFO - warning: no files found matching '*.txt' 14:03:30 INFO - no previously-included directories found matching 'build' 14:03:30 INFO - no previously-included directories found matching 'dist' 14:03:30 INFO - no previously-included directories found matching '.git*' 14:03:30 INFO - Installing collected packages: jsonschema, functools32 14:03:30 INFO - Running setup.py install for functools32 14:03:30 INFO - warning: no files found matching '*.txt' 14:03:30 INFO - no previously-included directories found matching 'build' 14:03:30 INFO - no previously-included directories found matching 'dist' 14:03:30 INFO - no previously-included directories found matching '.git*' 14:03:30 INFO - Successfully installed jsonschema functools32 14:03:30 INFO - Cleaning up... 14:03:30 INFO - Return code: 0 14:03:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0d931c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2758ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2755f60>, '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 0x2756d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27571d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', '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 14:03:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:03:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:03:30 INFO - Using env: {'DISPLAY': ':0', 14:03:30 INFO - 'HOME': '/home/cltbld', 14:03:30 INFO - 'LANG': 'en_US.UTF-8', 14:03:30 INFO - 'LANGUAGE': 'en_US:en', 14:03:30 INFO - 'LOGNAME': 'cltbld', 14:03:30 INFO - 'MAIL': '/var/mail/cltbld', 14:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:30 INFO - 'MOZ_NO_REMOTE': '1', 14:03:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:30 INFO - 'NO_EM_RESTART': '1', 14:03:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:30 INFO - 'PWD': '/builds/slave/test', 14:03:30 INFO - 'SHELL': '/bin/bash', 14:03:30 INFO - 'SHLVL': '1', 14:03:30 INFO - 'TERM': 'linux', 14:03:30 INFO - 'TMOUT': '86400', 14:03:30 INFO - 'USER': 'cltbld', 14:03:30 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', 14:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:30 INFO - '_': '/tools/buildbot/bin/python'} 14:03:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:03:30 INFO - Cleaning up... 14:03:30 INFO - Return code: 0 14:03:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0d931c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2758ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2755f60>, '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 0x2756d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27571d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', '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 14:03:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:03:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:03:30 INFO - Using env: {'DISPLAY': ':0', 14:03:30 INFO - 'HOME': '/home/cltbld', 14:03:30 INFO - 'LANG': 'en_US.UTF-8', 14:03:30 INFO - 'LANGUAGE': 'en_US:en', 14:03:30 INFO - 'LOGNAME': 'cltbld', 14:03:30 INFO - 'MAIL': '/var/mail/cltbld', 14:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:30 INFO - 'MOZ_NO_REMOTE': '1', 14:03:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:30 INFO - 'NO_EM_RESTART': '1', 14:03:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:30 INFO - 'PWD': '/builds/slave/test', 14:03:30 INFO - 'SHELL': '/bin/bash', 14:03:30 INFO - 'SHLVL': '1', 14:03:30 INFO - 'TERM': 'linux', 14:03:30 INFO - 'TMOUT': '86400', 14:03:30 INFO - 'USER': 'cltbld', 14:03:30 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', 14:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:30 INFO - '_': '/tools/buildbot/bin/python'} 14:03:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:30 INFO - Downloading/unpacking blobuploader==1.2.4 14:03:30 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 14:03:30 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 14:03:30 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 14:03:30 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 14:03:30 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 14:03:30 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 14:03:32 INFO - Downloading blobuploader-1.2.4.tar.gz 14:03:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:03:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:03:32 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 14:03:32 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 14:03:32 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 14:03:32 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 14:03:32 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 14:03:32 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 14:03:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:03:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:33 INFO - Downloading docopt-0.6.1.tar.gz 14:03:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:03:33 INFO - Installing collected packages: blobuploader, requests, docopt 14:03:33 INFO - Running setup.py install for blobuploader 14:03:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:03:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:03:33 INFO - Running setup.py install for requests 14:03:34 INFO - Running setup.py install for docopt 14:03:34 INFO - Successfully installed blobuploader requests docopt 14:03:34 INFO - Cleaning up... 14:03:34 INFO - Return code: 0 14:03:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:34 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 0x7f0d931c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2758ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2755f60>, '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 0x2756d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27571d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', '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 14:03:34 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 14:03:34 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 14:03:34 INFO - Using env: {'DISPLAY': ':0', 14:03:34 INFO - 'HOME': '/home/cltbld', 14:03:34 INFO - 'LANG': 'en_US.UTF-8', 14:03:34 INFO - 'LANGUAGE': 'en_US:en', 14:03:34 INFO - 'LOGNAME': 'cltbld', 14:03:34 INFO - 'MAIL': '/var/mail/cltbld', 14:03:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:34 INFO - 'MOZ_NO_REMOTE': '1', 14:03:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:34 INFO - 'NO_EM_RESTART': '1', 14:03:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:34 INFO - 'PWD': '/builds/slave/test', 14:03:34 INFO - 'SHELL': '/bin/bash', 14:03:34 INFO - 'SHLVL': '1', 14:03:34 INFO - 'TERM': 'linux', 14:03:34 INFO - 'TMOUT': '86400', 14:03:34 INFO - 'USER': 'cltbld', 14:03:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', 14:03:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:34 INFO - '_': '/tools/buildbot/bin/python'} 14:03:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:03:34 INFO - Running setup.py (path:/tmp/pip-jYbK9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:03:34 INFO - Running setup.py (path:/tmp/pip-T_Il1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:03:34 INFO - Running setup.py (path:/tmp/pip-08Xuk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:03:34 INFO - Running setup.py (path:/tmp/pip-0yHoc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:03:34 INFO - Running setup.py (path:/tmp/pip-32nBt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:03:34 INFO - Running setup.py (path:/tmp/pip-wkch_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:03:34 INFO - Running setup.py (path:/tmp/pip-SAT8HJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:03:35 INFO - Running setup.py (path:/tmp/pip-WZq31_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:03:35 INFO - Running setup.py (path:/tmp/pip-chxnYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:03:35 INFO - Running setup.py (path:/tmp/pip-XCZABd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:03:35 INFO - Running setup.py (path:/tmp/pip-kJPkgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:03:35 INFO - Running setup.py (path:/tmp/pip-YPrcXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:03:35 INFO - Running setup.py (path:/tmp/pip-UHb9m4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:03:35 INFO - Running setup.py (path:/tmp/pip-qiYESy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:03:35 INFO - Running setup.py (path:/tmp/pip-nYr3GQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:03:35 INFO - Running setup.py (path:/tmp/pip-6skw7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:03:35 INFO - Running setup.py (path:/tmp/pip-g1phUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:03:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:03:35 INFO - Running setup.py install for manifestparser 14:03:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:03:35 INFO - Running setup.py install for mozcrash 14:03:35 INFO - Running setup.py install for mozdebug 14:03:36 INFO - Running setup.py install for mozdevice 14:03:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:03:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:03:36 INFO - Running setup.py install for mozfile 14:03:36 INFO - Running setup.py install for mozhttpd 14:03:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:03:36 INFO - Running setup.py install for mozinfo 14:03:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:03:36 INFO - Running setup.py install for mozInstall 14:03:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:03:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:03:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:03:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:03:36 INFO - Running setup.py install for mozleak 14:03:36 INFO - Running setup.py install for mozlog 14:03:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:03:36 INFO - Running setup.py install for moznetwork 14:03:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:03:36 INFO - Running setup.py install for mozprocess 14:03:36 INFO - Running setup.py install for mozprofile 14:03:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:03:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:03:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:03:37 INFO - Running setup.py install for mozrunner 14:03:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:03:37 INFO - Running setup.py install for mozscreenshot 14:03:37 INFO - Running setup.py install for moztest 14:03:37 INFO - Running setup.py install for mozversion 14:03:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:03:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:03:37 INFO - Cleaning up... 14:03:37 INFO - Return code: 0 14:03:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:03:37 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')]} 14:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:37 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')]} 14:03:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:37 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 0x7f0d931c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2758ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2755f60>, '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 0x2756d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27571d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', '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 14:03:37 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 14:03:37 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 14:03:37 INFO - Using env: {'DISPLAY': ':0', 14:03:37 INFO - 'HOME': '/home/cltbld', 14:03:37 INFO - 'LANG': 'en_US.UTF-8', 14:03:37 INFO - 'LANGUAGE': 'en_US:en', 14:03:37 INFO - 'LOGNAME': 'cltbld', 14:03:37 INFO - 'MAIL': '/var/mail/cltbld', 14:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:37 INFO - 'MOZ_NO_REMOTE': '1', 14:03:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:37 INFO - 'NO_EM_RESTART': '1', 14:03:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:37 INFO - 'PWD': '/builds/slave/test', 14:03:37 INFO - 'SHELL': '/bin/bash', 14:03:37 INFO - 'SHLVL': '1', 14:03:37 INFO - 'TERM': 'linux', 14:03:37 INFO - 'TMOUT': '86400', 14:03:37 INFO - 'USER': 'cltbld', 14:03:37 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', 14:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:37 INFO - '_': '/tools/buildbot/bin/python'} 14:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:03:37 INFO - Running setup.py (path:/tmp/pip-Jc7V3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:03:37 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)) 14:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:03:37 INFO - Running setup.py (path:/tmp/pip-V3o7d5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:03:37 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)) 14:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:03:37 INFO - Running setup.py (path:/tmp/pip-4TdJg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:03:37 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)) 14:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:03:37 INFO - Running setup.py (path:/tmp/pip-rsi3s2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:03:38 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)) 14:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:03:38 INFO - Running setup.py (path:/tmp/pip-kKsbH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:03:38 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)) 14:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:03:38 INFO - Running setup.py (path:/tmp/pip-W5I4TL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:03:38 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)) 14:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:03:38 INFO - Running setup.py (path:/tmp/pip-tYuy3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:03:38 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)) 14:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:03:38 INFO - Running setup.py (path:/tmp/pip-3CASzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:03:38 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)) 14:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:03:38 INFO - Running setup.py (path:/tmp/pip-OPIXWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:03:38 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)) 14:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:03:38 INFO - Running setup.py (path:/tmp/pip-5dLnPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:03:38 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)) 14:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:03:38 INFO - Running setup.py (path:/tmp/pip-jyIWh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:03:38 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)) 14:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:03:38 INFO - Running setup.py (path:/tmp/pip-WiETQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:03:38 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)) 14:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:03:38 INFO - Running setup.py (path:/tmp/pip-PIbjbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:03:38 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)) 14:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:03:38 INFO - Running setup.py (path:/tmp/pip-MP_3ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:03:38 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)) 14:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:03:38 INFO - Running setup.py (path:/tmp/pip-QrtB0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:03:38 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)) 14:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:03:38 INFO - Running setup.py (path:/tmp/pip-j0wyVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:03:38 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)) 14:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:03:38 INFO - Running setup.py (path:/tmp/pip-YhhnAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:03:38 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)) 14:03:38 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)) 14:03:38 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)) 14:03:38 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)) 14:03:38 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)) 14:03:38 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)) 14:03:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:40 INFO - Downloading blessings-1.6.tar.gz 14:03:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:03:41 INFO - Installing collected packages: blessings 14:03:41 INFO - Running setup.py install for blessings 14:03:41 INFO - Successfully installed blessings 14:03:41 INFO - Cleaning up... 14:03:41 INFO - Return code: 0 14:03:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:03:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:03:41 INFO - Reading from file tmpfile_stdout 14:03:41 INFO - Current package versions: 14:03:41 INFO - argparse == 1.2.1 14:03:41 INFO - blessings == 1.6 14:03:41 INFO - blobuploader == 1.2.4 14:03:41 INFO - docopt == 0.6.1 14:03:41 INFO - functools32 == 3.2.3-2 14:03:41 INFO - jsonschema == 2.5.1 14:03:41 INFO - manifestparser == 1.1 14:03:41 INFO - mozInstall == 1.12 14:03:41 INFO - mozcrash == 0.17 14:03:41 INFO - mozdebug == 0.1 14:03:41 INFO - mozdevice == 0.48 14:03:41 INFO - mozfile == 1.2 14:03:41 INFO - mozhttpd == 0.7 14:03:41 INFO - mozinfo == 0.9 14:03:41 INFO - mozleak == 0.1 14:03:41 INFO - mozlog == 3.4 14:03:41 INFO - moznetwork == 0.27 14:03:41 INFO - mozprocess == 0.23 14:03:41 INFO - mozprofile == 0.28 14:03:41 INFO - mozrunner == 6.12 14:03:41 INFO - mozscreenshot == 0.1 14:03:41 INFO - mozsystemmonitor == 0.3 14:03:41 INFO - moztest == 0.7 14:03:41 INFO - mozversion == 1.4 14:03:41 INFO - psutil == 3.1.1 14:03:41 INFO - requests == 1.2.3 14:03:41 INFO - wsgiref == 0.1.2 14:03:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:41 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 0x7f0d931c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2758ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2755f60>, '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 0x2756d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27571d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', '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 14:03:41 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 14:03:41 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 14:03:41 INFO - Using env: {'DISPLAY': ':0', 14:03:41 INFO - 'HOME': '/home/cltbld', 14:03:41 INFO - 'LANG': 'en_US.UTF-8', 14:03:41 INFO - 'LANGUAGE': 'en_US:en', 14:03:41 INFO - 'LOGNAME': 'cltbld', 14:03:41 INFO - 'MAIL': '/var/mail/cltbld', 14:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:41 INFO - 'MOZ_NO_REMOTE': '1', 14:03:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:41 INFO - 'NO_EM_RESTART': '1', 14:03:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:41 INFO - 'PWD': '/builds/slave/test', 14:03:41 INFO - 'SHELL': '/bin/bash', 14:03:41 INFO - 'SHLVL': '1', 14:03:41 INFO - 'TERM': 'linux', 14:03:41 INFO - 'TMOUT': '86400', 14:03:41 INFO - 'USER': 'cltbld', 14:03:41 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', 14:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:41 INFO - '_': '/tools/buildbot/bin/python'} 14:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:41 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)) 14:03:41 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)) 14:03:41 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)) 14:03:41 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)) 14:03:41 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)) 14:03:41 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)) 14:03:41 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)) 14:03:41 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)) 14:03:41 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)) 14:03:41 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)) 14:03:41 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)) 14:03:41 INFO - Cleaning up... 14:03:41 INFO - Return code: 0 14:03:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d931c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2758ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2755f60>, '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 0x2756d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27571d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', '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 14:03:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:03:41 INFO - Using env: {'DISPLAY': ':0', 14:03:41 INFO - 'HOME': '/home/cltbld', 14:03:41 INFO - 'LANG': 'en_US.UTF-8', 14:03:41 INFO - 'LANGUAGE': 'en_US:en', 14:03:41 INFO - 'LOGNAME': 'cltbld', 14:03:41 INFO - 'MAIL': '/var/mail/cltbld', 14:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:41 INFO - 'MOZ_NO_REMOTE': '1', 14:03:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:41 INFO - 'NO_EM_RESTART': '1', 14:03:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:41 INFO - 'PWD': '/builds/slave/test', 14:03:41 INFO - 'SHELL': '/bin/bash', 14:03:41 INFO - 'SHLVL': '1', 14:03:41 INFO - 'TERM': 'linux', 14:03:41 INFO - 'TMOUT': '86400', 14:03:41 INFO - 'USER': 'cltbld', 14:03:41 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', 14:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:41 INFO - '_': '/tools/buildbot/bin/python'} 14:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:03:41 INFO - Cleaning up... 14:03:41 INFO - Return code: 0 14:03:41 INFO - Running post-action listener: _resource_record_post_action 14:03:41 INFO - Running post-action listener: _start_resource_monitoring 14:03:41 INFO - Starting resource monitoring. 14:03:41 INFO - [mozharness: 2016-10-23 21:03:41.889625Z] Finished create-virtualenv step (success) 14:03:41 INFO - [mozharness: 2016-10-23 21:03:41.890607Z] Running install step. 14:03:41 INFO - Running pre-action listener: _resource_record_pre_action 14:03:41 INFO - Running main action method: install 14:03:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:03:42 INFO - Reading from file tmpfile_stdout 14:03:42 INFO - Detecting whether we're running mozinstall >=1.0... 14:03:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:03:42 INFO - Reading from file tmpfile_stdout 14:03:42 INFO - Output received: 14:03:42 INFO - Usage: mozinstall [options] installer 14:03:42 INFO - Options: 14:03:42 INFO - -h, --help show this help message and exit 14:03:42 INFO - -d DEST, --destination=DEST 14:03:42 INFO - Directory to install application into. [default: 14:03:42 INFO - "/builds/slave/test"] 14:03:42 INFO - --app=APP Application being installed. [default: firefox] 14:03:42 INFO - mkdir: /builds/slave/test/build/application 14:03:42 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'] 14:03:42 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 14:03:58 INFO - Reading from file tmpfile_stdout 14:03:58 INFO - Output received: 14:03:58 INFO - /builds/slave/test/build/application/firefox/firefox 14:03:58 INFO - Running post-action listener: _resource_record_post_action 14:03:58 INFO - [mozharness: 2016-10-23 21:03:58.135303Z] Finished install step (success) 14:03:58 INFO - [mozharness: 2016-10-23 21:03:58.135550Z] Running run-tests step. 14:03:58 INFO - Running pre-action listener: _resource_record_pre_action 14:03:58 INFO - Running main action method: run_tests 14:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:03:58 INFO - Python 2.7.3 14:03:58 INFO - Return code: 0 14:03:58 INFO - grabbing minidump binary from tooltool 14:03:58 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')]} 14:03:58 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 0x2755f60>, '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 0x2756d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27571d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:03:58 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 14:03:58 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 14:03:58 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 14:03:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:03:58 INFO - Return code: 0 14:03:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:03:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:03:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:03:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:03:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:03:58 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/NBDzGw1iTTKuxYYR7sfxIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 14:03:58 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/NBDzGw1iTTKuxYYR7sfxIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 14:03:58 INFO - Using env: {'DISPLAY': ':0', 14:03:58 INFO - 'HOME': '/home/cltbld', 14:03:58 INFO - 'LANG': 'en_US.UTF-8', 14:03:58 INFO - 'LANGUAGE': 'en_US:en', 14:03:58 INFO - 'LOGNAME': 'cltbld', 14:03:58 INFO - 'MAIL': '/var/mail/cltbld', 14:03:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:03:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:58 INFO - 'MOZ_NO_REMOTE': '1', 14:03:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:58 INFO - 'NO_EM_RESTART': '1', 14:03:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:58 INFO - 'PWD': '/builds/slave/test', 14:03:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:03:58 INFO - 'SHELL': '/bin/bash', 14:03:58 INFO - 'SHLVL': '1', 14:03:58 INFO - 'TERM': 'linux', 14:03:58 INFO - 'TMOUT': '86400', 14:03:58 INFO - 'USER': 'cltbld', 14:03:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284', 14:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:58 INFO - '_': '/tools/buildbot/bin/python'} 14:03:58 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/NBDzGw1iTTKuxYYR7sfxIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 14:03:58 INFO - mozversion application_buildid: 20161023110422 14:03:58 INFO - mozversion application_changeset: 3f38f335bb384a9c37b4d3ddee6fdf47e37a79fe 14:03:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:03:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:03:58 INFO - mozversion application_name: Firefox 14:03:58 INFO - mozversion application_remotingname: firefox-dev 14:03:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:03:58 INFO - mozversion application_vendor: Mozilla 14:03:58 INFO - mozversion application_version: 51.0a2 14:03:58 INFO - mozversion platform_buildid: 20161023110422 14:03:58 INFO - mozversion platform_changeset: 3f38f335bb384a9c37b4d3ddee6fdf47e37a79fe 14:03:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:03:58 INFO - mozversion platform_version: 51.0a2 14:03:58 INFO - using testdate: 1477256638 14:03:58 INFO - actual date: 1477256638 14:03:58 INFO - starting webserver on 'localhost:47598' 14:03:58 INFO - SUITE-START | Running 2 tests 14:03:58 INFO - TEST-START | dromaeo_css 14:03:58 INFO - operating with platform_type : linux_ 14:03:58 INFO - Initialising browser for dromaeo_css test... 14:03:58 INFO - TEST-INFO | started process 3335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVKdmgp/profile http://localhost:47598/getInfo.html) 14:04:04 INFO - PROCESS | 3335 | __metrics Screen width/height:1600/1200 14:04:04 INFO - PROCESS | 3335 | colorDepth:24 14:04:04 INFO - PROCESS | 3335 | Browser inner width/height: 1024/697 14:04:04 INFO - PROCESS | 3335 | __metrics 14:04:05 INFO - PROCESS | 3335 | 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" 14:04:05 INFO - PROCESS | 3335 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:04:06 INFO - PROCESS | 3335 | console.error: PushService: 14:04:06 INFO - PROCESS | 3335 | stateChangeProcessEnqueue: Error transitioning state 14:04:06 INFO - PROCESS | 3335 | UnknownError 14:04:06 INFO - TEST-INFO | 3335: exit 0 14:04:06 INFO - Browser initialized. 14:04:06 INFO - Running cycle 1/1 for dromaeo_css test... 14:04:06 INFO - TEST-INFO | started process 3428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVKdmgp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:04:18 INFO - PROCESS | 3428 | RSS: Main: 144756736 14:04:18 INFO - PROCESS | 3428 | 14:05:09 INFO - PROCESS | 3428 | 1477256709315 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] 14:07:18 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:47598/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47598/tests/dromaeo/cssquery-ext.html) 14:07:19 INFO - PROCESS | 3428 | RSS: Main: 242016256 14:07:19 INFO - PROCESS | 3428 | 14:10:22 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:47598/tests/dromaeo/cssquery-ext.html (next: http://localhost:47598/tests/dromaeo/cssquery-jquery.html) 14:10:22 INFO - PROCESS | 3428 | RSS: Main: 234283008 14:10:22 INFO - PROCESS | 3428 | 14:13:24 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:47598/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47598/tests/dromaeo/cssquery-mootools.html) 14:13:25 INFO - PROCESS | 3428 | RSS: Main: 174227456 14:13:25 INFO - PROCESS | 3428 | 14:16:27 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:47598/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47598/tests/dromaeo/cssquery-prototype.html) 14:16:27 INFO - PROCESS | 3428 | RSS: Main: 173715456 14:16:27 INFO - PROCESS | 3428 | 14:19:30 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:47598/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47598/tests/dromaeo/cssquery-yui.html) 14:19:31 INFO - PROCESS | 3428 | RSS: Main: 175820800 14:19:31 INFO - PROCESS | 3428 | 14:22:33 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:47598/tests/dromaeo/cssquery-yui.html (next: http://localhost:47598/tests/dromaeo/cssquery-dojo.html) 14:22:33 INFO - PROCESS | 3428 | RSS: Main: 266870784 14:22:33 INFO - PROCESS | 3428 | 14:22:33 INFO - PROCESS | 3428 | __start_tp_report 14:22:33 INFO - PROCESS | 3428 | _x_x_mozilla_page_load 14:22:33 INFO - PROCESS | 3428 | _x_x_mozilla_page_load_details 14:22:33 INFO - PROCESS | 3428 | |i|pagename|runs| 14:22:33 INFO - PROCESS | 3428 | |0;dojo.html;3132.9530057049146;3187.0279564732764;3192.281736609263;3207.7433805295577;3232.53128296397;5592.217089607453;5683.573731970098;5692.57305702072;5693.03218452863;5728.455796699317;5617.634853734505;5667.376588575254;5667.603267771247;5678.48893599576;5705.4294570542925;5085.821996230124;5105.540501354877;5135.794568217267;5139.48605139485;5175.896482070356;5036.571891389236;5046.243063540462;5080.695158290496;5200.8699782505555;5229;5118.3857937047605;5149.639525233235;5202.219667049935;5212.687238765668;5221.138512145491;5211.843644690627;5212.244224587433;5217.686938783666;5218.895622087537;5251.842444726664;4921.8523444296725;4931.679440836334;5086.593072554187;5105.795768169269;5173.508516690908;5471.616986810925;5535.446455354472;5538.944610553883;5541.695206763627;5546.362168350651;6008.279006519246;6068.908966365508;6110.847228819315;6111.51107911366;6118.051701986199;5923.763049478016;6135.355787642278;6150.630962142286;6164.537659675498;6164.96917515414;5482.671039737628;5549.334079910396;5563.388027316992;5618.410066942994;5624;6163.599366041193;6166.845828854225;6169.9383006170265;6170.722317495633;6177.505799536027;5764.654120752768;5921.67430791302;5925.555583331267;5931.139984702194;5937.554683398763;5910.911336329958;5920.940790592125;5926.703664816742;5954.642721436728;6059.666718330534;5917.260342457193;5976.551758618034;5981.6710080945095;5986.700664966735;5986.73059712314;6002.879942401215;6007.06890431975;6008.429199226067;6011.909821352683;6019.969900150471;4507.4365704286965;4552.908941821145;4567.269236922077;4617.076584683077;4631.930521042187;4109.630133287958;4125.071858831739;4137.937930931039;4141.855035073758;4143.627073563393;5725.198472213893;5736.827895163152;5739.770409183586;5741;5741.19623252745;5756.30924289088;5801.12983052537;5974.641521508724;5999.820005399845;6003.429674180946;5774.393688662714;5776.249087618667;5785.71071446426;5801.274840644919;5820.214271073351;5279.128943724242;5305.363356397257;5315.123004704181;5317.680939143664;5319.973400133052;6078.3617720138745;6096.3903609639565;6143.849652621547;6289.088082228142;6337.714802833883;5942.524598032061;6025.758969641165;6056.788012419544;6070.423309785563;6076.8784624308155;6266.436020758154;6290.905636415366;6291.622502649856;6300.086487459201;6301.212348456443;5683.573731970201;5968.985272503598;6001.90997135052;6008.279006519071;6026;5894.528437725057;5952.642841429528;5972.462478376967;6010.639361638316;6114.205153330038;5902.793402230901;5935.495482884004;5948.2862056553495;5957.791477298274;5960.76156953717;5883.146943693226;5919.881602367843;5945.851353716192;5949.077892926603;5955.5235581154275;5631.211630371669;5698.686572238566;5757.165211044459;5784.2191304175085;5801.593888427769;5939.673317967553;5943.554233432424;5947.04847224442;5947.524198064058;5949.3455719871645;5626.549876009991;5689.118186681071;5786.479216870502;5796;5796.507296879812 14:22:33 INFO - PROCESS | 3428 | |1;ext.html;585.8213244960288;613.1997742945457;635.0696230023016;638.1544453598982;644.764660898772;35111.82444087779;38985.8050709746;39012.80493597528;39167.80416097919;39178.8041059795;48792.75603621977;50455.74772126143;50499;53795;53875;9306.11591898772;9440.291978101635;9446.291528135383;9448.244140468745;9448.905510944905;8312.33501319893;8459;9409.294302927308;9499.620015199383;9520.523973801317;8967.506787126706;11219.775604487906;11429.942850285737;11448.084153267719;11879.227850189753;11374.090072794157;11422.314661120276;11431.885681143165;11454.083673306115;11465.713357166054;11135.05352045077;11173.553057877674;11209.327440353523;11240.156988225915;11251.381174035425;46850.531494685296;46972;47402.76298618485;47416.52583474156;47424.5257547427;3693.9445908311395;3764.6611804937415;3808.866689665876;4044.28702350582;4449.8652843525015;34879.4768078479;34970.82514587411;35114.122146946276;35440;35706.28587428237;4690.829438381933;4693.155232058228;4710.199266124767;4713.198756211418;4730.219513780222;389077;389342;390160.99999999715;391585;394061;65142;65436;65505;65547.34452655508;65673.34326656768;41390.37914431225;41995.58004419978;42343.153136937086;69306.30693692999;69392.6530367345;18799;18928.905355473136;18930.43208703741;18933;18939.33712320062;14189.36147873348;14287.642808929651;14291.356888940023;14296.070755400866;14322.570322890122;19003.61992760165;19283.421497355102;21092.05085771144;21105.155793768383;21278.893605531874;7583.7724868254045;7682.846343073107;7800.985871836739;7972.880406793903;7977.840443191104;961.427950369529;1070.6466865934224;1115.5314767797545;1150.2121047082608;1209.5947857467847;34155.487667685;34418.82790586031;34864.30271394558;34919.12702182466;34999.30001399958;1110.3726394587034;1133.7222380516826;1186.0985650905202;1203.8796120387892;1236.4065248680504;17822.198001089724;17833.910830445766;17849.910750446164;18121.36575219861;18430.907845460955;623255.4186145383;627988;629336;629503;632065;62888.68555657192;63512.68243658752;63540.36459635437;63678.68160659167;63791;1435.33257035479;1447.7683570628649;1475.0707054555562;1483.5697647682266;1486.7026594681106;30730.692693072782;33287.66712332846;34130.82934585311;34158.487622686174;34473.65526344704;55986;56127.158092627826;56184.43815561956;56286.43713562812;56369.71815140898;525593;525648;527956;528315;528791;31702;32198.19504512406;32575.67424325821;32755.836220818743;32765.836170818995;52308.21537677014;52888;53103;54069.72965135149;54207.728961354944;43239;43729.874642423725;45246;45761.54238457706;46754.76622617001;44368.334474983545;44741;44801.55198447974;45765.31352029789;45929;43649.56350436455;43938.34092488551;43972.34041489444;44039.119217616106;44056.898577535816;37459.62540374562;37464.812675936446;38010.408921933085;38647.42028869625;38910.80544597259;29276.268093297836;29335;29757.70242297636;30001.54997674993;30049.399012020076 14:22:33 INFO - PROCESS | 3428 | |2;jquery.html;370.2871971454949;399.5325469201035;400.21158318113305;408.2875382457611;420.02554074547044;14354.569362919116;16598.087105209208;20693.689594656073;21417.892910535465;21487.892560537177;20462.590748185026;20545;20984.8950755246;21055.894720526416;21187.894060529714;5744;5829.271341082364;5988.730507127189;6051.576389652726;6100.328963813977;4076.103257283408;6132.50939924805;6164.198654174951;6164.445199932005;6175.289841668221;4358.934615980763;6142.0786881967615;6192.78325258616;6271.780487682932;6277.340879207686;6042.184305118797;6201.596896201778;6229.2524897012645;6258.1551490548645;6262.906056409158;6032.095185722133;6036.396360363972;6036.547258955552;6038.818835434944;6042.335343112254;14621.561353159423;14853.48012819546;14946;15085.622859428493;15218.923905380512;2463.3472129885595;2492.987535062313;2899.5505696617056;3126.390353880994;3195.6484786673445;10607.893921060844;10964.848690887502;11003.9092572411;11177.888221117848;11204.66386008421;1968.3012530551591;2014.738084049079;2019.545602239499;2055.106028877443;2075.1180748182114;84588.57705711432;87052.56473717654;87444.98343882801;88025.55987220023;96488;10822.783544329226;11132.387718675389;11423.657290281304;11460.083193344512;11485.253458525169;15326.157061361731;15330.080195188324;15330.616734581501;15335.386584536494;15365.154916479478;8230.135835737281;8411.369147313975;8421.284190843724;8477.27943124829;8490;8360.080391156967;8372.53951032687;8398.83202335962;8554.61504232311;8593.667981462882;4672;4694.779357367109;4698.906021879611;4890.706557606555;5053.01466214092;1911.62723268964;1925.6726356519425;1926.0754837677994;1954.355062829263;1966.675498542753;957.3011701457835;988.9060539248903;1010.6765834932751;1060.5015642647943;1084.6258040975852;19949;20608.69086963697;20611.175552978013;20634.690479642817;20808.063637136365;988.1847475832467;1024.2267088348249;1048.051513380392;1058.439027315524;1076.9784604308027;10938.289011214245;11086.722831929104;11889.28664280146;12174.939125304316;12384.504619815287;586875;608205.572225452;618320;628335;631141;64230;76623.61688191524;102120;103431;105628;1062.0759938853248;1080.4273734920348;1080.8108580998294;1086.5327908999207;1094.8795632480421;18364.632707346045;18604;18894;19065.71401428952;19087.8091219086;44343;44946.550534494236;45126.54873451223;45632.77183614061;45804.31293530666;62373.37626623676;63068;64358.67820660867;64487.355126448136;65711;8227.218414250636;8506.787330316543;8667.869981950149;9036.909630903607;9061.049377517438;12276.140670153003;13502.662433439242;13588.048836581343;13671.794923075962;13758.174509529461;10904.992719366448;11628;11651.126165537788;11710.88289117132;11884.524619015143;11428.085753139563;11616;11631.185816993067;11751.004658415837;11967.880321196677;11495.8275625864;11572.6528204154;11962.820557691468;12076.698082548006;12126.090543209119;8612;8858.512781797062;8879.378443509151;8893.333000025154;8915.55422228873;10602.628907988183;11429.257098288917;11619.302841829518;11665.650030499099;11871.406429678309 14:22:33 INFO - PROCESS | 3428 | |3;mootools.html;1517.764746464298;1530.7780371846084;1708.5386945524708;1803.2967142814296;1834.05546143736;8246.463979841306;8508.14918508149;8808.77978050549;9491.572879220434;9493.477858717768;9168.08319168083;9506.619735210601;9511.667091651794;9705.320627556073;9706.272029597772;2480.057578120316;2516.6979962404444;2518.294877434312;2518.357818756215;2520.4581015081753;2111.7043613894066;2181.6509358502644;2331.40549159964;2439.8414103083333;2537.8096642751775;2476.4428003699204;2520.1179587144443;2525.6085306777477;2525.671662683858;2526.608375701769;2441.8779061046966;2459.458919037818;2461.446174610725;2461.54461424637;2465.235776909146;2439.499902519979;2446.5351583199135;2454.2637208837455;2468.5556599812026;2477.1577663594285;9657.179139773129;9891.604335826558;9892.30753847231;9901.108900199017;9906.257030722652;5708.514776243983;5851.32709738377;5900.64596124234;5904.793332233394;5909.4090590941;3545.8936231913085;3585.928281434383;3656.579493358271;3691.5754688210664;3698.815059247027;1170.631251155883;1226.8957138643227;1250.337321219755;1255.209218192542;1259.8740125987329;12902.197835027955;12916.095873288874;13005.154664946844;13005.739885202243;13017.934910325483;4965.32968049316;5039.269305950616;5100.56645185156;5108.744562771846;5181.248718935733;10972.286801357886;11006.394648294261;11014.779704406028;11020.559177632806;11027.72430689223;5694.088945768657;5713.114467257582;5714.457126572969;5718.485336319751;5721.828345149652;5167.199084141889;5231.189165679326;5285.524302812765;5360.437154098763;5396.109641909041;4357.520672725997;4359.455068116486;4360.41134446852;4396.582324679151;4410.3825464435;1218.3360068762545;1239.2155296373194;1356.1117468058437;1364.0042768778846;1409.9295035248197;919.4207649181106;1011.4487604255698;1016.6848277034143;1023.3297190340339;1026.743314171457;6306.243250809932;6316.968415157895;6354.52341074412;6394.23269207698;6508.674566271668;989.7525618595351;1001.5092604623682;1007.5163921317809;1038.89611038897;1062.654637242899;4086.223617512663;4110.403991421227;4244.448221731155;4306.0957198987935;4310.80601372939;11260.268082574607;11499.3675347855;11555.42222888869;11649.242799218024;11760.176787624956;11663.708407289885;11673.182877198515;11674.299542027506;11677.416129193507;11681.415929203506;8362.790930226793;8512.702055428153;8584.31325493959;8595.269402100766;8599.828003440021;5761.971190144022;5816.302043754777;5840.795572154954;5844.47399734026;6014.6391216527145;10341.172706183337;10345.793084138426;10347.586096556355;10371.792564148825;10456.738581535523;10146.644867429604;10533.525991330256;10553.525091370753;10681.839772403575;10693.358398496115;7817;8021.358291336795;8028.317593004426;8030.63862126194;8032.277095061472;8686.435381700168;8692.913070869463;8729.301655867643;8789.07714689974;8798.38411311202;6787.355201255873;7596.886046709415;7833.177516360928;7881.566513841564;7967.482113662593;7377.594232317274;7382.9630851845395;7475.962620186864;7498.437617178843;7511.474196806171;7276.345128938421;7429.702811887464;7458.47790654649;7504.962475187589;7605.163432022584;5401;5427.158790387496;5460.972695136499;5485.725713714378;5594.1608758686525;5367.919481207863;5447.863803404788;5463.890722185613;5477.808276710296;5487.176923461513 14:22:33 INFO - PROCESS | 3428 | |4;prototype.html;340.9727221822253;347.8539013614282;348.41466336554595;348.8290737538607;354.46475821509523;5500.22996780451;5519.55843532518;5533.833984980452;5553.389517040054;5565.165225216219;5451.536619387357;5461.863453413666;5482.342118945722;5482.725863706819;5493.807716729915;3764.1555637737583;4088.6115818997223;4166.6874984376145;4197.811098500575;4306.935395969063;4297.828086876521;4299.935500967488;4300.139972005596;4305.698601097924;4310.211262326131;4263.424437700917;4279.978600107011;4294.355846623001;4295.849645262417;4299.247631664462;4042.4234548526097;4051.1897620476025;4158.334666453383;4294.849680261192;4305.203537345601;3806.1626442182674;3809.2191100824543;3811.123441608446;3825.1202223488754;3826.330392181357;5289.894202115975;5329.760160792774;5330.92003619946;5335.839924802223;5357.866053348697;4769.594584460325;4931.161702510582;4961.5038496150455;4962.330085438456;4973.801047958077;5688.520984544007;5696.658200507983;5706.773043795604;5715;5720.170575266605;4192.308269135589;4210.7473551587;4218.586773430904;4220.85227017056;4227.78861056949;5692.5161361284345;5944.613600115978;5964.479057840266;5977.521798256129;5992.31088424828;4252.234597772431;4260.360945858146;4260.360945858146;4261.808218630107;4268.396278270253;4281.807318670667;4288.7212331199;4304.80628371724;4308.095299987038;4311.223979683625;4788.186008378514;4869.878253043702;4889.511048895082;4898.363212782316;4913.70517768935;5735.942640573624;5736.741846616912;5767.711614419262;5814.418558144236;5819.243498345273;1465.1868213141809;1491.328901994107;1493.6041948883556;1493.7385957457402;1498.9550313490613;903.421810041574;949.3765660720107;955.7323949294208;957.3442192098296;965.888922773876;4892.975535122301;4920.6801557898625;4931.966840393204;4945.579625731782;4946.653734238641;5101.7348896706135;5117;5130.410002849645;5160.329157209614;5160.793568257228;4608.700434471749;4894.926576101361;4913.926291105637;4953.380827396575;4967;2720.9591856122174;2733.986330068337;2736.7011710163556;2750.477409292268;2773.736495032969;5347.41178470368;5394.568434525228;5410.215518749759;5424.918626220609;5446.863828404243;5290.984139040786;5311.336082989626;5696.259486266842;5840.2115714378015;6083.209182806207;6001.699915004232;6020.307664618625;6162.22972128484;6162.7534898605345;6163.9383606164265;5895.970520147372;5910.852228694317;5917.467427931507;5920.171176035445;5958.612690175125;5627.634203776742;5873.9412605873395;5882.999890018793;5887.7056147191615;5933.406659334032;6126.448619624077;6149.508039356931;6162;6174.351693072163;6189;4075.65356944663;4292.785360732013;4299.398084268142;4314.201872653569;4321.891952701208;5844.707764611668;5862.589618726819;5904.527637789052;5911.167538063214;5920.171176035445;5744.971275143765;5756.798512052058;5770.163326317745;5772.278465191851;5774.448714040751;5621.494065534122;5731.684757338387;5735.311762588516;5747.798827041033;5766.221560089502;5700.885982280248;5704.828855134353;5720.570957178145;5745.770169193185;5749.597528172988;5560.388357280615;5785.247917770663;5790.507806836466;5792.710364481674;5796.710164491674;5590.944090559043;5605.607607467438;5649.5762817789655;5650.63270887391;5660.7169641518585 14:22:33 INFO - PROCESS | 3428 | |5;yui.html;792.3027735592677;809.8947136872206;871.9782005449865;882.2765332427408;929.7815013471837;16634.168291585418;17845.375411860587;17989.820101798978;18072;18085.7287140693;15264;15652.608684782886;15793.052416854996;16433.342666293334;16449.91775041126;863.7106569299292;879.7668617816283;880.5553195636195;881.3301890563154;881.6561540999015;739.7152096442882;758.1773775453639;844.3625063077368;870.9172628600304;871.4596949891045;919.0487845080344;919.7148883845996;920.4155361345561;921.1709461484684;921.1847514949285;915.0346384564282;917.2478567574592;917.6008436330218;918.9862152067691;920.894097178823;566.583561082604;580.4630716587141;655.207199288861;671.0839703804272;679.6397909108181;15124.092554446768;15133;15154.393824247018;15171.544853654408;15175.241237938058;15074.924625376803;15442.922785386114;15649;16026.839731602768;16311.184440777914;14492;14501.637459063502;14514.419423223058;14788;14831.77752333716;4508.391367165424;4578.175928332898;4670.579647831712;4709.788059537329;4769.141554520185;86414.56792715997;87370.5631471845;87986;90963.99999999935;93732.53133734356;12323.322217278135;12427;12464.580770782208;12632.557860474839;12733.872661273454;21708.348749537538;21816.563668726536;21975.560488790135;21978.340649780534;21995.010224539936;9177.954110229406;9197;9207.539623018822;9235.769105772275;9257.444553326688;5187.896242075213;5190.506901844319;5263.47050496452;5282.8802715888905;5347;3612.458131280329;3759.548854137521;3762.548494180716;3762.6425489578446;3764.322421964018;559.7732918168149;630.2185290240161;637.1303171171318;638.6264035539168;639.3702203329716;649.7303618998158;679.751890559942;729.2707292707292;742.109468637637;747.7009196321515;9506.829475366418;9761.040276956863;10030.799384012278;10222.693319200436;10271.691849244535;547.2430036021116;569.7151424287856;609.9756009759649;659.4526542969325;691.9515633905578;4564.406627138517;4626.83806066786;4723.669343146015;4766.880827979259;4794.856154315376;74418;112691;129706;130485.34757326152;136761;93524.53237733767;117171.41414293044;118820;119185.40407298082;122445.38777306056;62267.68866155731;79133.60433197797;100454.4977275109;102657.48671256597;103289.35197916112;8669.21977022071;8872.423292485968;8874.423162494675;8919.910800891908;8965.910340896507;58334.708326458094;59447;59743.1038534431;59749;60329.69835150796;47412;47833;80192.59903700445;87498.56250718706;88807;12019.579314723942;12951.222926624432;13565.525206618116;13666.658333541742;13882.583522494342;13374.465021399035;13504.122232054886;13648.385822637807;14522.709545808813;15762.76355854686;14657.56027319182;15358.232088395313;15887.364505419653;15995.520134395521;16160;13595;14279.714405712035;14339.784903226251;15688.215589220721;15763;14035;14848.554543363285;15091;15100.39598416095;15119.319630616428;12252.87747122553;12398.25610463375;12639.873601264237;13283;13403.195808251536;12955.805662914876;13095.607131786062;13190.472381104648;13208.471661133448;13278.269695166859 14:22:33 INFO - PROCESS | 3428 | __end_tp_report 14:22:33 INFO - PROCESS | 3428 | __start_cc_report 14:22:33 INFO - PROCESS | 3428 | _x_x_mozilla_cycle_collect,884 14:22:33 INFO - PROCESS | 3428 | __end_cc_report 14:22:33 INFO - PROCESS | 3428 | __startTimestamp1477257753864__endTimestamp 14:22:33 INFO - PROCESS | 3428 | 14:22:33 INFO - PROCESS | 3428 | ------- Summary: start ------- 14:22:33 INFO - PROCESS | 3428 | Number of tests: 6 14:22:33 INFO - PROCESS | 3428 | 14:22:33 INFO - PROCESS | 3428 | [#0] dojo.html Cycles:165 Average:5596.88 Median:5786.48 stddev:640.21 (11.1%) stddev-sans-first:612.30 14:22:33 INFO - PROCESS | 3428 | Values: 3133.0 3187.0 3192.3 3207.7 3232.5 5592.2 5683.6 5692.6 5693.0 5728.5 5617.6 5667.4 5667.6 5678.5 5705.4 5085.8 5105.5 5135.8 5139.5 5175.9 5036.6 5046.2 5080.7 5200.9 5229.0 5118.4 5149.6 5202.2 5212.7 5221.1 5211.8 5212.2 5217.7 5218.9 5251.8 4921.9 4931.7 5086.6 5105.8 5173.5 5471.6 5535.4 5538.9 5541.7 5546.4 6008.3 6068.9 6110.8 6111.5 6118.1 5923.8 6135.4 6150.6 6164.5 6165.0 5482.7 5549.3 5563.4 5618.4 5624.0 6163.6 6166.8 6169.9 6170.7 6177.5 5764.7 5921.7 5925.6 5931.1 5937.6 5910.9 5920.9 5926.7 5954.6 6059.7 5917.3 5976.6 5981.7 5986.7 5986.7 6002.9 6007.1 6008.4 6011.9 6020.0 4507.4 4552.9 4567.3 4617.1 4631.9 4109.6 4125.1 4137.9 4141.9 4143.6 5725.2 5736.8 5739.8 5741.0 5741.2 5756.3 5801.1 5974.6 5999.8 6003.4 5774.4 5776.2 5785.7 5801.3 5820.2 5279.1 5305.4 5315.1 5317.7 5320.0 6078.4 6096.4 6143.8 6289.1 6337.7 5942.5 6025.8 6056.8 6070.4 6076.9 6266.4 6290.9 6291.6 6300.1 6301.2 5683.6 5969.0 6001.9 6008.3 6026.0 5894.5 5952.6 5972.5 6010.6 6114.2 5902.8 5935.5 5948.3 5957.8 5960.8 5883.1 5919.9 5945.9 5949.1 5955.5 5631.2 5698.7 5757.2 5784.2 5801.6 5939.7 5943.6 5947.0 5947.5 5949.3 5626.5 5689.1 5786.5 5796.0 5796.5 14:22:33 INFO - PROCESS | 3428 | 14:22:33 INFO - PROCESS | 3428 | [#1] ext.html Cycles:180 Average:68242.87 Median:199052.64 stddev:139489.67 (70.1%) stddev-sans-first:139788.48 14:22:33 INFO - PROCESS | 3428 | Values: 585.8 613.2 635.1 638.2 644.8 35111.8 38985.8 39012.8 39167.8 39178.8 48792.8 50455.7 50499.0 53795.0 53875.0 9306.1 9440.3 9446.3 9448.2 9448.9 8312.3 8459.0 9409.3 9499.6 9520.5 8967.5 11219.8 11429.9 11448.1 11879.2 11374.1 11422.3 11431.9 11454.1 11465.7 11135.1 11173.6 11209.3 11240.2 11251.4 46850.5 46972.0 47402.8 47416.5 47424.5 3693.9 3764.7 3808.9 4044.3 4449.9 34879.5 34970.8 35114.1 35440.0 35706.3 4690.8 4693.2 4710.2 4713.2 4730.2 389077.0 389342.0 390161.0 391585.0 394061.0 65142.0 65436.0 65505.0 65547.3 65673.3 41390.4 41995.6 42343.2 69306.3 69392.7 18799.0 18928.9 18930.4 18933.0 18939.3 14189.4 14287.6 14291.4 14296.1 14322.6 19003.6 19283.4 21092.1 21105.2 21278.9 7583.8 7682.8 7801.0 7972.9 7977.8 961.4 1070.6 1115.5 1150.2 1209.6 34155.5 34418.8 34864.3 34919.1 34999.3 1110.4 1133.7 1186.1 1203.9 1236.4 17822.2 17833.9 17849.9 18121.4 18430.9 623255.4 627988.0 629336.0 629503.0 632065.0 62888.7 63512.7 63540.4 63678.7 63791.0 1435.3 1447.8 1475.1 1483.6 1486.7 30730.7 33287.7 34130.8 34158.5 34473.7 55986.0 56127.2 56184.4 56286.4 56369.7 525593.0 525648.0 527956.0 528315.0 528791.0 31702.0 32198.2 32575.7 32755.8 32765.8 52308.2 52888.0 53103.0 54069.7 54207.7 43239.0 43729.9 45246.0 45761.5 46754.8 44368.3 44741.0 44801.6 45765.3 45929.0 43649.6 43938.3 43972.3 44039.1 44056.9 37459.6 37464.8 38010.4 38647.4 38910.8 29276.3 29335.0 29757.7 30001.5 30049.4 14:22:33 INFO - PROCESS | 3428 | 14:22:33 INFO - PROCESS | 3428 | [#2] jquery.html Cycles:180 Average:32927.02 Median:21020.39 stddev:100982.26 (480.4%) stddev-sans-first:101235.96 14:22:33 INFO - PROCESS | 3428 | Values: 370.3 399.5 400.2 408.3 420.0 14354.6 16598.1 20693.7 21417.9 21487.9 20462.6 20545.0 20984.9 21055.9 21187.9 5744.0 5829.3 5988.7 6051.6 6100.3 4076.1 6132.5 6164.2 6164.4 6175.3 4358.9 6142.1 6192.8 6271.8 6277.3 6042.2 6201.6 6229.3 6258.2 6262.9 6032.1 6036.4 6036.5 6038.8 6042.3 14621.6 14853.5 14946.0 15085.6 15218.9 2463.3 2493.0 2899.6 3126.4 3195.6 10607.9 10964.8 11003.9 11177.9 11204.7 1968.3 2014.7 2019.5 2055.1 2075.1 84588.6 87052.6 87445.0 88025.6 96488.0 10822.8 11132.4 11423.7 11460.1 11485.3 15326.2 15330.1 15330.6 15335.4 15365.2 8230.1 8411.4 8421.3 8477.3 8490.0 8360.1 8372.5 8398.8 8554.6 8593.7 4672.0 4694.8 4698.9 4890.7 5053.0 1911.6 1925.7 1926.1 1954.4 1966.7 957.3 988.9 1010.7 1060.5 1084.6 19949.0 20608.7 20611.2 20634.7 20808.1 988.2 1024.2 1048.1 1058.4 1077.0 10938.3 11086.7 11889.3 12174.9 12384.5 586875.0 608205.6 618320.0 628335.0 631141.0 64230.0 76623.6 102120.0 103431.0 105628.0 1062.1 1080.4 1080.8 1086.5 1094.9 18364.6 18604.0 18894.0 19065.7 19087.8 44343.0 44946.6 45126.5 45632.8 45804.3 62373.4 63068.0 64358.7 64487.4 65711.0 8227.2 8506.8 8667.9 9036.9 9061.0 12276.1 13502.7 13588.0 13671.8 13758.2 10905.0 11628.0 11651.1 11710.9 11884.5 11428.1 11616.0 11631.2 11751.0 11967.9 11495.8 11572.7 11962.8 12076.7 12126.1 8612.0 8858.5 8879.4 8893.3 8915.6 10602.6 11429.3 11619.3 11665.7 11871.4 14:22:33 INFO - PROCESS | 3428 | 14:22:33 INFO - PROCESS | 3428 | [#3] mootools.html Cycles:180 Average:6110.19 Median:4378.50 stddev:3451.51 (78.8%) stddev-sans-first:3443.94 14:22:33 INFO - PROCESS | 3428 | Values: 1517.8 1530.8 1708.5 1803.3 1834.1 8246.5 8508.1 8808.8 9491.6 9493.5 9168.1 9506.6 9511.7 9705.3 9706.3 2480.1 2516.7 2518.3 2518.4 2520.5 2111.7 2181.7 2331.4 2439.8 2537.8 2476.4 2520.1 2525.6 2525.7 2526.6 2441.9 2459.5 2461.4 2461.5 2465.2 2439.5 2446.5 2454.3 2468.6 2477.2 9657.2 9891.6 9892.3 9901.1 9906.3 5708.5 5851.3 5900.6 5904.8 5909.4 3545.9 3585.9 3656.6 3691.6 3698.8 1170.6 1226.9 1250.3 1255.2 1259.9 12902.2 12916.1 13005.2 13005.7 13017.9 4965.3 5039.3 5100.6 5108.7 5181.2 10972.3 11006.4 11014.8 11020.6 11027.7 5694.1 5713.1 5714.5 5718.5 5721.8 5167.2 5231.2 5285.5 5360.4 5396.1 4357.5 4359.5 4360.4 4396.6 4410.4 1218.3 1239.2 1356.1 1364.0 1409.9 919.4 1011.4 1016.7 1023.3 1026.7 6306.2 6317.0 6354.5 6394.2 6508.7 989.8 1001.5 1007.5 1038.9 1062.7 4086.2 4110.4 4244.4 4306.1 4310.8 11260.3 11499.4 11555.4 11649.2 11760.2 11663.7 11673.2 11674.3 11677.4 11681.4 8362.8 8512.7 8584.3 8595.3 8599.8 5762.0 5816.3 5840.8 5844.5 6014.6 10341.2 10345.8 10347.6 10371.8 10456.7 10146.6 10533.5 10553.5 10681.8 10693.4 7817.0 8021.4 8028.3 8030.6 8032.3 8686.4 8692.9 8729.3 8789.1 8798.4 6787.4 7596.9 7833.2 7881.6 7967.5 7377.6 7383.0 7476.0 7498.4 7511.5 7276.3 7429.7 7458.5 7505.0 7605.2 5401.0 5427.2 5461.0 5485.7 5594.2 5367.9 5447.9 5463.9 5477.8 5487.2 14:22:33 INFO - PROCESS | 3428 | 14:22:33 INFO - PROCESS | 3428 | [#4] prototype.html Cycles:180 Average:4756.70 Median:5341.63 stddev:1401.93 (26.2%) stddev-sans-first:1366.12 14:22:33 INFO - PROCESS | 3428 | Values: 341.0 347.9 348.4 348.8 354.5 5500.2 5519.6 5533.8 5553.4 5565.2 5451.5 5461.9 5482.3 5482.7 5493.8 3764.2 4088.6 4166.7 4197.8 4306.9 4297.8 4299.9 4300.1 4305.7 4310.2 4263.4 4280.0 4294.4 4295.8 4299.2 4042.4 4051.2 4158.3 4294.8 4305.2 3806.2 3809.2 3811.1 3825.1 3826.3 5289.9 5329.8 5330.9 5335.8 5357.9 4769.6 4931.2 4961.5 4962.3 4973.8 5688.5 5696.7 5706.8 5715.0 5720.2 4192.3 4210.7 4218.6 4220.9 4227.8 5692.5 5944.6 5964.5 5977.5 5992.3 4252.2 4260.4 4260.4 4261.8 4268.4 4281.8 4288.7 4304.8 4308.1 4311.2 4788.2 4869.9 4889.5 4898.4 4913.7 5735.9 5736.7 5767.7 5814.4 5819.2 1465.2 1491.3 1493.6 1493.7 1499.0 903.4 949.4 955.7 957.3 965.9 4893.0 4920.7 4932.0 4945.6 4946.7 5101.7 5117.0 5130.4 5160.3 5160.8 4608.7 4894.9 4913.9 4953.4 4967.0 2721.0 2734.0 2736.7 2750.5 2773.7 5347.4 5394.6 5410.2 5424.9 5446.9 5291.0 5311.3 5696.3 5840.2 6083.2 6001.7 6020.3 6162.2 6162.8 6163.9 5896.0 5910.9 5917.5 5920.2 5958.6 5627.6 5873.9 5883.0 5887.7 5933.4 6126.4 6149.5 6162.0 6174.4 6189.0 4075.7 4292.8 4299.4 4314.2 4321.9 5844.7 5862.6 5904.5 5911.2 5920.2 5745.0 5756.8 5770.2 5772.3 5774.4 5621.5 5731.7 5735.3 5747.8 5766.2 5700.9 5704.8 5720.6 5745.8 5749.6 5560.4 5785.2 5790.5 5792.7 5796.7 5590.9 5605.6 5649.6 5650.6 5660.7 14:22:33 INFO - PROCESS | 3428 | 14:22:33 INFO - PROCESS | 3428 | [#5] yui.html Cycles:180 Average:22364.80 Median:4571.29 stddev:32608.41 (713.3%) stddev-sans-first:32659.66 14:22:33 INFO - PROCESS | 3428 | Values: 792.3 809.9 872.0 882.3 929.8 16634.2 17845.4 17989.8 18072.0 18085.7 15264.0 15652.6 15793.1 16433.3 16449.9 863.7 879.8 880.6 881.3 881.7 739.7 758.2 844.4 870.9 871.5 919.0 919.7 920.4 921.2 921.2 915.0 917.2 917.6 919.0 920.9 566.6 580.5 655.2 671.1 679.6 15124.1 15133.0 15154.4 15171.5 15175.2 15074.9 15442.9 15649.0 16026.8 16311.2 14492.0 14501.6 14514.4 14788.0 14831.8 4508.4 4578.2 4670.6 4709.8 4769.1 86414.6 87370.6 87986.0 90964.0 93732.5 12323.3 12427.0 12464.6 12632.6 12733.9 21708.3 21816.6 21975.6 21978.3 21995.0 9178.0 9197.0 9207.5 9235.8 9257.4 5187.9 5190.5 5263.5 5282.9 5347.0 3612.5 3759.5 3762.5 3762.6 3764.3 559.8 630.2 637.1 638.6 639.4 649.7 679.8 729.3 742.1 747.7 9506.8 9761.0 10030.8 10222.7 10271.7 547.2 569.7 610.0 659.5 692.0 4564.4 4626.8 4723.7 4766.9 4794.9 74418.0 112691.0 129706.0 130485.3 136761.0 93524.5 117171.4 118820.0 119185.4 122445.4 62267.7 79133.6 100454.5 102657.5 103289.4 8669.2 8872.4 8874.4 8919.9 8965.9 58334.7 59447.0 59743.1 59749.0 60329.7 47412.0 47833.0 80192.6 87498.6 88807.0 12019.6 12951.2 13565.5 13666.7 13882.6 13374.5 13504.1 13648.4 14522.7 15762.8 14657.6 15358.2 15887.4 15995.5 16160.0 13595.0 14279.7 14339.8 15688.2 15763.0 14035.0 14848.6 15091.0 15100.4 15119.3 12252.9 12398.3 12639.9 13283.0 13403.2 12955.8 13095.6 13190.5 13208.5 13278.3 14:22:33 INFO - PROCESS | 3428 | -------- Summary: end -------- 14:22:33 INFO - PROCESS | 3428 | 14:22:34 INFO - TEST-INFO | 3428: exit 0 14:22:34 INFO - TEST-OK | dromaeo_css | took 1116092ms 14:22:34 INFO - TEST-START | kraken 14:22:34 INFO - operating with platform_type : linux_ 14:22:34 INFO - Initialising browser for kraken test... 14:22:34 INFO - TEST-INFO | started process 3751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsqovNS/profile http://localhost:47598/getInfo.html) 14:22:38 INFO - PROCESS | 3751 | __metrics Screen width/height:1600/1200 14:22:38 INFO - PROCESS | 3751 | colorDepth:24 14:22:38 INFO - PROCESS | 3751 | Browser inner width/height: 1024/697 14:22:38 INFO - PROCESS | 3751 | __metrics 14:22:39 INFO - PROCESS | 3751 | 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" 14:22:39 INFO - PROCESS | 3751 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:22:39 INFO - PROCESS | 3751 | console.error: PushService: 14:22:39 INFO - PROCESS | 3751 | stateChangeProcessEnqueue: Error transitioning state 14:22:39 INFO - PROCESS | 3751 | UnknownError 14:22:40 INFO - TEST-INFO | 3751: exit 0 14:22:40 INFO - Browser initialized. 14:22:40 INFO - Running cycle 1/1 for kraken test... 14:22:40 INFO - TEST-INFO | started process 3842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsqovNS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:52 INFO - PROCESS | 3842 | RSS: Main: 144355328 14:22:52 INFO - PROCESS | 3842 | 14:22:54 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47598/tests/kraken/driver.html?testName=audio-beat-detection) 14:22:55 INFO - PROCESS | 3842 | RSS: Main: 185352192 14:22:55 INFO - PROCESS | 3842 | 14:22:58 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47598/tests/kraken/driver.html?testName=audio-dft) 14:22:58 INFO - PROCESS | 3842 | RSS: Main: 175136768 14:22:58 INFO - PROCESS | 3842 | 14:23:01 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47598/tests/kraken/driver.html?testName=audio-fft) 14:23:02 INFO - PROCESS | 3842 | RSS: Main: 266776576 14:23:02 INFO - PROCESS | 3842 | 14:23:04 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47598/tests/kraken/driver.html?testName=audio-oscillator) 14:23:04 INFO - PROCESS | 3842 | RSS: Main: 173473792 14:23:04 INFO - PROCESS | 3842 | 14:23:06 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47598/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:23:07 INFO - PROCESS | 3842 | RSS: Main: 174989312 14:23:07 INFO - PROCESS | 3842 | 14:23:10 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47598/tests/kraken/driver.html?testName=imaging-darkroom) 14:23:10 INFO - PROCESS | 3842 | RSS: Main: 211025920 14:23:10 INFO - PROCESS | 3842 | 14:23:14 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47598/tests/kraken/driver.html?testName=imaging-desaturate) 14:23:14 INFO - PROCESS | 3842 | RSS: Main: 209289216 14:23:14 INFO - PROCESS | 3842 | 14:23:17 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47598/tests/kraken/driver.html?testName=json-parse-financial) 14:23:18 INFO - PROCESS | 3842 | RSS: Main: 209833984 14:23:18 INFO - PROCESS | 3842 | 14:23:19 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47598/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:23:20 INFO - PROCESS | 3842 | RSS: Main: 171687936 14:23:20 INFO - PROCESS | 3842 | 14:23:22 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47598/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:23:22 INFO - PROCESS | 3842 | RSS: Main: 178577408 14:23:22 INFO - PROCESS | 3842 | 14:23:24 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47598/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:23:25 INFO - PROCESS | 3842 | RSS: Main: 187617280 14:23:25 INFO - PROCESS | 3842 | 14:23:27 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47598/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:23:28 INFO - PROCESS | 3842 | RSS: Main: 196792320 14:23:28 INFO - PROCESS | 3842 | 14:23:31 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47598/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:23:31 INFO - PROCESS | 3842 | RSS: Main: 193277952 14:23:31 INFO - PROCESS | 3842 | 14:23:33 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:47598/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47598/tests/kraken/driver.html?testName=ai-astar) 14:23:33 INFO - PROCESS | 3842 | RSS: Main: 245047296 14:23:33 INFO - PROCESS | 3842 | 14:23:33 INFO - PROCESS | 3842 | __start_tp_report 14:23:33 INFO - PROCESS | 3842 | _x_x_mozilla_page_load 14:23:33 INFO - PROCESS | 3842 | _x_x_mozilla_page_load_details 14:23:33 INFO - PROCESS | 3842 | |i|pagename|runs| 14:23:33 INFO - PROCESS | 3842 | |0;ai-astar;108;110;109;109;112;108;109;109;110;109 14:23:33 INFO - PROCESS | 3842 | |1;audio-beat-detection;143;116;115;168;120;120;117;117;152;117 14:23:33 INFO - PROCESS | 3842 | |2;audio-dft;162;161;160;161;161;160;161;162;163;162 14:23:33 INFO - PROCESS | 3842 | |3;audio-fft;75;76;75;102;75;76;76;77;97;76 14:23:33 INFO - PROCESS | 3842 | |4;audio-oscillator;82;81;119;82;81;83;113;82;82;110 14:23:33 INFO - PROCESS | 3842 | |5;imaging-gaussian-blur;116;117;117;117;117;117;116;116;117;117 14:23:33 INFO - PROCESS | 3842 | |6;imaging-darkroom;145;146;145;146;146;147;145;145;146;146 14:23:33 INFO - PROCESS | 3842 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 14:23:33 INFO - PROCESS | 3842 | |8;json-parse-financial;50;61;50;51;49;51;59;49;50;52 14:23:33 INFO - PROCESS | 3842 | |9;json-stringify-tinderbox;59;59;60;59;58;58;58;59;59;58 14:23:33 INFO - PROCESS | 3842 | |10;stanford-crypto-aes;81;75;74;73;74;74;75;75;74;74 14:23:33 INFO - PROCESS | 3842 | |11;stanford-crypto-ccm;122;135;125;124;120;121;127;121;152;120 14:23:33 INFO - PROCESS | 3842 | |12;stanford-crypto-pbkdf2;155;154;156;159;153;153;150;151;151;155 14:23:33 INFO - PROCESS | 3842 | |13;stanford-crypto-sha256-iterative;61;62;61;61;66;61;61;60;59;60 14:23:33 INFO - PROCESS | 3842 | __end_tp_report 14:23:33 INFO - PROCESS | 3842 | __start_cc_report 14:23:33 INFO - PROCESS | 3842 | _x_x_mozilla_cycle_collect,1585 14:23:33 INFO - PROCESS | 3842 | __end_cc_report 14:23:33 INFO - PROCESS | 3842 | __startTimestamp1477257813542__endTimestamp 14:23:33 INFO - PROCESS | 3842 | 14:23:33 INFO - PROCESS | 3842 | ------- Summary: start ------- 14:23:33 INFO - PROCESS | 3842 | Number of tests: 14 14:23:33 INFO - PROCESS | 3842 | 14:23:33 INFO - PROCESS | 3842 | [#0] ai-astar Cycles:10 Average:109.30 Median:109.00 stddev:1.16 (1.1%) stddev-sans-first:1.13 14:23:33 INFO - PROCESS | 3842 | Values: 108.0 110.0 109.0 109.0 112.0 108.0 109.0 109.0 110.0 109.0 14:23:33 INFO - PROCESS | 3842 | 14:23:33 INFO - PROCESS | 3842 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:120.00 stddev:18.86 (15.7%) stddev-sans-first:19.26 14:23:33 INFO - PROCESS | 3842 | Values: 143.0 116.0 115.0 168.0 120.0 120.0 117.0 117.0 152.0 117.0 14:23:33 INFO - PROCESS | 3842 | 14:23:33 INFO - PROCESS | 3842 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 14:23:33 INFO - PROCESS | 3842 | Values: 162.0 161.0 160.0 161.0 161.0 160.0 161.0 162.0 163.0 162.0 14:23:33 INFO - PROCESS | 3842 | 14:23:33 INFO - PROCESS | 3842 | [#3] audio-fft Cycles:10 Average:80.50 Median:76.00 stddev:10.10 (13.3%) stddev-sans-first:10.52 14:23:33 INFO - PROCESS | 3842 | Values: 75.0 76.0 75.0 102.0 75.0 76.0 76.0 77.0 97.0 76.0 14:23:33 INFO - PROCESS | 3842 | 14:23:33 INFO - PROCESS | 3842 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:82.00 stddev:15.69 (19.1%) stddev-sans-first:16.26 14:23:33 INFO - PROCESS | 3842 | Values: 82.0 81.0 119.0 82.0 81.0 83.0 113.0 82.0 82.0 110.0 14:23:33 INFO - PROCESS | 3842 | 14:23:33 INFO - PROCESS | 3842 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 14:23:33 INFO - PROCESS | 3842 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 14:23:33 INFO - PROCESS | 3842 | 14:23:33 INFO - PROCESS | 3842 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 14:23:33 INFO - PROCESS | 3842 | Values: 145.0 146.0 145.0 146.0 146.0 147.0 145.0 145.0 146.0 146.0 14:23:33 INFO - PROCESS | 3842 | 14:23:33 INFO - PROCESS | 3842 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 14:23:33 INFO - PROCESS | 3842 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 14:23:33 INFO - PROCESS | 3842 | 14:23:33 INFO - PROCESS | 3842 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:51.00 stddev:4.24 (8.3%) stddev-sans-first:4.42 14:23:33 INFO - PROCESS | 3842 | Values: 50.0 61.0 50.0 51.0 49.0 51.0 59.0 49.0 50.0 52.0 14:23:33 INFO - PROCESS | 3842 | 14:23:33 INFO - PROCESS | 3842 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 14:23:33 INFO - PROCESS | 3842 | Values: 59.0 59.0 60.0 59.0 58.0 58.0 58.0 59.0 59.0 58.0 14:23:33 INFO - PROCESS | 3842 | 14:23:33 INFO - PROCESS | 3842 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:74.50 stddev:2.23 (3.0%) stddev-sans-first:0.67 14:23:33 INFO - PROCESS | 3842 | Values: 81.0 75.0 74.0 73.0 74.0 74.0 75.0 75.0 74.0 74.0 14:23:33 INFO - PROCESS | 3842 | 14:23:33 INFO - PROCESS | 3842 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:124.50 stddev:9.98 (8.0%) stddev-sans-first:10.44 14:23:33 INFO - PROCESS | 3842 | Values: 122.0 135.0 125.0 124.0 120.0 121.0 127.0 121.0 152.0 120.0 14:23:33 INFO - PROCESS | 3842 | 14:23:33 INFO - PROCESS | 3842 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.70 Median:154.50 stddev:2.71 (1.8%) stddev-sans-first:2.83 14:23:33 INFO - PROCESS | 3842 | Values: 155.0 154.0 156.0 159.0 153.0 153.0 150.0 151.0 151.0 155.0 14:23:33 INFO - PROCESS | 3842 | 14:23:33 INFO - PROCESS | 3842 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.20 Median:61.00 stddev:1.87 (3.1%) stddev-sans-first:1.99 14:23:33 INFO - PROCESS | 3842 | Values: 61.0 62.0 61.0 61.0 66.0 61.0 61.0 60.0 59.0 60.0 14:23:33 INFO - PROCESS | 3842 | -------- Summary: end -------- 14:23:33 INFO - PROCESS | 3842 | 14:23:34 INFO - TEST-INFO | 3842: exit 0 14:23:34 INFO - TEST-OK | kraken | took 59927ms 14:23:34 INFO - SUITE-END | took 1176s 14:23:34 INFO - Completed test suite (00:19:36) 14:23:34 INFO - javascript benchmark 14:23:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.9530057049146, 3187.0279564732764, 3192.281736609263, 3207.7433805295577, 3232.53128296397, 5592.217089607453, 5683.573731970098, 5692.57305702072, 5693.03218452863, 5728.455796699317, 5617.634853734505, 5667.376588575254, 5667.603267771247, 5678.48893599576, 5705.4294570542925, 5085.821996230124, 5105.540501354877, 5135.794568217267, 5139.48605139485, 5175.896482070356, 5036.571891389236, 5046.243063540462, 5080.695158290496, 5200.8699782505555, 5229.0, 5118.3857937047605, 5149.639525233235, 5202.219667049935, 5212.687238765668, 5221.138512145491, 5211.843644690627, 5212.244224587433, 5217.686938783666, 5218.895622087537, 5251.842444726664, 4921.8523444296725, 4931.679440836334, 5086.593072554187, 5105.795768169269, 5173.508516690908, 5471.616986810925, 5535.446455354472, 5538.944610553883, 5541.695206763627, 5546.362168350651, 6008.279006519246, 6068.908966365508, 6110.847228819315, 6111.51107911366, 6118.051701986199, 5923.763049478016, 6135.355787642278, 6150.630962142286, 6164.537659675498, 6164.96917515414, 5482.671039737628, 5549.334079910396, 5563.388027316992, 5618.410066942994, 5624.0, 6163.599366041193, 6166.845828854225, 6169.9383006170265, 6170.722317495633, 6177.505799536027, 5764.654120752768, 5921.67430791302, 5925.555583331267, 5931.139984702194, 5937.554683398763, 5910.911336329958, 5920.940790592125, 5926.703664816742, 5954.642721436728, 6059.666718330534, 5917.260342457193, 5976.551758618034, 5981.6710080945095, 5986.700664966735, 5986.73059712314, 6002.879942401215, 6007.06890431975, 6008.429199226067, 6011.909821352683, 6019.969900150471, 4507.4365704286965, 4552.908941821145, 4567.269236922077, 4617.076584683077, 4631.930521042187, 4109.630133287958, 4125.071858831739, 4137.937930931039, 4141.855035073758, 4143.627073563393, 5725.198472213893, 5736.827895163152, 5739.770409183586, 5741.0, 5741.19623252745, 5756.30924289088, 5801.12983052537, 5974.641521508724, 5999.820005399845, 6003.429674180946, 5774.393688662714, 5776.249087618667, 5785.71071446426, 5801.274840644919, 5820.214271073351, 5279.128943724242, 5305.363356397257, 5315.123004704181, 5317.680939143664, 5319.973400133052, 6078.3617720138745, 6096.3903609639565, 6143.849652621547, 6289.088082228142, 6337.714802833883, 5942.524598032061, 6025.758969641165, 6056.788012419544, 6070.423309785563, 6076.8784624308155, 6266.436020758154, 6290.905636415366, 6291.622502649856, 6300.086487459201, 6301.212348456443, 5683.573731970201, 5968.985272503598, 6001.90997135052, 6008.279006519071, 6026.0, 5894.528437725057, 5952.642841429528, 5972.462478376967, 6010.639361638316, 6114.205153330038, 5902.793402230901, 5935.495482884004, 5948.2862056553495, 5957.791477298274, 5960.76156953717, 5883.146943693226, 5919.881602367843, 5945.851353716192, 5949.077892926603, 5955.5235581154275, 5631.211630371669, 5698.686572238566, 5757.165211044459, 5784.2191304175085, 5801.593888427769, 5939.673317967553, 5943.554233432424, 5947.04847224442, 5947.524198064058, 5949.3455719871645, 5626.549876009991, 5689.118186681071, 5786.479216870502, 5796.0, 5796.507296879812], "value": 5552.834318344248, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.8213244960288, 613.1997742945457, 635.0696230023016, 638.1544453598982, 644.764660898772, 35111.82444087779, 38985.8050709746, 39012.80493597528, 39167.80416097919, 39178.8041059795, 48792.75603621977, 50455.74772126143, 50499.0, 53795.0, 53875.0, 9306.11591898772, 9440.291978101635, 9446.291528135383, 9448.244140468745, 9448.905510944905, 8312.33501319893, 8459.0, 9409.294302927308, 9499.620015199383, 9520.523973801317, 8967.506787126706, 11219.775604487906, 11429.942850285737, 11448.084153267719, 11879.227850189753, 11374.090072794157, 11422.314661120276, 11431.885681143165, 11454.083673306115, 11465.713357166054, 11135.05352045077, 11173.553057877674, 11209.327440353523, 11240.156988225915, 11251.381174035425, 46850.531494685296, 46972.0, 47402.76298618485, 47416.52583474156, 47424.5257547427, 3693.9445908311395, 3764.6611804937415, 3808.866689665876, 4044.28702350582, 4449.8652843525015, 34879.4768078479, 34970.82514587411, 35114.122146946276, 35440.0, 35706.28587428237, 4690.829438381933, 4693.155232058228, 4710.199266124767, 4713.198756211418, 4730.219513780222, 389077.0, 389342.0, 390160.99999999715, 391585.0, 394061.0, 65142.0, 65436.0, 65505.0, 65547.34452655508, 65673.34326656768, 41390.37914431225, 41995.58004419978, 42343.153136937086, 69306.30693692999, 69392.6530367345, 18799.0, 18928.905355473136, 18930.43208703741, 18933.0, 18939.33712320062, 14189.36147873348, 14287.642808929651, 14291.356888940023, 14296.070755400866, 14322.570322890122, 19003.61992760165, 19283.421497355102, 21092.05085771144, 21105.155793768383, 21278.893605531874, 7583.7724868254045, 7682.846343073107, 7800.985871836739, 7972.880406793903, 7977.840443191104, 961.427950369529, 1070.6466865934224, 1115.5314767797545, 1150.2121047082608, 1209.5947857467847, 34155.487667685, 34418.82790586031, 34864.30271394558, 34919.12702182466, 34999.30001399958, 1110.3726394587034, 1133.7222380516826, 1186.0985650905202, 1203.8796120387892, 1236.4065248680504, 17822.198001089724, 17833.910830445766, 17849.910750446164, 18121.36575219861, 18430.907845460955, 623255.4186145383, 627988.0, 629336.0, 629503.0, 632065.0, 62888.68555657192, 63512.68243658752, 63540.36459635437, 63678.68160659167, 63791.0, 1435.33257035479, 1447.7683570628649, 1475.0707054555562, 1483.5697647682266, 1486.7026594681106, 30730.692693072782, 33287.66712332846, 34130.82934585311, 34158.487622686174, 34473.65526344704, 55986.0, 56127.158092627826, 56184.43815561956, 56286.43713562812, 56369.71815140898, 525593.0, 525648.0, 527956.0, 528315.0, 528791.0, 31702.0, 32198.19504512406, 32575.67424325821, 32755.836220818743, 32765.836170818995, 52308.21537677014, 52888.0, 53103.0, 54069.72965135149, 54207.728961354944, 43239.0, 43729.874642423725, 45246.0, 45761.54238457706, 46754.76622617001, 44368.334474983545, 44741.0, 44801.55198447974, 45765.31352029789, 45929.0, 43649.56350436455, 43938.34092488551, 43972.34041489444, 44039.119217616106, 44056.898577535816, 37459.62540374562, 37464.812675936446, 38010.408921933085, 38647.42028869625, 38910.80544597259, 29276.268093297836, 29335.0, 29757.70242297636, 30001.54997674993, 30049.399012020076], "value": 22008.771200297346, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.2871971454949, 399.5325469201035, 400.21158318113305, 408.2875382457611, 420.02554074547044, 14354.569362919116, 16598.087105209208, 20693.689594656073, 21417.892910535465, 21487.892560537177, 20462.590748185026, 20545.0, 20984.8950755246, 21055.894720526416, 21187.894060529714, 5744.0, 5829.271341082364, 5988.730507127189, 6051.576389652726, 6100.328963813977, 4076.103257283408, 6132.50939924805, 6164.198654174951, 6164.445199932005, 6175.289841668221, 4358.934615980763, 6142.0786881967615, 6192.78325258616, 6271.780487682932, 6277.340879207686, 6042.184305118797, 6201.596896201778, 6229.2524897012645, 6258.1551490548645, 6262.906056409158, 6032.095185722133, 6036.396360363972, 6036.547258955552, 6038.818835434944, 6042.335343112254, 14621.561353159423, 14853.48012819546, 14946.0, 15085.622859428493, 15218.923905380512, 2463.3472129885595, 2492.987535062313, 2899.5505696617056, 3126.390353880994, 3195.6484786673445, 10607.893921060844, 10964.848690887502, 11003.9092572411, 11177.888221117848, 11204.66386008421, 1968.3012530551591, 2014.738084049079, 2019.545602239499, 2055.106028877443, 2075.1180748182114, 84588.57705711432, 87052.56473717654, 87444.98343882801, 88025.55987220023, 96488.0, 10822.783544329226, 11132.387718675389, 11423.657290281304, 11460.083193344512, 11485.253458525169, 15326.157061361731, 15330.080195188324, 15330.616734581501, 15335.386584536494, 15365.154916479478, 8230.135835737281, 8411.369147313975, 8421.284190843724, 8477.27943124829, 8490.0, 8360.080391156967, 8372.53951032687, 8398.83202335962, 8554.61504232311, 8593.667981462882, 4672.0, 4694.779357367109, 4698.906021879611, 4890.706557606555, 5053.01466214092, 1911.62723268964, 1925.6726356519425, 1926.0754837677994, 1954.355062829263, 1966.675498542753, 957.3011701457835, 988.9060539248903, 1010.6765834932751, 1060.5015642647943, 1084.6258040975852, 19949.0, 20608.69086963697, 20611.175552978013, 20634.690479642817, 20808.063637136365, 988.1847475832467, 1024.2267088348249, 1048.051513380392, 1058.439027315524, 1076.9784604308027, 10938.289011214245, 11086.722831929104, 11889.28664280146, 12174.939125304316, 12384.504619815287, 586875.0, 608205.572225452, 618320.0, 628335.0, 631141.0, 64230.0, 76623.61688191524, 102120.0, 103431.0, 105628.0, 1062.0759938853248, 1080.4273734920348, 1080.8108580998294, 1086.5327908999207, 1094.8795632480421, 18364.632707346045, 18604.0, 18894.0, 19065.71401428952, 19087.8091219086, 44343.0, 44946.550534494236, 45126.54873451223, 45632.77183614061, 45804.31293530666, 62373.37626623676, 63068.0, 64358.67820660867, 64487.355126448136, 65711.0, 8227.218414250636, 8506.787330316543, 8667.869981950149, 9036.909630903607, 9061.049377517438, 12276.140670153003, 13502.662433439242, 13588.048836581343, 13671.794923075962, 13758.174509529461, 10904.992719366448, 11628.0, 11651.126165537788, 11710.88289117132, 11884.524619015143, 11428.085753139563, 11616.0, 11631.185816993067, 11751.004658415837, 11967.880321196677, 11495.8275625864, 11572.6528204154, 11962.820557691468, 12076.698082548006, 12126.090543209119, 8612.0, 8858.512781797062, 8879.378443509151, 8893.333000025154, 8915.55422228873, 10602.628907988183, 11429.257098288917, 11619.302841829518, 11665.650030499099, 11871.406429678309], "value": 9529.730418068282, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1517.764746464298, 1530.7780371846084, 1708.5386945524708, 1803.2967142814296, 1834.05546143736, 8246.463979841306, 8508.14918508149, 8808.77978050549, 9491.572879220434, 9493.477858717768, 9168.08319168083, 9506.619735210601, 9511.667091651794, 9705.320627556073, 9706.272029597772, 2480.057578120316, 2516.6979962404444, 2518.294877434312, 2518.357818756215, 2520.4581015081753, 2111.7043613894066, 2181.6509358502644, 2331.40549159964, 2439.8414103083333, 2537.8096642751775, 2476.4428003699204, 2520.1179587144443, 2525.6085306777477, 2525.671662683858, 2526.608375701769, 2441.8779061046966, 2459.458919037818, 2461.446174610725, 2461.54461424637, 2465.235776909146, 2439.499902519979, 2446.5351583199135, 2454.2637208837455, 2468.5556599812026, 2477.1577663594285, 9657.179139773129, 9891.604335826558, 9892.30753847231, 9901.108900199017, 9906.257030722652, 5708.514776243983, 5851.32709738377, 5900.64596124234, 5904.793332233394, 5909.4090590941, 3545.8936231913085, 3585.928281434383, 3656.579493358271, 3691.5754688210664, 3698.815059247027, 1170.631251155883, 1226.8957138643227, 1250.337321219755, 1255.209218192542, 1259.8740125987329, 12902.197835027955, 12916.095873288874, 13005.154664946844, 13005.739885202243, 13017.934910325483, 4965.32968049316, 5039.269305950616, 5100.56645185156, 5108.744562771846, 5181.248718935733, 10972.286801357886, 11006.394648294261, 11014.779704406028, 11020.559177632806, 11027.72430689223, 5694.088945768657, 5713.114467257582, 5714.457126572969, 5718.485336319751, 5721.828345149652, 5167.199084141889, 5231.189165679326, 5285.524302812765, 5360.437154098763, 5396.109641909041, 4357.520672725997, 4359.455068116486, 4360.41134446852, 4396.582324679151, 4410.3825464435, 1218.3360068762545, 1239.2155296373194, 1356.1117468058437, 1364.0042768778846, 1409.9295035248197, 919.4207649181106, 1011.4487604255698, 1016.6848277034143, 1023.3297190340339, 1026.743314171457, 6306.243250809932, 6316.968415157895, 6354.52341074412, 6394.23269207698, 6508.674566271668, 989.7525618595351, 1001.5092604623682, 1007.5163921317809, 1038.89611038897, 1062.654637242899, 4086.223617512663, 4110.403991421227, 4244.448221731155, 4306.0957198987935, 4310.80601372939, 11260.268082574607, 11499.3675347855, 11555.42222888869, 11649.242799218024, 11760.176787624956, 11663.708407289885, 11673.182877198515, 11674.299542027506, 11677.416129193507, 11681.415929203506, 8362.790930226793, 8512.702055428153, 8584.31325493959, 8595.269402100766, 8599.828003440021, 5761.971190144022, 5816.302043754777, 5840.795572154954, 5844.47399734026, 6014.6391216527145, 10341.172706183337, 10345.793084138426, 10347.586096556355, 10371.792564148825, 10456.738581535523, 10146.644867429604, 10533.525991330256, 10553.525091370753, 10681.839772403575, 10693.358398496115, 7817.0, 8021.358291336795, 8028.317593004426, 8030.63862126194, 8032.277095061472, 8686.435381700168, 8692.913070869463, 8729.301655867643, 8789.07714689974, 8798.38411311202, 6787.355201255873, 7596.886046709415, 7833.177516360928, 7881.566513841564, 7967.482113662593, 7377.594232317274, 7382.9630851845395, 7475.962620186864, 7498.437617178843, 7511.474196806171, 7276.345128938421, 7429.702811887464, 7458.47790654649, 7504.962475187589, 7605.163432022584, 5401.0, 5427.158790387496, 5460.972695136499, 5485.725713714378, 5594.1608758686525, 5367.919481207863, 5447.863803404788, 5463.890722185613, 5477.808276710296, 5487.176923461513], "value": 4905.151631248672, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.9727221822253, 347.8539013614282, 348.41466336554595, 348.8290737538607, 354.46475821509523, 5500.22996780451, 5519.55843532518, 5533.833984980452, 5553.389517040054, 5565.165225216219, 5451.536619387357, 5461.863453413666, 5482.342118945722, 5482.725863706819, 5493.807716729915, 3764.1555637737583, 4088.6115818997223, 4166.6874984376145, 4197.811098500575, 4306.935395969063, 4297.828086876521, 4299.935500967488, 4300.139972005596, 4305.698601097924, 4310.211262326131, 4263.424437700917, 4279.978600107011, 4294.355846623001, 4295.849645262417, 4299.247631664462, 4042.4234548526097, 4051.1897620476025, 4158.334666453383, 4294.849680261192, 4305.203537345601, 3806.1626442182674, 3809.2191100824543, 3811.123441608446, 3825.1202223488754, 3826.330392181357, 5289.894202115975, 5329.760160792774, 5330.92003619946, 5335.839924802223, 5357.866053348697, 4769.594584460325, 4931.161702510582, 4961.5038496150455, 4962.330085438456, 4973.801047958077, 5688.520984544007, 5696.658200507983, 5706.773043795604, 5715.0, 5720.170575266605, 4192.308269135589, 4210.7473551587, 4218.586773430904, 4220.85227017056, 4227.78861056949, 5692.5161361284345, 5944.613600115978, 5964.479057840266, 5977.521798256129, 5992.31088424828, 4252.234597772431, 4260.360945858146, 4260.360945858146, 4261.808218630107, 4268.396278270253, 4281.807318670667, 4288.7212331199, 4304.80628371724, 4308.095299987038, 4311.223979683625, 4788.186008378514, 4869.878253043702, 4889.511048895082, 4898.363212782316, 4913.70517768935, 5735.942640573624, 5736.741846616912, 5767.711614419262, 5814.418558144236, 5819.243498345273, 1465.1868213141809, 1491.328901994107, 1493.6041948883556, 1493.7385957457402, 1498.9550313490613, 903.421810041574, 949.3765660720107, 955.7323949294208, 957.3442192098296, 965.888922773876, 4892.975535122301, 4920.6801557898625, 4931.966840393204, 4945.579625731782, 4946.653734238641, 5101.7348896706135, 5117.0, 5130.410002849645, 5160.329157209614, 5160.793568257228, 4608.700434471749, 4894.926576101361, 4913.926291105637, 4953.380827396575, 4967.0, 2720.9591856122174, 2733.986330068337, 2736.7011710163556, 2750.477409292268, 2773.736495032969, 5347.41178470368, 5394.568434525228, 5410.215518749759, 5424.918626220609, 5446.863828404243, 5290.984139040786, 5311.336082989626, 5696.259486266842, 5840.2115714378015, 6083.209182806207, 6001.699915004232, 6020.307664618625, 6162.22972128484, 6162.7534898605345, 6163.9383606164265, 5895.970520147372, 5910.852228694317, 5917.467427931507, 5920.171176035445, 5958.612690175125, 5627.634203776742, 5873.9412605873395, 5882.999890018793, 5887.7056147191615, 5933.406659334032, 6126.448619624077, 6149.508039356931, 6162.0, 6174.351693072163, 6189.0, 4075.65356944663, 4292.785360732013, 4299.398084268142, 4314.201872653569, 4321.891952701208, 5844.707764611668, 5862.589618726819, 5904.527637789052, 5911.167538063214, 5920.171176035445, 5744.971275143765, 5756.798512052058, 5770.163326317745, 5772.278465191851, 5774.448714040751, 5621.494065534122, 5731.684757338387, 5735.311762588516, 5747.798827041033, 5766.221560089502, 5700.885982280248, 5704.828855134353, 5720.570957178145, 5745.770169193185, 5749.597528172988, 5560.388357280615, 5785.247917770663, 5790.507806836466, 5792.710364481674, 5796.710164491674, 5590.944090559043, 5605.607607467438, 5649.5762817789655, 5650.63270887391, 5660.7169641518585], "value": 4312.414276822119, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.3027735592677, 809.8947136872206, 871.9782005449865, 882.2765332427408, 929.7815013471837, 16634.168291585418, 17845.375411860587, 17989.820101798978, 18072.0, 18085.7287140693, 15264.0, 15652.608684782886, 15793.052416854996, 16433.342666293334, 16449.91775041126, 863.7106569299292, 879.7668617816283, 880.5553195636195, 881.3301890563154, 881.6561540999015, 739.7152096442882, 758.1773775453639, 844.3625063077368, 870.9172628600304, 871.4596949891045, 919.0487845080344, 919.7148883845996, 920.4155361345561, 921.1709461484684, 921.1847514949285, 915.0346384564282, 917.2478567574592, 917.6008436330218, 918.9862152067691, 920.894097178823, 566.583561082604, 580.4630716587141, 655.207199288861, 671.0839703804272, 679.6397909108181, 15124.092554446768, 15133.0, 15154.393824247018, 15171.544853654408, 15175.241237938058, 15074.924625376803, 15442.922785386114, 15649.0, 16026.839731602768, 16311.184440777914, 14492.0, 14501.637459063502, 14514.419423223058, 14788.0, 14831.77752333716, 4508.391367165424, 4578.175928332898, 4670.579647831712, 4709.788059537329, 4769.141554520185, 86414.56792715997, 87370.5631471845, 87986.0, 90963.99999999935, 93732.53133734356, 12323.322217278135, 12427.0, 12464.580770782208, 12632.557860474839, 12733.872661273454, 21708.348749537538, 21816.563668726536, 21975.560488790135, 21978.340649780534, 21995.010224539936, 9177.954110229406, 9197.0, 9207.539623018822, 9235.769105772275, 9257.444553326688, 5187.896242075213, 5190.506901844319, 5263.47050496452, 5282.8802715888905, 5347.0, 3612.458131280329, 3759.548854137521, 3762.548494180716, 3762.6425489578446, 3764.322421964018, 559.7732918168149, 630.2185290240161, 637.1303171171318, 638.6264035539168, 639.3702203329716, 649.7303618998158, 679.751890559942, 729.2707292707292, 742.109468637637, 747.7009196321515, 9506.829475366418, 9761.040276956863, 10030.799384012278, 10222.693319200436, 10271.691849244535, 547.2430036021116, 569.7151424287856, 609.9756009759649, 659.4526542969325, 691.9515633905578, 4564.406627138517, 4626.83806066786, 4723.669343146015, 4766.880827979259, 4794.856154315376, 74418.0, 112691.0, 129706.0, 130485.34757326152, 136761.0, 93524.53237733767, 117171.41414293044, 118820.0, 119185.40407298082, 122445.38777306056, 62267.68866155731, 79133.60433197797, 100454.4977275109, 102657.48671256597, 103289.35197916112, 8669.21977022071, 8872.423292485968, 8874.423162494675, 8919.910800891908, 8965.910340896507, 58334.708326458094, 59447.0, 59743.1038534431, 59749.0, 60329.69835150796, 47412.0, 47833.0, 80192.59903700445, 87498.56250718706, 88807.0, 12019.579314723942, 12951.222926624432, 13565.525206618116, 13666.658333541742, 13882.583522494342, 13374.465021399035, 13504.122232054886, 13648.385822637807, 14522.709545808813, 15762.76355854686, 14657.56027319182, 15358.232088395313, 15887.364505419653, 15995.520134395521, 16160.0, 13595.0, 14279.714405712035, 14339.784903226251, 15688.215589220721, 15763.0, 14035.0, 14848.554543363285, 15091.0, 15100.39598416095, 15119.319630616428, 12252.87747122553, 12398.25610463375, 12639.873601264237, 13283.0, 13403.195808251536, 12955.805662914876, 13095.607131786062, 13190.472381104648, 13208.471661133448, 13278.269695166859], "value": 8048.348850925807, "unit": "score"}], "name": "dromaeo_css", "value": 7636.353982936957, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 109.0, 109.0, 112.0, 108.0, 109.0, 109.0, 110.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 116.0, 115.0, 168.0, 120.0, 120.0, 117.0, 117.0, 152.0, 117.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 161.0, 161.0, 160.0, 161.0, 162.0, 163.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 102.0, 75.0, 76.0, 76.0, 77.0, 97.0, 76.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 119.0, 82.0, 81.0, 83.0, 113.0, 82.0, 82.0, 110.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 147.0, 145.0, 145.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.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": [50.0, 61.0, 50.0, 51.0, 49.0, 51.0, 59.0, 49.0, 50.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 59.0, 58.0, 58.0, 58.0, 59.0, 59.0, 58.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 74.0, 73.0, 74.0, 74.0, 75.0, 75.0, 74.0, 74.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 135.0, 125.0, 124.0, 120.0, 121.0, 127.0, 121.0, 152.0, 120.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 154.0, 156.0, 159.0, 153.0, 153.0, 150.0, 151.0, 151.0, 155.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 66.0, 61.0, 61.0, 60.0, 59.0, 60.0], "value": 61.2, "unit": "score"}], "name": "kraken", "value": 1456.0000000000002, "alertThreshold": 2.0}]} 14:23:34 INFO - Return code: 0 14:23:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:23:34 INFO - # TBPL SUCCESS # 14:23:34 INFO - Running post-action listener: _resource_record_post_action 14:23:34 INFO - [mozharness: 2016-10-23 21:23:34.879774Z] Finished run-tests step (success) 14:23:34 INFO - Running post-run listener: _resource_record_post_run 14:23:34 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 7733248; Write bytes: 382296064; Read time: 1012; Write time: 323844 14:23:34 INFO - TinderboxPrint: CPU usage
13.0% 14:23:34 INFO - TinderboxPrint: I/O read bytes / time
7,733,248 / 1,012 14:23:34 INFO - TinderboxPrint: I/O write bytes / time
382,296,064 / 323,844 14:23:34 INFO - TinderboxPrint: CPU idle
8,280.2 (87.0%) 14:23:34 INFO - TinderboxPrint: CPU user
1,185.7 (12.5%) 14:23:34 INFO - TinderboxPrint: Swap in / out
0 / 0 14:23:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 4509696; Read time: 0; Write time: 420 14:23:34 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 5525504; Write bytes: 377786368; Read time: 832; Write time: 323424 14:23:35 INFO - Running post-run listener: _upload_blobber_files 14:23:35 INFO - Blob upload gear active. 14:23:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:23:35 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 14:23:35 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'] 14:23:35 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 14:23:35 INFO - (blobuploader) - INFO - Open directory for files ... 14:23:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:23:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:23:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:36 INFO - (blobuploader) - INFO - Done attempting. 14:23:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:23:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:23:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:37 INFO - (blobuploader) - INFO - Done attempting. 14:23:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:23:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:23:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:40 INFO - (blobuploader) - INFO - Done attempting. 14:23:40 INFO - (blobuploader) - INFO - Iteration through files over. 14:23:40 INFO - Return code: 0 14:23:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:23:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:23:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c925267876a67f32b3f19fe84ef69c0ab6b997d61755852c75c9c20c9f69a2c0b8fa6ae4f422f8f4074905b1e4e0b1de16ed990373ce4f9ebe0fb4e52cbcd55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3add47b4cf440ed532ccf436cba7d376b3c43878b57529e922bad721b360a053ce5c0ce04762117d82f88340f3c0bd0653a16b25d181ac263b4c76e1d395aab5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6cba31a235eff6883f40381bc274a38b80018135478841285853e81dfdc6c0b24bf0f8bc2e64f76c85309d8edc170c0517d630403796fdd986bd6d3b1cc43e9"} 14:23:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:23:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:23:40 INFO - Contents: 14:23:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c925267876a67f32b3f19fe84ef69c0ab6b997d61755852c75c9c20c9f69a2c0b8fa6ae4f422f8f4074905b1e4e0b1de16ed990373ce4f9ebe0fb4e52cbcd55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3add47b4cf440ed532ccf436cba7d376b3c43878b57529e922bad721b360a053ce5c0ce04762117d82f88340f3c0bd0653a16b25d181ac263b4c76e1d395aab5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6cba31a235eff6883f40381bc274a38b80018135478841285853e81dfdc6c0b24bf0f8bc2e64f76c85309d8edc170c0517d630403796fdd986bd6d3b1cc43e9"} 14:23:40 INFO - Running post-run listener: copy_logs_to_upload_dir 14:23:40 INFO - Copying logs to upload dir... 14:23:40 INFO - mkdir: /builds/slave/test/build/upload/logs 14:23:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.506673 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-23 14:23:40.917177) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-23 14:23:40.920791) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284 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/9c925267876a67f32b3f19fe84ef69c0ab6b997d61755852c75c9c20c9f69a2c0b8fa6ae4f422f8f4074905b1e4e0b1de16ed990373ce4f9ebe0fb4e52cbcd55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3add47b4cf440ed532ccf436cba7d376b3c43878b57529e922bad721b360a053ce5c0ce04762117d82f88340f3c0bd0653a16b25d181ac263b4c76e1d395aab5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6cba31a235eff6883f40381bc274a38b80018135478841285853e81dfdc6c0b24bf0f8bc2e64f76c85309d8edc170c0517d630403796fdd986bd6d3b1cc43e9"} build_url:https://queue.taskcluster.net/v1/task/NBDzGw1iTTKuxYYR7sfxIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/NBDzGw1iTTKuxYYR7sfxIQ/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/9c925267876a67f32b3f19fe84ef69c0ab6b997d61755852c75c9c20c9f69a2c0b8fa6ae4f422f8f4074905b1e4e0b1de16ed990373ce4f9ebe0fb4e52cbcd55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3add47b4cf440ed532ccf436cba7d376b3c43878b57529e922bad721b360a053ce5c0ce04762117d82f88340f3c0bd0653a16b25d181ac263b4c76e1d395aab5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6cba31a235eff6883f40381bc274a38b80018135478841285853e81dfdc6c0b24bf0f8bc2e64f76c85309d8edc170c0517d630403796fdd986bd6d3b1cc43e9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-23 14:23:40.946869) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 14:23:40.947202) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1477253253.383312-696276284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 14:23:41.032677) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-23 14:23:41.033006) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-23 14:23:41.033321) ========= ========= Total master_lag: 0.17 =========